Build failed in Hudson: JBoss-AS-5.x-testSuite-sun16 #464

See http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/464/ch... Changes: [sguilhen(a)redhat.com] JBAS-7430: Upgraded JBoss Security to version 2.0.4.SP2 [smarlow(a)redhat.com] JBAS-7241 Update to Entity Manager 3.5 and JPA 2. Use ejb3-jpa-int 2.0.0-20091105.115912-8 [jim.ma] [JBAS-7418]:Added spring framework log category limit ------------------------------------------ [...truncated 20909 lines...] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 8.275 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.PersistentStoreMaxUnreplicatedIntervalTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 10.434 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.PersistentStoreMemoryLeakTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 8.849 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.PersistentStoreSessionCountUnitTestCase [junit] Tests run: 11, Failures: 0, Errors: 0, Time elapsed: 19.512 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.PersistentStoreSessionNotificationPolicyTestCase [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 10.303 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.ReplicationToPassivatedSessionUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 9.994 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.SessionBasedMaxUnreplicatedIntervalTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 22.66 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.SessionCountUnitTestCase [junit] Tests run: 27, Failures: 0, Errors: 0, Time elapsed: 145.467 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.SessionExpirationUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 6.223 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.SetNewSessionCookieUnitTestCase [junit] Tests run: 9, Failures: 0, Errors: 0, Time elapsed: 0.945 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.StoppedManagerUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 1.997 sec [junit] Running org.jboss.test.cluster.defaultcfg.simpleweb.test.TreeCacheSSOClusterManagerUnitTestCase [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 12.578 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.CacheManagerUnitTestCase [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 40.716 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.ChannelFactoryManagedObjectsTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 14.265 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.ClusterPartitionManagedObjectsTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 2.407 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.DRMTestCase [junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 103.059 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HAInvokerUnitTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 18.674 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HAServiceMBeanSupportUnitTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.523 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HAServiceUnitTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 3.117 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HASingletonControllerBeanUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 3.211 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HASingletonControllerUnitTestCase [junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 0.67 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HASingletonDeployerTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 12.501 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HASingletonElectionPolicyTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 10.327 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HASingletonSupportUnitTestCase [junit] Tests run: 13, Failures: 0, Errors: 0, Time elapsed: 0.594 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.HASingletonUnitTestCase [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 3.454 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.JChannelFactoryClassLoaderLeakTestCase [junit] Tests run: 9, Failures: 0, Errors: 0, Time elapsed: 19.206 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.JChannelFactoryOverrideUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.478 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.JChannelFactoryUnitTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 9.446 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.JRMPInvokerHaTransactionStickyUnitTestCase [junit] Tests run: 0, Failures: 0, Errors: 0, Time elapsed: 0.052 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.JRMPInvokerHaUnitTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.618 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.LookupSucceededFilterUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.531 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.OpenChannelsMapperUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.995 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.PartitionRestartUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 18.879 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.PreferredMasterElectionPolicyUnitTestCase [junit] Tests run: 9, Failures: 0, Errors: 0, Time elapsed: 0.756 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.ProtocolStackConfigurationsMapperUnitTestCase [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 0.514 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.RPCTestCase [junit] Tests run: 9, Failures: 0, Errors: 0, Time elapsed: 8.441 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.ReadWriteClusteredLockManagerUnitTestCase [junit] Tests run: 20, Failures: 0, Errors: 0, Time elapsed: 4.198 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.TruthfulResponseFilterUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 2.747 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.UnifiedInvokerHaTransactionStickyUnitTestCase [junit] Tests run: 13, Failures: 0, Errors: 0, Time elapsed: 0.502 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.UnifiedInvokerHaUnitTestCase [junit] Tests run: 6, Failures: 0, Errors: 0, Time elapsed: 4.378 sec [junit] Running org.jboss.test.cluster.defaultcfg.test.YieldingGloballyExclusiveClusterLockSupportUnitTestCase [junit] Tests run: 15, Failures: 0, Errors: 0, Time elapsed: 3.873 sec [junit] Running org.jboss.test.cluster.multicfg.ejb2.test.BeanUnitTestCase [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 7.933 sec [junit] Running org.jboss.test.cluster.multicfg.ejb2.test.CacheInvalidationUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 5.368 sec [junit] Running org.jboss.test.cluster.multicfg.ejb2.test.StatefulPassivationExpirationUnitTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 116.241 sec [junit] Running org.jboss.test.cluster.multicfg.test.DRMTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 3.344 sec [junit] Running org.jboss.test.cluster.multicfg.test.DistributedStateTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 13.233 sec [junit] Running org.jboss.test.cluster.multicfg.test.GlobalDiscoveryDisableTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 0.624 sec [junit] Running org.jboss.test.cluster.multicfg.test.HAJndiTestCase [junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 4.38 sec [junit] Running org.jboss.test.cluster.multicfg.test.HAPartitionStateTransferTestCase [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 16.84 sec [echo] Going to call target tests-clustering-unit for HTTP tests (ASYNC, no BR) tests-clustering-unit: [junit] Running org.jboss.test.cluster.defaultcfg.web.test.AttributeBasedSessionPassivationTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 34.915 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.CleanShutdownTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 16.598 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.CrossContextCallsTestCase [junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 18.137 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.PersistentManagerCrossContextCallsTestCase [junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 10.386 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.PersistentManagerUndeployTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 7.951 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.ScopedSetAttributeTestCase [junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 16.377 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.ScopedSetTriggerTestCase [junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 16.58 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.SessionEventTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 8.124 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.SessionPassivationTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 31.994 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.test.SessionTimestampTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 24.091 sec [junit] Running org.jboss.test.cluster.multicfg.web.test.ScopedAttrBasedTestCase [junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 16.054 sec [junit] Running org.jboss.test.cluster.multicfg.web.test.ScopedTestCase [junit] Tests run: 10, Failures: 0, Errors: 0, Time elapsed: 15.851 sec [junit] Running org.jboss.test.cluster.multicfg.web.test.UndeployAttrTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 14.438 sec [junit] Running org.jboss.test.cluster.multicfg.web.test.UndeployTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 14.282 sec [junit] Running org.jboss.test.cluster.multicfg.web.test.WebSessionTestCase [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 7.873 sec [echo] Going to call target tests-clustering-unit again for FIELD granularity tests (ASYNC, no BR) tests-clustering-unit: [junit] Running org.jboss.test.cluster.defaultcfg.web.field.test.FieldBasedSessionPassivationTestCase [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 46.503 sec [junit] Running org.jboss.test.cluster.defaultcfg.web.field.test.ScopedFieldBasedTestCase [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 27.298 sec [junit] Running org.jboss.test.cluster.multicfg.web.field.test.FieldBasedTestCase [junit] Tests run: 12, Failures: 0, Errors: 0, Time elapsed: 32.378 sec [junit] Running org.jboss.test.cluster.multicfg.web.field.test.StateTransferTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 11.731 sec [junit] Running org.jboss.test.cluster.multicfg.web.field.test.UndeployFieldTestCase [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 18.677 sec [server:stop] Shutting down server: cluster-udp-0 [server:stop] shutdownTimeout will be=120 [server:stop] Server stopped. [server:stop] Shutting down server: cluster-udp-1 [server:stop] shutdownTimeout will be=120 [server:stop] Server stopped. [echo] Going to call target tests-clustering-unit again with new configuration (SYNC, no BR) tests-clustering-sync-configure: [echo] creating cluster-udp-SYNC-0 config, jboss.dist=http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-s... [copy] Copying 512 files to http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... [copy] Copied 136 empty directories to 3 empty directories under http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... [echo] Overwriting config descriptors [copy] Warning: http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... not found. [echo] creating cluster-udp-SYNC-1 config, jboss.dist=http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-s... [copy] Copying 512 files to http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... [copy] Copied 136 empty directories to 3 empty directories under http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... [echo] Overwriting config descriptors [copy] Warning: http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... not found. [echo] Modifying the node0 and node1 Tomcat configuration for JK [echo] Giving a name to the Tomcat instance under http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... [echo] Giving a name to the Tomcat instance under http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... [server:start] Starting server "cluster-udp-SYNC-0", with command (start timeout is 240 seconds ): [server:start] /qa/tools/opt/jdk1.6.0_15/bin/java -cp http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... :/qa/tools/opt/jdk1.6.0_15/lib/tools.jar -Xms128m -Xmx512m -XX:MaxPermSize=512m -XX:+HeapDumpOnOutOfMemoryError -Djava.net.preferIPv4Stack=true -Djava.endorsed.dirs=http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBossAS_5_x/build/output/jboss-5.2.0.Beta1/lib/endorsed -Dresolve.dns=false -Djgroups.udp.ip_ttl=0 -Djboss.multiplexer.stack=udp-sync -Djboss.messaging.ServerPeerID=0 -Dxb.builder.useUnorderedSequence=true -Dnode0.bind.address=10.16.95.21 -Djboss.server.log.threshold=DEBUG -Djava.endorsed.dirs=http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBossAS_5_x/build/output/jboss-5.2.0.Beta1/lib/endorsed/ -Dxb.builder.useUnorderedSequence=true org.jboss.Main -c cluster-udp-SYNC-0 -b 10.16.95.21 -g DefaultPartition -u 227.43.89.223 [server:start] Server started. BUILD FAILED http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... :1016: The following error occurred while executing this line: http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... :108: The following error occurred while executing this line: http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/ws/JBo... :199: Error starting server "cluster-udp-SYNC-1": Found a process already listening on:http://10.16.95.22:8080 or jnp://10.16.95.22:1099 Total time: 129 minutes 40 seconds Testsuite shutdown hook found server "cluster-udp-SYNC-0" still running; stopping it. Shutting down server: cluster-udp-SYNC-0 Writing server thread dump to http://hudson.qa.jboss.com/hudson/job/JBoss-AS-5.x-testSuite-sun16/464/ar... Failed to shutdown server "cluster-udp-SYNC-0". Destroying the process. Testsuite shutdown hook failed to stop server(s) on shutdown. org.jboss.jbossas.servermanager.ServerShutdownException: Failed to shutdown server.Process was destroyed. at org.jboss.jbossas.servermanager.ServerController.stopServer(ServerController.java:497) at org.jboss.jbossas.servermanager.ServerManager$1.run(ServerManager.java:80) Caused by: javax.naming.NameNotFoundException: jmx not bound at org.jnp.server.NamingServer.getBinding(NamingServer.java:771) at org.jnp.server.NamingServer.getBinding(NamingServer.java:779) at org.jnp.server.NamingServer.getObject(NamingServer.java:785) at org.jnp.server.NamingServer.lookup(NamingServer.java:396) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) at java.lang.reflect.Method.invoke(Method.java:597) at sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:305) at sun.rmi.transport.Transport$1.run(Transport.java:159) at java.security.AccessController.doPrivileged(Native Method) at sun.rmi.transport.Transport.serviceCall(Transport.java:155) at sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:535) at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:790) at sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:649) at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908) at java.lang.Thread.run(Thread.java:619) at sun.rmi.transport.StreamRemoteCall.exceptionReceivedFromServer(StreamRemoteCall.java:255) at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:233) at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:142) at org.jnp.server.NamingServer_Stub.lookup(Unknown Source) at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:734) at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:686) at javax.naming.InitialContext.lookup(InitialContext.java:392) at org.jboss.jbossas.servermanager.Server.getServerConnection(Server.java:660) at org.jboss.jbossas.servermanager.Server.doShutdown(Server.java:733) at org.jboss.jbossas.servermanager.ServerController.stopServer(ServerController.java:443) ... 1 more + BSTATUS=1 + [[ 1 -ne 0 ]] + kill-jboss ++ uname -s + [[ Linux == \L\i\n\u\x ]] + local 'PS=ps -eaf --columns 2200 | grep run.jar | grep -v grep | awk '\''{ print $2; }'\''' + eval 'ps -eaf --columns 2200 | grep run.jar | grep -v grep | awk '\''{ print $2; }'\''' ++ ps -eaf --columns 2200 + xargs kill -3 ++ grep run.jar ++ grep -v grep ++ awk '{ print $2; }' usage: kill [ -s signal | -p ] [ -a ] pid ... kill -l [ signal ] + sleep 1 + eval 'ps -eaf --columns 2200 | grep run.jar | grep -v grep | awk '\''{ print $2; }'\''' ++ ps -eaf --columns 2200 + xargs kill ++ grep run.jar ++ grep -v grep ++ awk '{ print $2; }' usage: kill [ -s signal | -p ] [ -a ] pid ... kill -l [ signal ] + sleep 10 + eval 'ps -eaf --columns 2200 | grep run.jar | grep -v grep | awk '\''{ print $2; }'\''' ++ ps -eaf --columns 2200 ++ grep run.jar + xargs kill -9 ++ grep -v grep ++ awk '{ print $2; }' usage: kill [ -s signal | -p ] [ -a ] pid ... kill -l [ signal ] + return 0 + exit 1 Recording test results Archiving artifacts