See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/77/changes Changes: [tcunning] bug:JBESB-1548 Quickstart should only log messages for the onSave/onDelete actions. ------------------------------------------ [...truncated 12797 lines...] [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar is a valid file [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] Undeploying QuickstartMessageStoreServer.sar, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar] [java] [junit] 18:09:38,758 DEBUG [main][SimpleCBRTest] undeployed package: QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,758 DEBUG [main][SimpleCBRTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 4.43 sec [java] [junit] Testsuite: org.jboss.soa.esb.quickstart.test.SimpleCBRTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 4.43 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 18:09:35,225 DEBUG [main][SimpleCBRTest] ==== setUp org.jboss.soa.esb.quickstart.test.SimpleCBRTest ==== [java] [junit] 18:09:35,226 DEBUG [main][SimpleCBRTest] JBossTestServices.setUp() [java] [junit] 18:09:35,251 DEBUG [main][SimpleCBRTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 18:09:35,251 INFO [main][SimpleCBRTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 18:09:35,251 INFO [main][SimpleCBRTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 18:09:35,251 INFO [main][SimpleCBRTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 18:09:35,251 INFO [main][SimpleCBRTest] jbosstest.nodeploy: null [java] [junit] 18:09:35,251 INFO [main][SimpleCBRTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 18:09:35,251 INFO [main][SimpleCBRTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 18:09:35,251 DEBUG [main][SimpleCBRTest] QuickstartMessageStoreServer.sar is not a valid URL, no protocol: QuickstartMessageStoreServer.sar [java] [junit] 18:09:35,251 DEBUG [main][SimpleCBRTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:35,252 DEBUG [main][SimpleCBRTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar is a valid file [java] [junit] 18:09:35,252 DEBUG [main][SimpleCBRTest] Deploying QuickstartMessageStoreServer.sar, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:35,464 DEBUG [main][SimpleCBRTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 18:09:35,465 DEBUG [main][SimpleCBRTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar] [java] [junit] 18:09:35,565 DEBUG [main][SimpleCBRTest] deployed package: QuickstartMessageStoreServer.sar [java] [junit] 18:09:35,565 DEBUG [main][SimpleCBRTest] Quickstart_simple_cbr.esb is not a valid URL, no protocol: Quickstart_simple_cbr.esb [java] [junit] 18:09:35,565 DEBUG [main][SimpleCBRTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb [java] [junit] 18:09:35,566 DEBUG [main][SimpleCBRTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb is a valid file [java] [junit] 18:09:35,566 DEBUG [main][SimpleCBRTest] Deploying Quickstart_simple_cbr.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb [java] [junit] 18:09:35,566 DEBUG [main][SimpleCBRTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 18:09:35,566 DEBUG [main][SimpleCBRTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb] [java] [junit] 18:09:35,950 DEBUG [main][SimpleCBRTest] deployed package: Quickstart_simple_cbr.esb [java] [junit] 18:09:35,955 DEBUG [main][SimpleCBRTest] ==== Starting testMessage ==== [java] [junit] Connection Started [java] [junit] 18:09:38,535 DEBUG [main][SimpleCBRTest] Quickstart_simple_cbr.esb is not a valid URL, no protocol: Quickstart_simple_cbr.esb [java] [junit] 18:09:38,535 DEBUG [main][SimpleCBRTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb [java] [junit] 18:09:38,535 DEBUG [main][SimpleCBRTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb is a valid file [java] [junit] 18:09:38,536 DEBUG [main][SimpleCBRTest] Undeploying Quickstart_simple_cbr.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb [java] [junit] 18:09:38,536 DEBUG [main][SimpleCBRTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 18:09:38,536 DEBUG [main][SimpleCBRTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_simple_cbr.esb] [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] undeployed package: Quickstart_simple_cbr.esb [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] QuickstartMessageStoreServer.sar is not a valid URL, no protocol: QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar is a valid file [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] Undeploying QuickstartMessageStoreServer.sar, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 18:09:38,750 DEBUG [main][SimpleCBRTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar] [java] [junit] 18:09:38,758 DEBUG [main][SimpleCBRTest] undeployed package: QuickstartMessageStoreServer.sar [java] [junit] 18:09:38,758 DEBUG [main][SimpleCBRTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testMessage took 2.583 sec [java] [junit] Running org.jboss.soa.esb.quickstart.test.SpringAOPTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 18:09:40,473 DEBUG [main][SpringAOPTest] ==== setUp org.jboss.soa.esb.quickstart.test.SpringAOPTest ==== [java] [junit] 18:09:40,474 DEBUG [main][SpringAOPTest] JBossTestServices.setUp() [java] [junit] 18:09:40,499 DEBUG [main][SpringAOPTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.nodeploy: null [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 18:09:40,499 DEBUG [main][SpringAOPTest] QuickstartMessageStoreServer.sar is not a valid URL, no protocol: QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,500 DEBUG [main][SpringAOPTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,500 DEBUG [main][SpringAOPTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar is a valid file [java] [junit] 18:09:40,500 DEBUG [main][SpringAOPTest] Deploying QuickstartMessageStoreServer.sar, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,751 DEBUG [main][SpringAOPTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 18:09:40,751 DEBUG [main][SpringAOPTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar] [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] deployed package: QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] Quickstart_spring_aop.esb is not a valid URL, no protocol: Quickstart_spring_aop.esb [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb is a valid file [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] Deploying Quickstart_spring_aop.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:09:40,875 DEBUG [main][SpringAOPTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 18:09:40,875 DEBUG [main][SpringAOPTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb] [java] [junit] 18:10:05,618 DEBUG [main][SpringAOPTest] ==== Starting testMessage ==== [java] [junit] 18:10:12,245 DEBUG [main][SpringAOPTest] Quickstart_spring_aop.esb is not a valid URL, no protocol: Quickstart_spring_aop.esb [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb is a valid file [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] Undeploying Quickstart_spring_aop.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb] [java] [junit] Tests run: 1, Failures: 0, Errors: 2, Time elapsed: 37.09 sec [java] [junit] Testsuite: org.jboss.soa.esb.quickstart.test.SpringAOPTest [java] [junit] Tests run: 1, Failures: 0, Errors: 2, Time elapsed: 37.09 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 18:09:40,473 DEBUG [main][SpringAOPTest] ==== setUp org.jboss.soa.esb.quickstart.test.SpringAOPTest ==== [java] [junit] 18:09:40,474 DEBUG [main][SpringAOPTest] JBossTestServices.setUp() [java] [junit] 18:09:40,499 DEBUG [main][SpringAOPTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.nodeploy: null [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 18:09:40,499 INFO [main][SpringAOPTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 18:09:40,499 DEBUG [main][SpringAOPTest] QuickstartMessageStoreServer.sar is not a valid URL, no protocol: QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,500 DEBUG [main][SpringAOPTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,500 DEBUG [main][SpringAOPTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar is a valid file [java] [junit] 18:09:40,500 DEBUG [main][SpringAOPTest] Deploying QuickstartMessageStoreServer.sar, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,751 DEBUG [main][SpringAOPTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 18:09:40,751 DEBUG [main][SpringAOPTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/QuickstartMessageStoreServer.sar] [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] deployed package: QuickstartMessageStoreServer.sar [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] Quickstart_spring_aop.esb is not a valid URL, no protocol: Quickstart_spring_aop.esb [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb is a valid file [java] [junit] 18:09:40,874 DEBUG [main][SpringAOPTest] Deploying Quickstart_spring_aop.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:09:40,875 DEBUG [main][SpringAOPTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 18:09:40,875 DEBUG [main][SpringAOPTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb] [java] [junit] 18:10:05,618 DEBUG [main][SpringAOPTest] ==== Starting testMessage ==== [java] [junit] 18:10:12,245 DEBUG [main][SpringAOPTest] Quickstart_spring_aop.esb is not a valid URL, no protocol: Quickstart_spring_aop.esb [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb is a valid file [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] Undeploying Quickstart_spring_aop.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 18:10:12,246 DEBUG [main][SpringAOPTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/quickstarts/lib/Quickstart_spring_aop.esb] [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testMessage took 6.633 sec [java] [junit] Caused an ERROR [java] [junit] null [java] [junit] javax.naming.CommunicationException [Root exception is java.rmi.UnmarshalException: Error unmarshaling return; nested exception is: [java] [junit] java.io.EOFException] [java] [junit] at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:722) [java] [junit] at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:587) [java] [junit] at javax.naming.InitialContext.lookup(InitialContext.java:351) [java] [junit] at org.jboss.soa.esb.samples.quickstart.spring_aop.test.SendJMSMessage.setupConnection(SendJMSMessage.java:52) [java] [junit] at org.jboss.soa.esb.quickstart.test.SpringAOPTest.sendMessage(SpringAOPTest.java:50) [java] [junit] at org.jboss.soa.esb.quickstart.test.SpringAOPTest.testMessage(SpringAOPTest.java:44) [java] [junit] at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:23) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] [junit] Caused by: java.rmi.UnmarshalException: Error unmarshaling return; nested exception is: [java] [junit] java.io.EOFException [java] [junit] at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:217) [java] [junit] at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:126) [java] [junit] at org.jnp.server.NamingServer_Stub.lookup(Unknown Source) [java] [junit] at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:625) [java] [junit] ... 26 more [java] [junit] Caused by: java.io.EOFException [java] [junit] at java.io.ObjectInputStream$BlockDataInputStream.peekByte(ObjectInputStream.java:2498) [java] [junit] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1273) [java] [junit] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:1908) [java] [junit] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:1832) [java] [junit] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:1719) [java] [junit] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1305) [java] [junit] at java.io.ObjectInputStream.readArray(ObjectInputStream.java:1634) [java] [junit] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1299) [java] [junit] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:1908) [java] [junit] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:1832) [java] [junit] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:1719) [java] [junit] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1305) [java] [junit] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:348) [java] [junit] at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:215) [java] [junit] ... 29 more [java] [junit] Testcase: unknown took 0 sec [java] [junit] Caused an ERROR [java] [junit] error unmarshalling return; nested exception is: [java] [junit] java.io.EOFException [java] [junit] java.rmi.UnmarshalException: error unmarshalling return; nested exception is: [java] [junit] java.io.EOFException [java] [junit] at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:157) [java] [junit] at org.jboss.invocation.jrmp.server.JRMPInvoker_Stub.invoke(Unknown Source) [java] [junit] at org.jboss.invocation.jrmp.interfaces.JRMPInvokerProxy.invoke(JRMPInvokerProxy.java:133) [java] [junit] at org.jboss.invocation.InvokerInterceptor.invokeInvoker(InvokerInterceptor.java:365) [java] [junit] at org.jboss.invocation.InvokerInterceptor.invoke(InvokerInterceptor.java:197) [java] [junit] at org.jboss.jmx.connector.invoker.client.InvokerAdaptorClientInterceptor.invoke(InvokerAdaptorClientInterceptor.java:66) [java] [junit] at org.jboss.proxy.SecurityInterceptor.invoke(SecurityInterceptor.java:70) [java] [junit] at org.jboss.proxy.ClientMethodInterceptor.invoke(ClientMethodInterceptor.java:74) [java] [junit] at org.jboss.proxy.ClientContainer.invoke(ClientContainer.java:100) [java] [junit] at $Proxy0.invoke(Unknown Source) [java] [junit] at org.jboss.test.JBossTestServices.invoke(JBossTestServices.java:240) [java] [junit] at org.jboss.test.JBossTestServices.invoke(JBossTestServices.java:229) [java] [junit] at org.jboss.test.JBossTestServices.undeploy(JBossTestServices.java:357) [java] [junit] at org.jboss.test.JBossTestSetup.undeploy(JBossTestSetup.java:197) [java] [junit] at org.jboss.test.JBossTestCase$1.tearDown(JBossTestCase.java:328) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:24) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] [junit] Caused by: java.io.EOFException [java] [junit] at java.io.ObjectInputStream$BlockDataInputStream.peekByte(ObjectInputStream.java:2498) [java] [junit] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1273) [java] [junit] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:348) [java] [junit] at sun.rmi.server.MarshalInputStream.readLocation(MarshalInputStream.java:285) [java] [junit] at sun.rmi.server.MarshalInputStream.resolveClass(MarshalInputStream.java:167) [java] [junit] at java.io.ObjectInputStream.readNonProxyDesc(ObjectInputStream.java:1544) [java] [junit] at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1466) [java] [junit] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:1699) [java] [junit] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1305) [java] [junit] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:348) [java] [junit] at sun.rmi.server.UnicastRef.unmarshalValue(UnicastRef.java:290) [java] [junit] at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:139) [java] [junit] ... 20 more [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:102: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/quickstarts/build.xml:358: Test org.jboss.soa.esb.quickstart.test.SpringAOPTest failed [java] Total time: 3 minutes 37 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Exception in thread "main" javax.naming.CommunicationException [Root exception is java.rmi.UnmarshalException: Error unmarshaling return header; nested exception is: [java] java.io.EOFException] [java] at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:724) [java] at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:589) [java] at javax.naming.InitialContext.lookup(InitialContext.java:351) [java] at org.jboss.Shutdown.main(Shutdown.java:214) [java] Caused by: java.rmi.UnmarshalException: Error unmarshaling return header; nested exception is: [java] java.io.EOFException [java] at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:203) [java] at sun.rmi.server.UnicastRef.invoke(UnicastRef.java:126) [java] at org.jnp.server.NamingServer_Stub.lookup(Unknown Source) [java] at org.jnp.interfaces.NamingContext.lookup(NamingContext.java:627) [java] ... 3 more [java] Caused by: java.io.EOFException [java] at java.io.DataInputStream.readByte(DataInputStream.java:243) [java] at sun.rmi.transport.StreamRemoteCall.executeCall(StreamRemoteCall.java:189) [java] ... 6 more [java] Java Result: 1 [echo] 2008-02-25 18:10:19 EST: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:12: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:81: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:126: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/esb-config.xml:107: Timeout waiting for ESB server to shutdown. Total time: 15 minutes 55 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/79/changes ------------------------------------------ [...truncated 6732 lines...] [java] org.jboss.esb.rosetta.compile: [java] org.jboss.esb.tests.init: [java] org.jboss.esb.rosetta.tests.compile: [java] jar: [java] [propertyfile] Creating new property file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build/classes/rosetta/VERSION [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build/jbossesb/lib/jbossesb-rosetta.jar [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build/jbossesb/lib/test-util.jar [java] test: [java] prepare: [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/jbossesb.esb/META-INF [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/classes [java] compile: [java] [javac] Compiling 8 source files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/classes [java] [javac] Note: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/main/java/org/jboss/internal/soa/esb/persistence/format/jcr/JCRMessageStoreImpl.java uses or overrides a deprecated API. [java] [javac] Note: Recompile with -Xlint:deprecation for details. [java] check.for.files: [java] jar: [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/jbossesb-jbossesb.jar [java] management-jar: [java] define-lib: [java] init: [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/classes [java] compile: [java] [echo] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product [java] [javac] Compiling 30 source files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/classes [java] [javac] Note: Some input files use or override a deprecated API. [java] [javac] Note: Recompile with -Xlint:deprecation for details. [java] [javac] Note: Some input files use unchecked or unsafe operations. [java] [javac] Note: Recompile with -Xlint:unchecked for details. [java] [copy] Copying 1 file to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/classes/org/jboss/soa/esb/monitoring [java] jar: [java] [echo] hsqldb [java] [echo] tools/console [java] [copy] Copying 1 file to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/management-client.jar [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/management-server.jar [java] esb: [java] [copy] Copying 23 files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/jbossesb.esb [java] base.test: [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/coverage/instr [java] [instr] processing instrumentation path ... [java] [instr] instrumentation path processed in 382 ms [java] [instr] [7 class(es) instrumented, 0 resource(s) copied] [java] [instr] metadata merged into [/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/coverage/coverage.emma] {in 13 ms} [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/classes [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/report [java] [javac] Compiling 8 source files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/classes [java] [copy] Copying 2 files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/classes [java] [echo] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb [java] [junit] Running org.jboss.internal.soa.esb.persistence.format.jcr.JCRConnectionManagerUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.536 sec [java] [junit] Testsuite: org.jboss.internal.soa.esb.persistence.format.jcr.JCRConnectionManagerUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 2.536 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] 03:49:56,069 DEBUG [main][MockContext] Bound object org.jboss.soa.esb.common.tests.MockDataSource@1976011 to the name datasource [java] [junit] 03:49:56,207 DEBUG [main][MockContext] Bound object org.apache.jackrabbit.core.TransientRepository@15db314 to the name path [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testConnectionManager took 2.509 sec [java] [junit] Running org.jboss.soa.esb.messagestore.MessageStoreUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 58.251 sec [java] [junit] Testsuite: org.jboss.soa.esb.messagestore.MessageStoreUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 58.251 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] Current dir=/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/test/resources [java] [junit] 03:50:12,304 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] 03:50:12,502 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] Dropping the schema if exist [java] [junit] Creating the message store schema [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] 03:50:35,552 INFO [Thread-10][MessageStoreUnitTest] total messages persisted to db: 1000 [java] [junit] 03:50:36,535 INFO [main][MessageStoreUnitTest] total messages persisted to db: 1000 [java] [junit] 03:50:36,882 INFO [Thread-6][MessageStoreUnitTest] total messages persisted to db: 1000 [java] [junit] 03:50:37,089 INFO [Thread-8][MessageStoreUnitTest] total messages persisted to db: 1000 [java] [junit] 03:50:38,004 INFO [Thread-7][MessageStoreUnitTest] total messages persisted to db: 1000 [java] [junit] 03:50:38,205 INFO [Thread-9][MessageStoreUnitTest] total messages persisted to db: 1000 [java] [junit] 03:50:48,060 INFO [Thread-10][MessageStoreUnitTest] total messages read from db: 1000 [java] [junit] 03:50:48,060 INFO [Thread-10][MessageStoreUnitTest] time to finish write/read for this client: 32738 milliseconds. [java] [junit] 03:50:48,233 INFO [Thread-8][MessageStoreUnitTest] total messages read from db: 1000 [java] [junit] 03:50:48,233 INFO [Thread-8][MessageStoreUnitTest] time to finish write/read for this client: 32912 milliseconds. [java] [junit] 03:50:48,257 INFO [Thread-6][MessageStoreUnitTest] total messages read from db: 1000 [java] [junit] 03:50:48,257 INFO [Thread-6][MessageStoreUnitTest] time to finish write/read for this client: 32937 milliseconds. [java] [junit] 03:50:48,353 INFO [main][MessageStoreUnitTest] total messages read from db: 1001 [java] [junit] 03:50:48,353 INFO [main][MessageStoreUnitTest] time to finish write/read for this client: 32979 milliseconds. [java] [junit] 03:50:48,368 INFO [Thread-7][MessageStoreUnitTest] total messages read from db: 1000 [java] [junit] 03:50:48,368 INFO [Thread-7][MessageStoreUnitTest] time to finish write/read for this client: 33047 milliseconds. [java] [junit] 03:50:48,420 INFO [Thread-9][MessageStoreUnitTest] total messages read from db: 1000 [java] [junit] 03:50:48,420 INFO [Thread-9][MessageStoreUnitTest] time to finish write/read for this client: 33099 milliseconds. [java] [junit] Stopping [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: unknown took 0.059 sec [java] [junit] Testcase: unknown took 32.98 sec [java] [junit] Running org.jboss.soa.esb.persistence.actions.MessagePersisterUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 11.908 sec [java] [junit] Testsuite: org.jboss.soa.esb.persistence.actions.MessagePersisterUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 11.908 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] Current dir=/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/test/resources [java] [junit] 03:51:13,475 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] 03:51:13,911 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] Dropping the schema if exist [java] [junit] Creating the message store schema [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] Reading the messages in the messageStore [java] [junit] Body=<message>First Message Sat Mar 15 03:51:15 EDT 2008 </message> [java] [junit] Getting message for classification TEST:{urn:jboss/esb/message/UID#36bbfa4d-2b07-45d6-ba73-fe7892385165=message: [ JBOSS_XML ] [java] [junit] header: [ ] [java] [junit] context: [ ] [java] [junit] body: [ objects: {org.jboss.soa.esb.message.defaultEntry=[B@9fa8f} ] [java] [junit] fault: [ ] [java] [junit] attachments: [ Named:{}, Unnamed:[] ] [java] [junit] properties: [ {} ]} [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: unknown took 2.885 sec [java] [junit] Running org.jboss.soa.esb.persistence.tests.MessageStoreUnitTest [java] [junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 10.239 sec [java] [junit] Testsuite: org.jboss.soa.esb.persistence.tests.MessageStoreUnitTest [java] [junit] Tests run: 7, Failures: 0, Errors: 0, Time elapsed: 10.239 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] Current dir=/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/test/resources [java] [junit] 03:51:38,130 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] 03:51:38,557 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] Dropping the schema if exist [java] [junit] Creating the message store schema [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] 03:51:43,251 INFO [main][DBMessageStoreImpl] retrieved 5 undelivered messages [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: unknown took 0.298 sec [java] [junit] Testcase: unknown took 0.002 sec [java] [junit] Testcase: unknown took 0.986 sec [java] [junit] Testcase: unknown took 0.006 sec [java] [junit] Testcase: unknown took 0.814 sec [java] [junit] Testcase: unknown took 0.275 sec [java] [junit] Testcase: unknown took 0.001 sec [java] [junit] Running org.jboss.soa.esb.persistence.tests.RedeliverUnitTest [java] [junit] Tests run: 5, Failures: 0, Errors: 1, Time elapsed: 43.806 sec [java] [junit] Testsuite: org.jboss.soa.esb.persistence.tests.RedeliverUnitTest [java] [junit] Tests run: 5, Failures: 0, Errors: 1, Time elapsed: 43.806 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] Current dir=/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/test/resources [java] [junit] 03:51:57,441 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] 03:51:58,210 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] Dropping the schema if exist [java] [junit] Creating the message store schema [java] [junit] 03:52:00,156 INFO [main][RedeliverUnitTest] ** redeliverOne [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] 03:52:03,854 INFO [main][RedeliverUnitTest] ** redeliverOneThreads [java] [junit] 03:52:04,364 INFO [main][RedeliverUnitTest] ** redeliverTwoThreads [java] [junit] 03:52:07,356 INFO [main][RedeliverUnitTest] Client1 processed 0 messages [java] [junit] 03:52:07,356 INFO [main][RedeliverUnitTest] Client2 processed 1 messages [java] [junit] 03:52:07,382 INFO [main][RedeliverUnitTest] ** redeliverFiftyTwoThreads [java] [junit] 03:52:28,159 INFO [main][RedeliverUnitTest] ** redeliverOneUnreachable [java] [junit] 03:52:28,185 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:28,185 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:28,642 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:28,642 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:28,688 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:28,689 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:30,298 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:30,298 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:31,451 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:31,451 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:31,494 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:31,494 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:34,324 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:34,329 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:36,804 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:36,805 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:38,093 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:38,093 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:38,461 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:38,461 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:38,473 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] 03:52:38,474 INFO [main][ServiceInvoker] Unresponsive EPR: EPR: PortReference < <wsa:Address null/> > for message: header: [ To: EPR: PortReference < <wsa:Address null/> > ] [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: unknown took 3.698 sec [java] [junit] Testcase: unknown took 0.508 sec [java] [junit] Testcase: unknown took 3.018 sec [java] [junit] Testcase: unknown took 20.764 sec [java] [junit] Caused an ERROR [java] [junit] Timeout waiting for client threads to terminate [java] [junit] java.lang.AssertionError: Timeout waiting for client threads to terminate [java] [junit] at org.junit.Assert.fail(Assert.java:69) [java] [junit] at org.jboss.soa.esb.persistence.tests.RedeliverUnitTest.redeliverFiftyTwoThreads(RedeliverUnitTest.java:181) [java] [junit] at org.junit.internal.runners.TestMethodRunner.executeMethodBody(TestMethodRunner.java:99) [java] [junit] at org.junit.internal.runners.TestMethodRunner.runUnprotected(TestMethodRunner.java:81) [java] [junit] at org.junit.internal.runners.BeforeAndAfterRunner.runProtected(BeforeAndAfterRunner.java:34) [java] [junit] at org.junit.internal.runners.TestMethodRunner.runMethod(TestMethodRunner.java:75) [java] [junit] at org.junit.internal.runners.TestMethodRunner.run(TestMethodRunner.java:45) [java] [junit] at org.junit.internal.runners.TestClassMethodsRunner.invokeTestMethod(TestClassMethodsRunner.java:71) [java] [junit] at org.junit.internal.runners.TestClassMethodsRunner.run(TestClassMethodsRunner.java:35) [java] [junit] at org.junit.internal.runners.TestClassRunner$1.runUnprotected(TestClassRunner.java:42) [java] [junit] at org.junit.internal.runners.BeforeAndAfterRunner.runProtected(BeforeAndAfterRunner.java:34) [java] [junit] at org.junit.internal.runners.TestClassRunner.run(TestClassRunner.java:52) [java] [junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:32) [java] [junit] Testcase: unknown took 10.352 sec [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build.xml:166: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/build.xml:26: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/base-project-build.xml:104: Test org.jboss.soa.esb.persistence.tests.RedeliverUnitTest failed [java] Total time: 40 minutes 56 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-15 03:52:54 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:11: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build.xml:491: Product Unit Test failure Total time: 45 minutes 41 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/81/changes Changes: [mark.little(a)jboss.com] http://jira.jboss.com/jira/browse/JBESB-1579 [mark.little(a)jboss.com] http://jira.jboss.com/jira/browse/JBESB-1170 ------------------------------------------ [...truncated 9061 lines...] [java] [junit] 16:28:02,652 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:28:02,652 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:28:02,653 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:28:02,653 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:02,667 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:28:02,667 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:03,106 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:03,107 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:28:04,118 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 16:28:04,119 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:28:04,119 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:04,171 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:28:04,171 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:04,171 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:04,172 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:28:04,800 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 16:28:04,802 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 16:28:09,882 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 16:28:12,020 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:28:12,021 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:12,021 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:28:12,021 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:12,022 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:12,022 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:28:12,172 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 16:28:12,172 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:28:12,425 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 16:28:12,426 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 10.439 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.SimpleDeployUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 10.439 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 16:28:02,618 DEBUG [main][SimpleDeployUnitTest] ==== setUp org.jboss.soa.esb.server.SimpleDeployUnitTest ==== [java] [junit] 16:28:02,619 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.setUp() [java] [junit] 16:28:02,651 DEBUG [main][SimpleDeployUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:28:02,651 INFO [main][SimpleDeployUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:28:02,651 INFO [main][SimpleDeployUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:28:02,651 INFO [main][SimpleDeployUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:28:02,652 INFO [main][SimpleDeployUnitTest] jbosstest.nodeploy: null [java] [junit] 16:28:02,652 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:28:02,652 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:28:02,653 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:28:02,653 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:02,667 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:28:02,667 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:03,106 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:03,107 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:28:04,118 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 16:28:04,119 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:28:04,119 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:04,171 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:28:04,171 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:04,171 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:04,172 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:28:04,800 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 16:28:04,802 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 16:28:09,882 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 16:28:12,020 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:28:12,021 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:12,021 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:28:12,021 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:28:12,022 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:12,022 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:28:12,172 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 16:28:12,172 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:12,173 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:28:12,425 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 16:28:12,426 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testSimple took 5.08 sec [java] [junit] Testcase: testScope took 2.138 sec [java] [junit] Running org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 16:28:14,816 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 16:28:14,818 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 16:28:14,931 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 16:28:14,933 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:28:14,933 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:28:14,933 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:28:14,934 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:14,936 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:28:14,936 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:15,456 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:15,456 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:28:17,315 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 16:28:17,319 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205612897323.dat [java] [junit] version=scope1 [java] [junit] 16:28:27,612 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:28:27,612 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:28:27,763 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 16:28:27,763 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 13.619 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 13.619 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 16:28:14,816 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 16:28:14,818 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 16:28:14,931 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:28:14,932 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 16:28:14,933 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:28:14,933 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:28:14,933 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:28:14,934 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:14,936 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:28:14,936 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:15,456 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:15,456 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:28:17,315 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 16:28:17,319 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205612897323.dat [java] [junit] version=scope1 [java] [junit] 16:28:27,612 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:28:27,612 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:27,613 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:28:27,763 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 16:28:27,763 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testFtp took 10.294 sec [java] [junit] Running org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 16:28:29,949 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 16:28:29,951 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 16:28:30,010 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 16:28:30,012 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:28:30,012 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:28:30,012 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:28:30,012 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:30,017 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:28:30,017 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:30,556 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:30,556 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:28:31,224 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 16:28:31,226 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 16:28:42,002 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:28:42,003 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:42,003 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:28:42,004 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:42,004 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:42,004 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:28:42,121 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 16:28:42,121 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 12.824 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 12.824 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 16:28:29,949 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 16:28:29,951 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 16:28:30,010 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:28:30,011 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 16:28:30,012 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:28:30,012 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:28:30,012 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:28:30,012 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:30,017 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:28:30,017 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:30,556 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:28:30,556 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:28:31,224 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 16:28:31,226 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 16:28:42,002 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:28:42,003 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:42,003 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:28:42,004 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:28:42,004 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:28:42,004 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:28:42,121 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 16:28:42,121 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testAsyncCallback took 10.77 sec [java] [junit] FAILED [java] [junit] checkWaitingAction expected:<true> but was:<false> [java] [junit] junit.framework.AssertionFailedError: checkWaitingAction expected:<true> but was:<false> [java] [junit] at org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest.testAsyncCallback(JbpmAsyncUnitTest.java:60) [java] [junit] at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:23) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:105: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/junit/build.xml:214: Test org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest failed [java] Total time: 1 minute 13 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-15 16:28:43 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:12: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:88: QA Unit Test failure Total time: 24 minutes 27 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/83/changes Changes: [mark.little(a)jboss.com] http://jira.jboss.com/jira/browse/JBESB-1606 and http://jira.jboss.com/jira/browse/JBESB-1607 ------------------------------------------ [...truncated 9093 lines...] [java] [junit] 19:44:51,106 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 19:44:51,106 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 19:44:51,108 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 19:44:51,109 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:44:51,112 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 19:44:51,113 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:44:58,887 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:44:58,887 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 19:45:10,381 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 19:45:10,381 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 19:45:10,381 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:10,387 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 19:45:10,388 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:10,388 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:45:10,388 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 19:45:20,305 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 19:45:20,307 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 19:45:52,819 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 19:45:59,340 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 19:45:59,342 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:59,345 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 19:45:59,347 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:59,348 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:45:59,350 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 19:45:59,679 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 19:45:59,679 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 19:45:59,679 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 19:46:02,388 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 19:46:02,388 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 84.231 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.SimpleDeployUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 84.231 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 19:44:51,021 DEBUG [main][SimpleDeployUnitTest] ==== setUp org.jboss.soa.esb.server.SimpleDeployUnitTest ==== [java] [junit] 19:44:51,023 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.setUp() [java] [junit] 19:44:51,100 DEBUG [main][SimpleDeployUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 19:44:51,101 INFO [main][SimpleDeployUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 19:44:51,102 INFO [main][SimpleDeployUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 19:44:51,104 INFO [main][SimpleDeployUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 19:44:51,104 INFO [main][SimpleDeployUnitTest] jbosstest.nodeploy: null [java] [junit] 19:44:51,106 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 19:44:51,106 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 19:44:51,108 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 19:44:51,109 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:44:51,112 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 19:44:51,113 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:44:58,887 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:44:58,887 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 19:45:10,381 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 19:45:10,381 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 19:45:10,381 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:10,387 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 19:45:10,388 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:10,388 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:45:10,388 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 19:45:20,305 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 19:45:20,307 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 19:45:52,819 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 19:45:59,340 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 19:45:59,342 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:59,345 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 19:45:59,347 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 19:45:59,348 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:45:59,350 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 19:45:59,679 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 19:45:59,679 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 19:45:59,679 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:45:59,681 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 19:46:02,388 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 19:46:02,388 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testSimple took 32.514 sec [java] [junit] Testcase: testScope took 6.52 sec [java] [junit] Running org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 19:46:13,833 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 19:46:13,834 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 19:46:13,881 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 19:46:13,882 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 19:46:13,882 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:13,887 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 19:46:13,888 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:15,488 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:46:15,488 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 19:46:21,644 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 19:46:21,689 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205711181720.dat [java] [junit] version=scope1 [java] [junit] 19:46:33,809 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 19:46:33,810 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 19:46:33,999 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 19:46:34,000 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 25.155 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 25.155 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 19:46:13,833 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 19:46:13,834 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 19:46:13,881 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 19:46:13,882 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 19:46:13,882 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 19:46:13,882 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:13,887 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 19:46:13,888 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:15,488 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:46:15,488 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 19:46:21,644 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 19:46:21,689 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205711181720.dat [java] [junit] version=scope1 [java] [junit] 19:46:33,809 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 19:46:33,810 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:46:33,811 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 19:46:33,999 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 19:46:34,000 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testFtp took 12.164 sec [java] [junit] Running org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 19:46:45,238 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 19:46:45,239 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 19:46:45,301 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 19:46:45,302 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 19:46:45,302 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:46:45,311 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 19:46:45,311 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:46:46,384 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:46:46,385 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 19:46:49,622 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 19:46:49,625 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 19:47:06,732 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 19:47:06,732 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:47:06,737 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 19:47:06,738 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:47:06,738 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:47:06,738 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 19:47:07,263 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 19:47:07,263 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 24.007 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 24.007 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 19:46:45,238 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 19:46:45,239 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 19:46:45,301 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 19:46:45,302 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 19:46:45,302 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 19:46:45,302 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:46:45,311 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 19:46:45,311 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:46:46,384 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 19:46:46,385 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 19:46:49,622 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 19:46:49,625 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 19:47:06,732 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 19:47:06,732 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:47:06,737 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 19:47:06,738 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 19:47:06,738 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 19:47:06,738 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 19:47:07,263 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 19:47:07,263 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testAsyncCallback took 17.103 sec [java] [junit] FAILED [java] [junit] checkWaitingAction expected:<true> but was:<false> [java] [junit] junit.framework.AssertionFailedError: checkWaitingAction expected:<true> but was:<false> [java] [junit] at org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest.testAsyncCallback(JbpmAsyncUnitTest.java:60) [java] [junit] at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:23) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:105: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/junit/build.xml:214: Test org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest failed [java] Total time: 4 minutes 51 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-16 19:47:13 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:12: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:88: QA Unit Test failure Total time: 66 minutes 29 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/85/changes Changes: [tcunning] SOA-430 Remove the part of the instructions that say that deploy-jms-dests is required for .esb package deployment. ------------------------------------------ [...truncated 6783 lines...] [java] test: [java] prepare: [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/jbossesb.esb/META-INF [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/classes [java] compile: [java] [javac] Compiling 8 source files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/classes [java] [javac] Note: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/main/java/org/jboss/internal/soa/esb/persistence/format/jcr/JCRMessageStoreImpl.java uses or overrides a deprecated API. [java] [javac] Note: Recompile with -Xlint:deprecation for details. [java] check.for.files: [java] jar: [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/jbossesb-jbossesb.jar [java] management-jar: [java] define-lib: [java] init: [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/classes [java] compile: [java] [echo] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product [java] [javac] Compiling 30 source files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/classes [java] [javac] Note: Some input files use or override a deprecated API. [java] [javac] Note: Recompile with -Xlint:deprecation for details. [java] [javac] Note: Some input files use unchecked or unsafe operations. [java] [javac] Note: Recompile with -Xlint:unchecked for details. [java] [copy] Copying 1 file to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/classes/org/jboss/soa/esb/monitoring [java] jar: [java] [echo] hsqldb [java] [echo] tools/console [java] [copy] Copying 1 file to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/management-client.jar [java] [jar] Building jar: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/tools/console/management/build/management-server.jar [java] esb: [java] [copy] Copying 23 files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/jbossesb.esb [java] base.test: [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/coverage/instr [java] [instr] processing instrumentation path ... [java] [instr] instrumentation path processed in 394 ms [java] [instr] [7 class(es) instrumented, 0 resource(s) copied] [java] [instr] metadata merged into [/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/coverage/coverage.emma] {in 26 ms} [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/classes [java] [mkdir] Created dir: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/report [java] [javac] Compiling 8 source files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/classes [java] [copy] Copying 2 files to /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/build/tests/classes [java] [echo] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb [java] [junit] Running org.jboss.internal.soa.esb.persistence.format.jcr.JCRConnectionManagerUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 7.51 sec [java] [junit] Testsuite: org.jboss.internal.soa.esb.persistence.format.jcr.JCRConnectionManagerUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 7.51 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] 14:37:31,067 DEBUG [main][MockContext] Bound object org.jboss.soa.esb.common.tests.MockDataSource@1976011 to the name datasource [java] [junit] 14:37:31,069 DEBUG [main][MockContext] Bound object org.apache.jackrabbit.core.TransientRepository@15db314 to the name path [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testConnectionManager took 7.481 sec [java] [junit] Running org.jboss.soa.esb.messagestore.MessageStoreUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 1, Time elapsed: 35.999 sec [java] [junit] Testsuite: org.jboss.soa.esb.messagestore.MessageStoreUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 1, Time elapsed: 35.999 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] Current dir=/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/jbossesb/src/test/resources [java] [junit] 14:37:43,020 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] 14:37:43,441 INFO [main][StandaloneConnectionManager] initializing... [java] [junit] Dropping the schema if exist [java] [junit] Creating the message store schema [java] [junit] EMMA: collecting runtime coverage data ... [java] [junit] 14:38:04,303 ERROR [Thread-9][DBMessageStoreImpl] java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] 14:38:04,306 ERROR [Thread-9][MessageStoreUnitTest] Adding message failed. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreClient.run(MessageStoreClient.java:75) [java] [junit] at java.lang.Thread.run(Thread.java:595) [java] [junit] Caused by: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106) [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:468) [java] [junit] at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:125) [java] [junit] at org.jboss.internal.soa.esb.persistence.manager.StandaloneConnectionManager.getConnection(StandaloneConnectionManager.java:117) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:90) [java] [junit] ... 2 more [java] [junit] Caused by: com.mchange.v2.resourcepool.TimeoutException: The pool timed out while waiting to acquire a resource -- timeout at awaitAvailable() [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1157) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:405) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:351) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:466) [java] [junit] ... 5 more [java] [junit] 14:38:04,371 ERROR [main][DBMessageStoreImpl] java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] 14:38:09,533 ERROR [Thread-7][DBMessageStoreImpl] java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] 14:38:09,534 ERROR [Thread-7][MessageStoreUnitTest] Adding message failed. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreClient.run(MessageStoreClient.java:75) [java] [junit] at java.lang.Thread.run(Thread.java:595) [java] [junit] Caused by: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106) [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:468) [java] [junit] at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:125) [java] [junit] at org.jboss.internal.soa.esb.persistence.manager.StandaloneConnectionManager.getConnection(StandaloneConnectionManager.java:117) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:90) [java] [junit] ... 2 more [java] [junit] Caused by: com.mchange.v2.resourcepool.TimeoutException: The pool timed out while waiting to acquire a resource -- timeout at awaitAvailable() [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1157) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:405) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:351) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:466) [java] [junit] ... 5 more [java] [junit] 14:38:12,964 ERROR [Thread-8][DBMessageStoreImpl] java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] 14:38:12,964 ERROR [Thread-8][MessageStoreUnitTest] Adding message failed. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreClient.run(MessageStoreClient.java:75) [java] [junit] at java.lang.Thread.run(Thread.java:595) [java] [junit] Caused by: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106) [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:468) [java] [junit] at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:125) [java] [junit] at org.jboss.internal.soa.esb.persistence.manager.StandaloneConnectionManager.getConnection(StandaloneConnectionManager.java:117) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:90) [java] [junit] ... 2 more [java] [junit] Caused by: com.mchange.v2.resourcepool.TimeoutException: The pool timed out while waiting to acquire a resource -- timeout at awaitAvailable() [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1157) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:405) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:351) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:466) [java] [junit] ... 5 more [java] [junit] 14:38:12,965 ERROR [Thread-10][DBMessageStoreImpl] java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] 14:38:12,965 ERROR [Thread-10][MessageStoreUnitTest] Adding message failed. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreClient.run(MessageStoreClient.java:75) [java] [junit] at java.lang.Thread.run(Thread.java:595) [java] [junit] Caused by: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106) [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:468) [java] [junit] at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:125) [java] [junit] at org.jboss.internal.soa.esb.persistence.manager.StandaloneConnectionManager.getConnection(StandaloneConnectionManager.java:117) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:90) [java] [junit] ... 2 more [java] [junit] Caused by: com.mchange.v2.resourcepool.TimeoutException: The pool timed out while waiting to acquire a resource -- timeout at awaitAvailable() [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1157) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:405) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:351) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:466) [java] [junit] ... 5 more [java] [junit] Stopping [java] [junit] 14:38:16,141 ERROR [Thread-10][DBMessageStoreImpl] java.sql.SQLException: Access is denied: Session is closed [java] [junit] 14:38:16,149 ERROR [Thread-10][MessageStoreUnitTest] Adding message failed. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: Access is denied: Session is closed [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreClient.run(MessageStoreClient.java:75) [java] [junit] at java.lang.Thread.run(Thread.java:595) [java] [junit] Caused by: java.sql.SQLException: Access is denied: Session is closed [java] [junit] at org.hsqldb.jdbc.Util.throwError(Unknown Source) [java] [junit] at org.hsqldb.jdbc.jdbcPreparedStatement.execute(Unknown Source) [java] [junit] at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.execute(NewProxyPreparedStatement.java:989) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.insert(DBMessageStoreImpl.java:598) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:96) [java] [junit] ... 2 more [java] [junit] 14:38:16,149 ERROR [Thread-7][DBMessageStoreImpl] java.sql.SQLException: Access is denied: Session is closed [java] [junit] 14:38:16,156 ERROR [Thread-7][MessageStoreUnitTest] Adding message failed. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: Access is denied: Session is closed [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreClient.run(MessageStoreClient.java:75) [java] [junit] at java.lang.Thread.run(Thread.java:595) [java] [junit] Caused by: java.sql.SQLException: Access is denied: Session is closed [java] [junit] at org.hsqldb.jdbc.Util.throwError(Unknown Source) [java] [junit] at org.hsqldb.jdbc.jdbcPreparedStatement.execute(Unknown Source) [java] [junit] at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.execute(NewProxyPreparedStatement.java:989) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.insert(DBMessageStoreImpl.java:598) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:96) [java] [junit] ... 2 more [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: unknown took 0.097 sec [java] [junit] Testcase: unknown took 16.79 sec [java] [junit] Caused an ERROR [java] [junit] java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] org.jboss.soa.esb.services.persistence.MessageStoreException: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:101) [java] [junit] at org.jboss.soa.esb.messagestore.MessageStoreUnitTest.testSingleLoad(MessageStoreUnitTest.java:96) [java] [junit] at org.junit.internal.runners.TestMethodRunner.executeMethodBody(TestMethodRunner.java:99) [java] [junit] at org.junit.internal.runners.TestMethodRunner.runUnprotected(TestMethodRunner.java:81) [java] [junit] at org.junit.internal.runners.BeforeAndAfterRunner.runProtected(BeforeAndAfterRunner.java:34) [java] [junit] at org.junit.internal.runners.TestMethodRunner.runMethod(TestMethodRunner.java:75) [java] [junit] at org.junit.internal.runners.TestMethodRunner.run(TestMethodRunner.java:45) [java] [junit] at org.junit.internal.runners.TestClassMethodsRunner.invokeTestMethod(TestClassMethodsRunner.java:71) [java] [junit] at org.junit.internal.runners.TestClassMethodsRunner.run(TestClassMethodsRunner.java:35) [java] [junit] at org.junit.internal.runners.TestClassRunner$1.runUnprotected(TestClassRunner.java:42) [java] [junit] at org.junit.internal.runners.BeforeAndAfterRunner.runProtected(BeforeAndAfterRunner.java:34) [java] [junit] at org.junit.internal.runners.TestClassRunner.run(TestClassRunner.java:52) [java] [junit] at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:32) [java] [junit] Caused by: java.sql.SQLException: An attempt by a client to checkout a Connection has timed out. [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106) [java] [junit] at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:65) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:468) [java] [junit] at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:125) [java] [junit] at org.jboss.internal.soa.esb.persistence.manager.StandaloneConnectionManager.getConnection(StandaloneConnectionManager.java:117) [java] [junit] at org.jboss.internal.soa.esb.persistence.format.db.DBMessageStoreImpl.addMessage(DBMessageStoreImpl.java:90) [java] [junit] ... 19 more [java] [junit] Caused by: com.mchange.v2.resourcepool.TimeoutException: The pool timed out while waiting to acquire a resource -- timeout at awaitAvailable() [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1157) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:405) [java] [junit] at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:351) [java] [junit] at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:466) [java] [junit] ... 22 more [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build.xml:166: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/build.xml:26: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/services/base-project-build.xml:104: Test org.jboss.soa.esb.messagestore.MessageStoreUnitTest failed [java] Total time: 49 minutes 37 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-17 14:38:29 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:11: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/product/build.xml:491: Product Unit Test failure Total time: 55 minutes 56 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/87/changes Changes: [tfennelly] http://jira.jboss.com/jira/browse/JBESB-1594 http://jira.jboss.com/jira/browse/JBESB-1439 ------------------------------------------ [...truncated 9062 lines...] [java] [junit] 16:34:08,196 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:34:08,197 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:34:08,197 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:34:08,198 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:08,199 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:34:08,200 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:08,540 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:08,543 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:34:08,947 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 16:34:08,948 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:34:08,949 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:08,950 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:34:08,951 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:08,952 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:08,953 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:34:09,334 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 16:34:09,339 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 16:34:13,194 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 16:34:15,394 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:34:15,395 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:15,398 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:34:15,399 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:15,399 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:15,399 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:34:15,730 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 16:34:15,731 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:34:15,731 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:15,735 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:34:15,736 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:15,736 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:15,736 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:34:16,034 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 16:34:16,034 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 8.385 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.SimpleDeployUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 8.385 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 16:34:08,079 DEBUG [main][SimpleDeployUnitTest] ==== setUp org.jboss.soa.esb.server.SimpleDeployUnitTest ==== [java] [junit] 16:34:08,084 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.setUp() [java] [junit] 16:34:08,192 DEBUG [main][SimpleDeployUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:34:08,193 INFO [main][SimpleDeployUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:34:08,194 INFO [main][SimpleDeployUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:34:08,195 INFO [main][SimpleDeployUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:34:08,195 INFO [main][SimpleDeployUnitTest] jbosstest.nodeploy: null [java] [junit] 16:34:08,196 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:34:08,197 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:34:08,197 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:34:08,198 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:08,199 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:34:08,200 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:08,540 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:08,543 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:34:08,947 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 16:34:08,948 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:34:08,949 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:08,950 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:34:08,951 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:08,952 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:08,953 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:34:09,334 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 16:34:09,339 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 16:34:13,194 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 16:34:15,394 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 16:34:15,395 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:15,398 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 16:34:15,399 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 16:34:15,399 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:15,399 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 16:34:15,730 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 16:34:15,731 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 16:34:15,731 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:15,735 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 16:34:15,736 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 16:34:15,736 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:15,736 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 16:34:16,034 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 16:34:16,034 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testSimple took 3.854 sec [java] [junit] Testcase: testScope took 2.2 sec [java] [junit] Running org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 16:34:18,115 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 16:34:18,120 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 16:34:18,167 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:34:18,169 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:34:18,170 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:34:18,171 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:34:18,171 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 16:34:18,174 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:34:18,175 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:34:18,176 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:34:18,177 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:18,178 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:34:18,179 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:18,527 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:18,531 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:34:19,567 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 16:34:19,569 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205872459571.dat [java] [junit] version=scope1 [java] [junit] 16:34:29,832 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:34:29,833 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:29,834 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:34:29,835 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:29,835 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:29,835 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:34:30,005 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 16:34:30,006 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 12.446 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 12.446 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 16:34:18,115 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 16:34:18,120 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 16:34:18,167 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:34:18,169 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:34:18,170 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:34:18,171 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:34:18,171 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 16:34:18,174 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:34:18,175 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:34:18,176 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:34:18,177 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:18,178 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:34:18,179 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:18,527 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:18,531 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:34:19,567 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 16:34:19,569 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205872459571.dat [java] [junit] version=scope1 [java] [junit] 16:34:29,832 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 16:34:29,833 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:29,834 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 16:34:29,835 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 16:34:29,835 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:29,835 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 16:34:30,005 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 16:34:30,006 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testFtp took 10.261 sec [java] [junit] Running org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 16:34:32,179 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 16:34:32,181 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 16:34:32,246 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:34:32,250 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:34:32,252 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:34:32,254 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:34:32,256 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 16:34:32,258 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:34:32,260 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:34:32,263 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:34:32,267 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:32,272 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:34:32,276 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:32,659 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:32,662 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:34:32,941 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 16:34:32,943 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 16:34:43,547 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:34:43,550 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:43,554 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:34:43,556 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:43,557 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:43,559 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:34:43,705 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 16:34:43,706 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 12.098 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 12.098 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 16:34:32,179 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 16:34:32,181 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 16:34:32,246 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 16:34:32,250 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 16:34:32,252 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 16:34:32,254 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 16:34:32,256 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 16:34:32,258 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 16:34:32,260 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 16:34:32,263 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:34:32,267 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:32,272 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:34:32,276 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:32,659 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 16:34:32,662 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:34:32,941 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 16:34:32,943 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 16:34:43,547 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 16:34:43,550 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:43,554 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 16:34:43,556 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 16:34:43,557 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 16:34:43,559 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 16:34:43,705 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 16:34:43,706 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testAsyncCallback took 10.6 sec [java] [junit] FAILED [java] [junit] checkWaitingAction expected:<true> but was:<false> [java] [junit] junit.framework.AssertionFailedError: checkWaitingAction expected:<true> but was:<false> [java] [junit] at org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest.testAsyncCallback(JbpmAsyncUnitTest.java:60) [java] [junit] at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:23) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:105: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/junit/build.xml:214: Test org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest failed [java] Total time: 1 minute 2 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-18 16:34:45 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:12: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:88: QA Unit Test failure Total time: 25 minutes 4 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/89/changes Changes: [tfennelly] Rolling back change to initialise singleton where RegistryService is not in play to initialise it. ------------------------------------------ [...truncated 9099 lines...] [java] [junit] 09:07:05,955 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 09:07:05,960 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 09:07:05,969 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 09:07:05,974 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:05,992 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 09:07:05,993 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:06,468 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:07:06,472 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 09:07:07,386 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 09:07:07,393 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 09:07:07,399 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:07,408 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 09:07:07,425 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:07,428 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:07:07,432 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 09:07:09,509 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 09:07:09,513 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 09:07:22,147 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 09:07:24,511 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 09:07:24,511 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:24,513 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 09:07:24,513 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:24,513 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:07:24,514 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 09:07:25,453 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 09:07:25,453 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 09:07:25,453 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:25,458 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 09:07:25,459 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:25,460 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:07:25,460 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 09:07:25,898 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 09:07:25,898 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 21.543 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.SimpleDeployUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 21.543 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 09:07:05,766 DEBUG [main][SimpleDeployUnitTest] ==== setUp org.jboss.soa.esb.server.SimpleDeployUnitTest ==== [java] [junit] 09:07:05,770 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.setUp() [java] [junit] 09:07:05,923 DEBUG [main][SimpleDeployUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 09:07:05,929 INFO [main][SimpleDeployUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 09:07:05,937 INFO [main][SimpleDeployUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 09:07:05,945 INFO [main][SimpleDeployUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 09:07:05,949 INFO [main][SimpleDeployUnitTest] jbosstest.nodeploy: null [java] [junit] 09:07:05,955 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 09:07:05,960 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 09:07:05,969 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 09:07:05,974 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:05,992 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 09:07:05,993 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:06,468 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:07:06,472 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 09:07:07,386 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 09:07:07,393 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 09:07:07,399 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:07,408 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 09:07:07,425 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:07,428 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:07:07,432 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 09:07:09,509 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 09:07:09,513 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 09:07:22,147 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 09:07:24,511 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 09:07:24,511 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:24,513 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 09:07:24,513 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 09:07:24,513 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:07:24,514 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 09:07:25,453 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 09:07:25,453 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 09:07:25,453 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:25,458 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 09:07:25,459 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 09:07:25,460 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:07:25,460 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 09:07:25,898 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 09:07:25,898 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testSimple took 12.632 sec [java] [junit] Testcase: testScope took 2.363 sec [java] [junit] Running org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 09:07:30,521 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 09:07:30,524 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 09:07:30,588 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 09:07:30,592 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 09:07:30,593 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 09:07:30,595 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 09:07:30,596 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 09:07:30,598 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 09:07:30,598 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 09:07:30,599 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 09:07:30,600 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:30,614 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 09:07:30,619 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:32,220 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:07:32,222 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 09:07:43,509 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 09:07:43,518 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205932063537.dat [java] [junit] version=scope1 [java] [junit] 09:07:54,061 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 09:07:54,062 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:54,067 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 09:07:54,068 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:54,069 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:07:54,069 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 09:07:54,412 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 09:07:54,413 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 24.417 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 24.417 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 09:07:30,521 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 09:07:30,524 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 09:07:30,588 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 09:07:30,592 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 09:07:30,593 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 09:07:30,595 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 09:07:30,596 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 09:07:30,598 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 09:07:30,598 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 09:07:30,599 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 09:07:30,600 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:30,614 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 09:07:30,619 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:32,220 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:07:32,222 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 09:07:43,509 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 09:07:43,518 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1205932063537.dat [java] [junit] version=scope1 [java] [junit] 09:07:54,061 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 09:07:54,062 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:54,067 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 09:07:54,068 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 09:07:54,069 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:07:54,069 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 09:07:54,412 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 09:07:54,413 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testFtp took 10.547 sec [java] [junit] Running org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 09:08:00,958 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 09:08:00,982 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 09:08:01,837 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 09:08:01,853 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 09:08:01,895 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 09:08:01,905 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 09:08:01,910 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 09:08:01,918 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 09:08:01,924 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 09:08:01,931 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 09:08:01,937 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:01,949 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 09:08:01,956 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:04,313 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:08:04,318 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 09:08:05,011 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 09:08:05,015 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 09:08:16,432 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 09:08:16,436 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:16,439 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 09:08:16,443 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:16,446 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:08:16,450 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 09:08:16,593 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 09:08:16,593 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 18.525 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 18.525 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 09:08:00,958 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 09:08:00,982 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 09:08:01,837 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 09:08:01,853 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 09:08:01,895 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 09:08:01,905 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 09:08:01,910 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 09:08:01,918 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 09:08:01,924 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 09:08:01,931 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 09:08:01,937 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:01,949 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 09:08:01,956 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:04,313 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 09:08:04,318 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 09:08:05,011 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 09:08:05,015 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 09:08:16,432 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 09:08:16,436 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:16,439 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 09:08:16,443 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 09:08:16,446 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 09:08:16,450 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 09:08:16,593 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 09:08:16,593 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testAsyncCallback took 11.398 sec [java] [junit] FAILED [java] [junit] checkWaitingAction expected:<true> but was:<false> [java] [junit] junit.framework.AssertionFailedError: checkWaitingAction expected:<true> but was:<false> [java] [junit] at org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest.testAsyncCallback(JbpmAsyncUnitTest.java:60) [java] [junit] at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:23) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:105: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/junit/build.xml:214: Test org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest failed [java] Total time: 2 minutes 24 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-19 09:08:20 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:12: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:88: QA Unit Test failure Total time: 63 minutes 25 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml

See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux_CP1/91/changes Changes: [kevin.conner(a)jboss.com] Fixed namespace/prefix: JBESB-1617 [kevin.conner(a)jboss.com] Update h2: JBESB-1611 [kevin.conner(a)jboss.com] remove debug line ------------------------------------------ [...truncated 9074 lines...] [java] [junit] 07:48:41,968 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 07:48:41,968 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 07:48:41,969 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 07:48:41,970 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:41,971 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 07:48:41,972 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:42,100 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:48:42,101 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 07:48:42,404 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 07:48:42,404 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 07:48:42,404 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:42,405 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 07:48:42,405 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:42,406 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:48:42,406 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 07:48:42,691 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 07:48:42,692 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 07:48:46,484 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 07:48:48,653 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 07:48:48,655 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:48,657 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 07:48:48,659 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:48,661 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:48:48,663 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 07:48:48,927 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 07:48:48,927 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 07:48:48,927 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:48,933 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 07:48:48,933 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:48,933 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:48:48,934 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 07:48:49,127 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 07:48:49,127 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 7.574 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.SimpleDeployUnitTest [java] [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 7.574 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 07:48:41,918 DEBUG [main][SimpleDeployUnitTest] ==== setUp org.jboss.soa.esb.server.SimpleDeployUnitTest ==== [java] [junit] 07:48:41,920 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.setUp() [java] [junit] 07:48:41,960 DEBUG [main][SimpleDeployUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 07:48:41,961 INFO [main][SimpleDeployUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 07:48:41,962 INFO [main][SimpleDeployUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 07:48:41,963 INFO [main][SimpleDeployUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 07:48:41,967 INFO [main][SimpleDeployUnitTest] jbosstest.nodeploy: null [java] [junit] 07:48:41,968 INFO [main][SimpleDeployUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 07:48:41,968 INFO [main][SimpleDeployUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 07:48:41,969 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 07:48:41,970 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:41,971 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 07:48:41,972 DEBUG [main][SimpleDeployUnitTest] Deploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:42,100 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:48:42,101 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 07:48:42,404 DEBUG [main][SimpleDeployUnitTest] deployed package: simple.esb [java] [junit] 07:48:42,404 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 07:48:42,404 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:42,405 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 07:48:42,405 DEBUG [main][SimpleDeployUnitTest] Deploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:42,406 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:48:42,406 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 07:48:42,691 DEBUG [main][SimpleDeployUnitTest] deployed package: simple-scoped.esb [java] [junit] 07:48:42,692 DEBUG [main][SimpleDeployUnitTest] ==== Starting testSimple ==== [java] [junit] 07:48:46,484 DEBUG [main][SimpleDeployUnitTest] ==== Starting testScope ==== [java] [junit] 07:48:48,653 DEBUG [main][SimpleDeployUnitTest] simple-scoped.esb is not a valid URL, no protocol: simple-scoped.esb [java] [junit] 07:48:48,655 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:48,657 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb is a valid file [java] [junit] 07:48:48,659 DEBUG [main][SimpleDeployUnitTest] Undeploying simple-scoped.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb [java] [junit] 07:48:48,661 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:48:48,663 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple-scoped.esb] [java] [junit] 07:48:48,927 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple-scoped.esb [java] [junit] 07:48:48,927 DEBUG [main][SimpleDeployUnitTest] simple.esb is not a valid URL, no protocol: simple.esb [java] [junit] 07:48:48,927 DEBUG [main][SimpleDeployUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:48,933 DEBUG [main][SimpleDeployUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb is a valid file [java] [junit] 07:48:48,933 DEBUG [main][SimpleDeployUnitTest] Undeploying simple.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb [java] [junit] 07:48:48,933 DEBUG [main][SimpleDeployUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:48:48,934 DEBUG [main][SimpleDeployUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/simple.esb] [java] [junit] 07:48:49,127 DEBUG [main][SimpleDeployUnitTest] undeployed package: simple.esb [java] [junit] 07:48:49,127 DEBUG [main][SimpleDeployUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testSimple took 3.786 sec [java] [junit] Testcase: testScope took 2.167 sec [java] [junit] Running org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 07:48:50,458 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 07:48:50,462 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 07:48:50,536 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 07:48:50,539 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 07:48:50,540 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 07:48:50,542 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 07:48:50,547 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 07:48:50,548 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 07:48:50,550 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 07:48:50,553 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 07:48:50,560 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:48:50,563 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 07:48:50,564 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:48:50,717 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:48:50,718 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 07:48:51,480 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 07:48:51,486 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1206100131495.dat [java] [junit] version=scope1 [java] [junit] 07:49:01,679 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 07:49:01,680 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:49:01,683 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 07:49:01,683 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:49:01,684 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:49:01,684 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 07:49:01,800 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 07:49:01,800 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 11.781 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.ftp.FtpUnitTest [java] [junit] Tests run: 1, Failures: 0, Errors: 0, Time elapsed: 11.781 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 07:48:50,458 DEBUG [main][FtpUnitTest] ==== setUp org.jboss.soa.esb.server.ftp.FtpUnitTest ==== [java] [junit] 07:48:50,462 DEBUG [main][FtpUnitTest] JBossTestServices.setUp() [java] [junit] 07:48:50,536 DEBUG [main][FtpUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 07:48:50,539 INFO [main][FtpUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 07:48:50,540 INFO [main][FtpUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 07:48:50,542 INFO [main][FtpUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 07:48:50,547 INFO [main][FtpUnitTest] jbosstest.nodeploy: null [java] [junit] 07:48:50,548 INFO [main][FtpUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 07:48:50,550 INFO [main][FtpUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 07:48:50,553 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 07:48:50,560 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:48:50,563 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 07:48:50,564 DEBUG [main][FtpUnitTest] Deploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:48:50,717 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:48:50,718 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 07:48:51,480 DEBUG [main][FtpUnitTest] deployed package: ftp-test.esb [java] [junit] 07:48:51,486 DEBUG [main][FtpUnitTest] ==== Starting testFtp ==== [java] [junit] FTP URL=ftp://ftpesb:ftppass@dev39.qa.atl.jboss.com/%2FFtpUnitTestCase-1206100131495.dat [java] [junit] version=scope1 [java] [junit] 07:49:01,679 DEBUG [main][FtpUnitTest] ftp-test.esb is not a valid URL, no protocol: ftp-test.esb [java] [junit] 07:49:01,680 DEBUG [main][FtpUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:49:01,683 DEBUG [main][FtpUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb is a valid file [java] [junit] 07:49:01,683 DEBUG [main][FtpUnitTest] Undeploying ftp-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb [java] [junit] 07:49:01,684 DEBUG [main][FtpUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:49:01,684 DEBUG [main][FtpUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/ftp-test.esb] [java] [junit] 07:49:01,800 DEBUG [main][FtpUnitTest] undeployed package: ftp-test.esb [java] [junit] 07:49:01,800 DEBUG [main][FtpUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testFtp took 10.194 sec [java] [junit] Running org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] 07:49:03,477 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 07:49:03,479 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 07:49:03,514 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 07:49:03,515 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 07:49:03,515 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 07:49:03,516 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 07:49:03,517 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 07:49:03,517 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 07:49:03,518 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 07:49:03,518 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 07:49:03,519 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:03,520 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 07:49:03,520 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:03,712 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:49:03,715 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 07:49:03,923 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 07:49:03,925 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 07:49:14,279 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 07:49:14,282 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:14,285 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 07:49:14,287 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:14,288 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:49:14,290 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 07:49:14,414 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 07:49:14,414 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 11.41 sec [java] [junit] Testsuite: org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest [java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 11.41 sec [java] [junit] ------------- Standard Output --------------- [java] [junit] 07:49:03,477 DEBUG [main][JbpmAsyncUnitTest] ==== setUp org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest ==== [java] [junit] 07:49:03,479 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.setUp() [java] [junit] 07:49:03,514 DEBUG [main][JbpmAsyncUnitTest] initialContext.getEnvironment()={jnp.parsedName=, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.provider.url=localhost:1099, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces} [java] [junit] 07:49:03,515 INFO [main][JbpmAsyncUnitTest] jbosstest.beancount: ${jbosstest.beancount} [java] [junit] 07:49:03,515 INFO [main][JbpmAsyncUnitTest] jbosstest.iterationcount: ${jbosstest.iterationcount} [java] [junit] 07:49:03,516 INFO [main][JbpmAsyncUnitTest] jbosstest.threadcount: ${jbosstest.threadcount} [java] [junit] 07:49:03,517 INFO [main][JbpmAsyncUnitTest] jbosstest.nodeploy: null [java] [junit] 07:49:03,517 INFO [main][JbpmAsyncUnitTest] jbosstest.jndiurl: localhost:1099 [java] [junit] 07:49:03,518 INFO [main][JbpmAsyncUnitTest] jbosstest.jndifactory: org.jnp.interfaces.NamingContextFactory [java] [junit] 07:49:03,518 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 07:49:03,519 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:03,520 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 07:49:03,520 DEBUG [main][JbpmAsyncUnitTest] Deploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:03,712 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=redeploy [java] [junit] 07:49:03,715 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 07:49:03,923 DEBUG [main][JbpmAsyncUnitTest] deployed package: jbpm-async-test.esb [java] [junit] 07:49:03,925 DEBUG [main][JbpmAsyncUnitTest] ==== Starting testAsyncCallback ==== [java] [junit] 07:49:14,279 DEBUG [main][JbpmAsyncUnitTest] jbpm-async-test.esb is not a valid URL, no protocol: jbpm-async-test.esb [java] [junit] 07:49:14,282 DEBUG [main][JbpmAsyncUnitTest] Testing file: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:14,285 DEBUG [main][JbpmAsyncUnitTest] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb is a valid file [java] [junit] 07:49:14,287 DEBUG [main][JbpmAsyncUnitTest] Undeploying jbpm-async-test.esb, url=file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb [java] [junit] 07:49:14,288 DEBUG [main][JbpmAsyncUnitTest] Invoking jboss.system:service=MainDeployer method=undeploy [java] [junit] 07:49:14,290 DEBUG [main][JbpmAsyncUnitTest] args=[file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/lib/jbpm-async-test.esb] [java] [junit] 07:49:14,414 DEBUG [main][JbpmAsyncUnitTest] undeployed package: jbpm-async-test.esb [java] [junit] 07:49:14,414 DEBUG [main][JbpmAsyncUnitTest] JBossTestServices.tearDown() [java] [junit] ------------- ---------------- --------------- [java] [junit] ------------- Standard Error ----------------- [java] [junit] Found log4j.xml: file:/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/log4j.xml [java] [junit] ------------- ---------------- --------------- [java] [junit] Testcase: testAsyncCallback took 10.35 sec [java] [junit] FAILED [java] [junit] checkWaitingAction expected:<true> but was:<false> [java] [junit] junit.framework.AssertionFailedError: checkWaitingAction expected:<true> but was:<false> [java] [junit] at org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest.testAsyncCallback(JbpmAsyncUnitTest.java:60) [java] [junit] at junit.extensions.TestDecorator.basicRun(TestDecorator.java:24) [java] [junit] at junit.extensions.TestSetup$1.protect(TestSetup.java:23) [java] [junit] at junit.extensions.TestSetup.run(TestSetup.java:27) [java] BUILD FAILED [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:105: The following error occurred while executing this line: [java] /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/junit/build.xml:214: Test org.jboss.soa.esb.server.jbpmAsync.JbpmAsyncUnitTest failed [java] Total time: 53 seconds [java] Java Result: 1 esb.init-app-server: esb.init-esb-server: esb.init-ftp-server: esb.init: stop-server: [echo] Stopping local ESB server [java] Shutdown message has been posted to the server. [java] Server shutdown may take a while - check logfiles for completion [echo] 2008-03-21 07:49:16 EDT: waiting for ESB server to stop, checking file /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build/jbossesb-test/jbossesb-server/server/default/log/server.log ... BUILD FAILED /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/integration-build.xml:12: The following error occurred while executing this line: /qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux_CP1/trunk/qa/build.xml:88: QA Unit Test failure Total time: 17 minutes 12 seconds Recording test results Recording Emma reports trunk/product/build/tests/coverage/coverage.xml