See <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/changes>
Changes: [mguillaume] Add delays between requests to nexus-sync ------------------------------------------ [...truncated 1829 lines...] + chmod u+x <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/catalina.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/digest.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/monitorctl.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nxdeploy.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/run.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/setclasspath.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/shutdown.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/startup.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/tool-wrapper.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/version.sh> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/jbossctl> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeoctl> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/openofficectl> + '[' tomcat = jboss ']' + '[' tomcat = tomcat ']' + echo org.nuxeo.systemlog.token=dolog <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/integration-lib.sh>: line 179: <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/nxserver/config/selenium.properties>: No such file or directory + '[' '!' -z secret ']' + setup_postgresql_database + '[' 0 == 1 ']' + '[' -z secret ']' + DBNAME=qualiscope-ci-0 + DBPORT=5432 + DBUSER=qualiscope + DBHOST=localhost + find_postgresql_log + logs=("$PGSQL_LOG" "/var/log/pgsql" "/var/log/postgresql/postgresql-8.4-main.log" "/var/log/postgresql/postgresql-8.3-main.log") + (( i=0 )) + (( i<4 )) + '[' -f '' ']' + (( i++ )) + (( i<4 )) + '[' -f /var/log/pgsql ']' + PGSQL_LOG=/var/log/pgsql + return + echo '### Initializing PostgreSQL DATABASE: qualiscope-ci-0' ### Initializing PostgreSQL DATABASE: qualiscope-ci-0 + dropdb qualiscope-ci-0 -U qualiscope -h localhost -p 5432 + '[' 0 '!=' 0 ']' + createdb qualiscope-ci-0 -U qualiscope -h localhost -p 5432 + createlang plpgsql qualiscope-ci-0 -U qualiscope -h localhost -p 5432 createlang: language "plpgsql" is already installed in database "qualiscope-ci-0" + NUXEO_CONF=<https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + activate_db_template postgresql + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + db=postgresql + get_templates_list + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' ++ grep -E '^#?nuxeo.templates=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ perl -p -e 's/^#?nuxeo.templates=//' ++ tr , ' ' + templates='default monitor' + newtemplates= + for t in '$templates' + '[' default = default ']' + t=postgresql + '[' '!' -z ']' + newtemplates+=postgresql + for t in '$templates' + '[' monitor = default ']' + '[' '!' -z postgresql ']' + newtemplates+=, + newtemplates+=monitor + perl -p -i -e 's/^#?nuxeo.templates=.*$/nuxeo.templates=postgresql,monitor/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + set_key_value nuxeo.db.port 5432 + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + '[' 2 '!=' 2 ']' + key=nuxeo.db.port + value=5432 ++ grep -E '^#?nuxeo.db.port=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ wc -l + has_key=1 + '[' 1 = 0 ']' + perl -p -i -e 's/^#?nuxeo.db.port=.*$/nuxeo.db.port=5432/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + set_key_value nuxeo.db.name qualiscope-ci-0 + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + '[' 2 '!=' 2 ']' + key=nuxeo.db.name + value=qualiscope-ci-0 ++ grep -E '^#?nuxeo.db.name=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ wc -l + has_key=1 + '[' 1 = 0 ']' + perl -p -i -e 's/^#?nuxeo.db.name=.*$/nuxeo.db.name=qualiscope-ci-0/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + set_key_value nuxeo.db.user qualiscope + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + '[' 2 '!=' 2 ']' + key=nuxeo.db.user + value=qualiscope ++ grep -E '^#?nuxeo.db.user=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ wc -l + has_key=1 + '[' 1 = 0 ']' + perl -p -i -e 's/^#?nuxeo.db.user=.*$/nuxeo.db.user=qualiscope/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + set_key_value nuxeo.db.password secret + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + '[' 2 '!=' 2 ']' + key=nuxeo.db.password + value=secret ++ grep -E '^#?nuxeo.db.password=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ wc -l + has_key=1 + '[' 1 = 0 ']' + perl -p -i -e 's/^#?nuxeo.db.password=.*$/nuxeo.db.password=secret/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + set_key_value nuxeo.db.max-pool-size 40 + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + '[' 2 '!=' 2 ']' + key=nuxeo.db.max-pool-size + value=40 ++ grep -E '^#?nuxeo.db.max-pool-size=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ wc -l + has_key=1 + '[' 1 = 0 ']' + perl -p -i -e 's/^#?nuxeo.db.max-pool-size=.*$/nuxeo.db.max-pool-size=40/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + set_key_value nuxeo.vcs.max-pool-size 40 + '[' -z <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ']' + '[' 2 '!=' 2 ']' + key=nuxeo.vcs.max-pool-size + value=40 ++ grep -E '^#?nuxeo.vcs.max-pool-size=' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> ++ wc -l + has_key=1 + '[' 1 = 0 ']' + perl -p -i -e 's/^#?nuxeo.vcs.max-pool-size=.*$/nuxeo.vcs.max-pool-size=40/g' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeo.conf> + cat + 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' ++ lsof -n -i [email protected]:14440 ++ grep '(LISTEN)' ++ awk '{print $2}' + RUNNING_PID= + '[' '!' -z ']' + <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeoctl> start Starting Nuxeo... (pressing Ctrl+C will interrupt starting process) ................................07:10:59,898 INFO [OSGiRuntimeService] Nuxeo EP Started ====================================================================== = Nuxeo EP Started ====================================================================== = Component Loading Status: Pending: 0 / Unstarted: 0 / Total: 388 ====================================================================== = Component Loading Status: Pending: 0 / Unstarted: 0 / Total: 388 + <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/monitorctl.sh> start Starting monitoring 2011-01-13 07:11:02+01:00 ... [21440] Monitoring started. + echo 'Benching nuxeo ep ...' Benching nuxeo ep ... + test_path=<https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/> + cd <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/> + make bench-long 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 7.560s OK fl-run-test -v --simple-fetch test_nuxeo.py -e testInit --no-color testInit (test_nuxeo.Nuxeo) ... FAIL ====================================================================== FAIL: testInit (test_nuxeo.Nuxeo) ---------------------------------------------------------------------- Traceback (most recent call last): File "build/bdist.linux-i686/egg/funkload/FunkLoadTestCase.py", line 897, in __call__ testMethod() File "<https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/test_nuxeo.py";,> line 49, in testInit p = LoginPage(self).login(self.cred_admin[0], self.cred_admin[1]) File "<https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/ftest/funkload/nuxeo/pages.py";,> line 101, in login fl.assert_(fl.listHref(content_pattern="Log out"), File "build/bdist.linux-i686/egg/funkload/FunkLoadTestCase.py", line 595, in listHref a_links = response.getDOM().getByName('a') File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/webunittest.py", line 542, in getDOM parser.parseString(self.body) File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/SimpleDOM.py", line 330, in parseString self.feed(data) File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/HTMLParser.py", line 115, in feed self.goahead(0) File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/HTMLParser.py", line 174, in goahead k = self.parse_endtag(i) File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/HTMLParser.py", line 390, in parse_endtag self.handle_endtag(string.lower(tag)) File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/SimpleDOM.py", line 370, in handle_endtag self.close_enclosed_tags(tag) File "/usr/local/lib/python2.6/dist-packages/webunit-1.3.9-py2.6.egg/webunit/SimpleDOM.py", line 400, in close_enclosed_tags raise NestingError(self.tagstack, tag, self.getpos()) NestingError: Open tags <html>, <body>, <table>, <tr>, <td> do not match close tag </div>, at line 343, column 7 ---------------------------------------------------------------------- Ran 1 test in 2.439s FAILED (failures=1) make: *** [init] Error 1 + ret=2 + make stop fl-monitor-ctl monitor.conf stop Server http://localhost:55502/ is stopped. fl-credential-ctl credential.conf stop Server http://localhost:55501/ is stopped. + exit 2 + ret1=2 + mv <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/nuxeo-distribution-5.4/nuxeo-distribution-dm/target/ftest/funkload/report> . + stop_server + SERVER_HOME=<https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat> + <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/monitorctl.sh> stop Stopping monitoring 2011-01-13 07:11:20+01: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/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/log-20110113-061122.tgz> + <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/nuxeoctl> stop ..Nuxeo stopped. + '[' '!' -z secret ']' + <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/ws/trunk/tomcat/bin/monitorctl.sh> vacuumdb Vacuuming qualiscope-ci-0 2011-01-13 07:11:26+01:00 ... Reindexing qualiscope-ci-0 2011-01-13 07:11:28+01:00 ... Done 2011-01-13 07:11:30+01:00 + echo '### 10 most frequent errors --------------' ### 10 most frequent errors -------------- + grep ' ERROR \[' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/server.log> + sed 's/^.\{24\}//g' + sort + uniq -c + sort -nr + head 1 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] java.net.MalformedURLException: unknown protocol: nxtheme 1 ERROR [nuxeo-error-log] java.net.MalformedURLException: unknown protocol: nxtheme 1 ERROR [nuxeo-error-log] 1 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 1 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] + echo '### 10 first errors ----------------------' ### 10 first errors ---------------------- + grep -nTm 10 ' ERROR ' <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/server.log> 483 :2011-01-13 07:11:19,280 ERROR [facelets.viewhandler] Error Rendering View[/view_documents.xhtml] 559 :2011-01-13 07:11:19,283 ERROR [javax.enterprise.resource.webcontainer.jsf.lifecycle] jsf.lifecycle.phase.exception 638 :2011-01-13 07:11:19,315 ERROR [org.nuxeo.ecm.platform.web.common.exceptionhandling.DefaultNuxeoExceptionHandler] java.net.MalformedURLException: unknown protocol: nxtheme 714 :2011-01-13 07:11:19,315 ERROR [nuxeo-error-log] java.net.MalformedURLException: unknown protocol: nxtheme 790 :2011-01-13 07:11:19,319 ERROR [nuxeo-error-log] + echo '### --------------------------------------' ### -------------------------------------- + gzip <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/console.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/gc.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/nuxeo-error.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/pgsql.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/reindexdb.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/server.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/stderr.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/sysstat-sar.log> <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/vacuum.log> + gzip -cd <https://qa.nuxeo.org/hudson/job/FT-nuxeo-5.4-funkload-bench/764/artifact/trunk/tomcat/log/server.log.gz> + '[' 2 -eq 0 ']' + exit 9 Archiving artifacts _______________________________________________ ECM-QA mailing list [email protected] http://lists.nuxeo.com/mailman/listinfo/ecm-qa
