Created
November 25, 2019 13:13
-
-
Save vmassol/29fe229bb6bdba21d080406dd446f5e3 to your computer and use it in GitHub Desktop.
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
[INFO] --- maven-failsafe-plugin:3.0.0-M4:integration-test (functional-tests) @ xwiki-platform-menu-test-docker --- | |
[INFO] | |
[INFO] ------------------------------------------------------- | |
[INFO] T E S T S | |
[INFO] ------------------------------------------------------- | |
[INFO] Listening for transport dt_socket at address: 5005 | |
[INFO] Running org.xwiki.menu.test.ui.MenuIT | |
ℹ︎ Checking the system... | |
✔ Docker version should be at least 1.6.0 | |
✔ Docker environment should have more than 2GB free disk space | |
14:03:49.576 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - XWiki is not started, starting all... | |
14:03:49.764 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting database [HSQLDB_EMBEDDED]... | |
14:03:49.822 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Building custom XWiki WAR... | |
14:03:49.835 [main] INFO o.x.t.d.internal.junit5.WARBuilder - XWiki WAR is not fully built in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki], (re)building it! | |
14:04:03.008 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Using the following extension overrides: [] | |
14:04:03.009 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Finding version ... | |
14:04:03.326 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Found version = [11.10-SNAPSHOT] | |
14:04:03.326 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Resolving distribution dependencies ... | |
14:04:10.466 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Copying JAR dependencies ... | |
14:04:19.614 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Expanding WAR dependencies ... | |
14:04:21.449 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Copying JDBC driver for database [HSQLDB_EMBEDDED]... | |
14:04:21.459 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Copying Skin resources ... | |
14:04:21.654 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Generating configuration files for database [HSQLDB_EMBEDDED]... | |
14:04:22.285 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting Servlet container [JETTY_STANDALONE]... | |
14:04:22.426 [main] INFO o.x.t.d.i.j.s.JettyStandaloneExecutor - Replacing variables in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/start_xwiki_debug.bat]... | |
14:04:22.427 [main] INFO o.x.t.d.i.j.s.JettyStandaloneExecutor - Replacing variables in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/start_xwiki_debug.sh]... | |
14:04:22.428 [main] INFO o.x.t.d.i.j.s.JettyStandaloneExecutor - Replacing variables in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/start_xwiki.bat]... | |
14:04:22.429 [main] INFO o.x.t.d.i.j.s.JettyStandaloneExecutor - Replacing variables in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/start_xwiki.sh]... | |
14:04:22.437 [main] INFO o.x.test.integration.XWikiExecutor - Stopping any potentially running XWiki server at [http://localhost:8080/xwiki/bin/get/Main/] | |
2019-11-25 14:04:22,590 [Exec Stream Pumper] - Lock file [/var/tmp/xwiki-8080.lck] is missing. Aborting stop. | |
14:04:22.619 [main] INFO o.x.test.integration.XWikiExecutor - Starting XWiki server at [http://localhost:8080/xwiki/bin/get/Main/], using stop port [8079] and RMI port [9010] | |
14:04:22.620 [main] INFO o.x.test.integration.XWikiExecutor - Checking that XWiki is up and running... | |
2019-11-25 14:04:22,629 [Exec Stream Pumper] - Starting Jetty on port 8080, please wait... | |
2019-11-25 14:04:23,259 [Exec Stream Pumper] - 2019-11-25 14:04:23.253:INFO::main: Logging initialized @516ms to org.eclipse.jetty.util.log.StdErrLog | |
2019-11-25 14:04:23,311 [Exec Stream Pumper] - 2019-11-25 14:04:23.310:INFO:oeju.TypeUtil:main: JVM Runtime does not support Modules | |
2019-11-25 14:04:23,544 [Exec Stream Pumper] - 2019-11-25 14:04:23.544:INFO:oejs.Server:main: jetty-9.4.22.v20191022; built: 2019-10-22T13:37:13.455Z; git: b1e6b55512e008f7fbdf1cbea4ff8a6446d1073b; jvm 1.8.0_202-b08 | |
2019-11-25 14:04:23,568 [Exec Stream Pumper] - 2019-11-25 14:04:23.568:INFO:oejdp.ScanningAppProvider:main: Deployment monitor [file:///Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/contexts/] at interval 1 | |
2019-11-25 14:04:25,144 [Exec Stream Pumper] - 2019-11-25 14:04:25.143:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0 | |
2019-11-25 14:04:25,144 [Exec Stream Pumper] - 2019-11-25 14:04:25.143:INFO:oejs.session:main: No SessionScavenger set, using defaults | |
2019-11-25 14:04:25,146 [Exec Stream Pumper] - 2019-11-25 14:04:25.146:INFO:oejs.session:main: node0 Scavenging every 660000ms | |
2019-11-25 14:04:28,808 [Exec Stream Pumper] - 2019-11-25 14:04:28,801 [main] INFO iPropertiesConfigurationSource - loading xwiki.properties from file:/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki/WEB-INF/xwiki.properties | |
2019-11-25 14:04:28,956 [Exec Stream Pumper] - 2019-11-25 14:04:28,955 [main] INFO o.x.e.i.ServletEnvironment - Using permanent directory [data] | |
2019-11-25 14:04:34,020 [Exec Stream Pumper] - 2019-11-25 14:04:34,020 [main] INFO o.x.s.f.i.FilesystemStoreTools - Using filesystem store directory [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/store/file] | |
2019-11-25 14:04:36,170 [Exec Stream Pumper] - 2019-11-25 14:04:36.169:INFO:oejsh.ContextHandler:main: Started o.e.j.w.WebAppContext@48503868{XWiki,/xwiki,file:///Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki/,AVAILABLE}{/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/../webapps/xwiki} | |
2019-11-25 14:04:36,172 [Exec Stream Pumper] - 2019-11-25 14:04:36.172:INFO:oejs.RequestLogWriter:main: Opened /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/logs/2019_11_25.request.log | |
2019-11-25 14:04:36,199 [Exec Stream Pumper] - 2019-11-25 14:04:36.199:INFO:oejs.AbstractConnector:main: Started ServerConnector@224edc67{HTTP/1.1,[http/1.1]}{0.0.0.0:8080} | |
2019-11-25 14:04:36,200 [Exec Stream Pumper] - 2019-11-25 14:04:36.200:INFO:oejs.Server:main: Started @13462ms | |
2019-11-25 14:04:36,200 [Exec Stream Pumper] - 2019-11-25 14:04:36.200:INFO:oxtjl.NotifyListener:main: ---------------------------------- | |
2019-11-25 14:04:36,212 [Exec Stream Pumper] - 2019-11-25 14:04:36.212:INFO:oxtjl.NotifyListener:main: Server started, you can now open http://vmassol:8080/ in your browser to access your wiki. | |
2019-11-25 14:04:36,212 [Exec Stream Pumper] - 2019-11-25 14:04:36.212:INFO:oxtjl.NotifyListener:main: ---------------------------------- | |
2019-11-25 14:04:38,498 [Exec Stream Pumper] - 2019-11-25 14:04:38,498 [Core extension repository updater] WARN o.e.a.i.i.WarnChecksumPolicy - Could not validate integrity of download from file:///Users/vmassol/.m2/repository/org/xwiki/platform/xwiki-platform-tool-jetty-listener/11.10-SNAPSHOT/xwiki-platform-tool-jetty-listener-11.10-SNAPSHOT.pom: Checksum validation failed, no checksums available | |
2019-11-25 14:04:40,550 [Exec Stream Pumper] - 2019-11-25 14:04:40,550 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] | |
2019-11-25 14:04:40,816 [Exec Stream Pumper] - 2019-11-25 14:04:40,815 [XWiki initialization] INFO .HibernateDataMigrationManager - Storage schema updates and data migrations are enabled | |
2019-11-25 14:04:41,047 [Exec Stream Pumper] - 2019-11-25 14:04:41,046 [XWiki initialization] INFO .HibernateDataMigrationManager - No data migration to apply for wiki [xwiki] currently in version [1138000] | |
2019-11-25 14:04:41,053 [Exec Stream Pumper] - 2019-11-25 14:04:41,053 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] | |
14:04:44.213 [main] INFO o.x.test.integration.XWikiExecutor - Server is answering to [http://localhost:8080/xwiki/bin/get/Main/]... cool | |
14:04:44.217 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Provision extensions for test... | |
14:04:44.383 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-index-tree-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-tree-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-icon-fontawesome/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-icon-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-menu-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-panels-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-application-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:04:44.384 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-display-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
2019-11-25 14:04:45,797 [Exec Stream Pumper] - 2019-11-25 14:04:45.793:INFO:oejshC.xwiki:http://localhost:8080/xwiki/rest/jobs?jobType=install&async=false: RestletServlet: [Restlet] ServerServlet: component class is null | |
2019-11-25 14:04:46,558 [Exec Stream Pumper] - 2019-11-25 14:04:46.557:INFO:oejshC.xwiki:http://localhost:8080/xwiki/rest/jobs?jobType=install&async=false: RestletServlet: [Restlet] Attaching application: org.xwiki.rest.internal.XWikiRestletJaxRsApplication@292c8a7c to URI: /xwiki/rest | |
14:05:12.295 [main] INFO o.x.t.d.i.j.b.BrowserContainerExecutor - (*) Starting browser [FIREFOX]... | |
14:05:12.315 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Pulling image [alpine:3.5] | |
Nov 25, 2019 2:05:28 PM org.openqa.selenium.remote.ProtocolHandshake createSession | |
INFO: Detected dialect: W3C | |
14:05:28.847 [main] INFO o.x.t.d.i.j.b.BrowserContainerExecutor - VNC server address: [vnc://vnc:secret@localhost:33298] | |
14:05:28.904 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Initialize Test Context... | |
14:05:37.391 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:05:40.923 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Pulling image [quay.io/testcontainers/vnc-recorder:1.1.0] | |
14:05:43.630 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuInApplicationsIndex] | |
14:05:49.048 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: console.error: BroadcastService: | |
14:05:49.050 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: receivedBroadcastMessage: handler for | |
14:05:49.051 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: remote-settings/monitor_changes | |
14:05:49.051 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: threw error: | |
14:05:49.051 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: Message: Error: Polling for changes failed: NetworkError when attempting to fetch resource.. | |
14:05:49.051 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: Stack: | |
14:05:49.052 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: remoteSettingsFunction/remoteSettings.pollChanges@resource://services-settings/remote-settings.js:750:13 | |
14:05:49.052 [tc-okhttp-stream-85933822] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: | |
14:05:56.107 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuInApplicationsIndex] | |
14:05:56.204 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuInApplicationsIndex] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuInApplicationsIndex.png]. | |
14:05:56.505 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuInApplicationsIndex.flv] | |
14:05:57.251 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:06:02.041 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] | |
14:06:37.497 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] | |
14:06:37.663 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuCreationInLeftPanelWithCurrentWikiVisibility.png]. | |
14:06:38.404 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuCreationInLeftPanelWithCurrentWikiVisibility.flv] | |
14:06:39.376 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:06:44.405 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuIsAvailableInAdministration] | |
14:07:08.937 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuIsAvailableInAdministration] | |
14:07:09.126 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuIsAvailableInAdministration] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuIsAvailableInAdministration.png]. | |
14:07:09.591 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuIsAvailableInAdministration.flv] | |
14:07:10.386 [main] WARN o.x.t.i.junit.LogCaptureValidator - The following lines were matching excluded patterns and need to be fixed: [ | |
2019-11-25 14:04:38,498 [Exec Stream Pumper] - 2019-11-25 14:04:38,498 [Core extension repository updater] WARN o.e.a.i.i.WarnChecksumPolicy - Could not validate integrity of download from file:///Users/vmassol/.m2/repository/org/xwiki/platform/xwiki-platform-tool-jetty-listener/11.10-SNAPSHOT/xwiki-platform-tool-jetty-listener-11.10-SNAPSHOT.pom: Checksum validation failed, no checksums available | |
] | |
[ERROR] Tests run: 3, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 208.724 s <<< FAILURE! - in org.xwiki.menu.test.ui.MenuIT | |
[ERROR] org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(TestUtils) Time elapsed: 42.082 s <<< FAILURE! | |
org.opentest4j.AssertionFailedError: expected: <true> but was: <false> | |
at org.junit.jupiter.api.AssertionUtils.fail(AssertionUtils.java:55) | |
at org.junit.jupiter.api.AssertTrue.assertTrue(AssertTrue.java:40) | |
at org.junit.jupiter.api.AssertTrue.assertTrue(AssertTrue.java:35) | |
at org.junit.jupiter.api.Assertions.assertTrue(Assertions.java:162) | |
at org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(MenuIT.java:110) | |
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) | |
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) | |
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) | |
at java.lang.reflect.Method.invoke(Method.java:498) | |
at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:675) | |
at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:125) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:132) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:124) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:74) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(ExecutableInvoker.java:115) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.lambda$invoke$0(ExecutableInvoker.java:105) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:104) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:62) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:43) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:35) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:104) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:98) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$6(TestMethodTestDescriptor.java:202) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:198) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:135) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:69) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:135) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at java.util.ArrayList.forEach(ArrayList.java:1257) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at java.util.ArrayList.forEach(ArrayList.java:1257) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:32) | |
at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) | |
at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:51) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:229) | |
at org.junit.platform.launcher.core.DefaultLauncher.lambda$execute$6(DefaultLauncher.java:197) | |
at org.junit.platform.launcher.core.DefaultLauncher.withInterceptedStreams(DefaultLauncher.java:211) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:191) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:128) | |
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:154) | |
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:127) | |
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:377) | |
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:138) | |
at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:465) | |
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:451) | |
[INFO] Running org.xwiki.menu.test.ui.MenuIT | |
14:07:10.477 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - XWiki is not started, starting all... | |
14:07:10.477 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting database [HSQLDB_EMBEDDED]... | |
14:07:10.478 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Building custom XWiki WAR... | |
14:07:10.479 [main] INFO o.x.t.d.internal.junit5.WARBuilder - XWiki WAR is already built in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki], rebuilding only the minimum! | |
14:07:10.480 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Finding version ... | |
14:07:10.537 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Found version = [11.10-SNAPSHOT] | |
14:07:10.538 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Generating configuration files for database [HSQLDB_EMBEDDED]... | |
14:07:10.628 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting Servlet container [JETTY_STANDALONE]... | |
14:07:10.728 [main] INFO o.x.test.integration.XWikiExecutor - Stopping any potentially running XWiki server at [http://localhost:8080/xwiki/bin/get/Main/] | |
2019-11-25 14:07:10,904 [Exec Stream Pumper] - Attempting to stop XWiki cleanly on port 8080... | |
2019-11-25 14:07:11,294 [Exec Stream Pumper] - 2019-11-25 14:07:11.288:INFO:oxtjl.NotifyListener:ShutdownMonitor: ---------------------------------- | |
2019-11-25 14:07:11,296 [Exec Stream Pumper] - 2019-11-25 14:07:11.293:INFO:oxtjl.NotifyListener:ShutdownMonitor: Server stopping, please wait while all resources are closed... | |
2019-11-25 14:07:11,393 [Exec Stream Pumper] - 2019-11-25 14:07:11.390:INFO:oejs.AbstractConnector:ShutdownMonitor: Stopped ServerConnector@224edc67{HTTP/1.1,[http/1.1]}{0.0.0.0:8080} | |
2019-11-25 14:07:11,396 [Exec Stream Pumper] - 2019-11-25 14:07:11.393:INFO:oejs.session:ShutdownMonitor: node0 Stopped scavenging | |
2019-11-25 14:07:11,778 [Exec Stream Pumper] - 2019-11-25 14:07:11,775 [ShutdownMonitor] ERROR h.d.H.ENGINE - error closing log | |
2019-11-25 14:07:11,778 [Exec Stream Pumper] - org.hsqldb.HsqlException: file input/output error java.io.FileNotFoundException: /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/database/xwiki_db.script.new (No such file or directory) /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/database/xwiki_db.script.new | |
2019-11-25 14:07:11,778 [Exec Stream Pumper] - at org.hsqldb.error.Error.error(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.scriptio.ScriptWriterBase.openFile(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.scriptio.ScriptWriterBase.<init>(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.scriptio.ScriptWriterText.<init>(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.persist.Log.writeScript(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.persist.Log.close(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.persist.Logger.close(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.Database.close(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.Database.closeIfLast(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.Session.close(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.hsqldb.jdbc.JDBCConnection.close(Unknown Source) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.apache.commons.dbcp2.DelegatingConnection.closeInternal(DelegatingConnection.java:238) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.apache.commons.dbcp2.PoolableConnection.reallyClose(PoolableConnection.java:232) | |
2019-11-25 14:07:11,779 [Exec Stream Pumper] - at org.apache.commons.dbcp2.PoolableConnectionFactory.destroyObject(PoolableConnectionFactory.java:137) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.apache.commons.pool2.impl.GenericObjectPool.destroy(GenericObjectPool.java:928) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.apache.commons.pool2.impl.GenericObjectPool.clear(GenericObjectPool.java:648) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.apache.commons.pool2.impl.GenericObjectPool.close(GenericObjectPool.java:692) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.apache.commons.dbcp2.BasicDataSource.close(BasicDataSource.java:427) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at com.xpn.xwiki.store.DBCPConnectionProvider.close(DBCPConnectionProvider.java:277) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at com.xpn.xwiki.store.DBCPConnectionProvider.stop(DBCPConnectionProvider.java:339) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.stopService(AbstractServiceRegistryImpl.java:390) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.destroy(AbstractServiceRegistryImpl.java:373) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.boot.registry.internal.StandardServiceRegistryImpl.destroy(StandardServiceRegistryImpl.java:129) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.deRegisterChild(AbstractServiceRegistryImpl.java:423) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.destroy(AbstractServiceRegistryImpl.java:380) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.service.internal.SessionFactoryServiceRegistryImpl.destroy(SessionFactoryServiceRegistryImpl.java:103) | |
2019-11-25 14:07:11,780 [Exec Stream Pumper] - at org.hibernate.internal.SessionFactoryImpl.close(SessionFactoryImpl.java:844) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at com.xpn.xwiki.internal.store.hibernate.HibernateStore.disposeInternal(HibernateStore.java:299) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at com.xpn.xwiki.internal.store.hibernate.HibernateStore.dispose(HibernateStore.java:306) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.xwiki.component.embed.EmbeddableComponentManager.dispose(EmbeddableComponentManager.java:685) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.xwiki.container.servlet.XWikiServletContextListener.contextDestroyed(XWikiServletContextListener.java:161) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.ContextHandler.callContextDestroyed(ContextHandler.java:936) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.servlet.ServletContextHandler.callContextDestroyed(ServletContextHandler.java:566) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.ContextHandler.stopContext(ContextHandler.java:904) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.servlet.ServletContextHandler.stopContext(ServletContextHandler.java:368) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.webapp.WebAppContext.stopWebapp(WebAppContext.java:1448) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.webapp.WebAppContext.stopContext(WebAppContext.java:1413) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.ContextHandler.doStop(ContextHandler.java:979) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.servlet.ServletContextHandler.doStop(ServletContextHandler.java:285) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.webapp.WebAppContext.doStop(WebAppContext.java:547) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:07:11,781 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.server.Server.doStop(Server.java:454) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.server.ShutdownMonitor$ShutdownMonitorRunnable.stopLifeCycles(ShutdownMonitor.java:443) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.eclipse.jetty.server.ShutdownMonitor$ShutdownMonitorRunnable.run(ShutdownMonitor.java:354) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at java.lang.Thread.run(Thread.java:748) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - Caused by: java.io.FileNotFoundException: /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/database/xwiki_db.script.new (No such file or directory) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at java.io.FileOutputStream.open0(Native Method) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at java.io.FileOutputStream.open(FileOutputStream.java:270) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at java.io.FileOutputStream.<init>(FileOutputStream.java:213) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - at org.hsqldb.lib.FileUtil.openOutputStreamElement(Unknown Source) | |
2019-11-25 14:07:11,782 [Exec Stream Pumper] - ... 56 common frames omitted | |
2019-11-25 14:07:11,944 [Exec Stream Pumper] - 2019-11-25 14:07:11.944:INFO:oejsh.ContextHandler:ShutdownMonitor: Stopped o.e.j.w.WebAppContext@48503868{XWiki,/xwiki,null,UNAVAILABLE}{/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/../webapps/xwiki} | |
2019-11-25 14:07:11,951 [Exec Stream Pumper] - 2019-11-25 14:07:11.951:INFO:oxtjl.NotifyListener:ShutdownMonitor: Done! | |
14:07:12.271 [main] INFO o.x.test.integration.XWikiExecutor - Starting XWiki server at [http://localhost:8080/xwiki/bin/get/Main/], using stop port [8079] and RMI port [9010] | |
14:07:12.272 [main] INFO o.x.test.integration.XWikiExecutor - Checking that XWiki is up and running... | |
2019-11-25 14:07:12,281 [Exec Stream Pumper] - Starting Jetty on port 8080, please wait... | |
2019-11-25 14:07:12,801 [Exec Stream Pumper] - 2019-11-25 14:07:12.795:INFO::main: Logging initialized @406ms to org.eclipse.jetty.util.log.StdErrLog | |
2019-11-25 14:07:12,871 [Exec Stream Pumper] - 2019-11-25 14:07:12.871:INFO:oeju.TypeUtil:main: JVM Runtime does not support Modules | |
2019-11-25 14:07:13,111 [Exec Stream Pumper] - 2019-11-25 14:07:13.110:INFO:oejs.Server:main: jetty-9.4.22.v20191022; built: 2019-10-22T13:37:13.455Z; git: b1e6b55512e008f7fbdf1cbea4ff8a6446d1073b; jvm 1.8.0_202-b08 | |
2019-11-25 14:07:13,130 [Exec Stream Pumper] - 2019-11-25 14:07:13.129:INFO:oejdp.ScanningAppProvider:main: Deployment monitor [file:///Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/contexts/] at interval 1 | |
2019-11-25 14:07:14,269 [Exec Stream Pumper] - 2019-11-25 14:07:14.269:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0 | |
2019-11-25 14:07:14,269 [Exec Stream Pumper] - 2019-11-25 14:07:14.269:INFO:oejs.session:main: No SessionScavenger set, using defaults | |
2019-11-25 14:07:14,273 [Exec Stream Pumper] - 2019-11-25 14:07:14.273:INFO:oejs.session:main: node0 Scavenging every 660000ms | |
2019-11-25 14:07:17,358 [Exec Stream Pumper] - 2019-11-25 14:07:17,350 [main] INFO iPropertiesConfigurationSource - loading xwiki.properties from file:/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki/WEB-INF/xwiki.properties | |
2019-11-25 14:07:17,475 [Exec Stream Pumper] - 2019-11-25 14:07:17,475 [main] INFO o.x.e.i.ServletEnvironment - Using permanent directory [data] | |
2019-11-25 14:07:22,081 [Exec Stream Pumper] - 2019-11-25 14:07:22,081 [main] INFO o.x.s.f.i.FilesystemStoreTools - Using filesystem store directory [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/store/file] | |
2019-11-25 14:07:24,356 [Exec Stream Pumper] - 2019-11-25 14:07:24.356:INFO:oejsh.ContextHandler:main: Started o.e.j.w.WebAppContext@48503868{XWiki,/xwiki,file:///Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki/,AVAILABLE}{/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/../webapps/xwiki} | |
2019-11-25 14:07:24,358 [Exec Stream Pumper] - 2019-11-25 14:07:24.358:INFO:oejs.RequestLogWriter:main: Opened /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/logs/2019_11_25.request.log | |
2019-11-25 14:07:24,377 [Exec Stream Pumper] - 2019-11-25 14:07:24.376:INFO:oejs.AbstractConnector:main: Started ServerConnector@224edc67{HTTP/1.1,[http/1.1]}{0.0.0.0:8080} | |
2019-11-25 14:07:24,377 [Exec Stream Pumper] - 2019-11-25 14:07:24.377:INFO:oejs.Server:main: Started @11988ms | |
2019-11-25 14:07:24,377 [Exec Stream Pumper] - 2019-11-25 14:07:24.377:INFO:oxtjl.NotifyListener:main: ---------------------------------- | |
2019-11-25 14:07:24,388 [Exec Stream Pumper] - 2019-11-25 14:07:24.388:INFO:oxtjl.NotifyListener:main: Server started, you can now open http://vmassol:8080/ in your browser to access your wiki. | |
2019-11-25 14:07:24,388 [Exec Stream Pumper] - 2019-11-25 14:07:24.388:INFO:oxtjl.NotifyListener:main: ---------------------------------- | |
2019-11-25 14:07:28,082 [Exec Stream Pumper] - 2019-11-25 14:07:28,079 [Core extension repository updater] WARN o.e.a.i.i.WarnChecksumPolicy - Could not validate integrity of download from file:///Users/vmassol/.m2/repository/org/xwiki/platform/xwiki-platform-tool-jetty-listener/11.10-SNAPSHOT/xwiki-platform-tool-jetty-listener-11.10-SNAPSHOT.pom: Checksum validation failed, no checksums available | |
2019-11-25 14:07:30,552 [Exec Stream Pumper] - 2019-11-25 14:07:30,534 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] | |
2019-11-25 14:07:31,302 [Exec Stream Pumper] - 2019-11-25 14:07:31,302 [XWiki initialization] INFO .HibernateDataMigrationManager - Storage schema updates and data migrations are enabled | |
2019-11-25 14:07:31,580 [Exec Stream Pumper] - 2019-11-25 14:07:31,580 [XWiki initialization] INFO .HibernateDataMigrationManager - No data migration to apply for wiki [xwiki] currently in version [1138000] | |
2019-11-25 14:07:31,585 [Exec Stream Pumper] - 2019-11-25 14:07:31,585 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] | |
14:07:34.829 [main] INFO o.x.test.integration.XWikiExecutor - Server is answering to [http://localhost:8080/xwiki/bin/get/Main/]... cool | |
14:07:34.831 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Provision extensions for test... | |
14:07:40.967 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-index-tree-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-tree-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-icon-fontawesome/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-icon-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-menu-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-panels-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-application-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:07:40.968 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-display-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
2019-11-25 14:07:41,281 [Exec Stream Pumper] - 2019-11-25 14:07:41.274:INFO:oejshC.xwiki:http://localhost:8080/xwiki/rest/jobs?jobType=install&async=false: RestletServlet: [Restlet] ServerServlet: component class is null | |
2019-11-25 14:07:43,522 [Exec Stream Pumper] - 2019-11-25 14:07:43.519:INFO:oejshC.xwiki:http://localhost:8080/xwiki/rest/jobs?jobType=install&async=false: RestletServlet: [Restlet] Attaching application: org.xwiki.rest.internal.XWikiRestletJaxRsApplication@83af3f to URI: /xwiki/rest | |
14:08:17.776 [main] INFO o.x.t.d.i.j.b.BrowserContainerExecutor - (*) Starting browser [FIREFOX]... | |
Detected dialect: W3C | |
14:08:29.163 [main] INFO o.x.t.d.i.j.b.BrowserContainerExecutor - VNC server address: [vnc://vnc:secret@localhost:33302] | |
14:08:29.233 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Initialize Test Context... | |
14:08:37.285 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:08:42.403 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] | |
14:08:50.649 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: console.error: BroadcastService: | |
14:08:50.655 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: receivedBroadcastMessage: handler for | |
14:08:50.658 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: remote-settings/monitor_changes | |
14:08:50.658 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: threw error: | |
14:08:50.659 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: Message: Error: Polling for changes failed: NetworkError when attempting to fetch resource.. | |
14:08:50.660 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: Stack: | |
14:08:50.660 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: remoteSettingsFunction/remoteSettings.pollChanges@resource://services-settings/remote-settings.js:750:13 | |
14:08:50.660 [tc-okhttp-stream-285327092] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: | |
14:09:10.540 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] | |
14:09:10.700 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuCreationInLeftPanelWithCurrentWikiVisibility.png]. | |
14:09:11.156 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuCreationInLeftPanelWithCurrentWikiVisibility.flv] | |
14:09:11.987 [main] WARN o.x.t.i.junit.LogCaptureValidator - The following lines were matching excluded patterns and need to be fixed: [ | |
2019-11-25 14:07:28,082 [Exec Stream Pumper] - 2019-11-25 14:07:28,079 [Core extension repository updater] WARN o.e.a.i.i.WarnChecksumPolicy - Could not validate integrity of download from file:///Users/vmassol/.m2/repository/org/xwiki/platform/xwiki-platform-tool-jetty-listener/11.10-SNAPSHOT/xwiki-platform-tool-jetty-listener-11.10-SNAPSHOT.pom: Checksum validation failed, no checksums available | |
] | |
[ERROR] Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 121.519 s <<< FAILURE! - in org.xwiki.menu.test.ui.MenuIT | |
[ERROR] org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(TestUtils) Time elapsed: 34.696 s <<< FAILURE! | |
org.opentest4j.AssertionFailedError: expected: <true> but was: <false> | |
at org.junit.jupiter.api.AssertionUtils.fail(AssertionUtils.java:55) | |
at org.junit.jupiter.api.AssertTrue.assertTrue(AssertTrue.java:40) | |
at org.junit.jupiter.api.AssertTrue.assertTrue(AssertTrue.java:35) | |
at org.junit.jupiter.api.Assertions.assertTrue(Assertions.java:162) | |
at org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(MenuIT.java:110) | |
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) | |
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) | |
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) | |
at java.lang.reflect.Method.invoke(Method.java:498) | |
at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:675) | |
at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:125) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:132) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:124) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:74) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(ExecutableInvoker.java:115) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.lambda$invoke$0(ExecutableInvoker.java:105) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:104) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:62) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:43) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:35) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:104) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:98) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$6(TestMethodTestDescriptor.java:202) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:198) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:135) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:69) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:135) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at java.util.ArrayList.forEach(ArrayList.java:1257) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at java.util.ArrayList.forEach(ArrayList.java:1257) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:32) | |
at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) | |
at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:51) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:229) | |
at org.junit.platform.launcher.core.DefaultLauncher.lambda$execute$6(DefaultLauncher.java:197) | |
at org.junit.platform.launcher.core.DefaultLauncher.withInterceptedStreams(DefaultLauncher.java:211) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:191) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:128) | |
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:165) | |
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:127) | |
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:377) | |
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:138) | |
at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:465) | |
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:451) | |
[INFO] Running org.xwiki.menu.test.ui.MenuIT | |
14:09:12.098 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - XWiki is not started, starting all... | |
14:09:12.098 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting database [HSQLDB_EMBEDDED]... | |
14:09:12.098 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Building custom XWiki WAR... | |
14:09:12.098 [main] INFO o.x.t.d.internal.junit5.WARBuilder - XWiki WAR is already built in [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki], rebuilding only the minimum! | |
14:09:12.098 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Finding version ... | |
14:09:12.158 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Found version = [11.10-SNAPSHOT] | |
14:09:12.158 [main] INFO o.x.t.d.internal.junit5.WARBuilder - Generating configuration files for database [HSQLDB_EMBEDDED]... | |
14:09:12.253 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting Servlet container [JETTY_STANDALONE]... | |
14:09:12.369 [main] INFO o.x.test.integration.XWikiExecutor - Stopping any potentially running XWiki server at [http://localhost:8080/xwiki/bin/get/Main/] | |
2019-11-25 14:09:12,526 [Exec Stream Pumper] - Attempting to stop XWiki cleanly on port 8080... | |
2019-11-25 14:09:12,836 [Exec Stream Pumper] - 2019-11-25 14:09:12.832:INFO:oxtjl.NotifyListener:ShutdownMonitor: ---------------------------------- | |
2019-11-25 14:09:12,837 [Exec Stream Pumper] - 2019-11-25 14:09:12.833:INFO:oxtjl.NotifyListener:ShutdownMonitor: Server stopping, please wait while all resources are closed... | |
2019-11-25 14:09:12,844 [Exec Stream Pumper] - 2019-11-25 14:09:12.844:INFO:oejs.AbstractConnector:ShutdownMonitor: Stopped ServerConnector@224edc67{HTTP/1.1,[http/1.1]}{0.0.0.0:8080} | |
2019-11-25 14:09:12,845 [Exec Stream Pumper] - 2019-11-25 14:09:12.844:INFO:oejs.session:ShutdownMonitor: node0 Stopped scavenging | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - 2019-11-25 14:09:12,944 [ShutdownMonitor] ERROR h.d.H.ENGINE - error closing log | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - org.hsqldb.HsqlException: file input/output error java.io.FileNotFoundException: /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/database/xwiki_db.script.new (No such file or directory) /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/database/xwiki_db.script.new | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.error.Error.error(Unknown Source) | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.scriptio.ScriptWriterBase.openFile(Unknown Source) | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.scriptio.ScriptWriterBase.<init>(Unknown Source) | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.scriptio.ScriptWriterText.<init>(Unknown Source) | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.persist.Log.writeScript(Unknown Source) | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.persist.Log.close(Unknown Source) | |
2019-11-25 14:09:12,945 [Exec Stream Pumper] - at org.hsqldb.persist.Logger.close(Unknown Source) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hsqldb.Database.close(Unknown Source) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hsqldb.Database.closeIfLast(Unknown Source) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hsqldb.Session.close(Unknown Source) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hsqldb.jdbc.JDBCConnection.close(Unknown Source) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.dbcp2.DelegatingConnection.closeInternal(DelegatingConnection.java:238) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.dbcp2.PoolableConnection.reallyClose(PoolableConnection.java:232) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.dbcp2.PoolableConnectionFactory.destroyObject(PoolableConnectionFactory.java:137) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.pool2.impl.GenericObjectPool.destroy(GenericObjectPool.java:928) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.pool2.impl.GenericObjectPool.clear(GenericObjectPool.java:648) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.pool2.impl.GenericObjectPool.close(GenericObjectPool.java:692) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.apache.commons.dbcp2.BasicDataSource.close(BasicDataSource.java:427) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at com.xpn.xwiki.store.DBCPConnectionProvider.close(DBCPConnectionProvider.java:277) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at com.xpn.xwiki.store.DBCPConnectionProvider.stop(DBCPConnectionProvider.java:339) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.stopService(AbstractServiceRegistryImpl.java:390) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.destroy(AbstractServiceRegistryImpl.java:373) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.boot.registry.internal.StandardServiceRegistryImpl.destroy(StandardServiceRegistryImpl.java:129) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.deRegisterChild(AbstractServiceRegistryImpl.java:423) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.service.internal.AbstractServiceRegistryImpl.destroy(AbstractServiceRegistryImpl.java:380) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.service.internal.SessionFactoryServiceRegistryImpl.destroy(SessionFactoryServiceRegistryImpl.java:103) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.hibernate.internal.SessionFactoryImpl.close(SessionFactoryImpl.java:844) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at com.xpn.xwiki.internal.store.hibernate.HibernateStore.disposeInternal(HibernateStore.java:299) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at com.xpn.xwiki.internal.store.hibernate.HibernateStore.dispose(HibernateStore.java:306) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.xwiki.component.embed.EmbeddableComponentManager.dispose(EmbeddableComponentManager.java:685) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.xwiki.container.servlet.XWikiServletContextListener.contextDestroyed(XWikiServletContextListener.java:161) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.ContextHandler.callContextDestroyed(ContextHandler.java:936) | |
2019-11-25 14:09:12,946 [Exec Stream Pumper] - at org.eclipse.jetty.servlet.ServletContextHandler.callContextDestroyed(ServletContextHandler.java:566) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.ContextHandler.stopContext(ContextHandler.java:904) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.servlet.ServletContextHandler.stopContext(ServletContextHandler.java:368) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.webapp.WebAppContext.stopWebapp(WebAppContext.java:1448) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.webapp.WebAppContext.stopContext(WebAppContext.java:1413) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.ContextHandler.doStop(ContextHandler.java:979) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.servlet.ServletContextHandler.doStop(ServletContextHandler.java:285) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.webapp.WebAppContext.doStop(WebAppContext.java:547) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:180) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:201) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:117) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.Server.doStop(Server.java:454) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:93) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.ShutdownMonitor$ShutdownMonitorRunnable.stopLifeCycles(ShutdownMonitor.java:443) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.eclipse.jetty.server.ShutdownMonitor$ShutdownMonitorRunnable.run(ShutdownMonitor.java:354) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at java.lang.Thread.run(Thread.java:748) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - Caused by: java.io.FileNotFoundException: /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/database/xwiki_db.script.new (No such file or directory) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at java.io.FileOutputStream.open0(Native Method) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at java.io.FileOutputStream.open(FileOutputStream.java:270) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at java.io.FileOutputStream.<init>(FileOutputStream.java:213) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - at org.hsqldb.lib.FileUtil.openOutputStreamElement(Unknown Source) | |
2019-11-25 14:09:12,947 [Exec Stream Pumper] - ... 56 common frames omitted | |
2019-11-25 14:09:13,082 [Exec Stream Pumper] - 2019-11-25 14:09:13.081:INFO:oejsh.ContextHandler:ShutdownMonitor: Stopped o.e.j.w.WebAppContext@48503868{XWiki,/xwiki,null,UNAVAILABLE}{/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/../webapps/xwiki} | |
2019-11-25 14:09:13,083 [Exec Stream Pumper] - 2019-11-25 14:09:13.083:INFO:oxtjl.NotifyListener:ShutdownMonitor: Done! | |
14:09:13.630 [main] INFO o.x.test.integration.XWikiExecutor - Starting XWiki server at [http://localhost:8080/xwiki/bin/get/Main/], using stop port [8079] and RMI port [9010] | |
14:09:13.631 [main] INFO o.x.test.integration.XWikiExecutor - Checking that XWiki is up and running... | |
2019-11-25 14:09:13,643 [Exec Stream Pumper] - Starting Jetty on port 8080, please wait... | |
2019-11-25 14:09:14,089 [Exec Stream Pumper] - 2019-11-25 14:09:14.085:INFO::main: Logging initialized @326ms to org.eclipse.jetty.util.log.StdErrLog | |
2019-11-25 14:09:14,130 [Exec Stream Pumper] - 2019-11-25 14:09:14.129:INFO:oeju.TypeUtil:main: JVM Runtime does not support Modules | |
2019-11-25 14:09:14,361 [Exec Stream Pumper] - 2019-11-25 14:09:14.361:INFO:oejs.Server:main: jetty-9.4.22.v20191022; built: 2019-10-22T13:37:13.455Z; git: b1e6b55512e008f7fbdf1cbea4ff8a6446d1073b; jvm 1.8.0_202-b08 | |
2019-11-25 14:09:14,378 [Exec Stream Pumper] - 2019-11-25 14:09:14.377:INFO:oejdp.ScanningAppProvider:main: Deployment monitor [file:///Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/contexts/] at interval 1 | |
2019-11-25 14:09:15,458 [Exec Stream Pumper] - 2019-11-25 14:09:15.458:INFO:oejs.session:main: DefaultSessionIdManager workerName=node0 | |
2019-11-25 14:09:15,459 [Exec Stream Pumper] - 2019-11-25 14:09:15.458:INFO:oejs.session:main: No SessionScavenger set, using defaults | |
2019-11-25 14:09:15,462 [Exec Stream Pumper] - 2019-11-25 14:09:15.461:INFO:oejs.session:main: node0 Scavenging every 600000ms | |
2019-11-25 14:09:18,017 [Exec Stream Pumper] - 2019-11-25 14:09:18,012 [main] INFO iPropertiesConfigurationSource - loading xwiki.properties from file:/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki/WEB-INF/xwiki.properties | |
2019-11-25 14:09:18,122 [Exec Stream Pumper] - 2019-11-25 14:09:18,121 [main] INFO o.x.e.i.ServletEnvironment - Using permanent directory [data] | |
2019-11-25 14:09:22,415 [Exec Stream Pumper] - 2019-11-25 14:09:22,415 [main] INFO o.x.s.f.i.FilesystemStoreTools - Using filesystem store directory [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/store/file] | |
2019-11-25 14:09:24,461 [Exec Stream Pumper] - 2019-11-25 14:09:24.460:INFO:oejsh.ContextHandler:main: Started o.e.j.w.WebAppContext@48503868{XWiki,/xwiki,file:///Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/xwiki/,AVAILABLE}{/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/jetty/../webapps/xwiki} | |
2019-11-25 14:09:24,466 [Exec Stream Pumper] - 2019-11-25 14:09:24.465:INFO:oejs.RequestLogWriter:main: Opened /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/jetty/data/logs/2019_11_25.request.log | |
2019-11-25 14:09:24,494 [Exec Stream Pumper] - 2019-11-25 14:09:24.494:INFO:oejs.AbstractConnector:main: Started ServerConnector@224edc67{HTTP/1.1,[http/1.1]}{0.0.0.0:8080} | |
2019-11-25 14:09:24,495 [Exec Stream Pumper] - 2019-11-25 14:09:24.494:INFO:oejs.Server:main: Started @10736ms | |
2019-11-25 14:09:24,495 [Exec Stream Pumper] - 2019-11-25 14:09:24.494:INFO:oxtjl.NotifyListener:main: ---------------------------------- | |
2019-11-25 14:09:24,506 [Exec Stream Pumper] - 2019-11-25 14:09:24.506:INFO:oxtjl.NotifyListener:main: Server started, you can now open http://vmassol:8080/ in your browser to access your wiki. | |
2019-11-25 14:09:24,507 [Exec Stream Pumper] - 2019-11-25 14:09:24.506:INFO:oxtjl.NotifyListener:main: ---------------------------------- | |
2019-11-25 14:09:26,769 [Exec Stream Pumper] - 2019-11-25 14:09:26,767 [Core extension repository updater] WARN o.e.a.i.i.WarnChecksumPolicy - Could not validate integrity of download from file:///Users/vmassol/.m2/repository/org/xwiki/platform/xwiki-platform-tool-jetty-listener/11.10-SNAPSHOT/xwiki-platform-tool-jetty-listener-11.10-SNAPSHOT.pom: Checksum validation failed, no checksums available | |
2019-11-25 14:09:28,210 [Exec Stream Pumper] - 2019-11-25 14:09:28,210 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] | |
2019-11-25 14:09:28,474 [Exec Stream Pumper] - 2019-11-25 14:09:28,474 [XWiki initialization] INFO .HibernateDataMigrationManager - Storage schema updates and data migrations are enabled | |
2019-11-25 14:09:28,696 [Exec Stream Pumper] - 2019-11-25 14:09:28,695 [XWiki initialization] INFO .HibernateDataMigrationManager - No data migration to apply for wiki [xwiki] currently in version [1138000] | |
2019-11-25 14:09:28,704 [Exec Stream Pumper] - 2019-11-25 14:09:28,704 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] | |
14:09:32.123 [main] INFO o.x.test.integration.XWikiExecutor - Server is answering to [http://localhost:8080/xwiki/bin/get/Main/]... cool | |
14:09:32.123 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Provision extensions for test... | |
14:09:37.786 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-index-tree-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-tree-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-icon-fontawesome/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-icon-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-menu-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-panels-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-application-ui/11.10-SNAPSHOT] to the list of extensions to provision... | |
14:09:37.787 [main] INFO o.x.t.d.i.junit5.ExtensionInstaller - ...Adding extension [org.xwiki.platform:xwiki-platform-display-macro/11.10-SNAPSHOT] to the list of extensions to provision... | |
2019-11-25 14:09:37,977 [Exec Stream Pumper] - 2019-11-25 14:09:37.977:INFO:oejshC.xwiki:http://localhost:8080/xwiki/rest/jobs?jobType=install&async=false: RestletServlet: [Restlet] ServerServlet: component class is null | |
2019-11-25 14:09:38,741 [Exec Stream Pumper] - 2019-11-25 14:09:38.741:INFO:oejshC.xwiki:http://localhost:8080/xwiki/rest/jobs?jobType=install&async=false: RestletServlet: [Restlet] Attaching application: org.xwiki.rest.internal.XWikiRestletJaxRsApplication@71811059 to URI: /xwiki/rest | |
14:10:01.571 [main] INFO o.x.t.d.i.j.b.BrowserContainerExecutor - (*) Starting browser [FIREFOX]... | |
Detected dialect: W3C | |
14:10:12.237 [main] INFO o.x.t.d.i.j.b.BrowserContainerExecutor - VNC server address: [vnc://vnc:secret@localhost:33306] | |
14:10:12.331 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Initialize Test Context... | |
14:10:18.883 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:10:23.650 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuInApplicationsIndex] | |
14:10:32.413 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: console.error: BroadcastService: | |
14:10:32.419 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: receivedBroadcastMessage: handler for | |
14:10:32.420 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: remote-settings/monitor_changes | |
14:10:32.422 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: threw error: | |
14:10:32.424 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: Message: Error: Polling for changes failed: NetworkError when attempting to fetch resource.. | |
14:10:32.424 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: Stack: | |
14:10:32.424 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: remoteSettingsFunction/remoteSettings.pollChanges@resource://services-settings/remote-settings.js:750:13 | |
14:10:32.425 [tc-okhttp-stream-1368514759] INFO o.x.t.d.i.j.XWikiDockerExtension - STDOUT: | |
14:10:33.083 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuInApplicationsIndex] | |
14:10:33.165 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuInApplicationsIndex] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuInApplicationsIndex.png]. | |
14:10:33.502 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuInApplicationsIndex.flv] | |
14:10:34.291 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:10:38.968 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] | |
14:10:53.161 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] | |
14:10:53.286 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuCreationInLeftPanelWithCurrentWikiVisibility] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuCreationInLeftPanelWithCurrentWikiVisibility.png]. | |
14:10:53.655 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuCreationInLeftPanelWithCurrentWikiVisibility.flv] | |
14:10:54.379 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Start VNC container... | |
14:10:58.996 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Starting test [verifyMenuIsAvailableInAdministration] | |
14:11:13.149 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) Stopping test [verifyMenuIsAvailableInAdministration] | |
14:11:13.318 [main] INFO o.x.t.d.i.junit5.DockerTestUtils - Screenshot for test [verifyMenuIsAvailableInAdministration] saved at [/Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuIsAvailableInAdministration.png]. | |
14:11:13.782 [main] INFO o.x.t.d.i.j.XWikiDockerExtension - (*) VNC recording of test has been saved to [./target/hsqldb_embedded-default-default-jetty_standalone-default-firefox/screenshots/hsqldb_embedded-default-default-jetty_standalone-default-firefox-org.xwiki.menu.test.ui.MenuIT-verifyMenuIsAvailableInAdministration.flv] | |
14:11:14.581 [main] WARN o.x.t.i.junit.LogCaptureValidator - The following lines were matching excluded patterns and need to be fixed: [ | |
2019-11-25 14:09:26,769 [Exec Stream Pumper] - 2019-11-25 14:09:26,767 [Core extension repository updater] WARN o.e.a.i.i.WarnChecksumPolicy - Could not validate integrity of download from file:///Users/vmassol/.m2/repository/org/xwiki/platform/xwiki-platform-tool-jetty-listener/11.10-SNAPSHOT/xwiki-platform-tool-jetty-listener-11.10-SNAPSHOT.pom: Checksum validation failed, no checksums available | |
] | |
[ERROR] Tests run: 3, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 122.492 s <<< FAILURE! - in org.xwiki.menu.test.ui.MenuIT | |
[ERROR] org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(TestUtils) Time elapsed: 20.085 s <<< FAILURE! | |
org.opentest4j.AssertionFailedError: expected: <true> but was: <false> | |
at org.junit.jupiter.api.AssertionUtils.fail(AssertionUtils.java:55) | |
at org.junit.jupiter.api.AssertTrue.assertTrue(AssertTrue.java:40) | |
at org.junit.jupiter.api.AssertTrue.assertTrue(AssertTrue.java:35) | |
at org.junit.jupiter.api.Assertions.assertTrue(Assertions.java:162) | |
at org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(MenuIT.java:110) | |
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) | |
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) | |
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) | |
at java.lang.reflect.Method.invoke(Method.java:498) | |
at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:675) | |
at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:125) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:132) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:124) | |
at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:74) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(ExecutableInvoker.java:115) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.lambda$invoke$0(ExecutableInvoker.java:105) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:104) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:62) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:43) | |
at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:35) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:104) | |
at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:98) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$6(TestMethodTestDescriptor.java:202) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:198) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:135) | |
at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:69) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:135) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at java.util.ArrayList.forEach(ArrayList.java:1257) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at java.util.ArrayList.forEach(ArrayList.java:1257) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125) | |
at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123) | |
at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122) | |
at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80) | |
at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:32) | |
at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) | |
at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:51) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:229) | |
at org.junit.platform.launcher.core.DefaultLauncher.lambda$execute$6(DefaultLauncher.java:197) | |
at org.junit.platform.launcher.core.DefaultLauncher.withInterceptedStreams(DefaultLauncher.java:211) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:191) | |
at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:128) | |
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:165) | |
at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:127) | |
at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:377) | |
at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:138) | |
at org.apache.maven.surefire.booter.ForkedBooter.run(ForkedBooter.java:465) | |
at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:451) | |
[INFO] | |
[INFO] Results: | |
[INFO] | |
[ERROR] Failures: | |
[ERROR] org.xwiki.menu.test.ui.MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility(TestUtils) | |
[ERROR] Run 1: MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility:110 expected: <true> but was: <false> | |
[ERROR] Run 2: MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility:110 expected: <true> but was: <false> | |
[ERROR] Run 3: MenuIT.verifyMenuCreationInLeftPanelWithCurrentWikiVisibility:110 expected: <true> but was: <false> | |
[INFO] | |
[INFO] | |
[ERROR] Tests run: 5, Failures: 1, Errors: 0, Skipped: 0 | |
[INFO] | |
[INFO] | |
[INFO] --- maven-checkstyle-plugin:3.1.0:check (default) @ xwiki-platform-menu-test-docker --- | |
[INFO] | |
[INFO] --- maven-checkstyle-plugin:3.1.0:check (blocker) @ xwiki-platform-menu-test-docker --- | |
[INFO] | |
[INFO] --- license-maven-plugin:3.0:check (default) @ xwiki-platform-menu-test-docker --- | |
[INFO] Checking licenses... | |
[INFO] | |
[INFO] --- revapi-maven-plugin:0.11.2:check (revapi-check) @ xwiki-platform-menu-test-docker --- | |
[INFO] | |
[INFO] --- spoon-maven-plugin:3.2:check (default) @ xwiki-platform-menu-test-docker --- | |
[INFO] | |
[INFO] --- maven-failsafe-plugin:3.0.0-M4:verify (functional-tests) @ xwiki-platform-menu-test-docker --- | |
[INFO] ------------------------------------------------------------------------ | |
[INFO] BUILD FAILURE | |
[INFO] ------------------------------------------------------------------------ | |
[INFO] Total time: 11:04 min | |
[INFO] Finished at: 2019-11-25T14:11:18+01:00 | |
[INFO] ------------------------------------------------------------------------ | |
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-failsafe-plugin:3.0.0-M4:verify (functional-tests) on project xwiki-platform-menu-test-docker: There are test failures. | |
[ERROR] | |
[ERROR] Please refer to /Users/vmassol/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker/target/failsafe-reports for the individual test results. | |
[ERROR] Please refer to dump files (if any exist) [date].dump, [date]-jvmRun[N].dump and [date].dumpstream. | |
[ERROR] -> [Help 1] | |
[ERROR] | |
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch. | |
[ERROR] Re-run Maven using the -X switch to enable full debug logging. | |
[ERROR] | |
[ERROR] For more information about the errors and possible solutions, please read the following articles: | |
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException | |
vmassol ~/dev/xwiki/xwiki-platform/xwiki-platform-core/xwiki-platform-menu/xwiki-platform-menu-test/xwiki-platform-menu-test-docker (master *+) $ |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment