[switchyard-dev] Build failed in Jenkins: SwitchYard-Release #1557

ci-builds at redhat.com ci-builds at redhat.com
Tue Feb 24 16:36:07 EST 2015


See <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/1557/>

------------------------------------------
[...truncated 146664 lines...]
	at org.jboss.netty.handler.codec.frame.FrameDecoder.messageReceived(FrameDecoder.java:303)
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:268)
	at org.jboss.netty.channel.Channels.fireMessageReceived(Channels.java:255)
	at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:88)
	at org.jboss.netty.channel.socket.nio.AbstractNioWorker.process(AbstractNioWorker.java:109)
	at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:312)
	at org.jboss.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:90)
	at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_67]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_67]
	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_67]

16:29:46,192 INFO  [org.switchyard.quickstarts.camel.netty.binding.SecuredGreetingServiceBean] (Camel (camel-1) thread #21 - NettyOrderedWorker) :: SecuredGreetingService :: Hello org.switchyard.test.quickstarts.CamelNettyBindingQuickstartTest! (caller principal=UserPrincipal at 20722777[name=kermit], in roles? 'friend'=true 'enemy'=false)
16:29:47,072 WARN  [org.apache.camel.component.netty.NettyConsumer] (Camel (camel-1) thread #7 - NettyOrderedWorker) Closing channel as an exception was thrown from Netty. Caused by: [java.io.IOException - Connection reset by peer]: java.io.IOException: Connection reset by peer
	at sun.nio.ch.FileDispatcherImpl.read0(Native Method) [rt.jar:1.7.0_67]
	at sun.nio.ch.SocketDispatcher.read(SocketDispatcher.java:39) [rt.jar:1.7.0_67]
	at sun.nio.ch.IOUtil.readIntoNativeBuffer(IOUtil.java:223) [rt.jar:1.7.0_67]
	at sun.nio.ch.IOUtil.read(IOUtil.java:192) [rt.jar:1.7.0_67]
	at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:379) [rt.jar:1.7.0_67]
	at org.jboss.netty.channel.socket.nio.NioWorker.read(NioWorker.java:64)
	at org.jboss.netty.channel.socket.nio.AbstractNioWorker.process(AbstractNioWorker.java:109)
	at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:312)
	at org.jboss.netty.channel.socket.nio.AbstractNioWorker.run(AbstractNioWorker.java:90)
	at org.jboss.netty.channel.socket.nio.NioWorker.run(NioWorker.java:178)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_67]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_67]
	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_67]

