Build failed in Hudson: jboss-aop-head-jbossas-4.0.4.GA #27

See http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/27/... Changes: [stalep] test to verify ticket 257109 https://enterprise.redhat.com/issue-tracker/257109 ------------------------------------------ [...truncated 30242 lines...] + telnet localhost 8080 + TELNET=3914 + wait 3914 + grep -q '^HTTP/.* 200 OK$' + kill 3915 + (( 120 > 1618 - 1597 )) + grep -q '^HTTP/.* 200 OK$' + echo -e 'GET / HTTP/1.0\nConnection: close\n\n' + sleep 5 + telnet localhost 8080 + TELNET=3932 + wait 3932 + kill 3933 + (( 120 > 1623 - 1597 )) + echo -e 'GET / HTTP/1.0\nConnection: close\n\n' + sleep 5 + telnet localhost 8080 + TELNET=3963 + wait 3963 + grep -q '^HTTP/.* 200 OK$' + kill 3964 + (( 120 > 1628 - 1597 )) + echo -e 'GET / HTTP/1.0\nConnection: close\n\n' + sleep 5 + grep -q '^HTTP/.* 200 OK$' + telnet localhost 8080 + TELNET=3982 + wait 3982 /home/hudson/config_repository/scripts/function.d/start-jboss: line 115: 3981 Done ( echo -e "GET / HTTP/1.0\nConnection: close\n\n"; sleep $INT ) 3982 Terminated | telnet $JBOSS_SERVER_BIND_ADDR 8080 2> /dev/null + kill 3985 + (( 120 > 1634 - 1597 )) + telnet localhost 8080 + TELNET=4032 + wait 4032 + grep -q '^HTTP/.* 200 OK$' + echo -e 'GET / HTTP/1.0\nConnection: close\n\n' + sleep 5 /home/hudson/config_repository/scripts/function.d/start-jboss: line 115: 4030 Done ( echo -e "GET / HTTP/1.0\nConnection: close\n\n"; sleep $INT ) 4032 Terminated | telnet $JBOSS_SERVER_BIND_ADDR 8080 2> /dev/null + kill 4033 + (( 120 > 1639 - 1597 )) + echo -e 'GET / HTTP/1.0\nConnection: close\n\n' + sleep 5 + telnet localhost 8080 + TELNET=4068 + wait 4068 + grep -q '^HTTP/.* 200 OK$' + kill 4069 + exit 0 + echo Server started successfully. Server started successfully. + cd /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/testsuite + bash build.sh test -Dtest=aop -Dconfig=4.0.4.GA Searching for build.xml ... Buildfile: /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/testsuite/build.xml Overriding previous definition of reference to xdoclet.task.classpath test: [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/testsuite/output/log [junit] Running org.jboss.test.aop.test.AOPUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.AOPUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.ObservableUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.ObservableUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.RemotingUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.RemotingUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.ScopedUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.ScopedUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.SecurityUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.SecurityUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.SimpleBeanUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.SimpleBeanUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.TxLockUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.TxLockUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.TxUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.TxUnitTestCase FAILED (timeout) [junit] Running org.jboss.test.aop.test.VersionedObjectUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec [junit] Test org.jboss.test.aop.test.VersionedObjectUnitTestCase FAILED (timeout) BUILD SUCCESSFUL Total time: 45 minutes 9 seconds + stop-jboss -p /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all -b localhost + local flag= + local OPTIND=1 + getopts p:b:t:m: flag + case $flag in + local JBOSS_SHUTDOWN_PATH=/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all + getopts p:b:t:m: flag + case $flag in + local JBOSS_SERVER_BIND_ADDR=localhost + getopts p:b:t:m: flag + [[ -frs /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all ]] + [[ -frs /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/shutdown.sh ]] + [[ -frs /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/bin/shutdown.sh ]] + [[ -frs /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/../../bin/shutdown.sh ]] + JBOSS_SHUTDOWN_PATH=/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/../../bin/shutdown.sh + chmod 770 /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/../../bin/shutdown.sh + [[ -n localhost ]] + [[ -n '' ]] + local JBOSS_SERVER_SHUTDOWN_MODE=S + [[ '' -gt 0 ]] + local JBOSS_SERVER_TIMEOUT=90 + local 'STOP_OPTS=-S -s localhost:1099' + echo Stopping server on IP localhost Stopping server on IP localhost + echo With command '"/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/../../bin/shutdown.sh -S -s localhost:1099"' With command "/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/../../bin/shutdown.sh -S -s localhost:1099" + /qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/../../bin/shutdown.sh -S -s localhost:1099 Shutdown message has been posted to the server. Server shutdown may take a while - check logfiles for completion ++ exec ++ IFS== ++ read IP ServerLog ++ [[ localhost == \l\o\c\a\l\h\o\s\t ]] ++ LOG=http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA... ++ read IP ServerLog ++ echo http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + JBOSS_SERVER_LOG=http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbo... + echo Checking Log '"http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/server_all.log"' for shutdown. Checking Log "http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/server_all.log" for shutdown. + echo Timeout will be 90 seconds. Timeout will be 90 seconds. + local interval=5 + local i=0 + (( 0 < 90 )) + i=5 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 5 < 90 )) + i=10 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 10 < 90 )) + i=15 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 15 < 90 )) + i=20 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 20 < 90 )) + i=25 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 25 < 90 )) + i=30 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 30 < 90 )) + i=35 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 35 < 90 )) + i=40 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 40 < 90 )) + i=45 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 45 < 90 )) + i=50 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 50 < 90 )) + i=55 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 55 < 90 )) + i=60 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 60 < 90 )) + i=65 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 65 < 90 )) + i=70 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 70 < 90 )) + i=75 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 75 < 90 )) + i=80 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 80 < 90 )) + i=85 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 85 < 90 )) + i=90 ++ tail -1 http://hudson.qa.jboss.com/hudson/job/jboss-aop-head-jbossas-4.0.4.GA/ws/... + [[ 01:27:43,883 INFO [EJBDeployer] Undeploying: file:/qa/services/hudson/hudson_workspace/workspace/jboss-aop-head-jbossas-4.0.4.GA/jboss-4.0.4.GA-src/build/output/jboss-4.0.4.GA/server/all/tmp/deploy/tmp54187simpleejb.sar-contents/simpleejb.jar == \H\a\l\t\i\n\g\ \V\M ]] + sleep 5 + (( 90 < 90 )) + echo JBoss Instance cannot shutdown in time. Killing. JBoss Instance cannot shutdown in time. Killing. + kill-jboss ++ uname -s + [[ Linux == \L\i\n\u\x ]] + ps -eaf --columns 2200 + grep run.jar + grep -v grep + awk '{ print $2; }' + xargs kill + sleep 10 + ps -eaf --columns 2200 + grep run.jar + grep -v grep + awk '{ print $2; }' + xargs kill -9 + echo Exiting with a failure. Exiting with a failure. + return 1 Terminating xvnc [jboss-aop-head-jbossas-4.0.4.GA] $ vncserver -kill :29 Killing Xvnc process ID 32421 [jboss-aop-head-jbossas-4.0.4.GA] $ bash -xe /tmp/hudson3855040069740019758.sh + kill 32405 Recording test results