You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@sling.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/11/28 14:59:53 UTC

[Jenkins] Sling » sling-org-apache-sling-launchpad-testing » master #417 is BROKEN

Please see https://builds.apache.org/job/Sling/job/sling-org-apache-sling-launchpad-testing/job/master/417/ for details.

No further emails will be sent until the status of the build is changed.
Build log follows below:

[...truncated 104 lines...]
[INFO] Downloading from Nexus: http://repository.apache.org/snapshots/org/apache/sling/org.apache.sling.launchpad.test-services-war/12-SNAPSHOT/maven-metadata.xml
[INFO] Downloaded from Nexus: http://repository.apache.org/snapshots/org/apache/sling/org.apache.sling.launchpad.test-services-war/12-SNAPSHOT/maven-metadata.xml (1.0 kB at 3.2 kB/s)
[INFO] Downloading from Nexus: http://repository.apache.org/snapshots/org/apache/sling/org.apache.sling.launchpad.test-fragment/12-SNAPSHOT/org.apache.sling.launchpad.test-fragment-12-20191128.144345-59.jar
[INFO] Downloaded from Nexus: http://repository.apache.org/snapshots/org/apache/sling/org.apache.sling.launchpad.test-fragment/12-SNAPSHOT/org.apache.sling.launchpad.test-fragment-12-20191128.144345-59.jar (9.2 kB at 28 kB/s)
[INFO] 
[INFO] --- maven-clean-plugin:3.0.0:clean (default-clean) @ org.apache.sling.launchpad.testing ---
[INFO] Deleting /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target
[INFO] 
[INFO] --- maven-enforcer-plugin:3.0.0-M1:enforce (enforce-property-values) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-enforcer-plugin:3.0.0-M1:enforce (enforce-java) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-enforcer-plugin:3.0.0-M1:enforce (ban-maven-scr-plugin) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-remote-resources-plugin:1.5:process (process-resource-bundles) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-remote-resources-plugin:1.5:process (default) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-resources-plugin:2.7:resources (default-resources) @ org.apache.sling.launchpad.testing ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] skip non existing resourceDirectory /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/src/main/resources
[INFO] Copying 3 resources
[INFO] Copying 3 resources
[INFO] 
[INFO] --- build-helper-maven-plugin:3.0.0:reserve-network-port (reserve-network-port) @ org.apache.sling.launchpad.testing ---
[INFO] Port assigned41000
[INFO] Reserved port 41000 for http.port
[INFO] Port assigned41001
[INFO] Reserved port 41001 for sling.control.port
[INFO] 
[INFO] --- maven-compiler-plugin:3.7.0:compile (default-compile) @ org.apache.sling.launchpad.testing ---
[INFO] No sources to compile
[INFO] 
[INFO] --- animal-sniffer-maven-plugin:1.16:check (default) @ org.apache.sling.launchpad.testing ---
[INFO] Checking unresolved references to org.codehaus.mojo.signature:java17:1.0
[INFO] 
[INFO] --- maven-resources-plugin:2.7:testResources (default-testResources) @ org.apache.sling.launchpad.testing ---
[INFO] Using 'UTF-8' encoding to copy filtered resources.
[INFO] Copying 1 resource
[INFO] Copying 3 resources
[INFO] Copying 3 resources
[INFO] 
[INFO] --- maven-compiler-plugin:3.7.0:testCompile (default-testCompile) @ org.apache.sling.launchpad.testing ---
[INFO] No sources to compile
[INFO] 
[INFO] --- maven-surefire-plugin:2.20.1:test (default-test) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- slingstart-maven-plugin:1.7.16:prepare-package (default-prepare-package) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- slingstart-maven-plugin:1.7.16:attach-slingfeature (default-attach-slingfeature) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- slingstart-maven-plugin:1.7.16:package (default-package) @ org.apache.sling.launchpad.testing ---
[INFO] Packaging standalone jar...
[INFO] Building zip: /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/org.apache.sling.launchpad.testing-12-SNAPSHOT.jar
[INFO] 
[INFO] >>> maven-source-plugin:3.0.1:jar (attach-sources) > generate-sources @ org.apache.sling.launchpad.testing >>>
[INFO] 
[INFO] --- maven-enforcer-plugin:3.0.0-M1:enforce (enforce-property-values) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-enforcer-plugin:3.0.0-M1:enforce (enforce-java) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- maven-enforcer-plugin:3.0.0-M1:enforce (ban-maven-scr-plugin) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] <<< maven-source-plugin:3.0.1:jar (attach-sources) < generate-sources @ org.apache.sling.launchpad.testing <<<
[INFO] 
[INFO] 
[INFO] --- maven-source-plugin:3.0.1:jar (attach-sources) @ org.apache.sling.launchpad.testing ---
[INFO] Building jar: /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/org.apache.sling.launchpad.testing-12-SNAPSHOT-sources.jar
[INFO] 
[INFO] --- maven-site-plugin:3.5.1:attach-descriptor (attach-descriptor) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] --- slingstart-maven-plugin:1.7.16:start (start-container) @ org.apache.sling.launchpad.testing ---
[INFO] Using launchpad jar being generated as this project's primary artifact: '/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/org.apache.sling.launchpad.testing-12-SNAPSHOT.jar'!
[INFO] Starting Launchpad _-41000...
Picked up JAVA_TOOL_OPTIONS: -Dmaven.ext.class.path="/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master@tmp/withMavenc54509a2/pipeline-maven-spy.jar" -Dorg.jenkinsci.plugins.pipeline.maven.reportsFolder="/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master@tmp/withMavenc54509a2" 
-------------------------------------------------------------------
Slingstart application: /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/org.apache.sling.launchpad.testing-12-SNAPSHOT.jar
Main class: org.apache.sling.launchpad.app.Main
Listener Port: 41461
Arguments: [-p, 41000, -j, 41001]
-------------------------------------------------------------------
28.11.2019 14:46:13.390 *INFO * [main] Setting sling.home=sling (default)
28.11.2019 14:46:13.391 *INFO * [main] Starting Apache Sling in /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling
28.11.2019 14:46:13.401 *INFO * [main] Sling  Extension Lib Home : /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling/ext
28.11.2019 14:46:13.402 *INFO * [main] Checking launcher JAR in folder /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling
28.11.2019 14:46:13.416 *INFO * [main] Installing new launcher: jar:file:/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/org.apache.sling.launchpad.testing-12-SNAPSHOT.jar!/resources/org.apache.sling.launchpad.base.jar, 6.0.2.2_6_36 (org.apache.sling.launchpad.base.jar.1574952373416)
28.11.2019 14:46:13.417 *INFO * [main] Loading launcher class org.apache.sling.launchpad.base.app.MainDelegate from org.apache.sling.launchpad.base.jar.1574952373416
28.11.2019 14:46:13.418 *INFO * [main] External Libs Home (ext) is null or does not exists.
28.11.2019 14:46:13.434 *INFO * [main] Setting sling.launchpad=/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling
28.11.2019 14:46:13.434 *INFO * [main] Setting org.osgi.service.http.port=41000
28.11.2019 14:46:13.434 *INFO * [main] Setting sling.control.socket=41001
28.11.2019 14:46:13.435 *INFO * [main] Starting launcher ...
28.11.2019 14:46:13.444 *INFO * [main] HTTP server port: 41000
28.11.2019 14:46:14.180 *INFO* [OsgiInstallerImpl] org.apache.sling.installer.core.impl.OsgiInstallerImpl Apache Sling OSGi Installer Service started.
28.11.2019 14:46:14.207 *INFO* [FelixStartLevel] org.apache.sling.settings.impl.SlingSettingsServiceImpl Read Sling ID null from file /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling/felix/bundle6/data/sling.id.file
28.11.2019 14:46:14.221 *INFO* [FelixStartLevel] org.apache.sling.settings.impl.SlingSettingsServiceImpl Created new Sling ID 6947dde2-13a0-4766-adc8-de0ceaf5cef2
28.11.2019 14:46:14.224 *INFO* [FelixStartLevel] org.apache.sling.settings.impl.SlingSettingsServiceImpl Active run modes: [oak_tar]
28.11.2019 14:46:14.226 *INFO* [FelixStartLevel] org.apache.sling.launchpad.installer.impl.LaunchpadConfigInstaller Activating launchpad config installer, configuration path=resources/config, install path=resources/install
28.11.2019 14:46:14.568 *INFO* [FelixStartLevel] org.apache.sling.launchpad.installer.impl.LaunchpadConfigInstaller 205 resources registered with OsgiInstaller
28.11.2019 14:46:14.722 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed bundle org.apache.felix.metatype [29] from resource TaskResource(url=launchpad:resources/install/4/org.apache.felix.metatype-1.2.2.jar, entity=bundle:org.apache.felix.metatype, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:, Bundle-SymbolicName=org.apache.felix.metatype, Bundle-Version=1.2.2], digest=1574952373000)
28.11.2019 14:46:14.723 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Set start level for bundle org.apache.felix.metatype [29] to 4
28.11.2019 14:46:14.787 *INFO * [main] Startup completed
INFO : bundle org.apache.felix.scr:2.1.16 (30)Starting with globalExtender setting: false
INFO : bundle org.apache.felix.scr:2.1.16 (30) Version = 2.1.16
[INFO] Started Jetty 9.4.20.v20190813 at port(s) HTTP:41000 on context path / [minThreads=8,maxThreads=200,acceptors=3,selectors=12]
[INFO] Apachde Felix Http Whiteboard Service started
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Storing Memory Dumps in /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling/felix/bundle50/data/dumps
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Setting Automatic Memory Dump Threshold to 0% for pools [Code Cache, Compressed Class Space, Metaspace, PS Old Gen]
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Automatic Memory Dump cannot be set for pools [PS Eden Space, PS Survivor Space]
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Setting Automatic Memory Dump Interval to 21600 seconds
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Setting Automatic Memory Dump Threshold to 0% for pools [Code Cache, Compressed Class Space, Metaspace, PS Old Gen]
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Automatic Memory Dump cannot be set for pools [PS Eden Space, PS Survivor Space]
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Setting Automatic Memory Dump Interval to 21600 seconds
INFO : org.apache.felix.webconsole.plugins.memoryusage (50): Storing Memory Dumps in /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/sling/felix/bundle50/data/dumps
Nov 28, 2019 2:46:18 PM org.apache.tika.config.InitializableProblemHandler$3 handleInitializableProblem
WARNING: TIFFImageWriter not loaded. tiff files will not be processed
See https://pdfbox.apache.org/2.0/dependencies.html#jai-image-io
for optional dependencies.
J2KImageReader not loaded. JPEG2000 files will not be processed.
See https://pdfbox.apache.org/2.0/dependencies.html#jai-image-io
for optional dependencies.

