See <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/changes>
Changes: [fguillaume] Proper selenium logging activation under tomcat ------------------------------------------ [...truncated 484 lines...] 04:59:41.058 INFO - Preparing Firefox profile... 04:59:43.396 INFO - Launching Firefox... 04:59:44.046 INFO - Checking Resource aliases 05:00:02.284 INFO - Checking Resource aliases 05:00:02.285 INFO - Received posted results 05:00:02.905 INFO - Killing Firefox... 05:00:02.963 INFO - Shutting down... 05:00:02.964 INFO - Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440] + [ 0 != 0 ] + echo ### [INFO] suite-dm TEST SUCCESSFUL ### [INFO] suite-dm TEST SUCCESSFUL + sleep 5 + echo ### [INFO] Running test suite suite-webengine ... ### [INFO] Running test suite suite-webengine ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/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-jboss-mysql/351/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 05:00:08.526 INFO - Java: Sun Microsystems Inc. 19.1-b02 05:00:08.527 INFO - OS: Linux 2.6.32-28-generic-pae i386 05:00:08.532 INFO - v2.0 [b1], with Core v2.0 [b1] 05:00:08.639 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 05:00:08.640 INFO - Version Jetty/5.1.x 05:00:08.641 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 05:00:08.642 INFO - Started HttpContext[/selenium-server,/selenium-server] 05:00:08.642 INFO - Started HttpContext[/,/] 05:00:30.944 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37 05:00:30.944 INFO - Started HttpContext[/wd,/wd] 05:00:30.948 INFO - Started SocketListener on 0.0.0.0:14440 05:00:30.948 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 05:00:31.037 INFO - Preparing Firefox profile... 05:00:33.331 INFO - Launching Firefox... 05:00:34.010 INFO - Checking Resource aliases 05:00:44.126 INFO - Checking Resource aliases 05:00:44.127 INFO - Received posted results 05:00:44.335 INFO - Killing Firefox... 05:00:44.398 INFO - Shutting down... 05:00:44.400 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 -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/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-jboss-mysql/351/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-website.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 05:00:49.816 INFO - Java: Sun Microsystems Inc. 19.1-b02 05:00:49.817 INFO - OS: Linux 2.6.32-28-generic-pae i386 05:00:49.822 INFO - v2.0 [b1], with Core v2.0 [b1] 05:00:49.926 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 05:00:49.927 INFO - Version Jetty/5.1.x 05:00:49.928 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 05:00:49.929 INFO - Started HttpContext[/selenium-server,/selenium-server] 05:00:49.929 INFO - Started HttpContext[/,/] 05:01:08.025 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37 05:01:08.025 INFO - Started HttpContext[/wd,/wd] 05:01:08.029 INFO - Started SocketListener on 0.0.0.0:14440 05:01:08.029 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 05:01:08.120 INFO - Preparing Firefox profile... 05:01:10.391 INFO - Launching Firefox... 05:01:11.047 INFO - Checking Resource aliases 05:01:23.395 INFO - Checking Resource aliases 05:01:23.396 INFO - Received posted results 05:01:23.896 INFO - Killing Firefox... Tests failed, see result file for details: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-website.html> 05:01:23.960 INFO - Shutting down... 05:01:23.961 INFO - Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440] + [ 1 != 0 ] + echo ### [ERROR] suite-webengine-website TEST FAILURE ### [ERROR] suite-webengine-website TEST FAILURE + exit_code=9 + 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 -htmlSuite *chrome http://localhost:8080/nuxeo/ <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/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-jboss-mysql/351/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-tags.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 05:01:29.651 INFO - Java: Sun Microsystems Inc. 19.1-b02 05:01:29.652 INFO - OS: Linux 2.6.32-28-generic-pae i386 05:01:29.657 INFO - v2.0 [b1], with Core v2.0 [b1] 05:01:29.764 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 05:01:29.765 INFO - Version Jetty/5.1.x 05:01:29.766 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 05:01:29.767 INFO - Started HttpContext[/selenium-server,/selenium-server] 05:01:29.767 INFO - Started HttpContext[/,/] 05:01:29.789 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@110fe28 05:01:29.790 INFO - Started HttpContext[/wd,/wd] 05:01:29.793 INFO - Started SocketListener on 0.0.0.0:14440 05:01:29.793 INFO - Started org.openqa.jetty.jetty.Server@116ab4e 05:01:29.882 INFO - Preparing Firefox profile... 05:01:32.145 INFO - Launching Firefox... 05:01:32.799 INFO - Checking Resource aliases 05:01:44.320 INFO - Checking Resource aliases 05:01:44.322 INFO - Received posted results 05:01:44.649 INFO - Killing Firefox... Tests failed, see result file for details: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-tags.html> 05:01:44.718 INFO - Shutting down... 05:01:44.719 INFO - Stopping Acceptor ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440] + [ 1 != 0 ] + echo ### [ERROR] suite-webengine-tags TEST FAILURE ### [ERROR] suite-webengine-tags TEST FAILURE + exit_code=9 + 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-jboss-mysql/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.048s OK fl-run-test -v --simple-fetch test_rest.py -e testWriter --no-color testWriter (test_rest.Rest) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.874s OK fl-run-test -v --simple-fetch test_rest.py -e testReader --no-color testReader (test_rest.Rest) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.975s 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) ... ok testNavigation (test_pages.Pages) ... ok testPublish (test_pages.Pages) ... ok testSections (test_pages.Pages) ... ok ---------------------------------------------------------------------- Ran 9 tests in 18.603s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testInit --no-color testInit (test_nuxeo.Nuxeo) ... ok ---------------------------------------------------------------------- Ran 1 test in 17.654s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testWriter --no-color testWriter (test_nuxeo.Nuxeo) ... ok ---------------------------------------------------------------------- Ran 1 test in 9.935s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testReader --no-color testReader (test_nuxeo.Nuxeo) ... ok ---------------------------------------------------------------------- Ran 1 test in 2.940s OK fl-run-test -v --simple-fetch test_webengine.py --no-color test_testWebengine (test_webengine.Webengine) ... ok ---------------------------------------------------------------------- Ran 1 test in 1.951s OK fl-monitor-ctl monitor.conf stop Server http://localhost:55502/ is stopped. fl-credential-ctl credential.conf stop Server http://localhost:55501/ is stopped. + ret2=0 + ret3=0 + stop_server + SERVER_HOME=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss> + <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/bin/monitorctl.sh> stop <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/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-04-09 05:02:47+02:00 ... Monitoring stopped. Archiving log ... Done: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/log-20110409-030251.tgz> + <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/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-jboss-mysql/ws/trunk/jboss> -Dnuxeo.conf=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/bin/nuxeo.conf> -jar <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/bin/nuxeo-launcher.jar> stop Nuxeo home: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss> Nuxeo configuration: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/bin/nuxeo.conf> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/templates/common-deploydir> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/templates/common-binding> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/templates/common> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/templates/mysql> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/ws/trunk/jboss/templates/monitor> Stopping server..................No answer from server, try to kill process 30081... + '[' '!' -z ']' + echo '### 10 most frequent errors --------------' ### 10 most frequent errors -------------- + sed 's/^.\{24\}//g' + sort + head + uniq -c + grep ' ERROR \[' <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/server.log> + sort -nr 6 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception 6 ERROR [nuxeo-error-log] 2 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1 2 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/that/does/not/exists 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1/testWebSite1 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/FLNXTEST Bench workspace/FLNXTEST Bench folder 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/sections/flnxtest-bench-section 1 ERROR [org.apache.catalina.connector.CoyoteAdapter] An exception or error occurred in the container during the request processing 1 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/that/does/not/exists + echo '### 10 first errors ----------------------' ### 10 first errors ---------------------- + grep -nTm 10 ' ERROR ' <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/server.log> 1989 :2011-04-09 05:01:13,313 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1 2194 :2011-04-09 05:01:13,313 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1 2399 :2011-04-09 05:01:13,334 ERROR [nuxeo-error-log] 2730 :2011-04-09 05:01:13,478 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception 2826 :2011-04-09 05:01:13,854 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1 3031 :2011-04-09 05:01:13,854 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1 3236 :2011-04-09 05:01:13,873 ERROR [nuxeo-error-log] 3567 :2011-04-09 05:01:13,876 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception 3663 :2011-04-09 05:01:14,218 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1/testWebSite1 3868 :2011-04-09 05:01:14,219 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.ClientException: Failed to get document /default-domain/workspaces/testWebWorkspace1/testWebSite1 + echo '### --------------------------------------' ### -------------------------------------- + gzip <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/boot.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/console.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/gc.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/jvm.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/nuxeo-ds.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/nuxeo-error.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/server.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/stderr.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/sysstat-sar.log > <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/vcs-ds.log> > > <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/webrequests.log> > > <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/webthreads.log> + gzip -cd <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-mysql/351/artifact/trunk/jboss/log/server.log.gz> + '[' 9 -eq 0 -a 0 -eq 0 ']' + exit 9 Archiving artifacts Publishing Selenium report... Test failures: 35 Test totals : 107 ------------------------ Command Passes : 1286 Command Failures : 18 Command Errors : 34 _______________________________________________ ECM-QA mailing list [email protected] http://lists.nuxeo.com/mailman/listinfo/ecm-qa
