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

------------------------------------------
[...truncated 976 lines...]
07:42:06.230 INFO - Started SocketListener on 0.0.0.0:14440
07:42:06.230 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
07:42:06.324 INFO - Preparing Firefox profile...
07:42:08.878 INFO - Launching Firefox...
07:42:09.538 INFO - Checking Resource aliases
07:42:14.393 INFO - Checking Resource aliases
07:42:14.394 INFO - Received posted results
07:42:14.883 INFO - Killing Firefox...
Tests failed, see result file for details: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-dm.html>
07:42:14.958 INFO - Shutting down...
07:42:14.959 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-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-oracle11/107/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
07:42:20.636 INFO - Java: Sun Microsystems Inc. 19.1-b02
07:42:20.638 INFO - OS: Linux 2.6.32-28-generic-pae i386
07:42:20.642 INFO - v2.0 [b1], with Core v2.0 [b1]
07:42:20.745 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
07:42:20.746 INFO - Version Jetty/5.1.x
07:42:20.746 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
07:42:20.747 INFO - Started HttpContext[/selenium-server,/selenium-server]
07:42:20.747 INFO - Started HttpContext[/,/]
07:42:41.226 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37
07:42:41.226 INFO - Started HttpContext[/wd,/wd]
07:42:41.231 INFO - Started SocketListener on 0.0.0.0:14440
07:42:41.231 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
07:42:41.322 INFO - Preparing Firefox profile...
07:42:43.580 INFO - Launching Firefox...
07:42:44.219 INFO - Checking Resource aliases
07:42:50.453 INFO - Checking Resource aliases
07:42:50.454 INFO - Received posted results
07:42:51.087 INFO - Killing Firefox...
07:42:51.145 INFO - Shutting down...
07:42:51.151 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-jboss-oracle11/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-oracle11/107/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-website.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
07:42:56.608 INFO - Java: Sun Microsystems Inc. 19.1-b02
07:42:56.609 INFO - OS: Linux 2.6.32-28-generic-pae i386
07:42:56.614 INFO - v2.0 [b1], with Core v2.0 [b1]
07:42:56.716 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
07:42:56.717 INFO - Version Jetty/5.1.x
07:42:56.718 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
07:42:56.719 INFO - Started HttpContext[/selenium-server,/selenium-server]
07:42:56.719 INFO - Started HttpContext[/,/]
07:42:56.732 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@110fe28
07:42:56.732 INFO - Started HttpContext[/wd,/wd]
07:42:56.736 INFO - Started SocketListener on 0.0.0.0:14440
07:42:56.736 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
07:42:56.824 INFO - Preparing Firefox profile...
07:42:59.030 INFO - Launching Firefox...
07:42:59.647 INFO - Checking Resource aliases
07:43:45.892 INFO - Checking Resource aliases
07:43:45.893 INFO - Received posted results
07:43:46.549 INFO - Killing Firefox...
07:43:46.663 INFO - Shutting down...
07:43:46.664 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-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-oracle11/107/artifact/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/selenium/result-suite-webengine-tags.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
07:43:52.427 INFO - Java: Sun Microsystems Inc. 19.1-b02
07:43:52.428 INFO - OS: Linux 2.6.32-28-generic-pae i386
07:43:52.433 INFO - v2.0 [b1], with Core v2.0 [b1]
07:43:52.541 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
07:43:52.542 INFO - Version Jetty/5.1.x
07:43:52.542 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
07:43:52.543 INFO - Started HttpContext[/selenium-server,/selenium-server]
07:43:52.543 INFO - Started HttpContext[/,/]
07:44:12.671 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@1d64c37
07:44:12.672 INFO - Started HttpContext[/wd,/wd]
07:44:12.681 INFO - Started SocketListener on 0.0.0.0:14440
07:44:12.681 INFO - Started org.openqa.jetty.jetty.Server@116ab4e
07:44:12.771 INFO - Preparing Firefox profile...
07:44:15.055 INFO - Launching Firefox...
07:44:15.676 INFO - Checking Resource aliases
07:44:33.073 INFO - Checking Resource aliases
07:44:33.074 INFO - Received posted results
07:44:33.564 INFO - Killing Firefox...
07:44:33.622 INFO - Shutting down...
07:44:33.623 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-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.027s

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

