Hi, UI tests seem to be failing rather consistently. As far as I can understand, "Caused by: org.openqa.selenium.WebDriverException: Unable to bind to locking port 7054 within 45000 ms" can have 2 causes: 1) A firefox instance is still opened when the test starts, so a new one can not be opened for the actual test. - This does not seem to be the case, as before and after the test I can see no opened firefox process. 2) Incompatibility between the selenium version (2.40.0) and the firefox version (27.0.1)? [1][2] - I doubt this is the case, since we did not change anything here recently. Any ideas? This seems to be reproducing on various agents both on master and on the 6.1 branch (for example). Thanks, Eduard ---------- [1] http://selenium.10932.n7.nabble.com/Unable-to-bind-to-locking-port-7054-with... [2] https://groups.google.com/forum/#!topic/webdriver/e8NiXwM-A1k On Sun, Aug 24, 2014 at 12:11 AM, Jenkins <[email protected]> wrote:

Check console output at http://ci.xwiki.org/job/xwiki-enterprise-test-ui/3380/ to view the results.

Changes since the previous successful build:

Changes for Build #3360

Changes for Build #3361

Changes for Build #3362 [Guillaume Delhumeau] Aug 18, 2014 12:24:23 PM XWIKI-10809: Move Font Awesome Icon Theme in the Icon module. (rev 77519cad877ea487b44e3fb1155a54df14c1dbe8) [Guillaume Delhumeau] Aug 18, 2014 1:07:56 PM XWIKI-10809: Move Font Awesome Icon Theme in the Icon module. (rev d660fdd67064ae6ff0259b44cfe937b8597d8a8e)

Changes for Build #3363 [Guillaume Delhumeau] Aug 20, 2014 5:25:46 PM XE-1404: Switch to Flamingo Skin by default. (rev 7c40f89248189af3486e4be631f5af9e1b566217)

Changes for Build #3364 [Guillaume Delhumeau] Aug 20, 2014 5:30:43 PM XE-1404: Switch to Flamingo Skin by default. (rev 90f4d266e2bf70a383494066a8493f4ba0985101)

Changes for Build #3365

Changes for Build #3366 [Guillaume Delhumeau] Aug 20, 2014 5:49:43 PM XWIKI-10809: Move Font Awesome Icon Theme in the Icon module. (rev fb62b467cae9932774f56951adcc8a33d3dd36e2) [Guillaume Delhumeau] Aug 20, 2014 6:22:10 PM XWIKI-10823: Rename the LESS module artifacts. (rev 56d184b40058fa529d794c9c04898d6b7f9f1686) [Guillaume Delhumeau] Aug 20, 2014 6:52:16 PM XE-1404: Switch to Flamingo Skin by default. (rev 41d771917b8e076a92c3bd370783c42867e086e1) [Guillaume Delhumeau] Aug 20, 2014 7:01:26 PM XE-1404: Switch to Flamingo Skin by default. (rev a481aeaa498763c11b88a290ba76abb373be1bc5)

Changes for Build #3367

Changes for Build #3368 [Guillaume Delhumeau] Aug 21, 2014 1:12:35 PM XE-1404: Switch to Flamingo Skin by default. (rev 65ede7701c8d2ad86238e1d17eca692f4646e368)

Changes for Build #3369 [Guillaume Delhumeau] Aug 21, 2014 1:58:27 PM XE-1404: Switch to Flamingo Skin by default. (rev 655d0f6b1869749207543b1c9abb5399deaf38e7)

Changes for Build #3370

Changes for Build #3371

Changes for Build #3372

Changes for Build #3373 [Guillaume Delhumeau] Aug 21, 2014 5:48:59 PM XE-1404: Switch to Flamingo Skin by default. (rev 61720c645a9cc960a7673611e1d3c01ca5346057)

Changes for Build #3374

Changes for Build #3375 [Vincent Massol] Aug 22, 2014 12:53:09 PM [Misc] Revert changes done by sdumitriu. The relativePath should not be set to not cause problems with Jenkins. BTW I couldn't reproduce the build warning problem that Sergiu fixed in his commit (would be interested to know more about it). (rev a74558130c4625fdd1dd6c3e2b5b609ed6c39b44)

