See <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-selenium-cap-jboss/399/changes>
Changes: [bdelbosc] NXBT: Display error log frequencies when stopping the server - bis ------------------------------------------ [...truncated 1044 lines...] + deploy_ear + JBOSS=/opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss + '[' '!' -d /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/server/default/deploy/nuxeo.ear ']' + '[' -z true ']' + echo 'Using EAR already present in JBoss assuming it'\''s a fresh build.' Using EAR already present in JBoss assuming it's a fresh build. + '[' '!' -z ']' + start_server 127.0.0.1 + '[' 1 == 2 ']' + IP=127.0.0.1 + check_ports_and_kill_ghost_process 127.0.0.1 + hostname=127.0.0.1 + ports='8080 14440' + for port in '$ports' ++ lsof -n -i [email protected]:8080 ++ grep '(LISTEN)' ++ awk '{print $2}' + RUNNING_PID= + '[' '!' -z ']' + for port in '$ports' ++ grep '(LISTEN)' ++ awk '{print $2}' ++ lsof -n -i [email protected]:14440 + RUNNING_PID= + '[' '!' -z ']' + /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/bin/nuxeoctl start Starting Nuxeo... (pressing Ctrl+C will interrupt starting process) .......................................................................14:23:30,047 INFO [OSGiRuntimeService] Nuxeo EP Started ====================================================================== = Nuxeo EP Started ====================================================================== = Component Loading Status: Pending: 0 / Unstarted: 0 / Total: 272 ====================================================================== = Component Loading Status: Pending: 0 / Unstarted: 0 / Total: 272 + /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/bin/monitorctl.sh start Starting monitoring 2010-11-22 14:23:34+01:00 ... [26571] Monitoring started. + SELENIUM_PATH=/opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium + SUITES='suite1 suite2 suite-webengine' + HIDE_FF=true + URL=http://127.0.0.1:8080/nuxeo/ + /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/run.sh +++ dirname /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/run.sh ++ cd /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium ++ pwd -P + HERE=/opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium + '[' -r /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/run.conf ']' + HIDE_FF=true + SUITES='suite1 suite2 suite-webengine' + URL=http://127.0.0.1:8080/nuxeo/ + cd /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium + mvn dependency:copy [INFO] Scanning for projects... [INFO] ------------------------------------------------------------------------ [INFO] Building Utility POM for running Selenium tests [INFO] task-segment: [dependency:copy] [INFO] ------------------------------------------------------------------------ [INFO] [dependency:copy {execution: default-cli}] [INFO] Configured Artifact: org.seleniumhq.selenium.server:selenium-server:standalone:1.0.3:jar [INFO] org.seleniumhq.selenium.server:selenium-server:standalone:1.0.3:jar already exists in /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESSFUL [INFO] ------------------------------------------------------------------------ [INFO] Total time: 3 seconds [INFO] Finished at: Mon Nov 22 14:23:44 CET 2010 [INFO] Final Memory: 20M/244M [INFO] ------------------------------------------------------------------------ + CMD='java -jar selenium-server.jar -port 14440 -timeout 7200 -htmlSuite *chrome http://127.0.0.1:8080/nuxeo/ ' + '[' '!' -z true ']' + export DISPLAY=:1 + DISPLAY=:1 + CMD_END='-firefoxProfileTemplate ffprofile -userExtensions user-extensions.js' + rm -rf /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite1.html /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite2.html /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html + cd /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium + sed s,/path/to/project-ear/ftest/selenium,/opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium,g + sed 's,\(capability.principal.codebase.p0.id...\).*$,\1"http://127.0.0.1:8080/nuxeo/");,g' + '[' '!' -z true ']' + echo '// do not load images' + echo 'user_pref("permissions.default.image", 2);' + exit_code=0 + for suite in '$SUITES' + echo '### [INFO] Running test suite suite1 ...' ### [INFO] Running test suite suite1 ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -htmlSuite '*chrome' http://127.0.0.1:8080/nuxeo/ /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite1.html /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite1.html -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 14:23:45.005 INFO - Java: Sun Microsystems Inc. 16.3-b01 14:23:45.007 INFO - OS: Linux 2.6.26-2-amd64 amd64 14:23:45.015 INFO - v2.0 [a2], with Core v2.0 [a2] 14:23:45.152 INFO - RemoteWebDriver instances should connect to: http://10.213.0.59:14440/wd/hub 14:23:45.153 INFO - Version Jetty/5.1.x 14:23:45.154 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 14:23:45.155 INFO - Started HttpContext[/selenium-server,/selenium-server] 14:23:45.155 INFO - Started HttpContext[/,/] 14:23:45.230 INFO - Started org.openqa.jetty.jetty.servlet.servlethand...@7a148bd3 14:23:45.230 INFO - Started HttpContext[/wd,/wd] 14:23:45.234 INFO - Started SocketListener on 0.0.0.0:14440 14:23:45.234 INFO - Started org.openqa.jetty.jetty.ser...@593d93f4 14:23:45.382 INFO - Preparing Firefox profile... 14:23:47.447 INFO - Launching Firefox... 14:23:48.090 INFO - Checking Resource aliases 14:28:54.371 INFO - Checking Resource aliases 14:28:54.372 INFO - Received posted results 14:28:55.051 INFO - Killing Firefox... + '[' 0 '!=' 0 ']' + echo '### [INFO] suite1 TEST SUCCESSFUL' ### [INFO] suite1 TEST SUCCESSFUL + sleep 5 + for suite in '$SUITES' + echo '### [INFO] Running test suite suite2 ...' ### [INFO] Running test suite suite2 ... + java -jar selenium-server.jar -port 14440 -timeout 7200 -htmlSuite '*chrome' http://127.0.0.1:8080/nuxeo/ /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite2.html /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite2.html -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 14:29:00.756 INFO - Java: Sun Microsystems Inc. 16.3-b01 14:29:00.757 INFO - OS: Linux 2.6.26-2-amd64 amd64 14:29:00.765 INFO - v2.0 [a2], with Core v2.0 [a2] 14:29:00.854 INFO - RemoteWebDriver instances should connect to: http://10.213.0.59:14440/wd/hub 14:29:00.855 INFO - Version Jetty/5.1.x 14:29:00.856 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 14:29:00.857 INFO - Started HttpContext[/selenium-server,/selenium-server] 14:29:00.857 INFO - Started HttpContext[/,/] 14:29:00.917 INFO - Started org.openqa.jetty.jetty.servlet.servlethand...@7a148bd3 14:29:00.917 INFO - Started HttpContext[/wd,/wd] 14:29:00.920 INFO - Started SocketListener on 0.0.0.0:14440 14:29:00.920 INFO - Started org.openqa.jetty.jetty.ser...@5cdf8f5e 14:29:01.036 INFO - Preparing Firefox profile... 14:29:03.102 INFO - Launching Firefox... 14:29:03.600 INFO - Checking Resource aliases 14:43:08.485 INFO - Checking Resource aliases 14:43:08.486 INFO - Received posted results 14:43:08.936 INFO - Killing Firefox... Tests failed, see result file for details: /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite2.html + '[' 1 '!=' 0 ']' + echo '### [ERROR] suite2 TEST FAILURE' ### [ERROR] suite2 TEST FAILURE + exit_code=9 + sleep 5 + for suite in '$SUITES' + 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://127.0.0.1:8080/nuxeo/ /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine.html /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js 14:43:14.908 INFO - Java: Sun Microsystems Inc. 16.3-b01 14:43:14.910 INFO - OS: Linux 2.6.26-2-amd64 amd64 14:43:14.917 INFO - v2.0 [a2], with Core v2.0 [a2] 14:43:15.008 INFO - RemoteWebDriver instances should connect to: http://10.213.0.59:14440/wd/hub 14:43:15.009 INFO - Version Jetty/5.1.x 14:43:15.010 INFO - Started HttpContext[/selenium-server/driver,/selenium-server/driver] 14:43:15.011 INFO - Started HttpContext[/selenium-server,/selenium-server] 14:43:15.011 INFO - Started HttpContext[/,/] 14:43:15.068 INFO - Started org.openqa.jetty.jetty.servlet.servlethand...@60765a16 14:43:15.068 INFO - Started HttpContext[/wd,/wd] 14:43:15.071 INFO - Started SocketListener on 0.0.0.0:14440 14:43:15.072 INFO - Started org.openqa.jetty.jetty.ser...@5cdf8f5e 14:43:15.187 INFO - Preparing Firefox profile... 14:43:17.220 INFO - Launching Firefox... 14:43:17.863 INFO - Checking Resource aliases 14:43:25.816 INFO - Checking Resource aliases 14:43:25.817 INFO - Received posted results 14:43:26.240 INFO - Killing Firefox... 14:43:26.263 INFO - Shutting down... + '[' 0 '!=' 0 ']' + echo '### [INFO] suite-webengine TEST SUCCESSFUL' ### [INFO] suite-webengine TEST SUCCESSFUL + sleep 5 + '[' 9 '!=' 0 ']' + echo '### [ERROR] TESTS FAILURE' ### [ERROR] TESTS FAILURE + exit 9 + ret1=9 + stop_server + SERVER_HOME=/opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss + /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/bin/monitorctl.sh stop Stopping monitoring 2010-11-22 14:43:31+01:00 ... Monitoring stopped. Archiving log ... Done: /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/log-20101122-134335.tgz + /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/bin/nuxeoctl stop .....Nuxeo stopped. + '[' '!' -z ']' + echo '### 10 most frequent errors --------------' ### 10 most frequent errors -------------- + grep ' ERROR \[' /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/server.log + sed 's/^.\{24\}//g' + sort + uniq -c + sort -nr + head 5 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 5 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 5 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 5 ERROR [nuxeo-error-log] 5 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 5 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] + echo '### 10 first errors ----------------------' ### 10 first errors ---------------------- + grep -nTm 10 ' ERROR ' /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/server.log 1633 :2010-11-22 14:41:28,278 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 1786 :2010-11-22 14:41:28,280 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 2091 :2010-11-22 14:41:28,341 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 2244 :2010-11-22 14:41:28,347 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2397 :2010-11-22 14:41:28,348 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2550 :2010-11-22 14:41:28,352 ERROR [nuxeo-error-log] 2745 :2010-11-22 14:41:40,658 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 2898 :2010-11-22 14:41:40,660 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 3203 :2010-11-22 14:41:40,667 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 3356 :2010-11-22 14:41:40,668 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager + echo '### --------------------------------------' ### -------------------------------------- + gzip /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/boot.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/console.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/gc.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/jvm.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/nuxeo-ds.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/nuxeo-error.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/server.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/stderr.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/sysstat-sar.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/vcs-ds.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/webrequests.log /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/webthreads.log + gzip -cd /opt/hudson/tmp/workspace/FT-nuxeo-5.4-selenium-cap-jboss/trunk/jboss/log/server.log.gz + '[' 9 -eq 0 ']' + exit 9 Archiving artifacts Publishing Selenium report... Test failures: 2 Test totals : 87 ------------------------ Command Passes : 1477 Command Failures : 4 Command Errors : 1 Checking ^\d{4}-\d{2}-\d{2}.*ERROR.* <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-selenium-cap-jboss/399/artifact/trunk/jboss/log/server.log>: 2010-11-22 14:41:28,278 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 2010-11-22 14:41:28,280 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 2010-11-22 14:41:28,341 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 2010-11-22 14:41:28,347 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:41:28,348 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:41:28,352 ERROR [nuxeo-error-log] 2010-11-22 14:41:40,658 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 2010-11-22 14:41:40,660 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 2010-11-22 14:41:40,667 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 2010-11-22 14:41:40,668 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:41:40,669 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:41:40,670 ERROR [nuxeo-error-log] 2010-11-22 14:42:09,364 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 2010-11-22 14:42:09,365 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 2010-11-22 14:42:09,373 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 2010-11-22 14:42:09,374 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:42:09,374 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:42:09,375 ERROR [nuxeo-error-log] 2010-11-22 14:42:21,389 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 2010-11-22 14:42:21,391 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 2010-11-22 14:42:21,399 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 2010-11-22 14:42:21,400 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:42:21,400 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:42:21,402 ERROR [nuxeo-error-log] 2010-11-22 14:42:41,215 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 2010-11-22 14:42:41,217 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 2010-11-22 14:42:41,224 ERROR [org.ajax4jsf.webapp.BaseXMLFilter] Exception in the filter chain 2010-11-22 14:42:41,225 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:42:41,225 ERROR [nuxeo-error-log] javax.servlet.ServletException: @In attribute requires non-null value: typesTool.typeManager 2010-11-22 14:42:41,227 ERROR [nuxeo-error-log] _______________________________________________ ECM-QA mailing list [email protected] http://lists.nuxeo.com/mailman/listinfo/ecm-qa