----------------------------------------------------------------------
Ran 1 test in 1.688s

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

----------------------------------------------------------------------
Ran 1 test in 0.971s

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

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

----------------------------------------------------------------------
Ran 1 test in 22.572s

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

----------------------------------------------------------------------
Ran 1 test in 15.603s

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

----------------------------------------------------------------------
Ran 1 test in 3.547s

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

----------------------------------------------------------------------
Ran 1 test in 2.489s

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: bad substitution
Stopping monitoring 2011-04-29 07:45:57+02:00 ...
Monitoring stopped.
Archiving log ...
Done: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/log-20110429-054603.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 
-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>
 -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 
19987...
+ '[' '!' -z ']'
+ echo '### 10 most frequent errors --------------'
### 10 most frequent errors --------------
+ sort
+ grep ' ERROR \[' 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/server.log>
+ head
+ uniq -c
+ sort -nr
+ sed 's/^.\{24\}//g'
      9 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception
      7 ERROR [nuxeo-error-log] 
      6 ERROR [org.nuxeo.ecm.core.event.impl.ReconnectedEventBundleImpl] Can 
not refetch Doc with ref 5dc8d99b-a073-4af4-a147-21e6ec4df645
      6 ERROR [org.nuxeo.ecm.core.event.impl.ReconnectedEventBundleImpl] Can 
not refetch Doc with ref 442467aa-9371-46b1-b008-771e7c651898
      6 ERROR 
[org.apache.catalina.core.ContainerBase.[jboss.web].[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.core.storage.sql.jdbc.JDBCMapper] XA end error on 
< 131075, 29, 27, 
494555102484848494849589850509758521009897525749555849979799551024848484948495898505097585210098975257495558499797102
 >
      2 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on 
< 131075, 29, 27, 
494555102484848494849589850509758521009897525749555849975598551024848484948495898505097585210098975257495558499755101
 >
      2 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: 
Resetting connection
+ 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/107/artifact/trunk/jboss/log/server.log>
1937    :2011-04-29 07:20:39,682 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: Resetting connection
2194    :2011-04-29 07:21:40,635 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589850509758521009897525749555849975598551024848484948495898505097585210098975257495558499755101
 >
2303    :2011-04-29 07:21:40,644 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589850509758521009897525749555849975598551024848484948495898505097585210098975257495558499755101
 >
2506    :2011-04-29 07:21:40,669 ERROR [org.jboss.seam.jsf.SeamPhaseListener] 
swallowing exception
2602    :2011-04-29 07:21:40,688 ERROR [org.jboss.seam.remoting.Remoting] Error
2666    :2011-04-29 07:21:44,396 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: Resetting connection
2923    :2011-04-29 07:22:39,696 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589850509758521009897525749555849979799551024848484948495898505097585210098975257495558499797102
 >
3032    :2011-04-29 07:22:39,699 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
494555102484848494849589850509758521009897525749555849979799551024848484948495898505097585210098975257495558499797102
 >
3235    :2011-04-29 07:22:39,704 ERROR [org.jboss.seam.jsf.SeamPhaseListener] 
swallowing exception
3331    :2011-04-29 07:22:39,731 ERROR [org.jboss.seam.remoting.Remoting] Error
+ echo '### --------------------------------------'
### --------------------------------------
+ gzip 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/boot.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/console.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/gc.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/jvm.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/nuxeo-ds.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/nuxeo-error.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/server.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/stderr.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trun
 k/jboss/log/sysstat-sar.log> 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/vcs-ds.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/webrequests.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/artifact/trunk/jboss/log/webthreads.log>
+ gzip -cd 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/107/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  : 107
------------------------
  Command Passes   : 989
  Command Failures : 35
  Command Errors   : 30

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

Reply via email to