Changes for Build #3376

Changes for Build #3377 [Vincent Massol] Aug 22, 2014 5:34:44 PM [Misc] Force Maven to use its repositories to resolve parent POM for top level modules. This is to prevent any error such as having a pom.xml file located in a directory above the top level modules for example. (rev 172194e2764218ba6796f6fb4e6bd3972ca2ce66) [Vincent Massol] Aug 22, 2014 6:19:43 PM XWIKI-10828: Speed up XWiki instance starting in functional tests (rev 6b00f7cd764aaab4522d1be7b65fff2c481d7a6e) [Eduard Moraru] Aug 23, 2014 12:15:44 AM XE-1404: Switch to Flamingo Skin by default. (rev b9260b50a3f69a99c96a050208e92f8d71688c91)

Changes for Build #3378

Changes for Build #3379

Changes for Build #3380

Failed tests:

1 tests failed. FAILED: org.apache.maven.surefire.junit4.JUnit4Provider.org.xwiki.test.ui.AllTests

Error Message: Failed to initialize PersistentTestContext

Stack Trace: java.lang.RuntimeException: Failed to initialize PersistentTestContext at org.xwiki.test.ui.PageObjectSuite.beforeTests(PageObjectSuite.java:67) at org.xwiki.test.integration.XWikiExecutorSuite.run(XWikiExecutorSuite.java:170) at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124) at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200) at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103) Caused by: org.openqa.selenium.WebDriverException: Unable to bind to locking port 7054 within 45000 ms Build info: version: '2.40.0', revision: '4c5c0568b004f67810ee41c459549aa4b09c651e', time: '2014-02-19 11:13:01' System info: host: 'vagent-3-3-dev', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '3.10.23-vs2.3.6.8-beng', java.version: '1.7.0_55' Driver info: driver.version: FirefoxDriver at org.openqa.selenium.internal.SocketLock.lock(SocketLock.java:98) at org.openqa.selenium.firefox.internal.NewProfileExtensionConnection.start(NewProfileExtensionConnection.java:84) at org.openqa.selenium.firefox.FirefoxDriver.startClient(FirefoxDriver.java:247) at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:112) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:192) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:187) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:183) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:100) at org.xwiki.test.ui.WebDriverFactory.createWebDriver(WebDriverFactory.java:56) at org.xwiki.test.ui.PersistentTestContext.<init>(PersistentTestContext.java:72) at org.xwiki.test.ui.PageObjectSuite.beforeTests(PageObjectSuite.java:59) ... 7 more

Last build logs:

[...truncated 393 lines...] [WARNING] /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/src/test/it/org/xwiki/test/ui/invitation/InvitationTest.java:[255,22] registerLoginAndGotoPage(java.lang.String,java.lang.String,java.lang.String) in org.xwiki.test.ui.TestUtils has been deprecated [WARNING] /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/src/test/it/org/xwiki/test/ui/invitation/InvitationTest.java:[310,22] registerLoginAndGotoPage(java.lang.String,java.lang.String,java.lang.String) in org.xwiki.test.ui.TestUtils has been deprecated [WARNING] /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/src/test/it/org/xwiki/test/ui/invitation/InvitationTest.java:[688,22] registerLoginAndGotoPage(java.lang.String,java.lang.String,java.lang.String) in org.xwiki.test.ui.TestUtils has been deprecated [INFO] [INFO] --- maven-dependency-plugin:2.8:unpack (unzip-application) @ xwiki-enterprise-test-ui --- [INFO] Configured Artifact: org.xwiki.enterprise:xwiki-enterprise-jetty-hsqldb:6.2-SNAPSHOT:zip Downloading: http://nexus.xwiki.org/nexus/content/groups/public-snapshots/org/xwiki/enter... Downloaded: http://nexus.xwiki.org/nexus/content/groups/public-snapshots/org/xwiki/enter... (799 B at 20.0 KB/sec) Downloading: http://nexus.xwiki.org/nexus/content/groups/public-snapshots/org/xwiki/enter... Downloaded: http://nexus.xwiki.org/nexus/content/groups/public-snapshots/org/xwiki/enter... (220669 KB at 11465.1 KB/sec) [INFO] Unpacking /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/.repository/org/xwiki/enterprise/xwiki-enterprise-jetty-hsqldb/6.2-SNAPSHOT/xwiki-enterprise-jetty-hsqldb-6.2-SNAPSHOT.zip to /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/target with includes "" and excludes "" [INFO] [INFO] --- maven-surefire-plugin:2.16:test (default) @ xwiki-enterprise-test-ui --- [INFO] Surefire report directory: /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/target/surefire-reports