Nov 28, 2019 2:46:18 PM org.apache.tika.config.InitializableProblemHandler$3 handleInitializableProblem
WARNING: org.xerial's sqlite-jdbc is not loaded.
Please provide the jar on your classpath to parse sqlite files.
See tika-parsers/pom.xml for the correct version.
[INFO] Started Launchpad '_-41000' at port 41000 [run modes: null]
[INFO] 
[INFO] --- maven-failsafe-plugin:2.21.0:integration-test (default) @ org.apache.sling.launchpad.testing ---
[INFO] 
[INFO] -------------------------------------------------------
[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running org.apache.sling.launchpad.webapp.integrationtest.WebdavOptionsTest
14:46:20,264 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
14:46:20,264 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback-test.xml] at [file:/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/test-classes/logback-test.xml]
14:46:20,265 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback-test.xml] occurs multiple times on the classpath.
14:46:20,265 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback-test.xml] occurs at [jar:file:/home/jenkins/.m2/repository/org/apache/sling/org.apache.sling.launchpad.integration-tests/12-SNAPSHOT/org.apache.sling.launchpad.integration-tests-12-SNAPSHOT.jar!/logback-test.xml]
14:46:20,265 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback-test.xml] occurs at [file:/home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/test-classes/logback-test.xml]
14:46:20,504 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
14:46:20,510 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
14:46:20,520 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [file]
14:46:20,563 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
14:46:20,623 |-INFO in ch.qos.logback.core.FileAppender[file] - File property is set to [target/sling-tests.log]
14:46:20,625 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.sift.SiftingAppender]
14:46:20,627 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [sift]
14:46:20,645 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.sift.MDCBasedDiscriminator] for [discriminator] property
14:46:20,658 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.apache.sling.launchpad] to DEBUG
14:46:20,658 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
14:46:20,658 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [file] to Logger[ROOT]
14:46:20,659 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [sift] to Logger[ROOT]
14:46:20,659 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
14:46:20,660 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@66d18979 - Registering current configuration as safe fallback point

