Hi, Ruwan
Here is the logging data, which seems no special warning,
just......uhhhm...
***************************** synapse log
*********************************
2008-05-07 10:41:05,138 [-] [Thread-0] INFO ServerManager Using the Axis2
Repository /home/CHENG/synapse-1.1.1-bin/repository
2008-05-07 10:41:10,726 [-] [Thread-0] INFO SynapseInitializationModule
Initializing Synapse at : Wed May 07 10:41:10 CEST 2008
2008-05-07 10:41:10,729 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Loading mediator extensions...
2008-05-07 10:41:10,730 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Initializing the Synapse configuration ...
2008-05-07 10:41:10,730 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseInitializationModule System property 'synapse.xml' specifies
Synapse configuration as
/home/CHENG/synapse-1.1.1-bin/repository/conf/sample/synapse_sample_1.xml
2008-05-07 10:41:10,787 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
XMLConfigurationBuilder Generating the Synapse configuration model by
parsing the XML configuration
2008-05-07 10:41:10,878 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
ConfigurationFactoryAndSerializerFinder
getConfiguration({http://ws.apache.org/ns/synapse}definitions)
2008-05-07 10:41:11,283 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.spring.SpringMediatorFactory to handle
{http://ws.apache.org/ns/synapse/spring}spring
2008-05-07 10:41:11,299 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.bsf.ScriptMediatorFactory to handle
{http://ws.apache.org/ns/synapse}script
2008-05-07 10:41:11,310 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.throttle.ThrottleMediatorFactory to handle
{http://ws.apache.org/ns/synapse}throttle
2008-05-07 10:41:11,355 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder Added MediatorFactory class
org.apache.synapse.mediators.xquery.XQueryMediatorFactory to handle
{http://ws.apache.org/ns/synapse}xquery
2008-05-07 10:41:11,355 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}filter)
2008-05-07 10:41:11,782 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}send)
2008-05-07 10:41:11,832 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}drop)
2008-05-07 10:41:11,833 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
MediatorFactoryFinder getMediator({http://ws.apache.org/ns/synapse}send)
2008-05-07 10:41:11,841 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseConfigurationBuilder Loaded Synapse configuration from :
/home/CHENG/synapse-1.1.1-bin/repository/conf/sample/synapse_sample_1.xml
2008-05-07 10:41:11,861 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Using synapse tuning parameter : synapse.threads.qlen
= 10
2008-05-07 10:41:11,861 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Using synapse tuning parameter : synapse.threads.core
= 20
2008-05-07 10:41:11,861 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Using synapse tuning parameter : synapse.threads.max
= 100
2008-05-07 10:41:11,862 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Using synapse tuning parameter :
synapse.threads.keepalive = 5
2008-05-07 10:41:11,871 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Using synapse tuning parameter :
synapse.threads.group = synapse-thread-group
2008-05-07 10:41:11,871 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Using synapse tuning parameter :
synapse.threads.idprefix = SynapseWorker
2008-05-07 10:41:11,872 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SynapseConfiguration Initializing the Synapse Configuration
2008-05-07 10:41:11,873 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SequenceMediator Initializing child mediators
2008-05-07 10:41:11,873 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
FilterMediator Initializing child mediators
2008-05-07 10:41:11,873 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
SequenceMediator Initializing child mediators
2008-05-07 10:41:11,873 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Deploying the Synapse service..
2008-05-07 10:41:11,922 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Initializing Sandesha 2...
2008-05-07 10:41:11,930 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Synapse server name : DEDSAV01.MAC.DOM
2008-05-07 10:41:11,931 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Deploying Proxy services...
2008-05-07 10:41:11,931 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
SynapseInitializationModule Synapse initialized successfully...!
2008-05-07 10:41:11,942 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
HttpCoreNIOSSLSender Loading Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/identity.jks
2008-05-07 10:41:12,152 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
HttpCoreNIOSSLSender Loading Trust Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/trust.jks
2008-05-07 10:41:17,194 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
HttpCoreNIOSender HTTPS Sender starting
2008-05-07 10:41:17,195 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
HttpCoreNIOSender HTTP Sender starting
2008-05-07 10:41:17,985 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpCoreNIOSender] DEBUG NativeWorkerPool Using native util.concurrent
package..
2008-05-07 10:41:17,987 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpCoreNIOSender] DEBUG NativeWorkerPool Using native util.concurrent
package..
2008-05-07 10:41:18,456 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
HttpCoreNIOSSLListener Loading Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/identity.jks
2008-05-07 10:41:18,458 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
HttpCoreNIOSSLListener Loading Trust Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/trust.jks
2008-05-07 10:41:18,656 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
HttpCoreNIOListener Starting Listener...
2008-05-07 10:41:18,657 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
HttpCoreNIOListener HTTPS Listener starting on port : 8443
2008-05-07 10:41:18,657 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
ServerManager Starting transport https on port 8443
2008-05-07 10:41:18,658 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
HttpCoreNIOListener Starting Listener...
2008-05-07 10:41:18,658 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
HttpCoreNIOListener HTTP Listener starting on port : 8080
2008-05-07 10:41:18,658 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
ServerManager Starting transport http on port 8080
2008-05-07 10:41:18,685 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
NativeWorkerPool Using native util.concurrent package..
2008-05-07 10:41:18,776 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpCoreNIOListener] DEBUG NativeWorkerPool Using native util.concurrent
package..
2008-05-07 10:41:18,797 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpCoreNIOListener] DEBUG NativeWorkerPool Using native util.concurrent
package..
2008-05-07 10:41:18,848 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
ServerManager Starting transport vfs
2008-05-07 10:41:18,855 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] DEBUG
NativeWorkerPool Using native util.concurrent package..
2008-05-07 10:41:18,855 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
ServerManager Starting transport mailto
2008-05-07 10:41:18,855 [192.168.150.24-DEDSAV01.MAC.DOM] [Thread-0] INFO
ServerManager Ready for processing
2008-05-07 10:43:56,681 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG ServerHandler HTTP connection [/127.0.0.1:7023]: Connected
2008-05-07 10:43:56,761 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG ServerHandler HTTP connection [/127.0.0.1:7023]: POST
/soap/StockQuote HTTP/1.1
2008-05-07 10:43:56,769 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] INFO PipeImpl Using native OS Pipes for event-driven to stream IO
bridging
2008-05-07 10:43:56,993 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG headers >> POST /soap/StockQuote HTTP/1.1
2008-05-07 10:43:56,994 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG headers >> Content-Type: text/xml; charset=UTF-8
2008-05-07 10:43:56,994 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG headers >> SOAPAction: "urn:getQuote"
2008-05-07 10:43:56,994 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG headers >> User-Agent: Axis2
2008-05-07 10:43:56,994 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG headers >> Host: localhost:8080
2008-05-07 10:43:56,994 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG headers >> Transfer-Encoding: chunked
2008-05-07 10:43:56,994 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG ServerHandler HTTP connection [LOOPBACK/127.0.0.1:7023]: Input
ready
2008-05-07 10:43:57,035 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG ServerHandler HTTP connection [LOOPBACK/127.0.0.1:7023]: Content
decoder [chunk-coded; completed: true]
2008-05-07 10:43:58,541 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG TransportUtils createSOAPEnvelope using Builder
(class org.apache.axis2.builder.SOAPBuilder) selected from type (text/xml)
2008-05-07 10:43:58,847 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SynapseMessageReceiver Synapse received a new
message for message mediation...
2008-05-07 10:43:58,847 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SynapseMessageReceiver Received To:
/soap/StockQuote
2008-05-07 10:43:58,848 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SynapseMessageReceiver SOAPAction: urn:getQuote
2008-05-07 10:43:58,848 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SynapseMessageReceiver WSA-Action: urn:getQuote
2008-05-07 10:43:58,885 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG Axis2SynapseEnvironment Injecting
MessageContext
2008-05-07 10:43:58,885 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG Axis2SynapseEnvironment Using Main Sequence for
injected message
2008-05-07 10:43:58,885 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SequenceMediator Start : Sequence <main>
2008-05-07 10:43:58,886 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SequenceMediator Sequence <SequenceMediator> ::
mediate()
2008-05-07 10:43:58,886 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG FilterMediator Start : Filter mediator
2008-05-07 10:43:58,908 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG FilterMediator Source : get-property('To')
against : .*/StockQuote.* matches - executing child mediators
2008-05-07 10:43:58,908 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG FilterMediator Sequence <FilterMediator> ::
mediate()
2008-05-07 10:43:58,908 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SendMediator Start : Send mediator
2008-05-07 10:43:58,919 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG AddressEndpoint Start : Address Endpoint
2008-05-07 10:43:58,919 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG AddressEndpoint Sending message to endpoint :
AnonymousEndpoint resolves to address =
http://localhost:9000/soap/SimpleStockQuoteService
2008-05-07 10:43:58,920 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG AddressEndpoint SOAPAction: urn:getQuote
2008-05-07 10:43:58,920 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG AddressEndpoint WSA-Action: urn:getQuote
2008-05-07 10:43:58,980 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG Axis2FlexibleMEPClient Sending [add = false]
[sec = false] [rm = false] [ mtom = false] [ swa = false] [ format = null]
[ force soap11=false] [ force soap12=false] [ pox=false] [ get=false] [ to
Address: /soap/StockQuote]
2008-05-07 10:43:59,100 [192.168.150.24-DEDSAV01.MAC.DOM]
[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-05-07 10:43:59,140 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG ConnectionPool No connections available for
reuse
2008-05-07 10:43:59,146 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG HttpCoreNIOSender A new connection established
2008-05-07 10:43:59,146 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG Axis2HttpRequest start streaming outgoing http
request
2008-05-07 10:43:59,147 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SOAPMessageFormatter start writeTo()
2008-05-07 10:43:59,147 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SOAPMessageFormatter preserve=true
2008-05-07 10:43:59,147 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SOAPMessageFormatter isOptimized=false
2008-05-07 10:43:59,147 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SOAPMessageFormatter isDoingSWA=false
2008-05-07 10:44:01,374 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]:
Connected ([EMAIL PROTECTED])
2008-05-07 10:44:01,384 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SOAPMessageFormatter end writeTo()
2008-05-07 10:44:01,392 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG Axis2HttpRequest get source channel of the pipe on which the
outgoing response is written
2008-05-07 10:44:01,393 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SendMediator End : Send mediator
2008-05-07 10:44:01,393 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG SOAPMessageFormatter contentType from the OMOutputFormat
=text/xml
2008-05-07 10:44:01,393 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG DropMediator Start : Drop mediator
2008-05-07 10:44:01,393 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG SOAPMessageFormatter contentType returned =text/xml;
charset=UTF-8
2008-05-07 10:44:01,423 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG DropMediator End : Drop mediator
2008-05-07 10:44:01,424 [192.168.150.24-DEDSAV01.MAC.DOM]
[HttpServerWorker-1] DEBUG SequenceMediator End : Sequence <main>
2008-05-07 10:44:01,442 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> POST
http://localhost:9000/soap/SimpleStockQuoteService HTTP/1.1
2008-05-07 10:44:01,442 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> Host: localhost:8080
2008-05-07 10:44:01,442 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> SOAPAction: urn:getQuote
2008-05-07 10:44:01,442 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> Content-Type: text/xml; charset=UTF-8
2008-05-07 10:44:01,442 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> Transfer-Encoding: chunked
2008-05-07 10:44:01,442 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> Connection: Keep-Alive
2008-05-07 10:44:01,443 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG headers >> User-Agent: Synapse-HttpComponents-NIO
2008-05-07 10:44:01,447 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]: Output
ready
2008-05-07 10:44:01,447 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]: Content
encoder [chunk-coded; completed: false]
2008-05-07 10:44:01,448 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]: Output
ready
2008-05-07 10:44:01,448 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]: Content
encoder [chunk-coded; completed: true]
2008-05-07 10:44:01,452 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]: Request
ready
2008-05-07 10:44:26,551 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
7] DEBUG ServerHandler HTTP connection [closed]: Closed
2008-05-07 10:45:00,113 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [localhost/127.0.0.1:9000]: Timeout
2008-05-07 10:45:00,123 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler Connection Timeout
2008-05-07 10:45:00,123 [192.168.150.24-DEDSAV01.MAC.DOM] [I/O dispatcher
3] DEBUG ClientHandler HTTP connection [closed]: Closed
***************************** axis2server log
*********************************
2008-05-07 10:41:52,530 [-] [Thread-0] INFO SampleAxis2ServerManager
[SimpleAxisServer] Starting
2008-05-07 10:41:58,646 [-] [Thread-0] DEBUG HttpCoreNIOSSLSender Loading
Key Store from URL : file:/home/CHENG/synapse-1.1.1-bin/lib/identity.jks
2008-05-07 10:41:58,865 [-] [Thread-0] DEBUG HttpCoreNIOSSLSender Loading
Trust Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/trust.jks
2008-05-07 10:42:04,158 [-] [Thread-0] INFO HttpCoreNIOSender HTTPS
Sender starting
2008-05-07 10:42:04,159 [-] [Thread-0] INFO HttpCoreNIOSender HTTP Sender
starting
2008-05-07 10:42:04,511 [-] [HttpCoreNIOSender] DEBUG NativeWorkerPool
Using native util.concurrent package..
2008-05-07 10:42:04,551 [-] [HttpCoreNIOSender] DEBUG NativeWorkerPool
Using native util.concurrent package..
2008-05-07 10:42:05,429 [-] [Thread-0] DEBUG HttpCoreNIOSSLListener
Loading Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/identity.jks
2008-05-07 10:42:05,430 [-] [Thread-0] DEBUG HttpCoreNIOSSLListener
Loading Trust Key Store from URL :
file:/home/CHENG/synapse-1.1.1-bin/lib/trust.jks
2008-05-07 10:42:05,611 [-] [Thread-0] DEBUG HttpCoreNIOListener Starting
Listener...
2008-05-07 10:42:05,619 [-] [Thread-0] INFO HttpCoreNIOListener HTTPS
Listener starting on port : 9002
2008-05-07 10:42:05,619 [-] [Thread-0] DEBUG HttpCoreNIOListener Starting
Listener...
2008-05-07 10:42:05,620 [-] [Thread-0] INFO HttpCoreNIOListener HTTP
Listener starting on port : 9000
2008-05-07 10:42:05,681 [-] [Thread-0] DEBUG NativeWorkerPool Using native
util.concurrent package..
2008-05-07 10:42:05,700 [-] [Thread-0] WARN MailTransportListener Error
configuring the Mail transport for Service : SimpleStockQuoteService ::
Cannot find parameter : transport.mail.Address for service :
SimpleStockQuoteService
2008-05-07 10:42:05,700 [-] [HttpCoreNIOListener] DEBUG NativeWorkerPool
Using native util.concurrent package..
2008-05-07 10:42:05,700 [-] [Thread-0] INFO SampleAxis2ServerManager
[SimpleAxisServer] Started
2008-05-07 10:42:05,730 [-] [HttpCoreNIOListener] DEBUG NativeWorkerPool
Using native util.concurrent package..
2008-05-07 10:42:05,770 [-] [HttpCoreNIOListener] WARN
HttpCoreNIOListener System may be unstable: IOReactor encountered a
checked exception : Adresse wird bereits verwendet.
java.net.SocketException: Adresse wird bereits verwendet.
at java.lang.Throwable.<init>(Throwable.java:196)
at java.lang.Exception.<init>(Exception.java:41)
at java.io.IOException.<init>(IOException.java:40)
at java.net.SocketException.<init>(SocketException.java:29)
at
sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:119)
at
sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:59)
at
sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:52)
at
org.apache.http.impl.nio.reactor.DefaultListeningIOReactor.processSessionRequests(DefaultListeningIOReactor.java:181)
at
org.apache.http.impl.nio.reactor.DefaultListeningIOReactor.processEvents(DefaultListeningIOReactor.java:91)
at
org.apache.http.impl.nio.reactor.AbstractMultiworkerIOReactor.execute(AbstractMultiworkerIOReactor.java:160)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOListener.startServerEngine(HttpCoreNIOListener.java:123)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOListener.access$200(HttpCoreNIOListener.java:59)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOListener$2.run(HttpCoreNIOListener.java:271)
at java.lang.Thread.run(Thread.java:595)
2008-05-07 10:42:07,532 [-] [HttpCoreNIOListener] WARN
HttpCoreNIOListener System may be unstable: IOReactor encountered a
checked exception : Adresse wird bereits verwendet.
java.net.SocketException: Adresse wird bereits verwendet.
at java.lang.Throwable.<init>(Throwable.java:196)
at java.lang.Exception.<init>(Exception.java:41)
at java.io.IOException.<init>(IOException.java:40)
at java.net.SocketException.<init>(SocketException.java:29)
at
sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:119)
at
sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:59)
at
sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:52)
at
org.apache.http.impl.nio.reactor.DefaultListeningIOReactor.processSessionRequests(DefaultListeningIOReactor.java:181)
at
org.apache.http.impl.nio.reactor.DefaultListeningIOReactor.processEvents(DefaultListeningIOReactor.java:91)
at
org.apache.http.impl.nio.reactor.AbstractMultiworkerIOReactor.execute(AbstractMultiworkerIOReactor.java:160)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOListener.startServerEngine(HttpCoreNIOListener.java:123)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOListener.access$200(HttpCoreNIOListener.java:59)
at
org.apache.synapse.transport.nhttp.HttpCoreNIOListener$2.run(HttpCoreNIOListener.java:271)
at java.lang.Thread.run(Thread.java:595)
2008-05-07 10:44:01,617 [-] [I/O dispatcher 6] DEBUG ServerHandler HTTP
connection [/127.0.0.1:63406]: Connected
2008-05-07 10:44:02,457 [-] [I/O dispatcher 6] DEBUG ServerHandler HTTP
connection [/127.0.0.1:63406]: POST
http://localhost:9000/soap/SimpleStockQuoteService HTTP/1.1
2008-05-07 10:44:03,438 [-] [I/O dispatcher 6] DEBUG headers >> POST
http://localhost:9000/soap/SimpleStockQuoteService HTTP/1.1
2008-05-07 10:44:03,438 [-] [I/O dispatcher 6] DEBUG headers >> Host:
localhost:8080
2008-05-07 10:44:03,441 [-] [I/O dispatcher 6] DEBUG headers >>
SOAPAction: urn:getQuote
2008-05-07 10:44:03,466 [-] [I/O dispatcher 6] DEBUG headers >>
Content-Type: text/xml; charset=UTF-8
2008-05-07 10:44:03,466 [-] [I/O dispatcher 6] DEBUG headers >>
Transfer-Encoding: chunked
2008-05-07 10:44:03,466 [-] [I/O dispatcher 6] DEBUG headers >>
Connection: Keep-Alive
2008-05-07 10:44:03,466 [-] [I/O dispatcher 6] DEBUG headers >>
User-Agent: Synapse-HttpComponents-NIO
2008-05-07 10:44:03,487 [-] [I/O dispatcher 6] DEBUG ServerHandler HTTP
connection [LOOPBACK/127.0.0.1:63406]: Input ready
2008-05-07 10:44:03,521 [-] [I/O dispatcher 6] DEBUG ServerHandler HTTP
connection [LOOPBACK/127.0.0.1:63406]: Content decoder [chunk-coded;
completed: true]
2008-05-07 10:44:03,936 [-] [HttpServerWorker-2] DEBUG TransportUtils
createSOAPEnvelope using Builder (class
org.apache.axis2.builder.SOAPBuilder) selected from type (text/xml)
2008-05-07 10:44:07,020 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter contentType from the OMOutputFormat =text/xml
2008-05-07 10:44:07,020 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter contentType returned =text/xml; charset=UTF-8
2008-05-07 10:44:07,097 [-] [HttpServerWorker-2] DEBUG headers << HTTP/1.1
200 OK
2008-05-07 10:44:07,098 [-] [HttpServerWorker-2] DEBUG headers <<
Content-Type: text/xml; charset=UTF-8
2008-05-07 10:44:07,101 [-] [HttpServerWorker-2] DEBUG headers << Date:
Wed, 07 May 2008 08:44:07 GMT
2008-05-07 10:44:07,101 [-] [HttpServerWorker-2] DEBUG headers << Server:
Synapse-HttpComponents-NIO
2008-05-07 10:44:07,101 [-] [HttpServerWorker-2] DEBUG headers <<
Transfer-Encoding: chunked
2008-05-07 10:44:07,101 [-] [HttpServerWorker-2] DEBUG headers <<
Connection: Keep-Alive
2008-05-07 10:44:07,101 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter start writeTo()
2008-05-07 10:44:07,127 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter preserve=true
2008-05-07 10:44:07,171 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter isOptimized=false
2008-05-07 10:44:07,172 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter isDoingSWA=false
2008-05-07 10:44:07,290 [-] [HttpServerWorker-2] DEBUG
SOAPMessageFormatter end writeTo()
2008-05-07 10:45:00,124 [-] [I/O dispatcher 6] DEBUG ServerHandler HTTP
connection [closed]: Closed
************************** client-service ant stockquote response
**************************
ant stockquote -Dtrpurl=http://localhost:8080/soap/StockQuote
Buildfile: build.xml
init:
compile:
stockquote:
[java] 2008-05-07 10:43:56,203 [-] [Thread-0] DEBUG
SOAPMessageFormatter contentType from the OMOutputFormat =text/xml
[java] 2008-05-07 10:43:56,212 [-] [Thread-0] DEBUG
SOAPMessageFormatter contentType returned =text/xml; charset=UTF-8
[java] 2008-05-07 10:43:56,379 [-] [Thread-0] DEBUG
SOAPMessageFormatter start writeTo()
[java] 2008-05-07 10:43:56,379 [-] [Thread-0] DEBUG
SOAPMessageFormatter preserve=false
[java] 2008-05-07 10:43:56,387 [-] [Thread-0] DEBUG
SOAPMessageFormatter isOptimized=false
[java] 2008-05-07 10:43:56,387 [-] [Thread-0] DEBUG
SOAPMessageFormatter isDoingSWA=false
[java] 2008-05-07 10:43:56,425 [-] [Thread-0] DEBUG
SOAPMessageFormatter end writeTo()
[java] 2008-05-07 10:44:26,500 [-] [Thread-0] INFO HTTPSender Unable
to sendViaPost to url[http://localhost:8080/soap/Stock
Quote]
[java] java.net.SocketTimeoutException: Leseanforderung hat Zeitlimit
}berschritten. [java] at
java.lang.Throwable.<init>(Throwable.java:196)
[java] at java.lang.Exception.<init>(Exception.java:41)
[java] at java.io.IOException.<init>(IOException.java:40)
[java] at
java.net.SocketTimeoutException.<init>(SocketTimeoutException.java:24)
[java] at
java.net.SocketInputStream.read(SocketInputStream.java:129)
[java] at
java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
[java] at
java.io.BufferedInputStream.read(BufferedInputStream.java:235)
[java] at
org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:77)
[java] at
org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:105)
[java] at
org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1115)
[java] at
org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.readLine(MultiThreadedH
ttpConnectionManager.java:1373)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1832)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1590)
[java] at
org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:995)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:397)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:170)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:396)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
[java] at
org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:520)
[java] at
org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:191)
[java] at
org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:77)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.
java:327)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:206)
[java] at
org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:396)
[java] at
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
[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-07 10:44:26,585 [-] [Thread-0] DEBUG
CommonsHTTPTransportSender org.apache.axis2.AxisFault: Leseanforderung hat
Zeitlimit }berschritten.
[java] 2008-05-07 10:44:26,585 [-] [Thread-0] DEBUG
CommonsHTTPTransportSender org.apache.axis2.AxisFault: Leseanforderung h
at Zeitlimit }berschritten.
[java] org.apache.axis2.AxisFault: Leseanforderung hat Zeitlimit
}berschritten.
[java] at java.lang.Throwable.<init>(Throwable.java:196)
[java] at java.lang.Exception.<init>(Exception.java:41)
[java] at java.io.IOException.<init>(IOException.java:40)
[java] at
java.rmi.RemoteException.<init>(RemoteException.java:75)
[java] at org.apache.axis2.AxisFault.<init>(AxisFault.java:280)
[java] at org.apache.axis2.AxisFault.<init>(AxisFault.java:246)
[java] at
org.apache.axis2.AxisFault.makeFault(AxisFault.java:417)
[java] at
org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:195)
[java] at
org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:77)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.
java:327)
[java] at
org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:206)
[java] at
org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:396) [java] at
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
[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] Caused by: java.net.SocketTimeoutException: Leseanforderung hat
Zeitlimit }berschritten.
[java] at java.lang.Throwable.<init>(Throwable.java:196)
[java] at java.lang.Exception.<init>(Exception.java:41)
[java] at java.io.IOException.<init>(IOException.java:40)
[java] at
java.net.SocketTimeoutException.<init>(SocketTimeoutException.java:24)
[java] at
java.net.SocketInputStream.read(SocketInputStream.java:129)
[java] at
java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
[java] at
java.io.BufferedInputStream.read(BufferedInputStream.java:235)
[java] at
org.apache.commons.httpclient.HttpParser.readRawLine(HttpParser.java:77)
[java] at
org.apache.commons.httpclient.HttpParser.readLine(HttpParser.java:105)
[java] at
org.apache.commons.httpclient.HttpConnection.readLine(HttpConnection.java:1115)
[java] at
org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.readLine(MultiThreadedH
ttpConnectionManager.java:1373)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readStatusLine(HttpMethodBase.java:1832)
[java] at
org.apache.commons.httpclient.HttpMethodBase.readResponse(HttpMethodBase.java:1590)
[java] at
org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:995)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:397)
[java] at
org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:170)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:396)
[java] at
org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
[java] at
org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:520)
[java] at
org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:191)
[java] ... 11 more
BUILD SUCCESSFUL
Total time: 50 seconds
$
Regards,
Cynthia