------------------------------------------------------- T E S T S ------------------------------------------------------- Running org.xwiki.test.ui.AllTests 23:10:31.124 [main] INFO o.x.test.integration.XWikiExecutor - Starting XWiki server at [http://localhost:8080/xwiki/bin/get/Main/] 23:10:31.138 [main] INFO o.x.test.integration.XWikiExecutor - Checking that XWiki is up and running... 23:10:31.143 [Thread-1] INFO o.x.t.i.XWikiLogOutputStream - Starting Jetty on port 8080, please wait... 23:10:31.518 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - Error binding monitor port 8079: java.net.BindException: Cannot assign requested address 23:10:38.638 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:38,634 [main] INFO o.x.s.s.i.EmbeddedSolrInstance - Starting embedded Solr server... 23:10:38.640 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:38,638 [main] INFO o.x.s.s.i.EmbeddedSolrInstance - Using Solr home directory: [data/solr] 23:10:39.931 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:39,930 [coreLoadExecutor-4-thread-1] WARN o.a.s.c.SolrCore - [xwiki] Solr index directory '/home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/target/xwiki-enterprise-jetty-hsqldb-6.2-SNAPSHOT/data/solr/xwiki/data/index' doesn't exist. Creating new index... 23:10:40.351 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:40,351 [coreLoadExecutor-4-thread-1] WARN o.a.s.r.ManagedResource - No stored data found for /rest/managed 23:10:40.352 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:40,351 [coreLoadExecutor-4-thread-1] WARN o.a.s.r.ManagedResource - No registered observers for /rest/managed 23:10:40.498 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:40,498 [main] INFO o.x.s.s.i.EmbeddedSolrInstance - Started embedded Solr server. 23:10:41.853 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:41.853:INFO:oxtjl.NotifyListener:---------------------------------- 23:10:41.854 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:41.854:INFO:oxtjl.NotifyListener:Server started, you can now open http://localhost:8080/ in your browser to access your wiki. 23:10:41.854 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:41.854:INFO:oxtjl.NotifyListener:---------------------------------- 23:10:45.501 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:45,501 [XWiki initialization] INFO .HibernateDataMigrationManager - Storage schema updates and data migrations are enabled 23:10:45.502 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:45,501 [XWiki initialization] INFO .HibernateDataMigrationManager - No data migration to apply for wiki [xwiki] currently in version [54300] 23:10:45.502 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:45,502 [XWiki initialization] INFO .HibernateDataMigrationManager - Checking Hibernate mapping and updating schema if needed for wiki [xwiki] 23:10:54.159 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:54,159 [XWiki Solr index job thread] INFO o.x.s.s.i.j.IndexerJob - Starting job of type [solr.indexer] with identifier [[solr, indexer]] 23:10:54.966 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:54,965 [XWiki Solr index job thread] INFO o.x.s.s.i.j.IndexerJob - 565 documents added, 0 deleted and 0 updated during the synchronization of the Solr index. 23:10:54.966 [Thread-2] ERROR o.x.t.i.XWikiLogOutputStream - 2014-08-23 23:10:54,965 [XWiki Solr index job thread] INFO o.x.s.s.i.j.IndexerJob - Finished job of type [solr.indexer] with identifier [[solr, indexer]] 23:10:56.985 [main] INFO o.x.test.integration.XWikiExecutor - Server is answering to [http://localhost:8080/xwiki/bin/get/Main/]... cool Tests run: 1, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 73.201 sec <<< FAILURE! - in org.xwiki.test.ui.AllTests org.xwiki.test.ui.AllTests Time elapsed: 73.2 sec <<< ERROR! java.lang.RuntimeException: Failed to initialize PersistentTestContext at org.xwiki.test.ui.PageObjectSuite.beforeTests(PageObjectSuite.java:67) at org.xwiki.test.integration.XWikiExecutorSuite.run(XWikiExecutorSuite.java:170) at org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:264) at org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:153) at org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:124) at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:200) at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:153) at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:103) Caused by: org.openqa.selenium.WebDriverException: Unable to bind to locking port 7054 within 45000 ms Build info: version: '2.40.0', revision: '4c5c0568b004f67810ee41c459549aa4b09c651e', time: '2014-02-19 11:13:01' System info: host: 'vagent-3-3-dev', ip: '127.0.0.1', os.name: 'Linux', os.arch: 'amd64', os.version: '3.10.23-vs2.3.6.8-beng', java.version: '1.7.0_55' Driver info: driver.version: FirefoxDriver at org.openqa.selenium.internal.SocketLock.lock(SocketLock.java:98) at org.openqa.selenium.firefox.internal.NewProfileExtensionConnection.start(NewProfileExtensionConnection.java:84) at org.openqa.selenium.firefox.FirefoxDriver.startClient(FirefoxDriver.java:247) at org.openqa.selenium.remote.RemoteWebDriver.<init>(RemoteWebDriver.java:112) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:192) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:187) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:183) at org.openqa.selenium.firefox.FirefoxDriver.<init>(FirefoxDriver.java:100) at org.xwiki.test.ui.WebDriverFactory.createWebDriver(WebDriverFactory.java:56) at org.xwiki.test.ui.PersistentTestContext.<init>(PersistentTestContext.java:72) at org.xwiki.test.ui.PageObjectSuite.beforeTests(PageObjectSuite.java:59) ... 7 more

Results :

Tests in error: JUnit4Provider.invoke:124->executeTestSet:153->execute:264 » Runtime Failed to...

Tests run: 1, Failures: 0, Errors: 1, Skipped: 0

[ERROR] There are test failures.

Please refer to /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/target/surefire-reports for the individual test results. [JENKINS] Recording test results log4j:WARN No appenders could be found for logger (org.apache.commons.beanutils.converters.BooleanConverter). log4j:WARN Please initialize the log4j system properly. [INFO] [INFO] --- maven-install-plugin:2.5.1:install (default-install) @ xwiki-enterprise-test-ui --- [INFO] Installing /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/pom.xml to /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/.repository/org/xwiki/enterprise/xwiki-enterprise-test-ui/6.2-SNAPSHOT/xwiki-enterprise-test-ui-6.2-SNAPSHOT.pom [INFO] [INFO] --- maven-deploy-plugin:2.8.1:deploy (default-deploy) @ xwiki-enterprise-test-ui --- Downloading: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... Downloaded: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... (621 B at 28.9 KB/sec) Uploading: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... Uploaded: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... (4 KB at 82.2 KB/sec) Downloading: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... Downloaded: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... (932 B at 60.7 KB/sec) Uploading: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... Uploaded: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... (621 B at 23.3 KB/sec) Uploading: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... Uploaded: http://nexus.xwiki.org/nexus/content/repositories/snapshots/org/xwiki/enterp... (932 B at 37.9 KB/sec) [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 1:56.610s [INFO] Finished at: Sat Aug 23 23:11:47 CEST 2014 [INFO] Final Memory: 34M/489M [INFO] ------------------------------------------------------------------------ [WARNING] The requested profile "legacy" could not be activated because it does not exist. [WARNING] The requested profile "jetty" could not be activated because it does not exist. Waiting for Jenkins to finish collecting data [JENKINS] Archiving /home/hudsonagent/hudson_root/workspace/xwiki-enterprise-test-ui/xwiki-enterprise-test/xwiki-enterprise-test-ui/pom.xml to org.xwiki.enterprise/xwiki-enterprise-test-ui/6.2-SNAPSHOT/xwiki-enterprise-test-ui-6.2-SNAPSHOT.pom channel stopped Terminating xvnc. $ vncserver -kill :43 Killing Xtightvnc process ID 31217 Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures)