You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@synapse.apache.org by Juho Jussila <ju...@jos.fi> on 2008/07/31 13:51:16 UTC
Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Hi
I installed Synapse 1.2 on Aix 5.2 and tried to run the samples.
Even the simplest sample (sample 0) doesn't work.
I think there is some communication problem between
axis2server.sh and synapse.sh because of this strange exception:
org.apache.axis2.AxisFault: com.ctc.wstx.exc.WstxEOFException:
Unexpected EOF in prolog at [row,col {unknown-source}]: [1,0]
Samples work fine on Linux but on not Aix.
All help appreciated,
Juho Jussila
java version "1.5.0"
Java(TM) 2 Runtime Environment, Standard Edition (build
pap64devifx-20071025 (SR6b))
IBM J9 VM (build 2.3, J2RE 1.5.0 IBM J9 2.3 AIX ppc64-64
j9vmap6423-20071007 (JIT enabled)
J9VM - 20071004_14218_BHdSMr
JIT - 20070820_1846ifx1_r8
GC - 200708_10)
JCL - 20071025
axis2Server>./axis2server.sh -name foobar -https 8608
Using Bouncy castle JAR for Java 1.5
Using JAVA_HOME: /home/my/sdk/jre/
Using AXIS2 Repository :
/home/my/synapse-1.2/samples/axis2Server/repository
Using AXIS2 Configuration :
/home/my/synapse-1.2/samples/axis2Server/repository/conf/axis2.xml
2008-07-31 14:10:11,041 [-] [main] INFO SampleAxis2ServerManager
[SimpleAxisServer] Starting
[SimpleAxisServer] Using the Axis2 Repository :
/home/my/synapse-1.2/samples/axis2Server/repository
[SimpleAxisServer] Using the Axis2 Configuration File :
/home/my/synapse-1.2/samples/axis2Server/repository/conf/axis2.xml
2008-07-31 14:10:13,317 [-] [main] INFO JMSSender JMS Sender started
2008-07-31 14:10:13,320 [-] [main] INFO HttpCoreNIOSender HTTP Sender
starting
2008-07-31 14:10:13,444 [-] [main] INFO HttpCoreNIOSSLSender Loading
Identity Keystore from : ../../lib/identity.jks
2008-07-31 14:10:13,516 [-] [main] INFO HttpCoreNIOSSLSender Loading
Trust Keystore from : ../../lib/trust.jks
2008-07-31 14:10:13,565 [-] [main] INFO HttpCoreNIOSender HTTPS Sender
starting
2008-07-31 14:10:14,706 [-] [main] INFO HttpCoreNIOListener HTTP Listener
starting on port : 9000
2008-07-31 14:10:14,711 [-] [main] INFO MailTransportListener MAILTO
Listener started
2008-07-31 14:10:14,720 [-] [main] WARN MailTransportListener Error
configuring the Mail transport for Service : SimpleStockQuoteService ::
Cannot find parameter : transport.mail.Address for service :
SimpleStockQuoteService
2008-07-31 14:10:14,722 [-] [main] WARN MailTransportListener Disabling
the mailto transport for the service SimpleStockQuoteService, because it
is not configured properly for the service
2008-07-31 14:10:14,791 [-] [main] INFO HttpCoreNIOSSLListener Loading
Identity Keystore from : ../../lib/identity.jks
2008-07-31 14:10:14,801 [-] [main] INFO HttpCoreNIOSSLListener Loading
Trust Keystore from : ../../lib/trust.jks
2008-07-31 14:10:14,819 [-] [main] INFO HttpCoreNIOListener HTTPS
Listener starting on port : 8608
2008-07-31 14:10:14,832 [-] [main] INFO SampleAxis2ServerManager
[SimpleAxisServer] Started
2008-07-31 14:11:07,422 [-] [HttpServerWorker-1] DEBUG TransportUtils
createSOAPEnvelope using Builder (class
org.apache.axis2.builder.SOAPBuilder) selected from type (text/xml)
2008-07-31 14:12:07,315 [-] [HttpServerWorker-1] ERROR ServerWorker Error
processing POST request
org.apache.axis2.AxisFault: com.ctc.wstx.exc.WstxEOFException: Unexpected
EOF in prolog
at [row,col {unknown-source}]: [1,0]
at org.apache.axis2.AxisFault.makeFault(AxisFault.java:430)
at
org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:283)
at
org.apache.synapse.transport.nhttp.ServerWorker.processPost(ServerWorker.java:253)
at
org.apache.synapse.transport.nhttp.ServerWorker.run(ServerWorker.java:194)
at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
at java.lang.Thread.run(Thread.java:810)
Caused by:
org.apache.axiom.om.OMException: com.ctc.wstx.exc.WstxEOFException:
Unexpected EOF in prolog
at [row,col {unknown-source}]: [1,0]
at
org.apache.axiom.om.impl.builder.StAXOMBuilder.next(StAXOMBuilder.java:249)
at
org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder.getSOAPEnvelope(StAXSOAPModelBuilder.java:156)
at
org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder.<init>(StAXSOAPModelBuilder.java:105)
at
org.apache.axis2.builder.SOAPBuilder.processDocument(SOAPBuilder.java:53)
at
org.apache.axis2.transport.TransportUtils.createDocumentElement(TransportUtils.java:164)
at
org.apache.axis2.transport.TransportUtils.createSOAPMessage(TransportUtils.java:112)
at
org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:270)
... 5 more
Caused by:
com.ctc.wstx.exc.WstxEOFException: Unexpected EOF in prolog
at [row,col {unknown-source}]: [1,0]
at
com.ctc.wstx.sr.StreamScanner.throwUnexpectedEOF(StreamScanner.java:661)
at
com.ctc.wstx.sr.BasicStreamReader.handleEOF(BasicStreamReader.java:2134)
at
com.ctc.wstx.sr.BasicStreamReader.nextFromProlog(BasicStreamReader.java:2040)
at
com.ctc.wstx.sr.BasicStreamReader.next(BasicStreamReader.java:1069)
at
org.apache.axiom.om.impl.builder.StAXOMBuilder.parserNext(StAXOMBuilder.java:506)
at
org.apache.axiom.om.impl.builder.StAXOMBuilder.next(StAXOMBuilder.java:161)
... 11 more
2008-07-31 14:12:07,545 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter contentType from the OMOutputFormat =text/xml
2008-07-31 14:12:07,546 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter contentType returned =text/xml; charset=UTF-8
2008-07-31 14:12:07,571 [-] [HttpServerWorker-1] ERROR ServerHandler IO
error submiting response : Connection is closed
org.apache.http.ConnectionClosedException: Connection is closed
at
org.apache.http.impl.nio.NHttpConnectionBase.assertNotClosed(NHttpConnectionBase.java:238)
at
org.apache.http.impl.nio.DefaultNHttpServerConnection.submitResponse(DefaultNHttpServerConnection.java:200)
at
org.apache.synapse.transport.nhttp.ServerHandler.commitResponse(ServerHandler.java:213)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOSender.sendAsyncResponse(HttpCoreNIOSender.java:409)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOSender.invoke(HttpCoreNIOSender.java:264)
at
org.apache.axis2.engine.AxisEngine.sendFault(AxisEngine.java:530)
at
org.apache.synapse.transport.nhttp.ServerWorker.handleException(ServerWorker.java:489)
at
org.apache.synapse.transport.nhttp.ServerWorker.processPost(ServerWorker.java:260)
at
org.apache.synapse.transport.nhttp.ServerWorker.run(ServerWorker.java:194)
at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
at java.lang.Thread.run(Thread.java:810)
2008-07-31 14:12:07,575 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter start writeTo()
2008-07-31 14:12:07,575 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter preserve=false
2008-07-31 14:12:07,576 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter isOptimized=false
2008-07-31 14:12:07,577 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter isDoingSWA=false
2008-07-31 14:12:07,690 [-] [HttpServerWorker-1] DEBUG
SOAPMessageFormatter end writeTo()
axis2Client>ant stockquote
-Daddurl=http://localhost:9000/soap/SimpleStockQuoteService/
-Dtrpurl=http://localhost:8280/
Buildfile: build.xml
init:
compile:
stockquote:
[java] 2008-07-31 14:11:06,051 [-] [main] INFO JMSSender JMS Sender
started
[java] 2008-07-31 14:11:06,057 [-] [main] INFO MailTransportSender
MAILTO Sender started
[java] 2008-07-31 14:11:06,353 [-] [main] DEBUG SOAPMessageFormatter
contentType from the OMOutputFormat =text/xml
[java] 2008-07-31 14:11:06,353 [-] [main] DEBUG SOAPMessageFormatter
contentType returned =text/xml; charset=UTF-8
[java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
start writeTo()
[java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
preserve=false
[java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
isOptimized=false
[java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
isDoingSWA=false
[java] 2008-07-31 14:11:06,790 [-] [main] DEBUG SOAPMessageFormatter
end writeTo()
[java] 2008-07-31 14:11:37,434 [-] [main] INFO HTTPSender Unable to
sendViaPost to url[http://localhost:8280/]
[java] java.net.SocketTimeoutException: Read timed out
[java] at java.net.SocketInputStream.socketRead0(Native Method)
[java] at
java.net.SocketInputStream.read(SocketInputStream.java:155)
[java] at
java.io.BufferedInputStream.fill(BufferedInputStream.java:229)
[java] at
java.io.BufferedInputStream.read(BufferedInputStream.java:246)
[java] at
org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:78)
[java] at
org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:106)
[java] at
org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1116)
[java] at
org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.readLine(MultiThreadedHttpConnectionManager.java:1413)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1973)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1735)
[java] at
org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1098)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
[java] at
org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:542)
[java] at
org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:189)
[java] at
org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:75)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:364)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:208)
[java] at
org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:448)
[java] at
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:401)
[java] at
org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
[java] at
org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
[java] at
org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:548)
[java] at
org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:528)
[java] at
samples.userguide.StockQuoteClient.executeClient(Unknown Source)
[java] at samples.userguide.StockQuoteClient.main(Unknown Source)
[java] 2008-07-31 14:11:37,480 [-] [main] DEBUG
CommonsHTTPTransportSender org.apache.axis2.AxisFault: Read timed out
[java] 2008-07-31 14:11:37,481 [-] [main] DEBUG
CommonsHTTPTransportSender org.apache.axis2.AxisFault: Read timed out
[java] org.apache.axis2.AxisFault: Read timed out
[java] at
org.apache.axis2.AxisFault.makeFault(AxisFault.java:430)
[java] at
org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:193)
[java] at
org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:75)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:364)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:208)
[java] at
org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:448)
[java] at
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:401)
[java] at
org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
[java] at
org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
[java] at
org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:548)
[java] at
org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:528)
[java] at
samples.userguide.StockQuoteClient.executeClient(Unknown Source)
[java] at samples.userguide.StockQuoteClient.main(Unknown Source)
[java] Caused by: java.net.SocketTimeoutException: Read timed out
[java] at java.net.SocketInputStream.socketRead0(Native Method)
[java] at
java.net.SocketInputStream.read(SocketInputStream.java:155)
[java] at
java.io.BufferedInputStream.fill(BufferedInputStream.java:229)
[java] at
java.io.BufferedInputStream.read(BufferedInputStream.java:246)
[java] at
org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:78)
[java] at
org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:106)
[java] at
org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1116)
[java] at
org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.readLine(MultiThreadedHttpConnectionManager.java:1413)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1973)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1735)
[java] at
org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1098)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
[java] at
org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:542)
[java] at
org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:189)
[java] ... 11 more
BUILD SUCCESSFUL
synapse-1.2/bin>./synapse.sh -sample 0
Using Bouncy castle JAR for Java 1.5
Starting Synapse/Java ...
Using SYNAPSE_HOME: /home/my/synapse-1.2
Using JAVA_HOME: /home/my/sdk/jre/
Using SYNAPSE_XML:
/home/my/synapse-1.2/repository/conf/sample/synapse_sample_0.xml
2008-07-31 14:10:52,514 [-] [main] INFO ServerManager Using Synapse home
as : /home/my/synapse-1.2
2008-07-31 14:10:52,520 [-] [main] INFO ServerManager Using the Axis2
Repository : /home/my/synapse-1.2/repository
2008-07-31 14:10:52,520 [-] [main] INFO ServerManager Using the axis2.xml
: /home/my/synapse-1.2/repository/conf/axis2.xml
2008-07-31 14:10:52,520 [-] [main] INFO ServerManager Using server name :
localhost
2008-07-31 14:10:52,521 [-] [main] INFO ServerManager The timeout handler
will run every : 15s
2008-07-31 14:10:54,821 [-] [main] INFO SynapseInitializationModule
Initializing Synapse at : Thu Jul 31 14:10:54 EEST 2008
2008-07-31 14:10:54,822 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseInitializationModule Loading mediator extensions...
2008-07-31 14:10:54,823 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseInitializationModule Initializing the Synapse configuration ...
2008-07-31 14:10:54,827 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
SynapseConfigurationBuilder synapse.properties file is loading from
classpath
2008-07-31 14:10:54,844 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
DataSourceRegistrar No DataSources defined for initialization..
2008-07-31 14:10:54,845 [xxx.xxx.xxx.xxx-hostname] [main] INFO
XMLConfigurationBuilder Generating the Synapse configuration model by
parsing the XML configuration
2008-07-31 14:10:54,869 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
ConfigurationFactoryAndSerializerFinder
getConfiguration({http://ws.apache.org/ns/synapse}definitions)
2008-07-31 14:10:54,950 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.spring.SpringMediatorFactory to handle
{http://ws.apache.org/ns/synapse/spring}spring
2008-07-31 14:10:54,953 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.bsf.ScriptMediatorFactory to handle
{http://ws.apache.org/ns/synapse}script
2008-07-31 14:10:54,961 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.throttle.ThrottleMediatorFactory to handle
{http://ws.apache.org/ns/synapse}throttle
2008-07-31 14:10:54,966 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.xquery.XQueryMediatorFactory to handle
{http://ws.apache.org/ns/synapse}xquery
2008-07-31 14:10:54,967 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}log)
2008-07-31 14:10:54,972 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}send)
2008-07-31 14:10:55,041 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseConfigurationBuilder Loaded Synapse configuration from :
/home/my/synapse-1.2/repository/conf/sample/synapse_sample_0.xml
2008-07-31 14:10:55,059 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
SynapseConfiguration Initializing the Synapse Configuration
2008-07-31 14:10:55,060 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
SequenceMediator Initializing child mediators
2008-07-31 14:10:55,060 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
SequenceMediator Initializing child mediators
2008-07-31 14:10:55,060 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseInitializationModule Deploying the Synapse service..
2008-07-31 14:10:55,100 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseInitializationModule Synapse server name : localhost
2008-07-31 14:10:55,101 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseInitializationModule Deploying Proxy services...
2008-07-31 14:10:55,101 [xxx.xxx.xxx.xxx-hostname] [main] INFO
SynapseInitializationModule Synapse initialized successfully...!
2008-07-31 14:10:55,233 [xxx.xxx.xxx.xxx-hostname] [main] INFO
VFSTransportSender VFS Sender started
2008-07-31 14:10:55,741 [xxx.xxx.xxx.xxx-hostname] [main] INFO JMSSender
JMS Sender started
2008-07-31 14:10:55,744 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOSender HTTP Sender starting
2008-07-31 14:10:55,879 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOSSLSender Loading Identity Keystore from : lib/identity.jks
2008-07-31 14:10:55,968 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOSSLSender Loading Trust Keystore from : lib/trust.jks
2008-07-31 14:10:56,034 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOSender HTTPS Sender starting
2008-07-31 14:10:56,070 [xxx.xxx.xxx.xxx-hostname] [main] INFO
ServerManager Starting transport vfs
2008-07-31 14:10:56,143 [xxx.xxx.xxx.xxx-hostname] [main] INFO
VFSTransportListener VFS Listener started
2008-07-31 14:10:56,158 [xxx.xxx.xxx.xxx-hostname] [main] INFO
ServerManager Starting transport http on port 8280
2008-07-31 14:10:56,161 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOListener HTTP Listener starting on port : 8280
2008-07-31 14:10:56,218 [xxx.xxx.xxx.xxx-hostname] [main] INFO
ServerManager Starting transport mailto
2008-07-31 14:10:56,219 [xxx.xxx.xxx.xxx-hostname] [main] INFO
MailTransportListener MAILTO Listener started
2008-07-31 14:10:56,220 [xxx.xxx.xxx.xxx-hostname] [main] INFO
ServerManager Starting transport https on port 8243
2008-07-31 14:10:56,221 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOSSLListener Loading Identity Keystore from : lib/identity.jks
2008-07-31 14:10:56,226 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOSSLListener Loading Trust Keystore from : lib/trust.jks
2008-07-31 14:10:56,231 [xxx.xxx.xxx.xxx-hostname] [main] INFO
HttpCoreNIOListener HTTPS Listener starting on port : 8243
2008-07-31 14:10:56,244 [xxx.xxx.xxx.xxx-hostname] [main] INFO
ServerManager Ready for processing
2008-07-31 14:11:06,784 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG TransportUtils createSOAPEnvelope using Builder (class
org.apache.axis2.builder.SOAPBuilder) selected from type (text/xml)
2008-07-31 14:11:06,929 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SynapseMessageReceiver Synapse received a new message for message
mediation...
2008-07-31 14:11:06,929 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SynapseMessageReceiver Received To:
http://localhost:9000/soap/SimpleStockQuoteService/
2008-07-31 14:11:06,929 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SynapseMessageReceiver SOAPAction: urn:getQuote
2008-07-31 14:11:06,930 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SynapseMessageReceiver WSA-Action: urn:getQuote
2008-07-31 14:11:06,931 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG Axis2SynapseEnvironment Injecting MessageContext
2008-07-31 14:11:06,931 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG Axis2SynapseEnvironment Using Main Sequence for injected message
2008-07-31 14:11:06,932 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SequenceMediator Start : Sequence <main>
2008-07-31 14:11:06,932 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SequenceMediator Sequence <SequenceMediator> :: mediate()
2008-07-31 14:11:06,932 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG LogMediator Start : Log mediator
2008-07-31 14:11:07,018 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
INFO LogMediator To: http://localhost:9000/soap/SimpleStockQuoteService/,
WSAction: urn:getQuote, SOAPAction: urn:getQuote, ReplyTo:
http://www.w3.org/2005/08/addressing/anonymous, MessageID:
urn:uuid:2E35DDC5B395559DDC1217502666264, Direction: request, Envelope:
<?xml version='1.0' encoding='utf-8'?><soapenv:Envelope
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header
xmlns:wsa="http://www.w3.org/2005/08/addressing"><wsa:To>http://localhost:9000/soap/SimpleStockQuoteService/</wsa:To><wsa:MessageID>urn:uuid:2E35DDC5B395559DDC1217502666264</wsa:MessageID><wsa:Action>urn:getQuote</wsa:Action></soapenv:Header><soapenv:Body><m0:getQuote
xmlns:m0="http://services.samples/xsd"><m0:request><m0:symbol>IBM</m0:symbol></m0:request></m0:getQuote></soapenv:Body></soapenv:Envelope>
2008-07-31 14:11:07,019 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG LogMediator End : Log mediator
2008-07-31 14:11:07,019 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SendMediator Start : Send mediator
2008-07-31 14:11:07,020 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SendMediator Sending request message using implicit message
properties..
Sending To: http://localhost:9000/soap/SimpleStockQuoteService/
SOAPAction: urn:getQuote
2008-07-31 14:11:07,032 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG Axis2FlexibleMEPClient Sending [add = false] [sec = false] [rm =
false] [to Address: http://localhost:9000/soap/SimpleStockQuoteService/]
2008-07-31 14:11:07,062 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
INFO TimeoutHandler This engine will expire all callbacks after : 86400
seconds, irrespective of the timeout action, after the specified or
optional timeout
2008-07-31 14:11:07,082 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SynapseCallbackReceiver Callback added. Total callbacks waiting for
: 1
2008-07-31 14:11:07,104 [xxx.xxx.xxx.xxx-hostname] [I/O dispatcher 1] DEBUG
SOAPMessageFormatter contentType from the OMOutputFormat =text/xml
2008-07-31 14:11:07,104 [xxx.xxx.xxx.xxx-hostname] [I/O dispatcher 1] DEBUG
SOAPMessageFormatter contentType returned =text/xml; charset=UTF-8
2008-07-31 14:11:07,122 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SOAPMessageFormatter start writeTo()
2008-07-31 14:11:07,123 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SOAPMessageFormatter preserve=false
2008-07-31 14:11:07,123 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SOAPMessageFormatter isOptimized=false
2008-07-31 14:11:07,123 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SOAPMessageFormatter isDoingSWA=false
2008-07-31 14:11:07,346 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SOAPMessageFormatter end writeTo()
2008-07-31 14:12:07,128 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SendMediator End : Send mediator
2008-07-31 14:12:07,128 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
DEBUG SequenceMediator End : Sequence <main>
2008-07-31 14:12:07,203 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG SynapseCallbackReceiver Callback removed. Pending callbacks count :
0
2008-07-31 14:12:07,205 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
WARN FaultHandler Fault handler - setting ERROR_MESSAGE : Connection
timeout
2008-07-31 14:12:07,209 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
WARN FaultHandler Fault handler - setting ERROR_DETAIL :
java.lang.Exception: Connection timeout
at
org.apache.synapse.core.axis2.SynapseCallbackReceiver.handleMessage(SynapseCallbackReceiver.java:172)
at
org.apache.synapse.core.axis2.SynapseCallbackReceiver.receive(SynapseCallbackReceiver.java:131)
at
org.apache.synapse.transport.nhttp.ClientHandler$1.run(ClientHandler.java:298)
at
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
at java.lang.Thread.run(Thread.java:810)
2008-07-31 14:12:07,209 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
WARN FaultHandler Fault handler - setting ERROR_EXCEPTION :
java.lang.Exception: Connection timeout
2008-07-31 14:12:07,210 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
WARN MediatorFaultHandler Executing fault handler mediator : fault
2008-07-31 14:12:07,210 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG SequenceMediator Start : Sequence <fault>
2008-07-31 14:12:07,211 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG SequenceMediator Sequence <SequenceMediator> :: mediate()
2008-07-31 14:12:07,211 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG LogMediator Start : Log mediator
2008-07-31 14:12:07,352 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
INFO LogMediator To: http://localhost:9000/soap/SimpleStockQuoteService/,
WSAction: urn:getQuote, SOAPAction: urn:getQuote, ReplyTo:
http://www.w3.org/2005/08/addressing/anonymous, MessageID:
urn:uuid:2E35DDC5B395559DDC1217502666264, Direction: request, MESSAGE =
Executing default "fault" sequence, ERROR_CODE = 00000, ERROR_MESSAGE =
Connection timeout, Envelope: <?xml version='1.0'
encoding='utf-8'?><soapenv:Envelope
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><m0:getQuote
xmlns:m0="http://services.samples/xsd"><m0:request><m0:symbol>IBM</m0:symbol></m0:request></m0:getQuote></soapenv:Body></soapenv:Envelope>
2008-07-31 14:12:07,354 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG LogMediator End : Log mediator
2008-07-31 14:12:07,355 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG DropMediator Start : Drop mediator
2008-07-31 14:12:07,356 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG DropMediator End : Drop mediator
2008-07-31 14:12:07,357 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
DEBUG SequenceMediator End : Sequence <fault>
RE: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by "Hubert, Eric" <er...@jamba.net>.
Hi all,
> > org.apache.axis2.AxisFault: com.ctc.wstx.exc.WstxEOFException:
> > Unexpected EOF in prolog at [row,col {unknown-source}]: [1,0]
> >
> > Samples work fine on Linux but on not Aix.
I have seen exactly the same error message on a Linux machine which had
some network configuration issues (some problem with full duplex mode of
NICs) that caused intermediate network connect problems. It might be
that you also have some network connect problems between Synapse and
your service.
Regards,
Eric
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by Juho Jussila <ju...@jos.fi>.
Hi
Paul Fremantle kirjoitti:
> Please subscribe to the mailing list or you won't see the responses -
> I let your message through, but in general this is a subscriber only
> list.
Oh, I'm sorry, I am a little bit newbie to mailing list practices.
> I don't have an AIX box to test on - can you please use TCPMON to
> trace the wire messages between the client and server and post them
> here.
> Let me know if you need help with that.
Thanks for the advice. I created TCPMon listener port 9000 and target
port 8607. I don't understand why Soap message is missing?
==============
Listen Port: 9000
Target Host: 127.0.0.1
Target Port: 8607
==== Request ====
POST http://localhost:9000/soap/SimpleStockQuoteService/ HTTP/1.1
Host: 127.0.0.1:9000
SOAPAction: urn:getQuote
Content-Type: text/xml; charset=UTF-8
Transfer-Encoding: chunked
Connection: Keep-Alive
User-Agent: Synapse-HttpComponents-NIO
==== Response ====
==============
I tested also on Linux server.
I think this is desirable result.
==============
Listen Port: 9000
Target Host: 127.0.0.1
Target Port: 8607
==== Request ====
POST http://localhost:9000/soap/SimpleStockQuoteService HTTP/1.1
Host: 127.0.0.1:9000
SOAPAction: urn:getQuote
Content-Type: text/xml; charset=UTF-8
Transfer-Encoding: chunked
Connection: Keep-Alive
User-Agent: Synapse-HttpComponents-NIO
15a
<?xml version='1.0' encoding='UTF-8'?><soapenv:Envelope
xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header
xmlns:wsa="http://www.w3.org/2005/08/addressing"
/><soapenv:Body><m0:getQuote
xmlns:m0="http://services.samples/xsd"><m0:request><m0:symbol>IBM</m0:symbol></m0:request></m0:getQuote></soapenv:Body></soapenv:Envelope>
0
==== Response ====
HTTP/1.1 200 OK
Content-Type: text/xml; charset=UTF-8
Date: Thu, 31 Jul 2008 15:34:57 GMT
Server: Synapse-HttpComponents-NIO
Transfer-Encoding: chunked
Connection: Keep-Alive
38b
<?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>-2.4741103874177757</ns:change><ns:earnings>-8.512128119235099</ns:earnings><ns:high>-144.57080730296153</ns:high><ns:last>145.8127088525282</ns:last><ns:lastTradeTimestamp>Thu
Jul 31 17:34:57 GMT+02:00
2008</ns:lastTradeTimestamp><ns:low>151.92850926893593</ns:low><ns:marketCap>4.088996315077977E7</ns:marketCap><ns:name>IBM
Company</ns:name><ns:open>-144.89544883903292</ns:open><ns:peRatio>-19.429599067865958</ns:peRatio><ns:percentageChange>1.7076958446416557</ns:percentageChange><ns:prevClose>-144.88003792835516</ns:prevClose><ns:symbol>IBM</ns:symbol><ns:volume>8310</ns:volume></ns:return></ns:getQuoteResponse></soapenv:Body></soapenv:Envelope>
0
==============
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by "Asankha C. Perera" <as...@wso2.com>.
Hi Juho
Please set these values on your log4j.properties before you run the
following scenarios
log4j.category.org.apache.synapse.transport.nhttp.util=DEBUG
log4j.category.org.apache.http.impl.nio.reactor=DEBUG
asankha
Asankha C. Perera wrote:
> Hi Juho
>
> Were you able to find a Sun JVM for AIX? or is there no such JVM from
> Sun? If you are unable to proceed further, I would like to get to the
> bottom of this issue.. Last year we saw some different behaviour with
> Solaris 2.6 versions, and Oleg was able to help figure it out, but
> with some considerable help from the user, as we do not have access to
> an AIX environment. If you still have the problem, can you try the
> following to help us narrow the root cause.
>
> 1. Try accessing AIX service from Linux client (with and without TCPMon)
>
> 2. Try accessing Linux service from AIX client (with and without TCPMon)
>
> Lets then decide the next steps depending on the findings
>
> asankha
>
> Asankha C. Perera wrote:
>> Hi Juho
>>>> java version "1.5.0"
>>>> Java(TM) 2 Runtime Environment, Standard Edition (build
>>>> pap64devifx-20071025 (SR6b))
>>>> IBM J9 VM (build 2.3, J2RE 1.5.0 IBM J9 2.3 AIX ppc64-64
>>>> j9vmap6423-20071007 (JIT enabled)
>>>> J9VM - 20071004_14218_BHdSMr
>>>> JIT - 20070820_1846ifx1_r8
>>>> GC - 200708_10)
>>>> JCL - 20071025
>>>>
>> Can you also try the Sun JDK on AIX?
>>
>> asankha
>>
>
--
Asankha C. Perera
WSO2 - http://wso2.org
http://esbmagic.blogspot.com
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by "Asankha C. Perera" <as...@wso2.com>.
Hi Juho
Do you know if I could run AIX within a VM environment? If so do you
recommend any? and whats the exact version of AIX you use, and do you
know if its freely available or only for paid IBM customers?
asankha
Juho Jussila wrote:
> Hi
>
> Sorry about the delay in reply.
>
> Asankha C. Perera kirjoitti:
>> Hi Juho
>>
>> Were you able to find a Sun JVM for AIX? or is there no such JVM from
>> Sun?
>
> Yes, I think there is only IBM JVM for AIX.
>
>
>> If you are unable to proceed further, I would like to get to the
>> bottom of this issue.. Last year we saw some different behaviour with
>> Solaris 2.6 versions, and Oleg was able to help figure it out, but
>> with some considerable help from the user, as we do not have access
>> to an AIX environment. If you still have the problem, can you try the
>> following to help us narrow the root cause.
>>
>> 1. Try accessing AIX service from Linux client (with and without TCPMon)
>>
>> 2. Try accessing Linux service from AIX client (with and without TCPMon)
>
> Thanks for your helpful advices.
> I tried to test with various combinations.
>
> These don't work in our server environment:
> synapse on Aix, axisClient on Aix, axisServer on Aix
> synapse on Aix, axisClient on Linux, axisServer on Aix
> synapse on Linux, axisClient on Linux, axisServer on Aix
> synapse on Linux, axisClient on Aix, axisServer on Aix
> synapse on Aix, axisClient on Linux, axisServer on Linux
> synapse on Aix, axisClient on Aix, axisServer on Linux
>
> And these work:
> synapse on Linux, axisClient on Linux, axisServer on Linux
> synapse on Linux, axisClient on Aix, axisServer on Linux
>
> I'm quite newbie to axis and synapse configuration, but I noticed that
> if I change axis2.xml -files:
>
> <transportReceiver name="http"
> old: class="org.apache.synapse.transport.nhttp.HttpCoreNIOListener">
> new: class="org.apache.axis2.transport.http.SimpleHTTPServer">
>
> <transportSender name="http"
> old: class="org.apache.synapse.transport.nhttp.HttpCoreNIOSender">
> new: class="org.apache.axis2.transport.http.CommonsHTTPTransportSender">
>
>
> Synapse works fine on Aix! (well, I tested just sample 0).
> Is it ok, if I use SimpleHTTPServer and CommonsHTTPTransportSender or
> are there some drawbacks?
>
>
>> Lets then decide the next steps depending on the findings
>
> I greatly appreciate your help, Synapse is just what I'm looking for,
> but because it didn't work on Aix I almost gave up.
>
--
Asankha C. Perera
WSO2 - http://wso2.org
http://esbmagic.blogspot.com
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by Juho Jussila <ju...@jos.fi>.
Hi
Sorry about the delay in reply.
Asankha C. Perera kirjoitti:
> Hi Juho
>
> Were you able to find a Sun JVM for AIX? or is there no such JVM from
> Sun?
Yes, I think there is only IBM JVM for AIX.
> If you are unable to proceed further, I would like to get to the
> bottom of this issue.. Last year we saw some different behaviour with
> Solaris 2.6 versions, and Oleg was able to help figure it out, but with
> some considerable help from the user, as we do not have access to an AIX
> environment. If you still have the problem, can you try the following to
> help us narrow the root cause.
>
> 1. Try accessing AIX service from Linux client (with and without TCPMon)
>
> 2. Try accessing Linux service from AIX client (with and without TCPMon)
Thanks for your helpful advices.
I tried to test with various combinations.
These don't work in our server environment:
synapse on Aix, axisClient on Aix, axisServer on Aix
synapse on Aix, axisClient on Linux, axisServer on Aix
synapse on Linux, axisClient on Linux, axisServer on Aix
synapse on Linux, axisClient on Aix, axisServer on Aix
synapse on Aix, axisClient on Linux, axisServer on Linux
synapse on Aix, axisClient on Aix, axisServer on Linux
And these work:
synapse on Linux, axisClient on Linux, axisServer on Linux
synapse on Linux, axisClient on Aix, axisServer on Linux
I'm quite newbie to axis and synapse configuration, but I noticed that
if I change axis2.xml -files:
<transportReceiver name="http"
old: class="org.apache.synapse.transport.nhttp.HttpCoreNIOListener">
new: class="org.apache.axis2.transport.http.SimpleHTTPServer">
<transportSender name="http"
old: class="org.apache.synapse.transport.nhttp.HttpCoreNIOSender">
new: class="org.apache.axis2.transport.http.CommonsHTTPTransportSender">
Synapse works fine on Aix! (well, I tested just sample 0).
Is it ok, if I use SimpleHTTPServer and CommonsHTTPTransportSender or
are there some drawbacks?
> Lets then decide the next steps depending on the findings
I greatly appreciate your help, Synapse is just what I'm looking for,
but because it didn't work on Aix I almost gave up.
--
Juho Jussila
JOS-Soft
050 358 0895
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by "Asankha C. Perera" <as...@wso2.com>.
Hi Juho
Were you able to find a Sun JVM for AIX? or is there no such JVM from
Sun? If you are unable to proceed further, I would like to get to the
bottom of this issue.. Last year we saw some different behaviour with
Solaris 2.6 versions, and Oleg was able to help figure it out, but with
some considerable help from the user, as we do not have access to an AIX
environment. If you still have the problem, can you try the following to
help us narrow the root cause.
1. Try accessing AIX service from Linux client (with and without TCPMon)
2. Try accessing Linux service from AIX client (with and without TCPMon)
Lets then decide the next steps depending on the findings
asankha
Asankha C. Perera wrote:
> Hi Juho
>>> java version "1.5.0"
>>> Java(TM) 2 Runtime Environment, Standard Edition (build
>>> pap64devifx-20071025 (SR6b))
>>> IBM J9 VM (build 2.3, J2RE 1.5.0 IBM J9 2.3 AIX ppc64-64
>>> j9vmap6423-20071007 (JIT enabled)
>>> J9VM - 20071004_14218_BHdSMr
>>> JIT - 20070820_1846ifx1_r8
>>> GC - 200708_10)
>>> JCL - 20071025
>>>
> Can you also try the Sun JDK on AIX?
>
> asankha
>
--
Asankha C. Perera
WSO2 - http://wso2.org
http://esbmagic.blogspot.com
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by "Asankha C. Perera" <as...@wso2.com>.
Hi Juho
>> java version "1.5.0"
>> Java(TM) 2 Runtime Environment, Standard Edition (build
>> pap64devifx-20071025 (SR6b))
>> IBM J9 VM (build 2.3, J2RE 1.5.0 IBM J9 2.3 AIX ppc64-64
>> j9vmap6423-20071007 (JIT enabled)
>> J9VM - 20071004_14218_BHdSMr
>> JIT - 20070820_1846ifx1_r8
>> GC - 200708_10)
>> JCL - 20071025
>>
Can you also try the Sun JDK on AIX?
asankha
--
Asankha C. Perera
WSO2 - http://wso2.org
http://esbmagic.blogspot.com
Re: Error Starting Axis2 On Windows: problem in starting wrapper
Posted by "Asankha C. Perera" <as...@apache.org>.
Hi Jay
> I downloaded and unzipped the ZIP file for Synapse 1.2. The process to build the SimpleStockQuoteService seemed to go just fine. However, when I tried to start axis2 using axis2server.bat under Windows XP, I got this UnsupportedClassVersionError:
>
> C:\PRO\synapse-1.2\samples\axis2Server>axis2server.bat
> "Starting Sample Axis2 Server ..."
> Using AXIS2_HOME: C:\PRO\SYNAPS~1.2\samples\AXIS2S~1\
> Using JAVA_HOME: c:\pro\jdk1.5.0_12
> .....
> WrapperSimpleApp: Unable to locate the class samples.util.SampleAxis2Server: java.lang.UnsupportedClassVersionError: samples/util/SampleAxis2Server (Unsupported major.minor version 49.0)
>
> My suspicion was that the Wrapper is picking up my *default* JRE, which is 1.4 -- i.e., it isn't passing JAVA_HOME thru. If we look at axis2server.bat, we see that the script does not appear to be passing JAVA_HOME thru:
> ...
>
> And, if I set my Windows PATH in the command window where I start this to have the JRE 1.5 bin directory first, then the error does not occur.
>
> synapse.bat has the very same problem. (I expect all of the .bat files that user the wrapper do).
>
> JIRA time? (A likely cure would be to set the path to %JAVA_HOME%\bin;%PATH% before executing the wrapper program).
>
Generally whenever I set a JDK, I set both the JAVA_HOME and put the
$JAVA_HOME/bin into my PATH. I think its wrong for the JAVA_HOME to
point to one, while the PATH contains another - since even the Java
tools will be picked up from the PATH. However we could certainly make
the modification you request, if you still think its valid..
> (Also, FYI, if you print the Quick Start guide in IE, some text gets chopped off. Watch out for long lines. IE doesn't print that stuff properly)
>
I do not use IE anymore.. and this is one area where we could definitely
make use of some user contributions :-)
cheers
asankha
--
Asankha C. Perera
http://adroitlogic.org
http://esbmagic.blogspot.com
Error Starting Axis2 On Windows: problem in starting wrapper
Posted by "Jaeger, Jay - DOT" <ja...@dot.state.wi.us>.
I downloaded and unzipped the ZIP file for Synapse 1.2. The process to build the SimpleStockQuoteService seemed to go just fine. However, when I tried to start axis2 using axis2server.bat under Windows XP, I got this UnsupportedClassVersionError:
C:\PRO\synapse-1.2\samples\axis2Server>axis2server.bat
"Starting Sample Axis2 Server ..."
Using AXIS2_HOME: C:\PRO\SYNAPS~1.2\samples\AXIS2S~1\
Using JAVA_HOME: c:\pro\jdk1.5.0_12
--> Wrapper Started as Console
Launching a JVM...
Wrapper (Version 3.2.3) http://wrapper.tanukisoftware.org
Copyright 1999-2006 Tanuki Software, Inc. All Rights Reserved.
WrapperSimpleApp: Unable to locate the class samples.util.SampleAxis2Server: java.lang.UnsupportedClassVersionError: samples/util/SampleAxis2Server (Unsupported major.minor version 49.0)
WrapperSimpleApp Usage:
java org.tanukisoftware.wrapper.WrapperSimpleApp {app_class} [app_arguments]
Where:
app_class: The fully qualified class name of the application to run.
app_arguments: The arguments that would normally be passed to the
application.
<-- Wrapper Stopped
Press any key to continue . . .
My suspicion was that the Wrapper is picking up my *default* JRE, which is 1.4 -- i.e., it isn't passing JAVA_HOME thru. If we look at axis2server.bat, we see that the script does not appear to be passing JAVA_HOME thru:
<< snip of axis2server.bat >>
rem
rem Find the wrapper.conf
rem
:conf
set _WRAPPER_CONF="%AXIS2_HOME%..\..\repository\conf\sample-server-wrapper.conf" <<< not here
rem
rem Start the Wrapper
rem
:startup
"%_WRAPPER_EXE%" -c %_WRAPPER_CONF% wrapper.java.additional.1=%_HTTPPORT% wrapper.java.additional.2=%_HTTPSPORT% wrapper.java.additional.3=%_SERVERNAME% %_XDEBUG% <<< and not here, either
<</snip>>
And, if I set my Windows PATH in the command window where I start this to have the JRE 1.5 bin directory first, then the error does not occur.
synapse.bat has the very same problem. (I expect all of the .bat files that user the wrapper do).
JIRA time? (A likely cure would be to set the path to %JAVA_HOME%\bin;%PATH% before executing the wrapper program).
(Also, FYI, if you print the Quick Start guide in IE, some text gets chopped off. Watch out for long lines. IE doesn't print that stuff properly)
Jay Jaeger
Re: Running Synapse 1.2 on Aix / Unexpected EOF in prolog
Posted by Paul Fremantle <pz...@gmail.com>.
Juho
Please subscribe to the mailing list or you won't see the responses -
I let your message through, but in general this is a subscriber only
list.
I don't have an AIX box to test on - can you please use TCPMON to
trace the wire messages between the client and server and post them
here.
Let me know if you need help with that.
Paul
On Thu, Jul 31, 2008 at 12:51 PM, Juho Jussila <ju...@jos.fi> wrote:
> Hi
>
> I installed Synapse 1.2 on Aix 5.2 and tried to run the samples.
> Even the simplest sample (sample 0) doesn't work.
> I think there is some communication problem between
> axis2server.sh and synapse.sh because of this strange exception:
>
> org.apache.axis2.AxisFault: com.ctc.wstx.exc.WstxEOFException:
> Unexpected EOF in prolog at [row,col {unknown-source}]: [1,0]
>
> Samples work fine on Linux but on not Aix.
>
> All help appreciated,
> Juho Jussila
>
>
> java version "1.5.0"
> Java(TM) 2 Runtime Environment, Standard Edition (build
> pap64devifx-20071025 (SR6b))
> IBM J9 VM (build 2.3, J2RE 1.5.0 IBM J9 2.3 AIX ppc64-64
> j9vmap6423-20071007 (JIT enabled)
> J9VM - 20071004_14218_BHdSMr
> JIT - 20070820_1846ifx1_r8
> GC - 200708_10)
> JCL - 20071025
>
>
> axis2Server>./axis2server.sh -name foobar -https 8608
>
> Using Bouncy castle JAR for Java 1.5
> Using JAVA_HOME: /home/my/sdk/jre/
> Using AXIS2 Repository :
> /home/my/synapse-1.2/samples/axis2Server/repository
> Using AXIS2 Configuration :
> /home/my/synapse-1.2/samples/axis2Server/repository/conf/axis2.xml
> 2008-07-31 14:10:11,041 [-] [main] INFO SampleAxis2ServerManager
> [SimpleAxisServer] Starting
> [SimpleAxisServer] Using the Axis2 Repository :
> /home/my/synapse-1.2/samples/axis2Server/repository
> [SimpleAxisServer] Using the Axis2 Configuration File :
> /home/my/synapse-1.2/samples/axis2Server/repository/conf/axis2.xml
> 2008-07-31 14:10:13,317 [-] [main] INFO JMSSender JMS Sender started
> 2008-07-31 14:10:13,320 [-] [main] INFO HttpCoreNIOSender HTTP Sender
> starting
> 2008-07-31 14:10:13,444 [-] [main] INFO HttpCoreNIOSSLSender Loading
> Identity Keystore from : ../../lib/identity.jks
> 2008-07-31 14:10:13,516 [-] [main] INFO HttpCoreNIOSSLSender Loading
> Trust Keystore from : ../../lib/trust.jks
> 2008-07-31 14:10:13,565 [-] [main] INFO HttpCoreNIOSender HTTPS Sender
> starting
> 2008-07-31 14:10:14,706 [-] [main] INFO HttpCoreNIOListener HTTP Listener
> starting on port : 9000
> 2008-07-31 14:10:14,711 [-] [main] INFO MailTransportListener MAILTO
> Listener started
> 2008-07-31 14:10:14,720 [-] [main] WARN MailTransportListener Error
> configuring the Mail transport for Service : SimpleStockQuoteService ::
> Cannot find parameter : transport.mail.Address for service :
> SimpleStockQuoteService
> 2008-07-31 14:10:14,722 [-] [main] WARN MailTransportListener Disabling
> the mailto transport for the service SimpleStockQuoteService, because it
> is not configured properly for the service
> 2008-07-31 14:10:14,791 [-] [main] INFO HttpCoreNIOSSLListener Loading
> Identity Keystore from : ../../lib/identity.jks
> 2008-07-31 14:10:14,801 [-] [main] INFO HttpCoreNIOSSLListener Loading
> Trust Keystore from : ../../lib/trust.jks
> 2008-07-31 14:10:14,819 [-] [main] INFO HttpCoreNIOListener HTTPS
> Listener starting on port : 8608
> 2008-07-31 14:10:14,832 [-] [main] INFO SampleAxis2ServerManager
> [SimpleAxisServer] Started
> 2008-07-31 14:11:07,422 [-] [HttpServerWorker-1] DEBUG TransportUtils
> createSOAPEnvelope using Builder (class
> org.apache.axis2.builder.SOAPBuilder) selected from type (text/xml)
> 2008-07-31 14:12:07,315 [-] [HttpServerWorker-1] ERROR ServerWorker Error
> processing POST request
> org.apache.axis2.AxisFault: com.ctc.wstx.exc.WstxEOFException: Unexpected
> EOF in prolog
> at [row,col {unknown-source}]: [1,0]
> at org.apache.axis2.AxisFault.makeFault(AxisFault.java:430)
> at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:283)
> at
> org.apache.synapse.transport.nhttp.ServerWorker.processPost(ServerWorker.java:253)
> at
> org.apache.synapse.transport.nhttp.ServerWorker.run(ServerWorker.java:194)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
> at java.lang.Thread.run(Thread.java:810)
> Caused by:
> org.apache.axiom.om.OMException: com.ctc.wstx.exc.WstxEOFException:
> Unexpected EOF in prolog
> at [row,col {unknown-source}]: [1,0]
> at
> org.apache.axiom.om.impl.builder.StAXOMBuilder.next(StAXOMBuilder.java:249)
> at
> org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder.getSOAPEnvelope(StAXSOAPModelBuilder.java:156)
> at
> org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder.<init>(StAXSOAPModelBuilder.java:105)
> at
> org.apache.axis2.builder.SOAPBuilder.processDocument(SOAPBuilder.java:53)
> at
> org.apache.axis2.transport.TransportUtils.createDocumentElement(TransportUtils.java:164)
> at
> org.apache.axis2.transport.TransportUtils.createSOAPMessage(TransportUtils.java:112)
> at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:270)
> ... 5 more
> Caused by:
> com.ctc.wstx.exc.WstxEOFException: Unexpected EOF in prolog
> at [row,col {unknown-source}]: [1,0]
> at
> com.ctc.wstx.sr.StreamScanner.throwUnexpectedEOF(StreamScanner.java:661)
> at
> com.ctc.wstx.sr.BasicStreamReader.handleEOF(BasicStreamReader.java:2134)
> at
> com.ctc.wstx.sr.BasicStreamReader.nextFromProlog(BasicStreamReader.java:2040)
> at
> com.ctc.wstx.sr.BasicStreamReader.next(BasicStreamReader.java:1069)
> at
> org.apache.axiom.om.impl.builder.StAXOMBuilder.parserNext(StAXOMBuilder.java:506)
> at
> org.apache.axiom.om.impl.builder.StAXOMBuilder.next(StAXOMBuilder.java:161)
>
> ... 11 more
> 2008-07-31 14:12:07,545 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter contentType from the OMOutputFormat =text/xml
> 2008-07-31 14:12:07,546 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter contentType returned =text/xml; charset=UTF-8
> 2008-07-31 14:12:07,571 [-] [HttpServerWorker-1] ERROR ServerHandler IO
> error submiting response : Connection is closed
> org.apache.http.ConnectionClosedException: Connection is closed
> at
> org.apache.http.impl.nio.NHttpConnectionBase.assertNotClosed(NHttpConnectionBase.java:238)
> at
> org.apache.http.impl.nio.DefaultNHttpServerConnection.submitResponse(DefaultNHttpServerConnection.java:200)
> at
> org.apache.synapse.transport.nhttp.ServerHandler.commitResponse(ServerHandler.java:213)
> at
> org.apache.synapse.transport.nhttp.HttpCoreNIOSender.sendAsyncResponse(HttpCoreNIOSender.java:409)
> at
> org.apache.synapse.transport.nhttp.HttpCoreNIOSender.invoke(HttpCoreNIOSender.java:264)
> at
> org.apache.axis2.engine.AxisEngine.sendFault(AxisEngine.java:530)
> at
> org.apache.synapse.transport.nhttp.ServerWorker.handleException(ServerWorker.java:489)
> at
> org.apache.synapse.transport.nhttp.ServerWorker.processPost(ServerWorker.java:260)
> at
> org.apache.synapse.transport.nhttp.ServerWorker.run(ServerWorker.java:194)
>
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
> at java.lang.Thread.run(Thread.java:810)
> 2008-07-31 14:12:07,575 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter start writeTo()
> 2008-07-31 14:12:07,575 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter preserve=false
> 2008-07-31 14:12:07,576 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter isOptimized=false
> 2008-07-31 14:12:07,577 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter isDoingSWA=false
> 2008-07-31 14:12:07,690 [-] [HttpServerWorker-1] DEBUG
> SOAPMessageFormatter end writeTo()
>
>
>
>
>
> axis2Client>ant stockquote
> -Daddurl=http://localhost:9000/soap/SimpleStockQuoteService/
> -Dtrpurl=http://localhost:8280/
>
> Buildfile: build.xml
>
> init:
>
> compile:
>
> stockquote:
> [java] 2008-07-31 14:11:06,051 [-] [main] INFO JMSSender JMS Sender
> started
> [java] 2008-07-31 14:11:06,057 [-] [main] INFO MailTransportSender
> MAILTO Sender started
> [java] 2008-07-31 14:11:06,353 [-] [main] DEBUG SOAPMessageFormatter
> contentType from the OMOutputFormat =text/xml
> [java] 2008-07-31 14:11:06,353 [-] [main] DEBUG SOAPMessageFormatter
> contentType returned =text/xml; charset=UTF-8
> [java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
> start writeTo()
> [java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
> preserve=false
> [java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
> isOptimized=false
> [java] 2008-07-31 14:11:06,607 [-] [main] DEBUG SOAPMessageFormatter
> isDoingSWA=false
> [java] 2008-07-31 14:11:06,790 [-] [main] DEBUG SOAPMessageFormatter
> end writeTo()
> [java] 2008-07-31 14:11:37,434 [-] [main] INFO HTTPSender Unable to
> sendViaPost to url[http://localhost:8280/]
> [java] java.net.SocketTimeoutException: Read timed out
> [java] at java.net.SocketInputStream.socketRead0(Native Method)
> [java] at
> java.net.SocketInputStream.read(SocketInputStream.java:155)
> [java] at
> java.io.BufferedInputStream.fill(BufferedInputStream.java:229)
> [java] at
> java.io.BufferedInputStream.read(BufferedInputStream.java:246)
> [java] at
> org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:78)
> [java] at
> org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:106)
> [java] at
> org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1116)
> [java] at
> org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.readLine(MultiThreadedHttpConnectionManager.java:1413)
> [java] at
> org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1973)
> [java] at
> org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1735)
> [java] at
> org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1098)
> [java] at
> org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398)
> [java] at
> org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)
> [java] at
> org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)
> [java] at
> org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
> [java] at
> org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:542)
> [java] at
> org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:189)
> [java] at
> org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:75)
> [java] at
> org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:364)
> [java] at
> org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:208)
> [java] at
> org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:448)
> [java] at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:401)
> [java] at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
> [java] at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> [java] at
> org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:548)
> [java] at
> org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:528)
> [java] at
> samples.userguide.StockQuoteClient.executeClient(Unknown Source)
> [java] at samples.userguide.StockQuoteClient.main(Unknown Source)
> [java] 2008-07-31 14:11:37,480 [-] [main] DEBUG
> CommonsHTTPTransportSender org.apache.axis2.AxisFault: Read timed out
> [java] 2008-07-31 14:11:37,481 [-] [main] DEBUG
> CommonsHTTPTransportSender org.apache.axis2.AxisFault: Read timed out
> [java] org.apache.axis2.AxisFault: Read timed out
> [java] at
> org.apache.axis2.AxisFault.makeFault(AxisFault.java:430)
> [java] at
> org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:193)
> [java] at
> org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:75)
> [java] at
> org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:364)
> [java] at
> org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:208)
> [java] at
> org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:448)
> [java] at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:401)
> [java] at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
> [java] at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> [java] at
> org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:548)
> [java] at
> org.apache.axis2.client.ServiceClient.sendReceive(ServiceClient.java:528)
> [java] at
> samples.userguide.StockQuoteClient.executeClient(Unknown Source)
> [java] at samples.userguide.StockQuoteClient.main(Unknown Source)
> [java] Caused by: java.net.SocketTimeoutException: Read timed out
> [java] at java.net.SocketInputStream.socketRead0(Native Method)
> [java] at
> java.net.SocketInputStream.read(SocketInputStream.java:155)
> [java] at
> java.io.BufferedInputStream.fill(BufferedInputStream.java:229)
> [java] at
> java.io.BufferedInputStream.read(BufferedInputStream.java:246)
> [java] at
> org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:78)
> [java] at
> org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:106)
> [java] at
> org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1116)
> [java] at
> org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.readLine(MultiThreadedHttpConnectionManager.java:1413)
> [java] at
> org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1973)
> [java] at
> org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1735)
> [java] at
> org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1098)
> [java] at
> org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398)
> [java] at
> org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)
> [java] at
> org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)
> [java] at
> org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
> [java] at
> org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:542)
> [java] at
> org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:189)
> [java] ... 11 more
>
> BUILD SUCCESSFUL
>
>
>
>
>
> synapse-1.2/bin>./synapse.sh -sample 0
> Using Bouncy castle JAR for Java 1.5
> Starting Synapse/Java ...
> Using SYNAPSE_HOME: /home/my/synapse-1.2
> Using JAVA_HOME: /home/my/sdk/jre/
> Using SYNAPSE_XML:
> /home/my/synapse-1.2/repository/conf/sample/synapse_sample_0.xml
> 2008-07-31 14:10:52,514 [-] [main] INFO ServerManager Using Synapse home
> as : /home/my/synapse-1.2
> 2008-07-31 14:10:52,520 [-] [main] INFO ServerManager Using the Axis2
> Repository : /home/my/synapse-1.2/repository
> 2008-07-31 14:10:52,520 [-] [main] INFO ServerManager Using the axis2.xml
> : /home/my/synapse-1.2/repository/conf/axis2.xml
> 2008-07-31 14:10:52,520 [-] [main] INFO ServerManager Using server name :
> localhost
> 2008-07-31 14:10:52,521 [-] [main] INFO ServerManager The timeout handler
> will run every : 15s
> 2008-07-31 14:10:54,821 [-] [main] INFO SynapseInitializationModule
> Initializing Synapse at : Thu Jul 31 14:10:54 EEST 2008
> 2008-07-31 14:10:54,822 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseInitializationModule Loading mediator extensions...
> 2008-07-31 14:10:54,823 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseInitializationModule Initializing the Synapse configuration ...
> 2008-07-31 14:10:54,827 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> SynapseConfigurationBuilder synapse.properties file is loading from
> classpath
> 2008-07-31 14:10:54,844 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> DataSourceRegistrar No DataSources defined for initialization..
> 2008-07-31 14:10:54,845 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> XMLConfigurationBuilder Generating the Synapse configuration model by
> parsing the XML configuration
> 2008-07-31 14:10:54,869 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> ConfigurationFactoryAndSerializerFinder
> getConfiguration({http://ws.apache.org/ns/synapse}definitions)
> 2008-07-31 14:10:54,950 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> MediatorFactoryFinder Added MediatorFactory class
> org.apache.synapse.mediators.spring.SpringMediatorFactory to handle
> {http://ws.apache.org/ns/synapse/spring}spring
> 2008-07-31 14:10:54,953 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> MediatorFactoryFinder Added MediatorFactory class
> org.apache.synapse.mediators.bsf.ScriptMediatorFactory to handle
> {http://ws.apache.org/ns/synapse}script
> 2008-07-31 14:10:54,961 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> MediatorFactoryFinder Added MediatorFactory class
> org.apache.synapse.mediators.throttle.ThrottleMediatorFactory to handle
> {http://ws.apache.org/ns/synapse}throttle
> 2008-07-31 14:10:54,966 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> MediatorFactoryFinder Added MediatorFactory class
> org.apache.synapse.mediators.xquery.XQueryMediatorFactory to handle
> {http://ws.apache.org/ns/synapse}xquery
> 2008-07-31 14:10:54,967 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}log)
> 2008-07-31 14:10:54,972 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}send)
> 2008-07-31 14:10:55,041 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseConfigurationBuilder Loaded Synapse configuration from :
> /home/my/synapse-1.2/repository/conf/sample/synapse_sample_0.xml
> 2008-07-31 14:10:55,059 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> SynapseConfiguration Initializing the Synapse Configuration
> 2008-07-31 14:10:55,060 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> SequenceMediator Initializing child mediators
> 2008-07-31 14:10:55,060 [xxx.xxx.xxx.xxx-hostname] [main] DEBUG
> SequenceMediator Initializing child mediators
> 2008-07-31 14:10:55,060 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseInitializationModule Deploying the Synapse service..
> 2008-07-31 14:10:55,100 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseInitializationModule Synapse server name : localhost
> 2008-07-31 14:10:55,101 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseInitializationModule Deploying Proxy services...
> 2008-07-31 14:10:55,101 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> SynapseInitializationModule Synapse initialized successfully...!
> 2008-07-31 14:10:55,233 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> VFSTransportSender VFS Sender started
> 2008-07-31 14:10:55,741 [xxx.xxx.xxx.xxx-hostname] [main] INFO JMSSender
> JMS Sender started
> 2008-07-31 14:10:55,744 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOSender HTTP Sender starting
> 2008-07-31 14:10:55,879 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOSSLSender Loading Identity Keystore from : lib/identity.jks
> 2008-07-31 14:10:55,968 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOSSLSender Loading Trust Keystore from : lib/trust.jks
> 2008-07-31 14:10:56,034 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOSender HTTPS Sender starting
> 2008-07-31 14:10:56,070 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> ServerManager Starting transport vfs
> 2008-07-31 14:10:56,143 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> VFSTransportListener VFS Listener started
> 2008-07-31 14:10:56,158 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> ServerManager Starting transport http on port 8280
> 2008-07-31 14:10:56,161 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOListener HTTP Listener starting on port : 8280
> 2008-07-31 14:10:56,218 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> ServerManager Starting transport mailto
> 2008-07-31 14:10:56,219 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> MailTransportListener MAILTO Listener started
> 2008-07-31 14:10:56,220 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> ServerManager Starting transport https on port 8243
> 2008-07-31 14:10:56,221 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOSSLListener Loading Identity Keystore from : lib/identity.jks
> 2008-07-31 14:10:56,226 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOSSLListener Loading Trust Keystore from : lib/trust.jks
> 2008-07-31 14:10:56,231 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> HttpCoreNIOListener HTTPS Listener starting on port : 8243
> 2008-07-31 14:10:56,244 [xxx.xxx.xxx.xxx-hostname] [main] INFO
> ServerManager Ready for processing
> 2008-07-31 14:11:06,784 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG TransportUtils createSOAPEnvelope using Builder (class
> org.apache.axis2.builder.SOAPBuilder) selected from type (text/xml)
> 2008-07-31 14:11:06,929 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SynapseMessageReceiver Synapse received a new message for message
> mediation...
> 2008-07-31 14:11:06,929 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SynapseMessageReceiver Received To:
> http://localhost:9000/soap/SimpleStockQuoteService/
> 2008-07-31 14:11:06,929 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SynapseMessageReceiver SOAPAction: urn:getQuote
> 2008-07-31 14:11:06,930 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SynapseMessageReceiver WSA-Action: urn:getQuote
> 2008-07-31 14:11:06,931 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG Axis2SynapseEnvironment Injecting MessageContext
> 2008-07-31 14:11:06,931 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG Axis2SynapseEnvironment Using Main Sequence for injected message
> 2008-07-31 14:11:06,932 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SequenceMediator Start : Sequence <main>
> 2008-07-31 14:11:06,932 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SequenceMediator Sequence <SequenceMediator> :: mediate()
> 2008-07-31 14:11:06,932 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG LogMediator Start : Log mediator
> 2008-07-31 14:11:07,018 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> INFO LogMediator To: http://localhost:9000/soap/SimpleStockQuoteService/,
> WSAction: urn:getQuote, SOAPAction: urn:getQuote, ReplyTo:
> http://www.w3.org/2005/08/addressing/anonymous, MessageID:
> urn:uuid:2E35DDC5B395559DDC1217502666264, Direction: request, Envelope:
> <?xml version='1.0' encoding='utf-8'?><soapenv:Envelope
> xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header
> xmlns:wsa="http://www.w3.org/2005/08/addressing"><wsa:To>http://localhost:9000/soap/SimpleStockQuoteService/</wsa:To><wsa:MessageID>urn:uuid:2E35DDC5B395559DDC1217502666264</wsa:MessageID><wsa:Action>urn:getQuote</wsa:Action></soapenv:Header><soapenv:Body><m0:getQuote
> xmlns:m0="http://services.samples/xsd"><m0:request><m0:symbol>IBM</m0:symbol></m0:request></m0:getQuote></soapenv:Body></soapenv:Envelope>
> 2008-07-31 14:11:07,019 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG LogMediator End : Log mediator
> 2008-07-31 14:11:07,019 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SendMediator Start : Send mediator
> 2008-07-31 14:11:07,020 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SendMediator Sending request message using implicit message
> properties..
> Sending To: http://localhost:9000/soap/SimpleStockQuoteService/
> SOAPAction: urn:getQuote
> 2008-07-31 14:11:07,032 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG Axis2FlexibleMEPClient Sending [add = false] [sec = false] [rm =
> false] [to Address: http://localhost:9000/soap/SimpleStockQuoteService/]
> 2008-07-31 14:11:07,062 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> INFO TimeoutHandler This engine will expire all callbacks after : 86400
> seconds, irrespective of the timeout action, after the specified or
> optional timeout
> 2008-07-31 14:11:07,082 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SynapseCallbackReceiver Callback added. Total callbacks waiting for
> : 1
> 2008-07-31 14:11:07,104 [xxx.xxx.xxx.xxx-hostname] [I/O dispatcher 1] DEBUG
> SOAPMessageFormatter contentType from the OMOutputFormat =text/xml
> 2008-07-31 14:11:07,104 [xxx.xxx.xxx.xxx-hostname] [I/O dispatcher 1] DEBUG
> SOAPMessageFormatter contentType returned =text/xml; charset=UTF-8
> 2008-07-31 14:11:07,122 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SOAPMessageFormatter start writeTo()
> 2008-07-31 14:11:07,123 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SOAPMessageFormatter preserve=false
> 2008-07-31 14:11:07,123 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SOAPMessageFormatter isOptimized=false
> 2008-07-31 14:11:07,123 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SOAPMessageFormatter isDoingSWA=false
> 2008-07-31 14:11:07,346 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SOAPMessageFormatter end writeTo()
> 2008-07-31 14:12:07,128 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SendMediator End : Send mediator
> 2008-07-31 14:12:07,128 [xxx.xxx.xxx.xxx-hostname] [HttpServerWorker-1]
> DEBUG SequenceMediator End : Sequence <main>
> 2008-07-31 14:12:07,203 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG SynapseCallbackReceiver Callback removed. Pending callbacks count :
> 0
> 2008-07-31 14:12:07,205 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> WARN FaultHandler Fault handler - setting ERROR_MESSAGE : Connection
> timeout
> 2008-07-31 14:12:07,209 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> WARN FaultHandler Fault handler - setting ERROR_DETAIL :
> java.lang.Exception: Connection timeout
> at
> org.apache.synapse.core.axis2.SynapseCallbackReceiver.handleMessage(SynapseCallbackReceiver.java:172)
> at
> org.apache.synapse.core.axis2.SynapseCallbackReceiver.receive(SynapseCallbackReceiver.java:131)
> at
> org.apache.synapse.transport.nhttp.ClientHandler$1.run(ClientHandler.java:298)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:665)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:690)
> at java.lang.Thread.run(Thread.java:810)
>
> 2008-07-31 14:12:07,209 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> WARN FaultHandler Fault handler - setting ERROR_EXCEPTION :
> java.lang.Exception: Connection timeout
> 2008-07-31 14:12:07,210 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> WARN MediatorFaultHandler Executing fault handler mediator : fault
> 2008-07-31 14:12:07,210 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG SequenceMediator Start : Sequence <fault>
> 2008-07-31 14:12:07,211 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG SequenceMediator Sequence <SequenceMediator> :: mediate()
> 2008-07-31 14:12:07,211 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG LogMediator Start : Log mediator
> 2008-07-31 14:12:07,352 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> INFO LogMediator To: http://localhost:9000/soap/SimpleStockQuoteService/,
> WSAction: urn:getQuote, SOAPAction: urn:getQuote, ReplyTo:
> http://www.w3.org/2005/08/addressing/anonymous, MessageID:
> urn:uuid:2E35DDC5B395559DDC1217502666264, Direction: request, MESSAGE =
> Executing default "fault" sequence, ERROR_CODE = 00000, ERROR_MESSAGE =
> Connection timeout, Envelope: <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope
> xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><m0:getQuote
> xmlns:m0="http://services.samples/xsd"><m0:request><m0:symbol>IBM</m0:symbol></m0:request></m0:getQuote></soapenv:Body></soapenv:Envelope>
> 2008-07-31 14:12:07,354 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG LogMediator End : Log mediator
> 2008-07-31 14:12:07,355 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG DropMediator Start : Drop mediator
> 2008-07-31 14:12:07,356 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG DropMediator End : Drop mediator
> 2008-07-31 14:12:07,357 [xxx.xxx.xxx.xxx-hostname] [HttpClientWorker-1]
> DEBUG SequenceMediator End : Sequence <fault>
>
--
Paul Fremantle
Co-Founder and CTO, WSO2
Apache Synapse PMC Chair
OASIS WS-RX TC Co-chair
blog: http://pzf.fremantle.org
paul@wso2.com
"Oxygenating the Web Service Platform", www.wso2.com