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

------------------------------------------
[...truncated 1007 lines...]
+ [ 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-I20110720_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/147/artifact/trunk/nuxeo-5.4.3-I20110720_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/results/result-suite-webengine.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
07:35:35.163 INFO - Java: Sun Microsystems Inc. 19.1-b02
07:35:35.164 INFO - OS: Linux 2.6.32-30-generic-pae i386
07:35:35.169 INFO - v2.0 [b3], with Core v2.0 [b3]
07:35:35.273 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
07:35:35.275 INFO - Version Jetty/5.1.x
07:35:35.275 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
07:35:35.276 INFO - Started HttpContext[/selenium-server,/selenium-server]
07:35:35.276 INFO - Started HttpContext[/,/]
07:35:55.487 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@1be0f0a
07:35:55.488 INFO - Started HttpContext[/wd,/wd]
07:35:55.491 INFO - Started SocketListener on 0.0.0.0:14440
07:35:55.492 INFO - Started org.openqa.jetty.jetty.Server@1cdeff
07:35:55.588 INFO - Preparing Firefox profile...
07:35:57.864 INFO - Launching Firefox...
07:35:58.578 INFO - Checking Resource aliases
07:36:03.007 INFO - Checking Resource aliases
07:36:03.008 INFO - Received posted results
07:36:03.367 INFO - Killing Firefox...
07:36:03.422 INFO - Shutting down...
07:36:03.423 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-5.4.3-I20110720_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/147/artifact/trunk/nuxeo-5.4.3-I20110720_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/results/result-suite-webengine-website.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
07:36:09.128 INFO - Java: Sun Microsystems Inc. 19.1-b02
07:36:09.130 INFO - OS: Linux 2.6.32-30-generic-pae i386
07:36:09.135 INFO - v2.0 [b3], with Core v2.0 [b3]
07:36:09.243 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
07:36:09.244 INFO - Version Jetty/5.1.x
07:36:09.245 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
07:36:09.246 INFO - Started HttpContext[/selenium-server,/selenium-server]
07:36:09.246 INFO - Started HttpContext[/,/]
07:36:25.643 INFO - Started 
org.openqa.jetty.jetty.servlet.ServletHandler@1df280b
07:36:25.643 INFO - Started HttpContext[/wd,/wd]
07:36:25.654 INFO - Started SocketListener on 0.0.0.0:14440
07:36:25.654 INFO - Started org.openqa.jetty.jetty.Server@1cdeff
07:36:25.775 INFO - Preparing Firefox profile...
07:36:28.069 INFO - Launching Firefox...
07:36:28.755 INFO - Checking Resource aliases
07:37:10.901 INFO - Checking Resource aliases
07:37:10.902 INFO - Received posted results
07:37:11.082 INFO - Killing Firefox...
07:37:11.194 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-jboss-oracle11/ws/trunk/nuxeo-5.4.3-I20110720_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/147/artifact/trunk/nuxeo-5.4.3-I20110720_0115/nuxeo-distribution/nuxeo-distribution-dm/ftest/selenium/results/result-suite-webengine-tags.html>
 -firefoxProfileTemplate ffprofile -userExtensions user-extensions.js
07:37:16.974 INFO - Java: Sun Microsystems Inc. 19.1-b02
07:37:16.975 INFO - OS: Linux 2.6.32-30-generic-pae i386
07:37:16.980 INFO - v2.0 [b3], with Core v2.0 [b3]
07:37:17.085 INFO - RemoteWebDriver instances should connect to: 
http://127.0.0.1:14440/wd/hub
07:37:17.086 INFO - Version Jetty/5.1.x
07:37:17.086 INFO - Started 
HttpContext[/selenium-server/driver,/selenium-server/driver]
07:37:17.087 INFO - Started HttpContext[/selenium-server,/selenium-server]
07:37:17.087 INFO - Started HttpContext[/,/]
07:37:17.102 INFO - Started org.openqa.jetty.jetty.servlet.ServletHandler@a1d1f4
07:37:17.102 INFO - Started HttpContext[/wd,/wd]
07:37:17.105 INFO - Started SocketListener on 0.0.0.0:14440
07:37:17.106 INFO - Started org.openqa.jetty.jetty.Server@1cdeff
07:37:17.199 INFO - Preparing Firefox profile...
07:37:19.418 INFO - Launching Firefox...
07:37:20.072 INFO - Checking Resource aliases
07:37:38.294 INFO - Checking Resource aliases
07:37:38.295 INFO - Received posted results
07:37:38.930 INFO - Killing Firefox...
07:37:38.994 INFO - Shutting down...
07:37:38.995 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-I20110720_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.013s

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

----------------------------------------------------------------------
Ran 1 test in 1.477s

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

----------------------------------------------------------------------
Ran 1 test in 0.659s

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

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

----------------------------------------------------------------------
Ran 1 test in 13.346s

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

----------------------------------------------------------------------
Ran 1 test in 13.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.711s

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

----------------------------------------------------------------------
Ran 1 test in 1.934s

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.478s

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-07-20 07:39:21+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: (23506) - No such process
Monitoring stopped.
Archiving log ...
Done: 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/log-20110720-053926.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 
23217...
+ '[' '!' -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-oracle11/147/artifact/trunk/jboss/log/server.log>
+ sort -nr
     12 ERROR [org.jboss.seam.jsf.SeamPhaseListener] swallowing exception
     10 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 963f4c56-3521-465a-9985-23b739716c9e
      6 ERROR [org.nuxeo.ecm.core.event.impl.ReconnectedEventBundleImpl] Can 
not refetch Doc with ref 8d1b1e66-fb0e-4464-88db-b0823066c0f6
      5 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: 
Resetting connection
      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, 
49455510248484849484958974854525852101505454524898584956995655102484848494849589748545258521015054545248985849569998
 >
      2 ERROR [org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on 
< 131075, 29, 27, 
49455510248484849484958974854525852101505454524898584956575355102484848494849589748545258521015054545248985849565756
 >
+ 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/147/artifact/trunk/jboss/log/server.log>
1924    :2011-07-20 07:19:56,272 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: Resetting connection
2184    :2011-07-20 07:20:07,544 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
49455510248484849484958974854525852101505454524898584955975155102484848494849589748545258521015054545248985849559754
 >
2390    :2011-07-20 07:20:07,566 ERROR [org.jboss.seam.jsf.SeamPhaseListener] 
swallowing exception
2491    :2011-07-20 07:20:16,697 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: Resetting connection
2751    :2011-07-20 07:21:07,603 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
49455510248484849484958974854525852101505454524898584956575355102484848494849589748545258521015054545248985849565756
 >
2863    :2011-07-20 07:21:07,612 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
49455510248484849484958974854525852101505454524898584956575355102484848494849589748545258521015054545248985849565756
 >
3072    :2011-07-20 07:21:07,621 ERROR [org.jboss.seam.jsf.SeamPhaseListener] 
swallowing exception
3171    :2011-07-20 07:21:11,070 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCLogger] (6) SQL: Resetting connection
3431    :2011-07-20 07:22:11,672 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
49455510248484849484958974854525852101505454524898584956995655102484848494849589748545258521015054545248985849569998
 >
3543    :2011-07-20 07:22:11,675 ERROR 
[org.nuxeo.ecm.core.storage.sql.jdbc.JDBCMapper] XA end error on < 131075, 29, 
27, 
49455510248484849484958974854525852101505454524898584956995655102484848494849589748545258521015054545248985849569998
 >
+ echo '### --------------------------------------'
### --------------------------------------
+ gzip 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/boot.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/console.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/gc.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/jmxstat.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/jvm.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/nuxeoctl.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/nuxeo-ds.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/nuxeo-error.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/t
 runk/jboss/log/server.log> 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/stderr.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/sysstat-sar.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/vcs-ds.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/webrequests.log>
 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/webthreads.log>
+ gzip -cd 
<https://qa.nuxeo.org/jenkins/job/IT-nuxeo-5.4-tests-dm-jboss-oracle11/147/artifact/trunk/jboss/log/server.log.gz>
+ '[' 9 -eq 0 -a 0 -eq 0 ']'
+ exit 9
Build step 'Execute shell' marked build as failure
Archiving artifacts
Publishing Selenium report...
  Test failures: 32
  Test totals  : 107
------------------------
  Command Passes   : 990
  Command Failures : 31
  Command Errors   : 30

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

Reply via email to