16:29:47,109 INFO  [org.switchyard.quickstarts.camel.netty.binding.DefaultGreetingServiceBean] (Camel (camel-1) thread #8 - NettyOrderedWorker) :: DefaultGreetingService :: Hello org.switchyard.test.quickstarts.CamelNettyBindingQuickstartTest! (caller principal=null, in roles? 'friend'=false 'enemy'=false)
16:29:48,146 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Starting to graceful shutdown 1 routes (timeout 30 seconds)
16:29:48,159 INFO  [org.apache.camel.component.netty.SingleTCPNettyServerBootstrapFactory] (Camel (camel-1) thread #23 - ShutdownTask) ServerBootstrap unbinding from localhost:3939
16:29:48,175 INFO  [org.apache.camel.component.netty.NettyConsumer] (Camel (camel-1) thread #23 - ShutdownTask) Netty consumer unbound from: localhost:3939
16:29:48,183 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (Camel (camel-1) thread #23 - ShutdownTask) Route: V1CamelNettyTcpBindingModel/SecuredGreetingService at _SecuredGreetingService_tcp_1#-1766359606 shutdown complete, was consuming from: Endpoint[tcp://localhost:3939]
16:29:48,185 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Graceful shutdown of 1 routes completed in 0 seconds
16:29:48,189 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Route: V1CamelNettyTcpBindingModel/SecuredGreetingService at _SecuredGreetingService_tcp_1#-1766359606 is stopped, was consuming from: Endpoint[tcp://localhost:3939]
16:29:48,196 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Route: V1CamelNettyTcpBindingModel/SecuredGreetingService at _SecuredGreetingService_tcp_1#-1766359606 is shutdown and removed, was consuming from: Endpoint[tcp://localhost:3939]
16:29:48,199 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Starting to graceful shutdown 1 routes (timeout 30 seconds)
16:29:48,201 INFO  [org.apache.camel.component.netty.SingleUDPNettyServerBootstrapFactory] (Camel (camel-1) thread #23 - ShutdownTask) ConnectionlessBootstrap disconnecting from localhost:3940
16:29:48,210 INFO  [org.apache.camel.component.netty.NettyConsumer] (Camel (camel-1) thread #23 - ShutdownTask) Netty consumer unbound from: localhost:3940
16:29:48,215 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (Camel (camel-1) thread #23 - ShutdownTask) Route: V1CamelNettyUdpBindingModel/DefaultGreetingService at _DefaultGreetingService_udp_1#1833197758 shutdown complete, was consuming from: Endpoint[udp://localhost:3940]
16:29:48,218 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Graceful shutdown of 1 routes completed in 0 seconds
16:29:48,221 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Route: V1CamelNettyUdpBindingModel/DefaultGreetingService at _DefaultGreetingService_udp_1#1833197758 is stopped, was consuming from: Endpoint[udp://localhost:3940]
16:29:48,226 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Route: V1CamelNettyUdpBindingModel/DefaultGreetingService at _DefaultGreetingService_udp_1#1833197758 is shutdown and removed, was consuming from: Endpoint[udp://localhost:3940]
16:29:48,244 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) is shutting down
16:29:48,247 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Starting to graceful shutdown 2 routes (timeout 30 seconds)
16:29:48,251 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (Camel (camel-1) thread #23 - ShutdownTask) Route: direct:{urn:switchyard-quickstart:camel-netty-binding:0.1.0}DefaultGreetingService shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-netty-binding:0.1.0%7DDefaultGreetingService]
16:29:48,253 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (Camel (camel-1) thread #23 - ShutdownTask) Route: direct:{urn:switchyard-quickstart:camel-netty-binding:0.1.0}SecuredGreetingService shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-netty-binding:0.1.0%7DSecuredGreetingService]
16:29:48,256 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Graceful shutdown of 2 routes completed in 0 seconds
16:29:48,308 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) uptime 33.194 seconds
16:29:48,310 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) is shutdown in 0.063 seconds
16:29:48,318 INFO  [org.jboss.weld.deployer] (MSC service thread 1-2) JBAS016009: Stopping weld service for deployment switchyard-camel-netty-binding-2.0.0.CR1.jar
16:29:48,363 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-2) JBAS015877: Stopped deployment switchyard-camel-netty-binding-2.0.0.CR1.jar (runtime-name: switchyard-camel-netty-binding-2.0.0.CR1.jar) in 231ms
16:29:49,319 INFO  [org.jboss.as.repository] (management-handler-thread - 1) JBAS014901: Content removed from location <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/data/content/7f/69719baa5565668ce3ecb65587827301f83cf9/content>
16:29:49,321 INFO  [org.jboss.as.server] (management-handler-thread - 1) JBAS018558: Undeployed "switchyard-camel-netty-binding-2.0.0.CR1.jar" (runtime-name: "switchyard-camel-netty-binding-2.0.0.CR1.jar")
 at SLTests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 62.415 sec
Running org.switchyard.test.quickstarts.RemoteInvokerQuickstartTest
log4j:WARN No appenders could be found for logger (org.jboss.logging).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
Feb 24, 2015 4:29:55 PM org.jboss.as.arquillian.container.managed.ManagedDeployableContainer startInternal
INFO: Starting container with: [/qa/tools/opt/jdk1.7.0_last/bin/java, -Xms256m, -Xmx1024m, -XX:MaxPermSize=512m, -ea, -Djboss.home.dir=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3,> -Dorg.jboss.boot.log.file=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/log/boot.log,> -Dlogging.configuration=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/configuration/logging.properties,> -Djboss.bundles.dir=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/bundles,> -jar, <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/jboss-modules.jar,> -mp, <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/modules,> -jaxpmodule, javax.xml.jaxp-provider, org.jboss.as.standalone, -server-config, standalone-full.xml]
16:29:56,121 INFO  [org.jboss.modules] (main) JBoss Modules version 1.3.3.Final-redhat-1
16:29:56,564 INFO  [org.jboss.msc] (main) JBoss MSC version 1.1.5.Final-redhat-1
16:29:56,716 INFO  [org.jboss.as] (MSC service thread 1-4) JBAS015899: JBoss EAP 6.3.0.GA (AS 7.4.0.Final-redhat-19) starting
16:29:59,201 INFO  [org.switchyard] (ServerService Thread Pool -- 5) SwitchYard version 2.0.0.CR1
16:29:59,673 INFO  [org.xnio] (MSC service thread 1-3) XNIO Version 3.0.10.GA-redhat-1
16:29:59,677 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS015888: Creating http management service using socket-binding (management-http)
16:29:59,693 INFO  [org.xnio.nio] (MSC service thread 1-3) XNIO NIO Implementation Version 3.0.10.GA-redhat-1
16:29:59,752 INFO  [org.jboss.remoting] (MSC service thread 1-3) JBoss Remoting version (unknown)
16:29:59,915 INFO  [org.jboss.as.jacorb] (ServerService Thread Pool -- 37) JBAS016300: Activating JacORB Subsystem
16:29:59,967 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 36) JBAS010280: Activating Infinispan subsystem.
16:30:00,042 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 48) JBAS011800: Activating Naming Subsystem
16:30:00,068 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 32) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
16:30:00,105 WARN  [org.jboss.as.txn] (ServerService Thread Pool -- 55) JBAS010153: Node identifier property is set to the default value. Please make sure it is unique.
16:30:00,114 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 57) JBAS015537: Activating WebServices Extension
16:30:00,133 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 44) JBAS012605: Activated the following JSF Implementations: [main, 1.2]
16:30:00,062 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 53) JBAS013171: Activating Security Subsystem
16:30:00,187 INFO  [org.switchyard] (ServerService Thread Pool -- 59) Activating SwitchYard Subsystem
16:30:00,283 INFO  [org.jboss.as.naming] (MSC service thread 1-2) JBAS011802: Starting Naming Service
16:30:00,297 INFO  [org.jboss.as.security] (MSC service thread 1-5) JBAS013170: Current PicketBox version=4.0.19.SP8-redhat-1
16:30:00,350 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-4) JBAS015400: Bound mail session [java:jboss/mail/Default]
16:30:00,356 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-4) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.26.Final-redhat-1)
16:30:00,542 INFO  [org.jboss.jaxr] (MSC service thread 1-2) JBAS014000: Started JAXR subsystem, binding JAXR connection factory into JNDI as: java:jboss/jaxr/ConnectionFactory
16:30:01,595 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-1) JBWEB003001: Coyote HTTP/1.1 initializing on : http-/127.0.0.1:8080
16:30:01,682 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-1) JBWEB003000: Coyote HTTP/1.1 starting on: http-/127.0.0.1:8080
16:30:02,238 INFO  [org.jboss.ws.common.management] (MSC service thread 1-6) JBWS022052: Starting JBoss Web Services - Stack CXF Server 4.3.0.Final-redhat-3
16:30:02,379 INFO  [org.jboss.as.jacorb] (MSC service thread 1-3) JBAS016330: CORBA ORB Service started
16:30:02,584 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-5) JBAS015012: Started FileSystemDeploymentService for directory <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/deployments>
16:30:02,610 INFO  [org.jboss.as.remoting] (MSC service thread 1-6) JBAS017100: Listening on 127.0.0.1:4447
16:30:02,610 INFO  [org.jboss.as.remoting] (MSC service thread 1-4) JBAS017100: Listening on 127.0.0.1:9999
16:30:03,288 INFO  [org.jboss.as.jacorb] (MSC service thread 1-3) JBAS016328: CORBA Naming Service started
16:30:03,733 INFO  [org.switchyard.component.bpel] (MSC service thread 1-2) SWITCHYARD030800: Init BPEL component
16:30:03,799 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221000: live server is starting with configuration HornetQ Configuration (clustered=false,backup=false,sharedStore=true,journalDirectory=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/data/messagingjournal,bindingsDirectory=/mnt/hudson_workspace/workspace/SwitchYard-Release/jboss-eap-6.3/standalone/data/messagingbindings,largeMessagesDirectory=/mnt/hudson_workspace/workspace/SwitchYard-Release/jboss-eap-6.3/standalone/data/messaginglargemessages,pagingDirectory=/mnt/hudson_workspace/workspace/SwitchYard-Release/jboss-eap-6.3/standalone/data/messagingpaging)>
16:30:03,802 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221006: Waiting to obtain live lock
16:30:03,833 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-3) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS]
16:30:03,864 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221013: Using NIO Journal
16:30:05,182 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221034: Waiting to obtain live lock
16:30:05,183 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221035: Live Server Obtained live lock
16:30:18,763 WARN  [com.arjuna.ats.jta] (Periodic Recovery) ARJUNA016037: Could not find new XAResource to use for recovering non-serializable XAResource XAResourceRecord < resource:null, txid:< formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffff0a1059e0:75b5ecfe:54eceae0:52, node_name=1, branch_uid=0:ffff0a1059e0:75b5ecfe:54eceae0:53, subordinatenodename=null, eis_name=unknown eis name >, heuristic: TwoPhaseOutcome.FINISH_OK com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord at 15e3f1 >
16:30:23,732 WARN  [com.arjuna.ats.jta] (Periodic Recovery) ARJUNA016038: No XAResource to recover < formatId=131077, gtrid_length=29, bqual_length=36, tx_uid=0:ffff0a1059e0:75b5ecfe:54eceae0:52, node_name=1, branch_uid=0:ffff0a1059e0:75b5ecfe:54eceae0:53, subordinatenodename=null, eis_name=unknown eis name >
16:30:26,942 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221020: Started Netty Acceptor version 3.6.9.Final-redhat-1-4cc400c 127.0.0.1:5445 for CORE protocol
16:30:26,947 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221020: Started Netty Acceptor version 3.6.9.Final-redhat-1-4cc400c 127.0.0.1:5455 for CORE protocol
16:30:26,952 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221007: Server is now live
16:30:26,953 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221001: HornetQ Server version 2.3.20.Final (2.3.20, 123) [f2426136-bc66-11e4-972a-41bd5806d934] 
16:30:26,979 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 60) HQ221003: trying to deploy queue jms.queue.ExpiryQueue
16:30:27,009 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 60) JBAS011601: Bound messaging object to jndi name java:/jms/queue/ExpiryQueue
16:30:27,011 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 70) HQ221003: trying to deploy queue jms.queue.JCAInflowGreetingServiceQueue
16:30:28,522 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-5) JBAS010406: Registered connection factory java:/JmsXA
16:30:28,674 INFO  [org.hornetq.ra] (MSC service thread 1-5) HornetQ resource adaptor started
16:30:28,680 INFO  [org.jboss.as.connector.services.resourceadapters.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-5) IJ020002: Deployed: file://RaActivatorhornetq-ra
16:30:28,687 INFO  [org.jboss.as.connector.deployment] (MSC service thread 1-6) JBAS010401: Bound JCA ConnectionFactory [java:/JmsXA]
16:30:38,467 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 70) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/JCAInflowGreetingServiceQueue
16:30:38,469 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 70) JBAS011601: Bound messaging object to jndi name java:/JCAInflowGreetingServiceQueue
16:30:38,470 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 69) HQ221003: trying to deploy queue jms.queue.TestQueue
16:30:38,475 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 69) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/TestQueue
16:30:38,476 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 69) JBAS011601: Bound messaging object to jndi name java:/TestQueue
16:30:38,478 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 67) HQ221003: trying to deploy queue jms.queue.StoreFaultQueue
16:30:38,482 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 67) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/StoreFaultQueue
16:30:38,483 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 67) JBAS011601: Bound messaging object to jndi name java:/StoreFaultQueue
16:30:38,484 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 76) HQ221003: trying to deploy queue jms.queue.InOutTestQueue_replyTo
16:30:38,488 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 76) JBAS011601: Bound messaging object to jndi name java:/InOutTestQueue_replyTo
16:30:38,489 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 76) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/InOutTestQueue_replyTo
16:30:38,490 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 68) HQ221003: trying to deploy queue jms.queue.ShippingQueue
16:30:38,494 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 68) JBAS011601: Bound messaging object to jndi name java:/ShippingQueue
16:30:38,495 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 68) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/ShippingQueue
16:30:38,496 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 75) HQ221003: trying to deploy queue jms.queue.OrderQueue
16:30:38,499 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 75) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/OrderQueue
16:30:38,501 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 75) JBAS011601: Bound messaging object to jndi name java:/OrderQueue
16:30:38,501 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 74) HQ221003: trying to deploy queue jms.queue.InOutTestQueue_faultTo
16:30:38,506 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 74) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/InOutTestQueue_faultTo
16:30:38,507 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 74) JBAS011601: Bound messaging object to jndi name java:/InOutTestQueue_faultTo
16:30:38,508 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 64) HQ221003: trying to deploy queue jms.queue.InOutPhysicalNameTestQueue_replyTo_physical
16:30:38,513 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 64) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/InOutPhysicalNameTestQueue_replyTo_jndi
16:30:38,514 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 64) JBAS011601: Bound messaging object to jndi name java:/InOutPhysicalNameTestQueue_replyTo_jndi
16:30:38,515 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 73) HQ221003: trying to deploy queue jms.queue.InOutTestQueue
16:30:38,519 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 73) JBAS011601: Bound messaging object to jndi name java:/InOutTestQueue
16:30:38,521 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 73) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/InOutTestQueue
16:30:38,522 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 72) HQ221003: trying to deploy queue jms.queue.FillingStockQueue
16:30:38,527 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 72) JBAS011601: Bound messaging object to jndi name java:/FillingStockQueue
16:30:38,528 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 72) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/FillingStockQueue
16:30:38,529 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 71) HQ221003: trying to deploy queue jms.queue.InOutPhysicalNameTestQueue_physical
16:30:38,533 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 71) JBAS011601: Bound messaging object to jndi name java:/InOutPhysicalNameTestQueue_jndi
16:30:38,534 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 71) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/InOutPhysicalNameTestQueue_jndi
16:30:38,535 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 63) HQ221003: trying to deploy queue jms.queue.InOutPhysicalNameTestQueue_faultTo_physical
16:30:38,539 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 63) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/InOutPhysicalNameTestQueue_faultTo_jndi
16:30:38,540 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 63) JBAS011601: Bound messaging object to jndi name java:/InOutPhysicalNameTestQueue_faultTo_jndi
16:30:38,541 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 65) HQ221003: trying to deploy queue jms.queue.StoreResultQueue
16:30:38,545 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 65) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/StoreResultQueue
16:30:38,546 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 65) JBAS011601: Bound messaging object to jndi name java:/StoreResultQueue
16:30:38,547 INFO  [org.hornetq.core.server] (ServerService Thread Pool -- 62) HQ221003: trying to deploy queue jms.queue.DLQ
16:30:38,549 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 62) JBAS011601: Bound messaging object to jndi name java:/jms/queue/DLQ
16:30:38,564 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 66) JBAS011601: Bound messaging object to jndi name java:/ConnectionFactory
16:30:38,567 INFO  [org.jboss.as.messaging] (ServerService Thread Pool -- 61) JBAS011601: Bound messaging object to jndi name java:jboss/exported/jms/RemoteConnectionFactory
16:30:39,603 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015961: Http management interface listening on http://127.0.0.1:9990/management
16:30:39,605 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990
16:30:39,606 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss EAP 6.3.0.GA (AS 7.4.0.Final-redhat-19) started in 44305ms - Started 232 of 269 services (80 services are lazy, passive or on-demand)
16:30:40,248 INFO  [org.jboss.as.repository] (management-handler-thread - 4) JBAS014900: Content added at location <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/data/content/76/ef48cba2c67c3acb84d3cf8d31f3220e32dbbd/content>
16:30:40,308 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-2) JBAS015876: Starting deployment of "switchyard-remote-invoker-2.0.0.CR1.jar" (runtime-name: "switchyard-remote-invoker-2.0.0.CR1.jar")
16:30:41,068 INFO  [org.jboss.weld.deployer] (MSC service thread 1-5) JBAS016002: Processing weld deployment switchyard-remote-invoker-2.0.0.CR1.jar
16:30:41,277 INFO  [org.jboss.weld.deployer] (MSC service thread 1-2) JBAS016005: Starting Services for CDI deployment: switchyard-remote-invoker-2.0.0.CR1.jar
16:30:41,452 INFO  [org.jboss.weld.Version] (MSC service thread 1-2) WELD-000900 1.1.23 (redhat)
16:30:41,505 INFO  [org.switchyard] (MSC service thread 1-2) Deploying SwitchYard application 'switchyard-remote-invoker-2.0.0.CR1.jar'
16:30:41,554 INFO  [org.jboss.weld.deployer] (MSC service thread 1-1) JBAS016008: Starting weld service for deployment switchyard-remote-invoker-2.0.0.CR1.jar
16:30:42,374 INFO  [org.switchyard] (MSC service thread 1-2) Starting SwitchYard service
16:30:42,705 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) is starting
16:30:42,707 INFO  [org.apache.camel.management.ManagedManagementStrategy] (MSC service thread 1-2) JMX is enabled
16:30:42,975 INFO  [org.apache.deltaspike.core.util.ProjectStageProducer] (MSC service thread 1-2) Computed the following DeltaSpike ProjectStage: Production
16:30:42,990 INFO  [org.apache.camel.impl.converter.DefaultTypeConverter] (MSC service thread 1-2) Loaded 220 type converters
16:30:43,031 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) AllowUseOriginalMessage is enabled. If access to the original message is not needed, then its recommended to turn this option off as it may improve performance.
16:30:43,032 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) StreamCaching is not in use. If using streams then its recommended to enable stream caching. See more details at http://camel.apache.org/stream-caching.html
16:30:43,032 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) Total 0 routes, of which 0 is started.
16:30:43,034 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) started in 0.328 seconds
16:30:43,059 INFO  [org.switchyard.component.sca] (MSC service thread 1-2) SWITCHYARD039200: Unable to resolve cache-container cluster.  clustering for <binding.sca> will not be available for services and references.
16:30:43,324 INFO  [org.apache.camel.impl.converter.DefaultTypeConverter] (MSC service thread 1-2) Loaded 220 type converters
16:30:44,600 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) Route: direct:{urn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0}DealerBean/CreditCheck started and consuming from: Endpoint[direct://%7Burn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0%7DDealerBean/CreditCheck]
16:30:47,453 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-2) Route: direct:{urn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0}Dealer started and consuming from: Endpoint[direct://%7Burn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0%7DDealer]
16:30:47,468 INFO  [org.switchyard.as7.extension.cluster.RemoteEndpointListener] (MSC service thread 1-2) Published Remote Service Endpoint /switchyard-remote
16:30:50,311 INFO  [org.jboss.as.server] (management-handler-thread - 4) JBAS018559: Deployed "switchyard-remote-invoker-2.0.0.CR1.jar" (runtime-name : "switchyard-remote-invoker-2.0.0.CR1.jar")
16:30:56,314 INFO  [stdout] (http-/127.0.0.1:8080-1) Approving credit for Magesh
16:30:56,803 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) is shutting down
16:30:56,806 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Starting to graceful shutdown 2 routes (timeout 30 seconds)
16:30:56,822 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (Camel (camel-1) thread #0 - ShutdownTask) Route: direct:{urn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0}Dealer shutdown complete, was consuming from: Endpoint[direct://%7Burn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0%7DDealer]
16:30:56,824 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (Camel (camel-1) thread #0 - ShutdownTask) Route: direct:{urn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0}DealerBean/CreditCheck shutdown complete, was consuming from: Endpoint[direct://%7Burn:com.example.switchyard:switchyard-quickstart-remote-invoker:1.0%7DDealerBean/CreditCheck]
16:30:56,826 INFO  [org.apache.camel.impl.DefaultShutdownStrategy] (MSC service thread 1-6) Graceful shutdown of 2 routes completed in 0 seconds
16:30:56,871 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) uptime 14.166 seconds
16:30:56,872 INFO  [org.switchyard.common.camel.SwitchYardCamelContextImpl] (MSC service thread 1-6) Apache Camel 2.0.0.CR1 (CamelContext: camel-1) is shutdown in 0.067 seconds
16:30:56,877 INFO  [org.jboss.weld.deployer] (MSC service thread 1-1) JBAS016009: Stopping weld service for deployment switchyard-remote-invoker-2.0.0.CR1.jar
16:30:56,912 INFO  [org.jboss.as.server.deployment] (MSC service thread 1-2) JBAS015877: Stopped deployment switchyard-remote-invoker-2.0.0.CR1.jar (runtime-name: switchyard-remote-invoker-2.0.0.CR1.jar) in 140ms
16:30:57,585 INFO  [org.jboss.as.repository] (management-handler-thread - 1) JBAS014901: Content removed from location <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/data/content/76/ef48cba2c67c3acb84d3cf8d31f3220e32dbbd/content>
16:30:57,586 INFO  [org.jboss.as.server] (management-handler-thread - 1) JBAS018558: Undeployed "switchyard-remote-invoker-2.0.0.CR1.jar" (runtime-name: "switchyard-remote-invoker-2.0.0.CR1.jar")
 at SLTests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 64.347 sec
Running org.switchyard.test.quickstarts.demo.PolicySecurityWssSignencryptDemoQuickstartTest
log4j:WARN No appenders could be found for logger (org.jboss.logging).
log4j:WARN Please initialize the log4j system properly.
log4j:WARN See http://logging.apache.org/log4j/1.2/faq.html#noconfig for more info.
Feb 24, 2015 4:31:17 PM org.jboss.as.arquillian.container.managed.ManagedDeployableContainer startInternal
INFO: Starting container with: [/qa/tools/opt/jdk1.7.0_last/bin/java, -Xms256m, -Xmx1024m, -XX:MaxPermSize=512m, -ea, -Djboss.home.dir=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3,> -Dorg.jboss.boot.log.file=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/log/boot.log,> -Dlogging.configuration=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/configuration/logging.properties,> -Djboss.bundles.dir=<http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/bundles,> -jar, <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/jboss-modules.jar,> -mp, <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/modules,> -jaxpmodule, javax.xml.jaxp-provider, org.jboss.as.standalone, -server-config, standalone-full.xml]
16:31:18,845 INFO  [org.jboss.modules] (main) JBoss Modules version 1.3.3.Final-redhat-1
16:31:19,294 INFO  [org.jboss.msc] (main) JBoss MSC version 1.1.5.Final-redhat-1
16:31:19,466 INFO  [org.jboss.as] (MSC service thread 1-3) JBAS015899: JBoss EAP 6.3.0.GA (AS 7.4.0.Final-redhat-19) starting
16:31:21,912 INFO  [org.switchyard] (ServerService Thread Pool -- 27) SwitchYard version 2.0.0.CR1
16:31:22,389 INFO  [org.xnio] (MSC service thread 1-5) XNIO Version 3.0.10.GA-redhat-1
16:31:22,397 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS015888: Creating http management service using socket-binding (management-http)
16:31:22,413 INFO  [org.xnio.nio] (MSC service thread 1-5) XNIO NIO Implementation Version 3.0.10.GA-redhat-1
16:31:22,495 INFO  [org.jboss.remoting] (MSC service thread 1-5) JBoss Remoting version (unknown)
16:31:22,593 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 36) JBAS010280: Activating Infinispan subsystem.
16:31:22,607 INFO  [org.jboss.as.jacorb] (ServerService Thread Pool -- 37) JBAS016300: Activating JacORB Subsystem
16:31:22,797 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 44) JBAS012605: Activated the following JSF Implementations: [main, 1.2]
16:31:22,866 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 48) JBAS011800: Activating Naming Subsystem
16:31:22,842 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 53) JBAS013171: Activating Security Subsystem
16:31:22,899 WARN  [org.jboss.as.txn] (ServerService Thread Pool -- 55) JBAS010153: Node identifier property is set to the default value. Please make sure it is unique.
16:31:22,980 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 57) JBAS015537: Activating WebServices Extension
16:31:23,010 INFO  [org.jboss.as.naming] (MSC service thread 1-4) JBAS011802: Starting Naming Service
16:31:23,056 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 32) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
16:31:23,078 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-3) JBAS015400: Bound mail session [java:jboss/mail/Default]
16:31:23,339 INFO  [org.switchyard] (ServerService Thread Pool -- 59) Activating SwitchYard Subsystem
16:31:23,387 INFO  [org.jboss.jaxr] (MSC service thread 1-5) JBAS014000: Started JAXR subsystem, binding JAXR connection factory into JNDI as: java:jboss/jaxr/ConnectionFactory
16:31:23,461 INFO  [org.jboss.as.security] (MSC service thread 1-5) JBAS013170: Current PicketBox version=4.0.19.SP8-redhat-1
16:31:23,472 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-3) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.26.Final-redhat-1)
16:31:24,790 INFO  [org.jboss.as.jacorb] (MSC service thread 1-2) JBAS016330: CORBA ORB Service started
16:31:24,862 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-4) JBWEB003001: Coyote HTTP/1.1 initializing on : http-/127.0.0.1:8080
16:31:24,994 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-4) JBWEB003000: Coyote HTTP/1.1 starting on: http-/127.0.0.1:8080
16:31:25,453 INFO  [org.jboss.ws.common.management] (MSC service thread 1-1) JBWS022052: Starting JBoss Web Services - Stack CXF Server 4.3.0.Final-redhat-3
Build timed out (after 120 minutes). Marking the build as failed.
Build was aborted
Archiving artifacts
16:31:25,520 INFO  [org.jboss.as.remoting] (MSC service thread 1-1) JBAS017100: Listening on 127.0.0.1:4447
16:31:25,520 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on 127.0.0.1:9999
16:31:25,592 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-3) JBAS015012: Started FileSystemDeploymentService for directory <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Release/ws/jboss-eap-6.3/standalone/deployments>
16:31:25,597 ERROR [org.jboss.msc.service.fail] (MSC service thread 1-5) MSC000001: Failed to start service jboss.jacorb.naming-service: org.jboss.msc.service.StartException in service jboss.jacorb.naming-service: Failed to start service
	at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1936) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [rt.jar:1.7.0_67]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [rt.jar:1.7.0_67]
	at java.lang.Thread.run(Thread.java:745) [rt.jar:1.7.0_67]
Caused by: java.lang.IllegalStateException: Container is down
	at org.jboss.msc.service.ServiceContainerImpl.install(ServiceContainerImpl.java:690) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	at org.jboss.msc.service.ServiceTargetImpl.install(ServiceTargetImpl.java:243) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	at org.jboss.msc.service.ServiceControllerImpl$ChildServiceTarget.install(ServiceControllerImpl.java:2433) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	at org.jboss.msc.service.ServiceBuilderImpl.install(ServiceBuilderImpl.java:345) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	at org.jboss.as.jacorb.service.CorbaServiceUtil.bindObject(CorbaServiceUtil.java:62)
	at org.jboss.as.jacorb.service.CorbaNamingService.start(CorbaNamingService.java:89)
	at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1980) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1913) [jboss-msc-1.1.5.Final-redhat-1.jar:1.1.5.Final-redhat-1]
	... 3 more

Destroying 1 processes
Destroying process..
Destroyed 1 processes
Recording test results



More information about the switchyard-dev mailing list