See <https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/>

------------------------------------------
[...truncated 1012 lines...]
08:00:40.520 INFO - Shutting down...
08:00:40.521 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-jboss-oracle11/ws/trunk/nuxeo-5.4.3-I20110602_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine.html>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/nuxeo-5.4.3-I20110602_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
08:00:46.116 INFO - Java: Sun Microsystems Inc. 19.1-b02
08:00:46.117 INFO - OS: Linux 2.6.32-28-generic-pae i386
08:00:46.122 INFO - v2.0 [b1], with Core v2.0 [b1]
08:00:46.224 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
08:00:46.225 INFO - Version Jetty/5.1.x
08:00:46.226 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
08:00:46.227 INFO - Started HttpContext[/selenium-server,/selenium-server]
08:00:46.227 INFO - Started HttpContext[/,/]
08:01:09.343 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@25d2b2
08:01:09.344 INFO - Started HttpContext[/wd,/wd]
08:01:09.352 INFO - Started SocketListener on 0.0.0.0:14440
08:01:09.353 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
08:01:09.441 INFO - Preparing Firefox profile...
08:01:12.070 INFO - Launching Firefox...
08:01:12.703 INFO - Checking Resource aliases
08:01:19.796 INFO - Checking Resource aliases
08:01:19.797 INFO - Received posted results
08:01:20.074 INFO - Killing Firefox...
+ [ 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-jboss-oracle11/ws/trunk/nuxeo-5.4.3-I20110602_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine-website.html>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/nuxeo-5.4.3-I20110602_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-website.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
08:01:25.566 INFO - Java: Sun Microsystems Inc. 19.1-b02
08:01:25.567 INFO - OS: Linux 2.6.32-28-generic-pae i386
08:01:25.572 INFO - v2.0 [b1], with Core v2.0 [b1]
08:01:25.674 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
08:01:25.675 INFO - Version Jetty/5.1.x
08:01:25.676 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
08:01:25.677 INFO - Started HttpContext[/selenium-server,/selenium-server]
08:01:25.677 INFO - Started HttpContext[/,/]
08:01:42.337 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37
08:01:42.337 INFO - Started HttpContext[/wd,/wd]
08:01:42.344 INFO - Started SocketListener on 0.0.0.0:14440
08:01:42.345 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
08:01:42.432 INFO - Preparing Firefox profile...
08:01:44.732 INFO - Launching Firefox...
08:01:45.379 INFO - Checking Resource aliases
08:02:26.409 INFO - Checking Resource aliases
08:02:26.410 INFO - Received posted results
08:02:26.751 INFO - Killing Firefox...
08:02:26.899 INFO - Shutting down...
08:02:26.900 INFO - Stopping Acceptor 
ServerSocket[addr=0.0.0.0/0.0.0.0,port=0,localport=14440]
+ [ 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-jboss-oracle11/ws/trunk/nuxeo-5.4.3-I20110602_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/tests/suite-webengine-tags.html>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/nuxeo-5.4.3-I20110602_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-tags.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
08:02:32.572 INFO - Java: Sun Microsystems Inc. 19.1-b02
08:02:32.574 INFO - OS: Linux 2.6.32-28-generic-pae i386
08:02:32.579 INFO - v2.0 [b1], with Core v2.0 [b1]
08:02:32.714 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
08:02:32.716 INFO - Version Jetty/5.1.x
08:02:32.716 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
08:02:32.717 INFO - Started HttpContext[/selenium-server,/selenium-server]
08:02:32.718 INFO - Started HttpContext[/,/]
08:02:32.754 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@110fe28
08:02:32.754 INFO - Started HttpContext[/wd,/wd]
08:02:32.769 INFO - Started SocketListener on 0.0.0.0:14440
08:02:32.769 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
08:02:32.895 INFO - Preparing Firefox profile...
08:02:35.170 INFO - Launching Firefox...
08:02:35.794 INFO - Checking Resource aliases
08:02:52.082 INFO - Checking Resource aliases
08:02:52.082 INFO - Received posted results
08:02:52.675 INFO - Killing Firefox...
08:02:52.738 INFO - Shutting down...
08:02:52.739 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-jboss-oracle11/ws/trunk/nuxeo-5.4.3-I20110602_0115/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.033s

OK
fl-run-test -v --simple-fetch test_rest.py -e testWriter --no-color
testWriter (test_rest.Rest) ... ok

----------------------------------------------------------------------
Ran 1 test in 1.480s

OK
fl-run-test -v --simple-fetch test_rest.py -e testReader --no-color
testReader (test_rest.Rest) ... ok

----------------------------------------------------------------------
Ran 1 test in 0.651s

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 66.748s

OK
fl-run-test -v --simple-fetch test_nuxeo.py -e testInit --no-color
testInit (test_nuxeo.Nuxeo) ... ok

----------------------------------------------------------------------
Ran 1 test in 12.619s

OK
fl-run-test -v --simple-fetch test_nuxeo.py -e testWriter --no-color
testWriter (test_nuxeo.Nuxeo) ... ok

----------------------------------------------------------------------
Ran 1 test in 11.490s

OK
fl-run-test -v --simple-fetch test_nuxeo.py -e testReader --no-color
testReader (test_nuxeo.Nuxeo) ... ok

----------------------------------------------------------------------
Ran 1 test in 2.690s

OK
fl-run-test -v --simple-fetch test_webengine.py --no-color
test_testWebengine (test_webengine.Webengine) ... ok

----------------------------------------------------------------------
Ran 1 test in 2.240s

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 4.624s

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-oracle11/ws/trunk/jboss>
+ 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/bin/monitorctl.sh>
 stop
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/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 -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-02 08:04:45+02:00 ...
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/bin/monitorctl.sh>:
 line 414: kill: (32473) - No such process
Monitoring stopped.
Archiving log ...
Done: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/log-20110602-060501.tgz>
+ 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/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 
-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-jboss-oracle11/ws/trunk/jboss>
 
-Dnuxeo.conf=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/bin/nuxeo.conf>
 
-Dnuxeo.log.dir=<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/log>
 -jar 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/bin/nuxeo-launcher.jar>
 stop
Nuxeo home:          
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss>
Nuxeo configuration: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/bin/nuxeo.conf>
Include template: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/templates/common-deploydir>
Include template: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/templates/common-binding>
Include template: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/templates/common>
Include template: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/templates/oracle>
Include template: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/ws/trunk/jboss/templates/monitor>
Stopping server..................No answer from server, try to kill process 
32197...
+ '[' '!' -z ']'
+ echo '### 10 most frequent errors --------------'
### 10 most frequent errors --------------
+ sort -nr
+ sort
+ grep ' ERROR \[' 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/server.log>
+ head
+ uniq -c
+ sed 's/^.\{24\}//g'
     12 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception
     11 ERROR 
[org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/nuxeo]] 
Session event listener threw exception
      7 ERROR [nuxeo-error-log] 
      6 ERROR [org.nuxeo.ecm.core.event.impl.ReconnectedEventBundleImpl] Can 
not refetch Doc with ref 0ef4879e-9f53-49ac-81df-a46e8383aaa0
      6 ERROR [org.nuxeo.ecm.core.event.impl.ReconnectedEventBundleImpl] Can 
not refetch Doc with ref 07ec9077-f8b8-4a15-8b47-8c7edb4575cc
      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 [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (5) SQL: 
Resetting connection
      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.core.storage.sql.jdbc.JDBCMapper] XA end error on 
< 131075, 29, 27, 
494555102484848494849589956985158521001015550491015258495753555510248484849484958995698515852100101555049101525849575397
 >
      2 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on 
< 131075, 29, 27, 
494555102484848494849589956985158521001015550491015258495750555510248484849484958995698515852100101555049101525849575097
 >
+ echo '### 10 first errors ----------------------'
### 10 first errors ----------------------
+ grep -nTm 10 ' ERROR ' 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/server.log>
1962    :2011-06-02 07:44:58,289 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (5) SQL: Resetting connection
2222    :2011-06-02 07:45:15,344 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589956985158521001015550491015258495650565510248484849484958995698515852100101555049101525849565098
 >
2428    :2011-06-02 07:45:15,399 ERROR [org.jboss.seam.jsf.SeamPhaseListener] 
swallowing exception
2527    :2011-06-02 07:45:16,133 ERROR 
[org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/nuxeo]] 
Session event listener threw exception
2574    :2011-06-02 07:45:24,923 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (5) SQL: Resetting connection
2834    :2011-06-02 07:46:15,399 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589956985158521001015550491015258495750555510248484849484958995698515852100101555049101525849575097
 >
