DEBUG 2007-10-11 11:42:24,945 [FileConnector.receiver.1] org.mule.impl.MuleMessage: new copy of message for Thread[FileConnector.receiver.1,5,main]
DEBUG 2007-10-11 11:42:24,961 [connector.axis.0.dispatcher.1] org.mule.impl.MuleMessage: new copy of message for Thread[connector.axis.0.dispatcher.1,5,main]
DEBUG 2007-10-11 11:42:24,961 [connector.axis.0.dispatcher.1] org.mule.providers.soap.axis.AxisMessageDispatcher: Connecting: AxisMessageDispatcher{this=8b677f,
endpoint=
http://localhost:8888/CallImporter/CallImporter.asmx?method=ImportFile}
INFO 2007-10-11 11:42:24,992 [connector.axis.0.dispatcher.1] org.mule.providers.soap.axis.AxisMessageDispatcher: Connected: AxisMessageDispatcher{this=8b677f,
endpoint=
http://localhost:8888/CallImporter/CallImporter.asmx?method=ImportFile}
DEBUG 2007-10-11 11:42:25,054 [connector.axis.0.dispatcher.1] org.mule.providers.soap.axis.AxisMessageDispatcher: SoapAction for this call is: urn:www-callcomma
nd-com:web-services.CallImporter/ImportFile
DEBUG 2007-10-11 11:42:25,101 [connector.axis.0.dispatcher.1] org.mule.providers.soap.axis.extensions.MuleSoapHeadersHandler: After Client Request, Message is:
<?xml version="1.0" encoding="UTF-8"?><soapenv:Envelope xmlns:soapenv="
http://schemas.xmlsoap.org/soap/envelope/" xmlns:xsd="
http://www.w3.org/2001/XMLSchema" x
mlns:xsi="
http://www.w3.org/2001/XMLSchema-instance"><soapenv:Header><mule:header soapenv:actor="
http://www.muleumo.org/providers/soap/1.0" soapenv:mustUndersta
nd="0" xmlns:mule="
http://www.muleumo.org/providers/soap/1.0"><mule:MULE_CORRELATION_ID>C:\Work\inbox\2066961-8639.xml</mule:MULE_CORRELATION_ID><mule:MULE_CORR
ELATION_GROUP_SIZE>-1</mule:MULE_CORRELATION_GROUP_SIZE><mule:MULE_CORRELATION_SEQUENCE>-1</mule:MULE_CORRELATION_SEQUENCE></mule:header></soapenv:Header><soape
nv:Body><ns1:ImportFile soapenv:encodingStyle="
http://schemas.xmlsoap.org/soap/encoding/" xmlns:ns1="urn:www-callcommand-com%3Aweb-services.CallImporter"><ns1:d
ataProvider xsi:type="xsd:string">muledd</ns1:dataProvider><ns1:username xsi:type="xsd:string">muledd</ns1:username><ns1:password xsi:type="xsd:string">nB5Qagb%
</ns1:password><ns1:xmlDocument xsi:type="xsd:string">[
B@1a0b53e</ns1:xmlDocument><ns1:documentType xsi:type="xsd:string">BulkCore</ns1:documentType><ns1:batchI
dentifier xsi:type="xsd:string">MuleTest101010</ns1:batchIdentifier></ns1:ImportFile></soapenv:Body></soapenv:Envelope>
DEBUG 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.service.TransportServiceDescriptor: Endpoint resolver not set, Loading default
resolver: org.mule.impl.endpoint.UrlEndpointBuilder
DEBUG 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.service.TransportServiceDescriptor: Endpoint resolver not set, Loading default
resolver: org.mule.impl.endpoint.UrlEndpointBuilder
DEBUG 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Set UMOConnector name to: connector.http.0
DEBUG 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Set UMOConnector name to: connector.http.0
INFO 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Initialising: HttpConnector{this=31688f, started=false, ini
tialised=false, name='connector.http.0', disposed=false, numberOfConcurrentTransactedReceivers=4, createMultipleTransactedReceivers=true, connected=false, suppo
rtedProtocols=[http], serviceOverrides=null}
DEBUG 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Loading DispatcherFactory: org.mule.providers.http.HttpClie
ntMessageDispatcherFactory
INFO 2007-10-11 11:42:25,117 [connector.axis.0.dispatcher.1] org.mule.providers.service.TransportServiceDescriptor: Loading default outbound transformer: org.m
ule.providers.http.transformers.ObjectToHttpClientMethodRequest
INFO 2007-10-11 11:42:25,132 [connector.axis.0.dispatcher.1] org.mule.providers.service.TransportServiceDescriptor: Loading default response transformer: org.m
ule.providers.http.transformers.UMOMessageToHttpResponse
DEBUG 2007-10-11 11:42:25,132 [connector.axis.0.dispatcher.1] org.mule.providers.http.transformers.UMOMessageToHttpResponse: java.lang.Object has been added as
source type for this transformer, there will be no source type checking performed
DEBUG 2007-10-11 11:42:25,132 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Disposing Dispatchers
DEBUG 2007-10-11 11:42:25,132 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Dispatchers Disposed
DEBUG 2007-10-11 11:42:25,132 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Disposing Receivers
DEBUG 2007-10-11 11:42:25,132 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Receivers Disposed
INFO 2007-10-11 11:42:25,148 [connector.axis.0.dispatcher.1] org.mule.impl.DefaultExceptionStrategy: Initialising exception listener: org.mule.impl.DefaultExce
ptionStrategy@2a987d
DEBUG 2007-10-11 11:42:25,164 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Connecting: HttpConnector{this=31688f, started=false, initi
alised=true, name='connector.http.0', disposed=false, numberOfConcurrentTransactedReceivers=4, createMultipleTransactedReceivers=true, connected=false, supporte
dProtocols=[http], serviceOverrides=null}
INFO 2007-10-11 11:42:25,179 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Starting: HttpConnector{this=31688f, started=false, initial
ised=true, name='connector.http.0', disposed=false, numberOfConcurrentTransactedReceivers=4, createMultipleTransactedReceivers=true, connected=true, supportedPr
otocols=[http], serviceOverrides=null}
INFO 2007-10-11 11:42:25,179 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Started: HttpConnector{this=31688f, started=true, initialis
ed=true, name='connector.http.0', disposed=false, numberOfConcurrentTransactedReceivers=4, createMultipleTransactedReceivers=true, connected=true, supportedProt
ocols=[http], serviceOverrides=null}
INFO 2007-10-11 11:42:25,179 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Connected: HttpConnector{this=31688f, started=true, initial
ised=true, name='connector.http.0', disposed=false, numberOfConcurrentTransactedReceivers=4, createMultipleTransactedReceivers=true, connected=true, supportedPr
otocols=[http], serviceOverrides=null}
DEBUG 2007-10-11 11:42:25,179 [connector.axis.0.dispatcher.1] org.mule.providers.http.transformers.ObjectToHttpClientMethodRequest: Setting transformer name to:
ObjectToHttpClientMethodRequest
INFO 2007-10-11 11:42:25,210 [connector.axis.0.dispatcher.1] org.mule.providers.soap.axis.extensions.UniversalSender: Making Axis soap request on: urn:www-call
command-com:web-services.CallImporter/ImportFile
DEBUG 2007-10-11 11:42:25,210 [connector.axis.0.dispatcher.1] org.mule.providers.soap.axis.extensions.UniversalSender: Soap request is:
[
B@10ebe18
DEBUG 2007-10-11 11:42:25,210 [connector.axis.0.dispatcher.1] org.mule.impl.MuleSession: dispatching event: Event: 906c51cd-7810-11dc-9205-ab65db856178, sync=fa
lse, stop processing=false, MuleEndpoint{endpointUri=
http://localhost:8888/CallImporter/CallImporter.asmx?method=ImportFile, connector=HttpConnector{this=31688f
, started=true, initialised=true, name='connector.http.0', disposed=false, numberOfConcurrentTransactedReceivers=4, createMultipleTransactedReceivers=true, conn
ected=true, supportedProtocols=[http], serviceOverrides=null}, transformer=ObjectToHttpClientMethodRequest{this=e2433b, name='ObjectToHttpClientMethodRequest',
ignoreBadInput=false, returnClass=interface org.apache.commons.httpclient.HttpMethod, sourceTypes=[]}, name='endpoint.http.localhost.8888.CallImporter.CallImpor
ter.asmx.method.ImportFile', type='sender', properties={method=ImportFile}, transactionConfig=Transaction{factory=null, action=NONE, timeout=30000}, filter=null
, deleteUnacceptedMessages=false, initialised=false, securityFilter=null, synchronous=null, initialState=started, createConnector=0, remoteSync=false, remoteSyn
cTimeout=10000, endpointEncoding=null}
DEBUG 2007-10-11 11:42:25,226 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Borrowing a dispatcher for endpoint:
http://localhost:8888/
CallImporter/CallImporter.asmx?method=ImportFile
DEBUG 2007-10-11 11:42:25,242 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Borrowed dispatcher: HttpClientMessageDispatcher{this=1ce66
3c, endpoint=
http://localhost:8888/CallImporter/CallImporter.asmx?method=ImportFile}
DEBUG 2007-10-11 11:42:25,242 [connector.axis.0.dispatcher.1] org.mule.impl.MuleMessage: new copy of message for Thread[connector.axis.0.dispatcher.1,5,main]
DEBUG 2007-10-11 11:42:25,242 [connector.axis.0.dispatcher.1] org.mule.providers.http.HttpConnector: Returning dispatcher for endpoint:
http://localhost:8888/Ca
llImporter/CallImporter.asmx?method=ImportFile = HttpClientMessageDispatcher{this=1ce663c, endpoint=
http://localhost:8888/CallImporter/CallImporter.asmx?method=
ImportFile}
DEBUG 2007-10-11 11:42:25,257 [connector.http.0.dispatcher.1] org.mule.impl.MuleMessage: new copy of message for Thread[connector.http.0.dispatcher.1,5,main]
DEBUG 2007-10-11 11:42:25,257 [connector.http.0.dispatcher.1] org.mule.providers.http.HttpClientMessageDispatcher: Connecting: HttpClientMessageDispatcher{this=
1ce663c, endpoint=
http://localhost:8888/CallImporter/CallImporter.asmx?method=ImportFile}
INFO 2007-10-11 11:42:25,273 [connector.http.0.dispatcher.1] org.mule.providers.http.HttpClientMessageDispatcher: Connected: HttpClientMessageDispatcher{this=1
ce663c, endpoint=
http://localhost:8888/CallImporter/CallImporter.asmx?method=ImportFile}
DEBUG 2007-10-11 11:42:25,273 [connector.http.0.dispatcher.1] org.mule.providers.http.transformers.ObjectToHttpClientMethodRequest: Applying transformer ObjectT
oHttpClientMethodRequest (org.mule.providers.http.transformers.ObjectToHttpClientMethodRequest)
DEBUG 2007-10-11 11:42:25,273 [connector.http.0.dispatcher.1] org.mule.providers.http.transformers.ObjectToHttpClientMethodRequest: Object before transform: {60
,63,120,109,108,32,118,101,114,115,105,111,110,61,34,49,46,48,34,32,101,110,99,111,100,105,110,103,61,34,85,84,70,45,56,34,63,62,60,115,111,97,112,101,110,118,5
8,69,110,118 [..]}
DEBUG 2007-10-11 11:42:25,366 [connector.http.0.dispatcher.1] org.mule.providers.http.transformers.ObjectToHttpClientMethodRequest: Object after transform: org.
apache.commons.httpclient.methods.PostMethod@7f8922
DEBUG 2007-10-11 11:42:25,366 [connector.http.0.dispatcher.1] org.mule.providers.http.transformers.ObjectToHttpClientMethodRequest: The transformed object is of
expected type. Type is: PostMethod
After staring at this and the relevant bits of code I have to confess that I just don't understand enough about QNames and SOAPMethods to make sense of this bug - sorry. Can you please provide a failing test case based on either org.mule.test.config.QNameConverterTestCase or org.mule.providers.soap.SoapMethodTestCase (which I think applies too?) that explains the problem a bit better? That would be a great help. Thanks.