Skip to content

Instantly share code, notes, and snippets.

@vmassol
Created November 25, 2019 13:13
Show Gist options
  • Save vmassol/29fe229bb6bdba21d080406dd446f5e3 to your computer and use it in GitHub Desktop.
Save vmassol/29fe229bb6bdba21d080406dd446f5e3 to your computer and use it in GitHub Desktop.
[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