Hi, here is the log data when trying synapse and Axis2 (v1.4) with the synapse sample client program.
It seems axis2 received the request and generated the quote for client and sent it back, but problem appears at the CallbackReceiver of synapse. Did it not understand the response soap message, or the axis2 side gave the wrong response? So so so strange! But at least this time the client connected the axis2 server successfully through synapse! Regards, Cynthia ============================ synapse xml configure(edited from sample 6) =============================== <!-- Manipulating SOAP headers, and filtering incoming and outgoing messages --> <definitions xmlns="http://ws.apache.org/ns/synapse";> <in> <header name="To" value="http://localhost:8080/axis2/services/SimpleStockQuoteService"/> </in> <send/> </definitions> ============================== client program (from axis2 v1.4 quickstartadb)============================== synapse --> sample client program no change COMMAND:(edited from sample 6) ant stockquote -Dtrpurl=http://localhost:8290/ ============================ synapse log=============================== 2008-05-16 15:57:31,770 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 7] DEBUG ServerHandler HTTP connection [/127.0.0.1:2330 0]: Connected 2008-05-16 15:57:32,001 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 7] DEBUG ServerHandler HTTP connection [/127.0.0.1:2330 0]: POST http://localhost:8290/ HTTP/1.1 2008-05-16 15:57:32,002 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 7] INFO PipeImpl Using native OS Pipes for event-drive n to stream IO bridging 2008-05-16 15:57:32,644 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 7] DEBUG ServerHandler HTTP connection [LOOPBACK/127.0. 0.1:23300]: Input ready 2008-05-16 15:57:32,645 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 7] DEBUG ServerHandler HTTP connection [LOOPBACK/127.0. 0.1:23300]: Content decoder [chunk-coded; completed: true] 2008-05-16 15:57:33,534 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SynapseMessageReceiver Synapse received a ne w message for message mediation... 2008-05-16 15:57:33,534 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SynapseMessageReceiver Received To: http://l ocalhost:8290/ 2008-05-16 15:57:33,535 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SynapseMessageReceiver SOAPAction: urn:getQu ote 2008-05-16 15:57:33,535 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SynapseMessageReceiver WSA-Action: urn:getQu ote 2008-05-16 15:57:33,539 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG Axis2SynapseEnvironment Injecting MessageCon text 2008-05-16 15:57:33,540 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG Axis2SynapseEnvironment Using Main Sequence for injected message 2008-05-16 15:57:33,540 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SequenceMediator Start : Sequence <main> 2008-05-16 15:57:33,540 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SequenceMediator Sequence <SequenceMediator> :: mediate() 2008-05-16 15:57:33,540 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG InMediator Start : In mediator 2008-05-16 15:57:33,541 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG InMediator Current message is incoming - exe cuting child mediators 2008-05-16 15:57:33,541 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG InMediator Sequence <InMediator> :: mediate( ) 2008-05-16 15:57:33,541 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG HeaderMediator Start : Header mediator 2008-05-16 15:57:33,541 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG HeaderMediator Set SOAP header : To to : htt p://localhost:8080/axis2/services/SimpleStockQuoteService 2008-05-16 15:57:33,541 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG HeaderMediator End : Header mediator 2008-05-16 15:57:33,542 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG InMediator End : In mediator 2008-05-16 15:57:33,542 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SendMediator Start : Send mediator 2008-05-16 15:57:33,542 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SendMediator Sending request message using i mplicit message properties.. Sending To: http://localhost:8080/axis2/services/SimpleStockQuoteService SOAPAction: urn:getQuote 2008-05-16 15:57:33,651 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG Axis2FlexibleMEPClient Sending [add = false] [sec = false] [rm = false] [ to Address: http://localhost:8080/axis2/services/SimpleStockQuoteService] 2008-05-16 15:57:33,902 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] INFO TimeoutHandler This engine will expire all c allbacks after : 86400 seconds, irrespective of the timeout action, after the specified or optional timeout 2008-05-16 15:57:34,022 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG ConnectionPool No connections available for reuse 2008-05-16 15:57:34,023 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG HttpCoreNIOSender A new connection establish ed 2008-05-16 15:57:34,023 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG Axis2HttpRequest start streaming outgoing ht tp request 2008-05-16 15:57:34,132 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Connected ([EMAIL PROTECTED]) 2008-05-16 15:57:34,132 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG Axis2HttpRequest get source channel of the pip e on which the outgoing response is written 2008-05-16 15:57:34,163 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Output ready 2008-05-16 15:57:34,419 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Content encoder [chunk-coded; completed: false] 2008-05-16 15:57:34,419 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SendMediator End : Send mediator 2008-05-16 15:57:34,419 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpServerWorker-1] DEBUG SequenceMediator End : Sequence <main> 2008-05-16 15:57:34,419 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Output ready 2008-05-16 15:57:34,420 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Content encoder [chunk-coded; completed: true] 2008-05-16 15:57:34,453 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Request ready 2008-05-16 15:57:40,505 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: HTTP/1.1 200 OK 2008-05-16 15:57:40,545 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Input ready 2008-05-16 15:57:40,547 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ConnectionPool Released a connection to host: localhost on port : 8080 to the connection pool of current size : 1 2008-05-16 15:57:40,555 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [localhost/127.0 .0.1:8080]: Content decoder [chunk-coded; completed: true] 2008-05-16 15:57:40,606 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SynapseCallbackReceiver Synapse received an asynchronous response message 2008-05-16 15:57:40,607 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SynapseCallbackReceiver Received To: null 2008-05-16 15:57:40,607 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SynapseCallbackReceiver SOAPAction: null 2008-05-16 15:57:40,607 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SynapseCallbackReceiver WSA-Action: null 2008-05-16 15:57:40,645 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SynapseCallbackReceiver Body : <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/";><soapenv:Body>< ns:getQuoteResponse xmlns:ns="http://services.samples/xsd";><ns:return type="samples.services.GetQuoteResponse"><ns:change>4.29086 01370053</ns:change><ns:earnings>-9.533756272266443</ns:earnings><ns:high>-149.06101369040186</ns:high><ns:last>151.5679492660207 8</ns:last><ns:lastTradeTimestamp>Fri May 16 15:57:39 CEST 2008</ns:lastTradeTimestamp><ns:low>-150.61316089735473</ns:low><ns:ma rketCap>1839679.0819715653</ns:marketCap><ns:name>IBM Company</ns:name><ns:open>157.49811197907718</ns:open><ns:peRatio>-17.80115 2833926515</ns:peRatio><ns:percentageChange>-3.003482178280913</ns:percentageChange><ns:prevClose>-142.86284659965042</ns:prevClo se><ns:symbol>IBM</ns:symbol><ns:volume>15968</ns:volume></ns:return></ns:getQuoteResponse></soapenv:Body></soapenv:Envelope> 2008-05-16 15:57:40,665 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG Axis2SynapseEnvironment Injecting MessageCon text 2008-05-16 15:57:40,666 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG Axis2SynapseEnvironment Using Main Sequence for injected message 2008-05-16 15:57:40,666 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SequenceMediator Start : Sequence <main> 2008-05-16 15:57:40,666 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SequenceMediator Sequence <SequenceMediator> :: mediate() 2008-05-16 15:57:40,666 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG InMediator Start : In mediator 2008-05-16 15:57:40,667 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG InMediator Current message is a response - s kipping child mediators 2008-05-16 15:57:40,667 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG InMediator End : In mediator 2008-05-16 15:57:40,667 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SendMediator Start : Send mediator 2008-05-16 15:57:40,667 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SendMediator Sending response message using implicit message properties.. Sending To: http://www.w3.org/2005/08/addressing/anonymous SOAPAction: null 2008-05-16 15:57:40,755 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SendMediator End : Send mediator 2008-05-16 15:57:40,756 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpClientWorker-1] DEBUG SequenceMediator End : Sequence <main> 2008-05-16 15:58:00,630 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [closed]: Closed 2008-05-16 15:58:31,498 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 7] DEBUG ServerHandler HTTP connection [closed]: Closed CallbackReceiver's Action is "nul"???????????????????????????????????????? ============================ axis2 log=============================== Fri May 16 15:57:39 CEST 2008 samples.services.SimpleStockQuoteService :: Generating quote for : IBM ============================ client log =============================== .............................................. [java] 2008-05-16 15:57:20,947 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO SynapseInitializationModule Deploying the Synapse service.. [java] 2008-05-16 15:57:21,013 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO SynapseInitializationModule Initializing S andesha 2... [java] 2008-05-16 15:57:21,021 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO SynapseInitializationModule Synapse server name : DEDSAV01.MAC.DOM [java] 2008-05-16 15:57:21,022 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO SynapseInitializationModule Deploying Prox y services... [java] 2008-05-16 15:57:21,022 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO SynapseInitializationModule Synapse initia lized successfully...! [java] 2008-05-16 15:57:21,052 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG HttpCoreNIOSSLSender Loading Key Store fro m URL : file:/home/CHENG/synapse-1.1.1-bin/lib/identity.jks [java] 2008-05-16 15:57:21,714 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG HttpCoreNIOSSLSender Loading Trust Key Sto re from URL : file:/home/CHENG/synapse-1.1.1-bin/lib/trust.jks [java] 2008-05-16 15:57:26,905 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO HttpCoreNIOSender HTTPS Sender starting [java] 2008-05-16 15:57:26,906 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO HttpCoreNIOSender HTTP Sender starting [java] 2008-05-16 15:57:29,437 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpCoreNIOSender] DEBUG NativeWorkerPool Using native uti l.concurrent package.. [java] 2008-05-16 15:57:29,438 [192.168.150.24-DEDSAV01.MAC.DOM] [HttpCoreNIOSender] DEBUG NativeWorkerPool Using native uti l.concurrent package.. [java] 2008-05-16 15:57:30,118 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO PipeImpl Using native OS Pipes for event-d riven to stream IO bridging [java] 2008-05-16 15:57:30,909 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG ConnectionPool No connections available fo r reuse [java] 2008-05-16 15:57:30,949 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG HttpCoreNIOSender A new connection establi shed [java] 2008-05-16 15:57:30,949 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG Axis2HttpRequest start streaming outgoing http request [java] org.apache.axis2.AxisFault: The input stream for an incoming message is null. [java] at java.lang.Throwable.<init>(Throwable.java:181) [java] at java.lang.Exception.<init>(Exception.java:29) [java] at java.io.IOException.<init>(IOException.java:28) [java] at java.rmi.RemoteException.<init>(RemoteException.java:51) [java] at org.apache.axis2.AxisFault.<init>(AxisFault.java:126) [java] at org.apache.axis2.transport.TransportUtils.createSOAPMessage(TransportUtils.java:71) [java] at org.apache.axis2.description.OutInAxisOperationClient.handleResponse(OutInAxisOperation.java:326) [java] at org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:389) [java] at org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211) [java] at org.apache.axis2.client.OperationClient.execute(OperationClient.java:163) [java] at org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:528) [java] at org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:508) [java] at samples.userguide.StockQuoteClient.executeClient(Unknown Source) [java] at samples.userguide.StockQuoteClient.main(Unknown Source) [java] 2008-05-16 15:57:31,771 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Connected ([EMAIL PROTECTED]) [java] 2008-05-16 15:57:31,771 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG Axis2HttpRequest get source channe l of the pipe on which the outgoing response is written [java] 2008-05-16 15:57:31,831 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Output ready [java] 2008-05-16 15:57:31,839 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Content encoder [chunk-coded; completed: false] [java] 2008-05-16 15:57:31,839 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Output ready [java] 2008-05-16 15:57:31,839 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Content encoder [chunk-coded; completed: true] [java] 2008-05-16 15:57:31,849 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Request ready [java] 2008-05-16 15:58:31,496 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [loc alhost/127.0.0.1:8290]: Timeout [java] 2008-05-16 15:58:31,496 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler Connection Timeout [java] 2008-05-16 15:58:31,497 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher 1] DEBUG ClientHandler HTTP connection [clo sed]: Closed