Checking if the required Sling services are started (timeout 60 seconds)...
(base URLs=http://localhost:41000 and http://localhost:41000; servlet context=; readiness type=.txt : text/plain
28.11.2019 14:46:21.387 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.jcr.base.internal.LoginAdminWhitelist from resource TaskResource(url=launchpad:resources/config/org.apache.sling.jcr.base.internal.LoginAdminWhitelist.config, entity=config:org.apache.sling.jcr.base.internal.LoginAdminWhitelist, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.pid=org.apache.sling.jcr.base.internal.LoginAdminWhitelist], digest=783e80c0a2cc122b6d0ee0804cf9a3cf)
28.11.2019 14:46:21.386 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.filter.ServiceUnavailableFilter~startupandshutdown)] org.apache.felix.hc.core.impl.filter.ServiceUnavailableFilter ServiceUnavailableFilter active (start level 30)
28.11.2019 14:46:21.388 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment~composum from resource TaskResource(url=launchpad:resources/config/org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment-composum.config, entity=config:org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment~composum, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment, service.pid=composum], digest=c4f9cd8cb76da8c38c28dd2ef7ded99)
28.11.2019 14:46:21.389 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment~sling from resource TaskResource(url=launchpad:resources/config/org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment-sling.config, entity=config:org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment~sling, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.jcr.base.internal.LoginAdminWhitelist.fragment, service.pid=sling], digest=4798f118db6cc67a2da762b3a793b179)
28.11.2019 14:46:21.392 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.jcr.davex.impl.servlets.SlingDavExServlet from resource TaskResource(url=launchpad:resources/config/org.apache.sling.jcr.davex.impl.servlets.SlingDavExServlet.config, entity=config:org.apache.sling.jcr.davex.impl.servlets.SlingDavExServlet, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.pid=org.apache.sling.jcr.davex.impl.servlets.SlingDavExServlet], digest=b5da891740ad9c266fbc1b28a602dd5d)
28.11.2019 14:46:21.395 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.jcr.repoinit.impl.RepositoryInitializer from resource TaskResource(url=launchpad:resources/config/org.apache.sling.jcr.repoinit.impl.RepositoryInitializer.config, entity=config:org.apache.sling.jcr.repoinit.impl.RepositoryInitializer, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.pid=org.apache.sling.jcr.repoinit.impl.RepositoryInitializer], digest=65247ee84a0b61150ac674d7eeccbc89)
28.11.2019 14:46:21.397 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.jcr.webdav.impl.servlets.SimpleWebDavServlet from resource TaskResource(url=launchpad:resources/config/org.apache.sling.jcr.webdav.impl.servlets.SimpleWebDavServlet.config, entity=config:org.apache.sling.jcr.webdav.impl.servlets.SimpleWebDavServlet, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.pid=org.apache.sling.jcr.webdav.impl.servlets.SimpleWebDavServlet], digest=b51abcc7f240ddf1280eadcf45b57140)
28.11.2019 14:46:21.420 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet defaultStatusMapping={OK=200, WARN=200, TEMPORARILY_UNAVAILABLE=503, CRITICAL=503, HEALTH_CHECK_ERROR=500}
28.11.2019 14:46:21.420 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet servletDefaultTimeout=-1
28.11.2019 14:46:21.420 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet servletDefaultTags=[]
28.11.2019 14:46:21.420 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet defaultCombineTagsWithOr=true
28.11.2019 14:46:21.420 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet defaultFormat=html
28.11.2019 14:46:21.420 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~observation from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-observation.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~observation, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=observation], digest=b358fca04fc5775b5fee0983520f157b)
28.11.2019 14:46:21.421 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet corsAccessControlAllowOrigin=*
28.11.2019 14:46:21.422 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet Registering HC servlet HealthCheckExecutorServlet to path /system/health
28.11.2019 14:46:21.423 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~resourceresolver from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-resourceresolver.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~resourceresolver, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=resourceresolver], digest=d317bcbc20315e21bdbb0480199d7a55)
28.11.2019 14:46:21.423 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet Registering HC servlet HealthCheckExecutorServlet to path /system/health.html
28.11.2019 14:46:21.423 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet Registering HC servlet HealthCheckExecutorServlet to path /system/health.json
28.11.2019 14:46:21.424 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet Registering HC servlet HealthCheckExecutorServlet to path /system/health.jsonp
28.11.2019 14:46:21.424 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet Registering HC servlet HealthCheckExecutorServlet to path /system/health.txt
28.11.2019 14:46:21.425 *INFO* [CM Event Dispatcher (Fire ConfigurationEvent: pid=org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet~default)] org.apache.felix.hc.core.impl.servlet.HealthCheckExecutorServlet Registering HC servlet HealthCheckExecutorServlet to path /system/health.verbose.txt
28.11.2019 14:46:21.425 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~scripting from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-scripting.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~scripting, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=scripting], digest=479bf62d1c800aa03dba13706319afd1)
28.11.2019 14:46:21.426 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~servletsresolver from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-servletsresolver.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~servletsresolver, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=servletsresolver], digest=36b119a784d011be61d06b5de31d4753)
28.11.2019 14:46:21.427 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling-caconfig from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-sling-caconfig.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling-caconfig, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=sling-caconfig], digest=f21cac1a9c2ba6661442ce589b9242f3)
28.11.2019 14:46:21.428 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling.discovery from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-sling.discovery.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling.discovery, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=sling.discovery], digest=49f8c02a6e35568185d429678b3264ee)
28.11.2019 14:46:21.429 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling.event from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-sling.event.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling.event, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=sling.event], digest=93dccd670f84159c69e74973251b7371)
28.11.2019 14:46:21.430 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling.slingshot from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-sling.slingshot.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~sling.slingshot, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=sling.slingshot], digest=ac3800c55b3adba9322abd54ff91dfda)
28.11.2019 14:46:21.431 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~validation from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-validation.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~validation, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=validation], digest=c08b4504cea7305ee153a040fa8177ca)
28.11.2019 14:46:21.431 *INFO* [OsgiInstallerImpl] org.apache.sling.audit.osgi.installer Installed configuration org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~xss from resource TaskResource(url=launchpad:resources/config/org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended-xss.config, entity=config:org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended~xss, state=INSTALL, attributes=[org.apache.sling.installer.api.tasks.ResourceTransformer=:9:226:447:, service.factoryPid=org.apache.sling.serviceusermapping.impl.ServiceUserMapperImpl.amended, service.pid=xss], digest=3ca37545204425ef337f981e2f6ab7f2)
System property [org.owasp.esapi.opsteam] is not set
System property [org.owasp.esapi.devteam] is not set
Attempting to load ESAPI.properties via file I/O.
Attempting to load ESAPI.properties as resource file via file I/O.
Not found in 'org.owasp.esapi.resources' directory or file not readable: /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/ESAPI.properties
Not found in SystemResource Directory/resourceDirectory: .esapi/ESAPI.properties
Not found in 'user.home' (/home/jenkins) directory: /home/jenkins/esapi/ESAPI.properties
Loading ESAPI.properties via file I/O failed. Exception was: java.io.FileNotFoundException
Attempting to load ESAPI.properties via the classpath.
SUCCESSFULLY LOADED ESAPI.properties via the CLASSPATH from '/ (root)' using class loader for DefaultSecurityConfiguration class!
SecurityConfiguration for Validator.ConfigurationFile.MultiValued not found in ESAPI.properties. Using default: false
Attempting to load validation.properties via file I/O.
Attempting to load validation.properties as resource file via file I/O.
Not found in 'org.owasp.esapi.resources' directory or file not readable: /home/jenkins/jenkins-slave/workspace/e-sling-launchpad-testing_master/target/_-41000/validation.properties
Not found in SystemResource Directory/resourceDirectory: .esapi/validation.properties
Not found in 'user.home' (/home/jenkins) directory: /home/jenkins/esapi/validation.properties
Loading validation.properties via file I/O failed.
Attempting to load validation.properties via the classpath.
SUCCESSFULLY LOADED validation.properties via the CLASSPATH from '/ (root)' using class loader for DefaultSecurityConfiguration class!
Sling services seem to be started, continuing with integration tests.
[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 14.912 s - in org.apache.sling.launchpad.webapp.integrationtest.WebdavOptionsTest
[INFO] Running org.apache.sling.launchpad.webapp.integrationtest.FiltersTest
[ERROR] Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 0.001 s <<< FAILURE! - in org.apache.sling.launchpad.webapp.integrationtest.FiltersTest
[ERROR] testCounters(org.apache.sling.launchpad.webapp.integrationtest.FiltersTest)  Time elapsed: 0.001 s  <<< FAILURE!
junit.framework.AssertionFailedError: http://localhost:41000/index.html expected:<200> but was:<404>
	at org.apache.sling.launchpad.webapp.integrationtest.FiltersTest.testCounters(FiltersTest.java:26)

[INFO] Running org.apache.sling.launchpad.webapp.integrationtest.resourceresolver.ResourceResolverApiTest
Aborted by bdelacretaz
Sending interrupt signal to process
[INFO] 
[INFO] Results:
[INFO] 
[ERROR] Failures: 
[ERROR]   FiltersTest.testCounters:26->HttpTestBase.assertHttpStatus:392->HttpTestBase.assertHttpStatus:381 http://localhost:41000/index.html expected:<200> but was:<404>
[INFO] 
[ERROR] Tests run: 3, Failures: 1, Errors: 0, Skipped: 0
[INFO] 
[INFO] 
[INFO] --- slingstart-maven-plugin:1.7.16:stop (stop-container) @ org.apache.sling.launchpad.testing ---
[INFO] Stopping 1 Launchpad instances
[INFO] Stopping Launchpad '_-41000'
28.11.2019 14:59:23.604 *INFO * [Apache Sling Terminator] Java VM is shutting down
28.11.2019 14:59:23.606 *INFO * [Apache Sling Terminator] Stopping Apache Sling
[DEBUG] [ServiceReference 942 from bundle 95 : org.apache.sling.jcr.davex:1.3.10 ref=[javax.servlet.Servlet] properties={objectClass=[javax.servlet.Servlet], osgi.http.whiteboard.context.select=(osgi.http.whiteboard.context.name=DavExAuthHttpContext), osgi.http.whiteboard.servlet.pattern=/server/*, service.bundleid=95, service.description=Sling JcrRemoting Servlet, service.id=942, service.scope=singleton, service.vendor=The Apache Software Foundation, servlet.init.createAbsoluteURI=true, servlet.init.csrf-protection=disabled, servlet.init.protectedhandlers-config=org.apache.jackrabbit.server.remoting.davex.AclRemoveHandler, servlet.init.resource-path-prefix=/server, sling.auth.requirements=-/server}] Ignoring unmatching Servlet service
[DEBUG] [ServiceReference 321 from bundle 144 : org.apache.sling.engine:2.6.20 ref=[javax.servlet.Filter] properties={component.id=204, component.name=org.apache.sling.engine.parameters, file.max=-1, file.threshold=256000, objectClass=[javax.servlet.Filter], osgi.http.whiteboard.context.select=(osgi.http.whiteboard.context.name=org.apache.sling), osgi.http.whiteboard.filter.pattern=/, request.max=-1, service.bundleid=144, service.id=321, service.ranking=2147483647, service.scope=bundle, sling.default.max.parameters=10000, sling.default.parameter.checkForAdditionalContainerParameters=false, sling.default.parameter.encoding=ISO-8859-1}] Ignoring unmatching Filter service
[DEBUG] [ServiceReference 306 from bundle 144 : org.apache.sling.engine:2.6.20 ref=[javax.servlet.Servlet] properties={component.id=199, component.name=org.apache.sling.engine.impl.SlingMainServlet, objectClass=[javax.servlet.Servlet], osgi.http.whiteboard.context.select=(osgi.http.whiteboard.context.name=org.apache.sling), osgi.http.whiteboard.servlet.pattern=/, service.bundleid=144, service.description=Apache Sling Engine Main Servlet, service.id=306, service.scope=singleton, service.vendor=The Apache Software Foundation, servlet-name=ApacheSling/2.6, sling.additional.response.headers=[Ljava.lang.String;@42efe627, sling.max.calls=1000, sling.max.inclusions=50, sling.max.record.requests=20, sling.trace.allow=false}] Ignoring unmatching Servlet service
[DEBUG] [ServiceReference 531 from bundle 144 : org.apache.sling.engine:2.6.20 ref=[javax.servlet.Filter] properties={component.id=203, component.name=org.apache.sling.engine.impl.log.RequestLoggerFilter, objectClass=[javax.servlet.Filter], osgi.http.whiteboard.context.select=(osgi.http.whiteboard.context.name=org.apache.sling), osgi.http.whiteboard.filter.pattern=/, service.bundleid=144, service.description=Request Logger Filter, service.id=531, service.ranking=32768, service.scope=bundle, service.vendor=The Apache Software Foundation}] Ignoring unmatching Filter service
[INFO] Apachde Felix Http Whiteboard Service stopped
[DEBUG] [ServiceReference 1019 from bundle 39 : org.apache.felix.healthcheck.core:2.0.6 ref=[javax.servlet.Servlet] properties={objectClass=[javax.servlet.Servlet], osgi.http.whiteboard.context.select=(osgi.http.whiteboard.context.name=internal.http.serviceunavailablefilter), osgi.http.whiteboard.servlet.pattern=/, service.bundleid=39, service.id=1019, service.ranking=0, service.scope=singleton}] Ignoring unmatching Servlet service
Click here to forcibly terminate running steps
After 20s process did not stop
[Pipeline] }
[withMaven] One or multiple Maven executions have been ignored by the Jenkins Pipeline Maven Plugin because they have been interrupted before completion (1). See Pipeline Maven Plugin FAQ for more details.
[Pipeline] // withMaven
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // timeout
[Pipeline] stage
[Pipeline] { (Notifications)
[Pipeline] echo
Status change is BROKEN, notifications will be sent.
[Pipeline] emailext