2946    :2011-06-02 07:46:15,570 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589956985158521001015550491015258495750555510248484849484958995698515852100101555049101525849575097
 >
3155    :2011-06-02 07:46:15,623 ERROR [org.jboss.seam.jsf.SeamPhaseListener] 
swallowing exception
3254    :2011-06-02 07:46:19,165 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (5) SQL: Resetting connection
3514    :2011-06-02 07:47:14,455 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589956985158521001015550491015258495753555510248484849484958995698515852100101555049101525849575397
 >
+ echo '### --------------------------------------'
### --------------------------------------
+ gzip 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/boot.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/console.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/gc.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/jmxstat.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/jvm.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/nuxeoctl.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/nuxeo-ds.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/nuxeo-error.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/t
 runk/jboss/log/server.log> 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/stderr.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/sysstat-sar.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/vcs-ds.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/webrequests.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/webthreads.log>
+ gzip -cd 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/119/artifact/trunk/jboss/log/server.log.gz>
+ '[' 9 -eq 0 -a 0 -eq 0 ']'
+ exit 9
Archiving artifacts
Publishing Selenium report...
  Test failures: 32
  Test totals  : 108
------------------------
  Command Passes   : 989
  Command Failures : 32
  Command Errors   : 30

_______________________________________________
ECM-QA mailing list
[email protected]
http://lists.nuxeo.com/mailman/listinfo/ecm-qa

Reply via email to