See <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/>
------------------------------------------ [...truncated 1022 lines...] 05:03:57.371 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-oracle11/ws/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 05:04:02.873 INFO - Java: Sun Microsystems Inc. 19.1-b02 05:04:02.874 INFO - OS: Linux 2.6.32-28-server amd64 05:04:02.879 INFO - v2.0 [b1], with Core v2.0 [b1] 05:04:02.978 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 05:04:02.979 INFO - Version Jetty/5.1.x 05:04:02.980 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 05:04:02.981 INFO - Started HttpContext[/selenium-server,/selenium-server] 05:04:02.981 INFO - Started HttpContext[/,/] 05:04:37.039 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@79a5f739 05:04:37.039 INFO - Started HttpContext[/wd,/wd] 05:04:37.046 INFO - Started SocketListener on 0.0.0.0:14440 05:04:37.046 INFO - Started org.openqa.jetty.jetty.Server@3716ab4e 05:04:37.124 INFO - Preparing Firefox profile... 05:04:39.366 INFO - Launching Firefox... 05:04:39.941 INFO - Checking Resource aliases 05:04:45.924 INFO - Checking Resource aliases 05:04:45.925 INFO - Received posted results 05:04:46.374 INFO - Killing Firefox... 05:04:46.491 INFO - Shutting down... 05:04:46.493 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-oracle11/ws/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine-website.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-website.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 05:04:52.015 INFO - Java: Sun Microsystems Inc. 19.1-b02 05:04:52.017 INFO - OS: Linux 2.6.32-28-server amd64 05:04:52.021 INFO - v2.0 [b1], with Core v2.0 [b1] 05:04:52.121 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 05:04:52.122 INFO - Version Jetty/5.1.x 05:04:52.123 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 05:04:52.124 INFO - Started HttpContext[/selenium-server,/selenium-server] 05:04:52.124 INFO - Started HttpContext[/,/] 05:05:17.040 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@45d64c37 05:05:17.040 INFO - Started HttpContext[/wd,/wd] 05:05:17.050 INFO - Started SocketListener on 0.0.0.0:14440 05:05:17.050 INFO - Started org.openqa.jetty.jetty.Server@3716ab4e 05:05:17.195 INFO - Preparing Firefox profile... 05:05:19.367 INFO - Launching Firefox... 05:05:19.959 INFO - Checking Resource aliases 05:05:54.456 INFO - Checking Resource aliases 05:05:54.458 INFO - Received posted results 05:05:54.882 INFO - Killing Firefox... 05:05:55.119 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-oracle11/ws/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine-tags.html> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-tags.html> -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 05:06:00.623 INFO - Java: Sun Microsystems Inc. 19.1-b02 05:06:00.624 INFO - OS: Linux 2.6.32-28-server amd64 05:06:00.629 INFO - v2.0 [b1], with Core v2.0 [b1] 05:06:00.728 INFO - RemoteWebDriver instances should connect to: http://127.0.0.1:14440/wd/hub 05:06:00.729 INFO - Version Jetty/5.1.x 05:06:00.730 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 05:06:00.730 INFO - Started HttpContext[/selenium-server,/selenium-server] 05:06:00.730 INFO - Started HttpContext[/,/] 05:06:27.040 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@7825d2b2 05:06:27.040 INFO - Started HttpContext[/wd,/wd] 05:06:27.045 INFO - Started SocketListener on 0.0.0.0:14440 05:06:27.045 INFO - Started org.openqa.jetty.jetty.Server@3716ab4e 05:06:27.129 INFO - Preparing Firefox profile... 05:06:29.306 INFO - Launching Firefox... 05:06:29.858 INFO - Checking Resource aliases 05:06:43.827 INFO - Checking Resource aliases 05:06:43.828 INFO - Received posted results 05:06:44.312 INFO - Killing Firefox... 05:06:44.452 INFO - Shutting down... + [ 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-oracle11/ws/trunk/nuxeo-5.4.3-I20110619_0116/nuxeo-distribution/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.091s OK fl-run-test -v --simple-fetch test_rest.py -e testWriter --no-color testWriter (test_rest.Rest) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.704s OK fl-run-test -v --simple-fetch test_rest.py -e testReader --no-color testReader (test_rest.Rest) ... ok ---------------------------------------------------------------------- Ran 1 test in 0.181s 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 testNavigation (test_pages.Pages) ... ok testPublish (test_pages.Pages) ... ok testSections (test_pages.Pages) ... ok testUsersGroupsPage (test_pages.Pages) ... ok ---------------------------------------------------------------------- Ran 9 tests in 57.280s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testInit --no-color testInit (test_nuxeo.Nuxeo) ... ok ---------------------------------------------------------------------- Ran 1 test in 9.292s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testWriter --no-color testWriter (test_nuxeo.Nuxeo) ... ok ---------------------------------------------------------------------- Ran 1 test in 7.420s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testReader --no-color testReader (test_nuxeo.Nuxeo) ... ok ---------------------------------------------------------------------- Ran 1 test in 2.156s OK fl-run-test -v --simple-fetch test_webengine.py --no-color test_testWebengine (test_webengine.Webengine) ... ok ---------------------------------------------------------------------- Ran 1 test in 1.092s OK fl-run-test -v --simple-fetch test_dav.py --no-color testDav (test_dav.Dav) ... ok testLocks (test_dav.Dav) ... ok testUserAgents (test_dav.Dav) ... ok testWriter (test_dav.Dav) ... ok ---------------------------------------------------------------------- Ran 4 tests in 1.259s 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-tomcat-oracle11/ws/trunk/tomcat> + <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/bin/monitorctl.sh> stop <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/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 -Dcom.sun.management.jmxremote -Dcom.sun.management.jmxremote.port=1089 -Dcom.sun.management.jmxremote.ssl=false -Dcom.sun.management.jmxremote.authenticate=false: bad substitution Stopping monitoring 2011-06-19 05:08:14+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-oracle11/140/artifact/trunk/tomcat/log/log-20110619-030823.tgz> + <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/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 -Dcom.sun.management.jmxremote -Dcom.sun.management.jmxremote.port=1089 -Dcom.sun.management.jmxremote.ssl=false -Dcom.sun.management.jmxremote.authenticate=false -Djava.net.preferIPv4Stack=true -Djava.awt.headless=true -Dnuxeo.home=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat> -Dnuxeo.conf=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/bin/nuxeo.conf> -Dnuxeo.log.dir=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/log> -jar <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/bin/nuxeo-launcher.jar> stop Nuxeo home: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat> Nuxeo configuration: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/bin/nuxeo.conf> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/templates/common> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/templates/default> Include template: <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/ws/trunk/tomcat/templates/oracle> Template 'monitor' not found with relative or absolute path (<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/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-oracle11/140/artifact/trunk/tomcat/log/server.log> + head + sort + sed 's/^.\{24\}//g' + sort -nr + uniq -c 7 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception 7 ERROR [nuxeo-error-log] 5 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (3) SQL: Resetting connection 5 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' 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' 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/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 + echo '### 10 first errors ----------------------' ### 10 first errors ---------------------- + grep -nTm 10 ' ERROR ' <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/server.log> 588 :2011-06-19 04:50:40,979 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (3) SQL: Resetting connection 785 :2011-06-19 04:50:48,244 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on [globalId=54900000047544d4944000000000000000000000000000000000000000000000000000,branchId=1000000047544d4944000000000000000000000000000000000000000000000000000] 985 :2011-06-19 04:50:56,210 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (3) SQL: Resetting connection 1182 :2011-06-19 04:51:45,415 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on [globalId=ffffffbe900000047544d4944000000000000000000000000000000000000000000000000000,branchId=1000000047544d4944000000000000000000000000000000000000000000000000000] 1380 :2011-06-19 04:51:48,538 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (3) SQL: Resetting connection 1577 :2011-06-19 04:52:47,159 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on [globalId=ffffffcc900000047544d4944000000000000000000000000000000000000000000000000000,branchId=1000000047544d4944000000000000000000000000000000000000000000000000000] 1841 :2011-06-19 04:58:22,745 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (3) SQL: Resetting connection 2038 :2011-06-19 04:58:38,510 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on [globalId=ffffffb82000000047544d4944000000000000000000000000000000000000000000000000000,branchId=1000000047544d4944000000000000000000000000000000000000000000000000000] 2248 :2011-06-19 05:03:09,828 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' 2388 :2011-06-19 05:03:09,828 ERROR [nuxeo-error-log] javax.el.ELException: org.nuxeo.ecm.core.api.DocumentSecurityException: Privilege 'Read' is not granted to 'bree' + echo '### --------------------------------------' ### -------------------------------------- + gzip <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/console.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/gc.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/jmxstat.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/nuxeoctl.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/nuxeo-error.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/server.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/stderr.log> <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/sysstat-sar.log> + gzip -cd <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-tomcat-oracle11/140/artifact/trunk/tomcat/log/server.log.gz> + '[' 9 -eq 0 -a 0 -eq 0 ']' + exit 9 + exit Archiving artifacts Publishing Selenium report... Test failures: 32 Test totals : 108 ------------------------ Command Passes : 990 Command Failures : 32 Command Errors : 30 _______________________________________________ ECM-QA mailing list [email protected] http://lists.nuxeo.com/mailman/listinfo/ecm-qa
