See <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/>
------------------------------------------ [...truncated 347 lines...] + echo ### [INFO] Running test suite suite-dm ... ### [INFO] Running test suite suite-dm ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -browserSideLog -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite-dm.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-dm.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 04:21:09.242 INFO - Java: Sun Microsystems Inc. 19.1-b02 04:21:09.243 INFO - OS: Linux 2.6.32-28-generic-pae i386 04:21:09.248 INFO - v2.0 [b1], with Core v2.0 [b1] 04:21:09.357 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 04:21:09.358 INFO - Version Jetty/5.1.x 04:21:09.359 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 04:21:09.360 INFO - Started HttpContext[/selenium-server,/selenium-server] 04:21:09.360 INFO - Started HttpContext[/,/] 04:21:36.766 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37 04:21:36.766 INFO - Started HttpContext[/wd,/wd] 04:21:36.774 INFO - Started SocketListener on 0.0.0.0:14440 04:21:36.774 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 04:21:36.865 INFO - Preparing Firefox profile... 04:21:39.215 INFO - Launching Firefox... 04:21:39.859 INFO - Checking Resource aliases 04:21:44.025 INFO - Checking Resource aliases 04:21:44.026 INFO - Received posted results 04:21:44.218 INFO - Killing Firefox... Tests failed, see result file for details: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-dm.html> 04:21:44.271 INFO - Shutting down... 04:21:44.272 INFO - Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440] + [ 1 != 0 ] + echo ### [ERROR] suite-dm TEST FAILURE ### [ERROR] suite-dm TEST FAILURE + exit_code=9 + sleep 5 + echo ### [INFO] Running test suite suite-webengine ... ### [INFO] Running test suite suite-webengine ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -browserSideLog -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 04:21:49.668 INFO - Java: Sun Microsystems Inc. 19.1-b02 04:21:49.669 INFO - OS: Linux 2.6.32-28-generic-pae i386 04:21:49.674 INFO - v2.0 [b1], with Core v2.0 [b1] 04:21:49.776 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 04:21:49.777 INFO - Version Jetty/5.1.x 04:21:49.778 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 04:21:49.779 INFO - Started HttpContext[/selenium-server,/selenium-server] 04:21:49.779 INFO - Started HttpContext[/,/] 04:22:16.766 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37 04:22:16.767 INFO - Started HttpContext[/wd,/wd] 04:22:16.773 INFO - Started SocketListener on 0.0.0.0:14440 04:22:16.773 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 04:22:16.866 INFO - Preparing Firefox profile... 04:22:19.136 INFO - Launching Firefox... 04:22:19.754 INFO - Checking Resource aliases 04:22:25.082 INFO - Checking Resource aliases 04:22:25.083 INFO - Received posted results 04:22:25.647 INFO - Killing Firefox... 04:22:25.700 INFO - Shutting down... 04:22:25.702 INFO - Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440] + [ 0 != 0 ] + echo ### [INFO] suite-webengine TEST SUCCESSFUL ### [INFO] suite-webengine TEST SUCCESSFUL + sleep 5 + echo ### [INFO] Running test suite suite-webengine-website ... ### [INFO] Running test suite suite-webengine-website ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -browserSideLog -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine-website.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-website.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 04:22:31.156 INFO - Java: Sun Microsystems Inc. 19.1-b02 04:22:31.157 INFO - OS: Linux 2.6.32-28-generic-pae i386 04:22:31.162 INFO - v2.0 [b1], with Core v2.0 [b1] 04:22:31.270 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 04:22:31.271 INFO - Version Jetty/5.1.x 04:22:31.271 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 04:22:31.272 INFO - Started HttpContext[/selenium-server,/selenium-server] 04:22:31.272 INFO - Started HttpContext[/,/] 04:22:51.767 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37 04:22:51.767 INFO - Started HttpContext[/wd,/wd] 04:22:51.777 INFO - Started SocketListener on 0.0.0.0:14440 04:22:51.777 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 04:22:51.869 INFO - Preparing Firefox profile... 04:22:54.165 INFO - Launching Firefox... 04:22:54.819 INFO - Checking Resource aliases 04:23:24.651 INFO - Checking Resource aliases 04:23:24.652 INFO - Received posted results 04:23:25.182 INFO - Killing Firefox... 04:23:25.309 INFO - Shutting down... + [ 0 != 0 ] + echo ### [INFO] suite-webengine-website TEST SUCCESSFUL ### [INFO] suite-webengine-website TEST SUCCESSFUL + sleep 5 + echo ### [INFO] Running test suite suite-webengine-tags ... ### [INFO] Running test suite suite-webengine-tags ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -browserSideLog -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine-tags.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-tags.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 04:23:30.983 INFO - Java: Sun Microsystems Inc. 19.1-b02 04:23:30.984 INFO - OS: Linux 2.6.32-28-generic-pae i386 04:23:30.989 INFO - v2.0 [b1], with Core v2.0 [b1] 04:23:31.099 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 04:23:31.100 INFO - Version Jetty/5.1.x 04:23:31.100 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 04:23:31.101 INFO - Started HttpContext[/selenium-server,/selenium-server] 04:23:31.101 INFO - Started HttpContext[/,/] 04:23:31.115 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@9e29fb 04:23:31.115 INFO - Started HttpContext[/wd,/wd] 04:23:31.119 INFO - Started SocketListener on 0.0.0.0:14440 04:23:31.119 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 04:23:31.207 INFO - Preparing Firefox profile... 04:23:33.451 INFO - Launching Firefox... 04:23:34.127 INFO - Checking Resource aliases 04:23:44.834 INFO - Checking Resource aliases 04:23:44.835 INFO - Received posted results 04:23:45.457 INFO - Killing Firefox... 04:23:45.517 INFO - Shutting down... 04:23:45.518 INFO - Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440] + [ 0 != 0 ] + echo ### [INFO] suite-webengine-tags TEST SUCCESSFUL ### [INFO] suite-webengine-tags TEST SUCCESSFUL + sleep 5 + [ 9 != 0 ] + echo ### [ERROR] TESTS FAILURE ### [ERROR] TESTS FAILURE + exit 9 + ret1=9 + '[' -z ']' + java -version + grep 1.6.0 java version "1.6.0_24" Java(TM) SE Runtime Environment (build 1.6.0_24-b07) + '[' 0 == 0 ']' + cd <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload> + make EXT=--no-color mkdir -p ../../target/ftest/funkload/report ../../target/ftest/funkload/log fl-monitor-ctl monitor.conf restart Starting monitor server at http://localhost:55502/ as daemon. fl-credential-ctl credential.conf restart Starting file_credential server at http://localhost:55501/ as daemon. fl-run-test test_pages.py --simple-fetch -v -e testAvailable --no-color testAvailable (test_pages.Pages) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.055s OK fl-run-test -v --simple-fetch test_rest.py -e testWriter --no-color testWriter (test_rest.Rest) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.446s OK fl-run-test -v --simple-fetch test_rest.py -e testReader --no-color testReader (test_rest.Rest) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.125s OK fl-run-test -v --simple-fetch test_pages.py --no-color testAvailable (test_pages.Pages) ... ok testBasePageViewDocumentPath (test_pages.Pages) ... ok testFileTabs (test_pages.Pages) ... ok testFolderPage (test_pages.Pages) ... ok testLoginPage (test_pages.Pages) ... ok testMemberManagementPage (test_pages.Pages) ... FAIL testNavigation (test_pages.Pages) ... ok testPublish (test_pages.Pages) ... ok testSections (test_pages.Pages) ... ok ====================================================================== FAIL: testMemberManagementPage (test_pages.Pages) ---------------------------------------------------------------------- Traceback (most recent call last): File "/usr/local/lib/python2.6/dist-packages/funkload-1.16.0a_20110408-py2.6.egg/funkload/FunkLoadTestCase.py", line 923, in __call__ testMethod() File "<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/test_pages.py";,> line 161, in testMemberManagementPage firstname="first", lastname=login.capitalize()) File "<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/nuxeo/pages.py";,> line 178, in createUser jsfState = fl.getLastJsfState() File "<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/nuxeo/testcase.py";,> line 118, in getLastJsfState return extractJsfState(self.getBody()) File "<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/nuxeo/utils.py";,> line 15, in extractJsfState raise ValueError('Invalid JSF State found: %s.' % str(state)) ValueError: Invalid JSF State found: > <title>Nuxeo Error Page</title> <style type=. ---------------------------------------------------------------------- Ran 9 tests in 9.315s FAILED (failures=1) make: *** [page] Error 1 + ret2=2 + ret3=0 + stop_server + SERVER_HOME=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat> + <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/bin/monitorctl.sh> stop <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/bin/monitorctl.sh>: line 121: -server -Xms1g -Xmx1g -XX:MaxPermSize=512m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Xloggc:${nuxeo.log.dir}/gc.log -verbose:gc -XX:+PrintGCDetails -XX:+PrintGCTimeStamps: bad substitution Stopping monitoring 2011-05-05 04:24:04+02:00 ... Monitoring stopped. Archiving log ... tar: log/*.html: Cannot stat: No such file or directory tar: Exiting with failure status due to previous errors Done: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/log-20110505-022407.tgz> + <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/bin/nuxeoctl> stop Launcher command: java -Dlauncher.java.opts=-server -Xms1g -Xmx1g -XX:MaxPermSize=512m -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Xloggc:${nuxeo.log.dir}/gc.log -verbose:gc -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -Djava.net.preferIPv4Stack=true -Djava.awt.headless=true -Dnuxeo.home=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat> -Dnuxeo.conf=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/bin/nuxeo.conf> -jar <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/bin/nuxeo-launcher.jar> stop Nuxeo home: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat> Nuxeo configuration: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/bin/nuxeo.conf> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/templates/common> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/templates/default> Template 'monitor' not found with relative or absolute path (<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/ws/trunk/tomcat/templates/monitor).> Check your nuxeo.templates parameter, and nuxeo.template.includes for included files. Stopping server.....Server stopped. + '[' '!' -z ']' + echo '### 10 most frequent errors --------------' ### 10 most frequent errors -------------- + grep ' ERROR \[' <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/server.log> + sort + sort -nr + uniq -c + sed 's/^.\{24\}//g' + head 102 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 6 ERROR [nuxeo-error-log] 5 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception 4 ERROR [org.apache.catalina.core.ContainerBase.[Catalina].[localhost].[/nuxeo]] Session event listener threw exception 3 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.DocumentSecurityException: Privilege 'Read' is not granted to 'jdoe' 3 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.DocumentSecurityException: Privilege 'Read' is not granted to 'jdoe' 2 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab with id 'TAB_CONTENT_JBPM': action does not exist. 1 ERROR [org.nuxeo.runtime.deployment.preprocessor.FragmentRegistry] Overriding fragment with name 'org.nuxeo.ecm.core.storage.sql.ra' and path 'bundles/nuxeo-core-storage-sql-ra-5.4.2-I20110505_0115.rar' that is already present with path 'bundles/nuxeo-core-storage-sql-ra-5.4.2-I20110505_0115.jar' 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: viewId:/view_users.faces - View /view_users.faces could not be restored. 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.DocumentSecurityException: Privilege 'Read' is not granted to 'bree' + echo '### 10 first errors ----------------------' ### 10 first errors ---------------------- + grep -nTm 10 ' ERROR ' <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/server.log> 3 :2011-05-05 03:58:49,793 ERROR [org.nuxeo.runtime.deployment.preprocessor.FragmentRegistry] Overriding fragment with name 'org.nuxeo.ecm.core.storage.sql.ra' and path 'bundles/nuxeo-core-storage-sql-ra-5.4.2-I20110505_0115.rar' that is already present with path 'bundles/nuxeo-core-storage-sql-ra-5.4.2-I20110505_0115.jar' 555 :2011-05-05 03:59:50,369 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 556 :2011-05-05 03:59:54,607 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 557 :2011-05-05 03:59:56,967 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 558 :2011-05-05 03:59:59,577 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 562 :2011-05-05 04:00:50,681 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 563 :2011-05-05 04:00:51,870 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 565 :2011-05-05 04:00:57,349 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 566 :2011-05-05 04:00:58,412 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : 568 :2011-05-05 04:01:08,994 ERROR [org.nuxeo.ecm.webapp.action.WebActionsBean] Cannot set current tab from given encoded action: : + echo '### --------------------------------------' ### -------------------------------------- + gzip <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/console.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/gc.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/nuxeo-error.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/server.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/stderr.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/sysstat-sar.log> + gzip -cd <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat/744/artifact/trunk/tomcat/log/server.log.gz> + '[' 9 -eq 0 -a 2 -eq 0 ']' + exit 9 + exit Archiving artifacts Publishing Selenium report... Test failures: 32 Test totals : 107 ------------------------ Command Passes : 1029 Command Failures : 26 Command Errors : 31 _______________________________________________ ECM-QA mailing list [email protected] http://lists.nuxeo.com/mailman/listinfo/ecm-qa
