You are viewing a plain text version of this content. The canonical link for it is here.
Posted to savan-dev@ws.apache.org by "Amila Chinthaka Suriarachchi (JIRA)" <ji...@apache.org> on 2010/04/23 14:10:50 UTC

[jira] Commented: (AXIS2-4693) NTLM preemprt authenticate with BASIC

    [ https://issues.apache.org/jira/browse/AXIS2-4693?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12860229#action_12860229 ] 

Amila Chinthaka Suriarachchi commented on AXIS2-4693:
-----------------------------------------------------

have a look at with the tcpmon[1]. to check the messages pass around. First call should return a challenge response.

[1] http://ws.apache.org/commons/tcpmon/

> NTLM preemprt authenticate with BASIC
> -------------------------------------
>
>                 Key: AXIS2-4693
>                 URL: https://issues.apache.org/jira/browse/AXIS2-4693
>             Project: Axis2
>          Issue Type: Bug
>          Components: client-api, transports
>    Affects Versions: 1.5.1
>         Environment: Windows 7 
> java jdk 1.5.0.22
>            Reporter: Stefano Ghezzi
>
> I have to call a web service which is protected by NTLM authentication
> Here's my code
>         sidacWSStub = new Bexppage_wsWSServiceStub("http://sasv00t2.saipem.pri:9191/sidac");
>         HttpTransportProperties.Authenticator auth = new HttpTransportProperties.Authenticator();
>         auth.setUsername("aaaaa");
>         auth.setPassword("bbbb");
>         auth.setHost("sasv00t2.saipem.pri");
>         auth.setPort(9191);
>         auth.setDomain("myDomain");
>         auth.setPreemptiveAuthentication(true);
>         List<String> authSchema = new ArrayList<String>();
>         authSchema.add(HttpTransportProperties.Authenticator.NTLM);
>         auth.setAuthSchemes(authSchema);
>         sidacWSStub._getServiceClient().getOptions().setProperty(HTTPConstants.AUTHENTICATE, auth);
> Here's the axis2 interesting log
> 9:21:47,872 DEBUG [AxisService] Get operation for {http://bexppage_ws.ws.localhost/}bexppage_ws_Run
> 19:21:47,872 DEBUG [AxisService] Found axis operation:  org.apache.axis2.description.OutInAxisOperation@1a06e38
> 19:21:47,938 DEBUG [ConfigurationContext] registerOperationContext (false): org.apache.axis2.context.OperationContext@1a897a9 with key: urn:uuid:C97B59FBD82B4E4DFB1271956907945
> 19:21:47,938 DEBUG [OutInAxisOperationClient] Entry: OutInAxisOperationClient::execute, true
> 19:21:47,941 DEBUG [OutInAxisOperationClient] OutInAxisOperationClient: useAsyncOption null
> 19:21:47,941 DEBUG [ConfigurationContext] registerOperationContext (false): org.apache.axis2.context.OperationContext@1a897a9 with key: urn:uuid:C97B59FBD82B4E4DFB1271956907945
> 19:21:47,941 DEBUG [ConfigurationContext] msgContext: [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] action: http://bexppage_ws.ws.localhost/bexppage_wsWS/bexppage_ws_Run
> 19:21:47,944 DEBUG [AxisEngine] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] send:urn:uuid:C97B59FBD82B4E4DFB1271956907945
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking pre-condition for Phase "OperationOutPhase"
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking phase "OperationOutPhase"
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking post-conditions for phase "OperationOutPhase"
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking pre-condition for Phase "RMPhase"
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking phase "RMPhase"
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking post-conditions for phase "RMPhase"
> 19:21:47,946 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking pre-condition for Phase "PolicyDetermination"
> 19:21:47,947 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking phase "PolicyDetermination"
> 19:21:47,947 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking post-conditions for phase "PolicyDetermination"
> 19:21:47,947 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking pre-condition for Phase "MessageOut"
> 19:21:47,947 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking phase "MessageOut"
> 19:21:47,947 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking post-conditions for phase "MessageOut"
> 19:21:47,948 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking pre-condition for Phase "Security"
> 19:21:47,948 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking phase "Security"
> 19:21:47,948 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Checking post-conditions for phase "Security"
> 19:21:47,954 DEBUG [EndpointReference] hasAnonymousAddress: http://sasv00t2.saipem.pri:9191/sidac is Anonymous: false
> 19:21:47,954 DEBUG [EndpointReference] hasNoneAddress: http://sasv00t2.saipem.pri:9191/sidac is None: false
> 19:21:47,973 DEBUG [AbstractHTTPSender] Making new ConnectionManager
> 19:21:47,994 DEBUG [DefaultHttpParams] Set parameter http.useragent = Jakarta Commons-HttpClient/3.1
> 19:21:47,996 DEBUG [DefaultHttpParams] Set parameter http.protocol.version = HTTP/1.1
> 19:21:47,998 DEBUG [DefaultHttpParams] Set parameter http.connection-manager.class = class org.apache.commons.httpclient.SimpleHttpConnectionManager
> 19:21:47,998 DEBUG [DefaultHttpParams] Set parameter http.protocol.cookie-policy = default
> 19:21:47,998 DEBUG [DefaultHttpParams] Set parameter http.protocol.element-charset = US-ASCII
> 19:21:47,998 DEBUG [DefaultHttpParams] Set parameter http.protocol.content-charset = ISO-8859-1
> 19:21:48,000 DEBUG [DefaultHttpParams] Set parameter http.method.retry-handler = org.apache.commons.httpclient.DefaultHttpMethodRetryHandler@14d7745
> 19:21:48,000 DEBUG [DefaultHttpParams] Set parameter http.dateparser.patterns = [EEE, dd MMM yyyy HH:mm:ss zzz, EEEE, dd-MMM-yy HH:mm:ss zzz, EEE MMM d HH:mm:ss yyyy, EEE, dd-MMM-yyyy HH:mm:ss z, EEE, dd-MMM-yyyy HH-mm-ss z, EEE, dd MMM yy HH:mm:ss z, EEE dd-MMM-yyyy HH:mm:ss z, EEE dd MMM yyyy HH:mm:ss z, EEE dd-MMM-yyyy HH-mm-ss z, EEE dd-MMM-yy HH:mm:ss z, EEE dd MMM yy HH:mm:ss z, EEE,dd-MMM-yy HH:mm:ss z, EEE,dd-MMM-yyyy HH:mm:ss z, EEE, dd-MM-yyyy HH:mm:ss z]
> 19:21:48,007 DEBUG [HttpClient] Java version: 1.5.0_22
> 19:21:48,007 DEBUG [HttpClient] Java vendor: Sun Microsystems Inc.
> 19:21:48,007 DEBUG [HttpClient] Operating system name: Windows 7
> 19:21:48,007 DEBUG [HttpClient] Operating system architecture: x86
> 19:21:48,008 DEBUG [HttpClient] Operating system version: 6.1
> 19:21:48,037 DEBUG [HttpClient] SUN 1.5: SUN (DSA key/parameter generation; DSA signing; SHA-1, MD5 digests; SecureRandom; X.509 certificates; JKS keystore; PKIX CertPathValidator; PKIX CertPathBuilder; LDAP, Collection CertStores)
> 19:21:48,037 DEBUG [HttpClient] SunRsaSign 1.5: Sun RSA signature provider
> 19:21:48,037 DEBUG [HttpClient] SunJSSE 1.5: Sun JSSE provider(PKCS12, SunX509 key/trust factories, SSLv3, TLSv1)
> 19:21:48,037 DEBUG [HttpClient] SunJCE 1.5: SunJCE Provider (implements RSA, DES, Triple DES, AES, Blowfish, ARCFOUR, RC2, PBE, Diffie-Hellman, HMAC)
> 19:21:48,037 DEBUG [HttpClient] SunJGSS 1.0: Sun (Kerberos v5)
> 19:21:48,037 DEBUG [HttpClient] SunSASL 1.5: Sun SASL provider(implements client mechanisms for: DIGEST-MD5, GSSAPI, EXTERNAL, PLAIN, CRAM-MD5; server mechanisms for: DIGEST-MD5, GSSAPI, CRAM-MD5)
> 19:21:48,045 DEBUG [DefaultHttpParams] Set parameter http.connection-manager.timeout = 30000
> 19:21:48,046 DEBUG [DefaultHttpParams] Set parameter http.connection.timeout = 600000
> 19:21:48,046 DEBUG [DefaultHttpParams] Set parameter http.socket.timeout = 600000
> 19:21:48,046 DEBUG [DefaultHttpParams] Set parameter http.socket.timeout = 600000
> 19:21:48,061 DEBUG [HTTPSender] Thread[main,5,main] PostMethod org.apache.commons.httpclient.methods.PostMethod@15e2ccd / org.apache.commons.httpclient.HttpClient@1cf7491
> 19:21:48,063 DEBUG [OMOutputFormat] Start getContentType: OMOutputFormat [ mimeBoundary =null rootContentId=null doOptimize=false doingSWA=false isSOAP11=true charSetEncoding=UTF-8 xmlVersion=null contentType=null ignoreXmlDeclaration=false autoCloseWriter=false actionProperty=null optimizedThreshold=0]
> 19:21:48,063 DEBUG [OMOutputFormat] getContentType= {text/xml}   OMOutputFormat [ mimeBoundary =null rootContentId=null doOptimize=false doingSWA=false isSOAP11=true charSetEncoding=UTF-8 xmlVersion=null contentType=text/xml ignoreXmlDeclaration=false autoCloseWriter=false actionProperty=null optimizedThreshold=0]
> 19:21:48,063 DEBUG [SOAPMessageFormatter] contentType from the OMOutputFormat =text/xml
> 19:21:48,063 DEBUG [SOAPMessageFormatter] contentType returned =text/xml; charset=UTF-8
> 19:21:48,066 DEBUG [PostMethod] enter PostMethod.clearRequestBody()
> 19:21:48,066 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.clearRequestBody()
> 19:21:48,072 DEBUG [DefaultHttpParams] Set parameter http.authentication.preemptive = true
> 19:21:48,072 DEBUG [HttpState] enter HttpState.setCredentials(AuthScope, Credentials)
> 19:21:48,074 DEBUG [DefaultHttpParams] Set parameter http.auth.scheme-priority = [NTLM]
> 19:21:48,079 DEBUG [HttpClient] enter HttpClient.executeMethod(HostConfiguration,HttpMethod)
> 19:21:48,079 DEBUG [HttpClient] enter HttpClient.executeMethod(HostConfiguration,HttpMethod,HttpState)
> 19:21:48,107 DEBUG [MultiThreadedHttpConnectionManager] enter HttpConnectionManager.getConnectionWithTimeout(HostConfiguration, long)
> 19:21:48,107 DEBUG [MultiThreadedHttpConnectionManager] HttpConnectionManager.getConnection:  config = HostConfiguration[host=http://sasv00t2.saipem.pri:9191], timeout = 30000
> 19:21:48,107 DEBUG [MultiThreadedHttpConnectionManager] enter HttpConnectionManager.ConnectionPool.getHostPool(HostConfiguration)
> 19:21:48,109 DEBUG [MultiThreadedHttpConnectionManager] enter HttpConnectionManager.ConnectionPool.getHostPool(HostConfiguration)
> 19:21:48,109 DEBUG [MultiThreadedHttpConnectionManager] Allocating new connection, hostConfig=HostConfiguration[host=http://sasv00t2.saipem.pri:9191]
> 19:21:48,119 DEBUG [HttpMethodDirector] Preemptively sending default basic credentials
> 19:21:48,131 DEBUG [HttpMethodDirector] Authenticating with BASIC <any realm>@sasv00t2.saipem.pri:9191
> 19:21:48,131 DEBUG [HttpState] enter HttpState.getCredentials(AuthScope)
> 19:21:48,131 DEBUG [BasicScheme] enter BasicScheme.authenticate(Credentials, HttpMethod)
> 19:21:48,132 DEBUG [HttpMethodParams] Credential charset not configured, using HTTP element charset
> 19:21:48,132 DEBUG [BasicScheme] enter BasicScheme.authenticate(UsernamePasswordCredentials, String)
> 19:21:48,139 DEBUG [HttpMethodBase] HttpMethodBase.addRequestHeader(Header)
> 19:21:48,139 DEBUG [HttpMethodDirector] Attempt number 1 to process request
> 19:21:48,139 DEBUG [HttpConnection] enter HttpConnection.open()
> 19:21:48,139 DEBUG [HttpConnection] Open connection to sasv00t2.saipem.pri:9191
> 19:21:48,152 DEBUG [HttpMethodBase] enter HttpMethodBase.execute(HttpState, HttpConnection)
> 19:21:48,152 DEBUG [HttpMethodBase] enter HttpMethodBase.writeRequest(HttpState, HttpConnection)
> 19:21:48,152 DEBUG [HttpMethodBase] enter HttpMethodBase.writeRequestLine(HttpState, HttpConnection)
> 19:21:48,152 DEBUG [HttpMethodBase] enter HttpMethodBase.generateRequestLine(HttpConnection, String, String, String, String)
> 19:21:48,153 DEBUG [header] >> "POST /sidac HTTP/1.1[\r][\n]"
> 19:21:48,154 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,154 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,162 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,162 DEBUG [HttpMethodBase] enter HttpMethodBase.writeRequestHeaders(HttpState,HttpConnection)
> 19:21:48,162 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.addRequestHeaders(HttpState, HttpConnection)
> 19:21:48,162 DEBUG [ExpectContinueMethod] enter ExpectContinueMethod.addRequestHeaders(HttpState, HttpConnection)
> 19:21:48,162 DEBUG [HttpMethodBase] enter HttpMethodBase.addRequestHeaders(HttpState, HttpConnection)
> 19:21:48,163 DEBUG [HttpMethodBase] enter HttpMethodBase.addUserAgentRequestHeaders(HttpState, HttpConnection)
> 19:21:48,163 DEBUG [HttpMethodBase] enter HttpMethodBase.addHostRequestHeader(HttpState, HttpConnection)
> 19:21:48,163 DEBUG [HttpMethodBase] Adding Host request header
> 19:21:48,163 DEBUG [HttpMethodBase] enter HttpMethodBase.addCookieRequestHeader(HttpState, HttpConnection)
> 19:21:48,185 DEBUG [HttpState] enter HttpState.getCookies()
> 19:21:48,185 DEBUG [CookieSpec] enter CookieSpecBase.match(String, int, String, boolean, Cookie[])
> 19:21:48,185 DEBUG [HttpMethodBase] enter HttpMethodBase.addProxyConnectionHeader(HttpState, HttpConnection)
> 19:21:48,185 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.addContentLengthRequestHeader(HttpState, HttpConnection)
> 19:21:48,185 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.getRequestContentLength()
> 19:21:48,185 DEBUG [PostMethod] enter PostMethod.hasRequestContent()
> 19:21:48,185 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.hasRequestContent()
> 19:21:48,186 DEBUG [HttpMethodBase] HttpMethodBase.addRequestHeader(Header)
> 19:21:48,186 DEBUG [header] >> "Content-Type: text/xml; charset=UTF-8[\r][\n]"
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,186 DEBUG [header] >> "SOAPAction: "http://bexppage_ws.ws.localhost/bexppage_wsWS/bexppage_ws_Run"[\r][\n]"
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,186 DEBUG [header] >> "User-Agent: Axis2[\r][\n]"
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,186 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,186 DEBUG [header] >> "Authorization: Basic U0FDTzQ3Mjg6U2FpcGVtMTIz[\r][\n]"
> 19:21:48,187 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,187 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,187 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,187 DEBUG [header] >> "Host: sasv00t2.saipem.pri:9191[\r][\n]"
> 19:21:48,187 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,187 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,187 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,188 DEBUG [header] >> "Transfer-Encoding: chunked[\r][\n]"
> 19:21:48,188 DEBUG [HttpConnection] enter HttpConnection.print(String)
> 19:21:48,188 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,188 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,188 DEBUG [HttpConnection] enter HttpConnection.writeLine()
> 19:21:48,188 DEBUG [HttpConnection] enter HttpConnection.write(byte[])
> 19:21:48,188 DEBUG [HttpConnection] enter HttpConnection.write(byte[], int, int)
> 19:21:48,188 DEBUG [header] >> "[\r][\n]"
> 19:21:48,188 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.writeRequestBody(HttpState, HttpConnection)
> 19:21:48,188 DEBUG [PostMethod] enter PostMethod.hasRequestContent()
> 19:21:48,188 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.hasRequestContent()
> 19:21:48,188 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.getRequestContentLength()
> 19:21:48,188 DEBUG [PostMethod] enter PostMethod.hasRequestContent()
> 19:21:48,188 DEBUG [EntityEnclosingMethod] enter EntityEnclosingMethod.hasRequestContent()
> 19:21:48,189 DEBUG [HttpConnection] enter HttpConnection.getRequestOutputStream()
> 19:21:48,190 DEBUG [SOAPMessageFormatter] start writeTo()
> 19:21:48,190 DEBUG [SOAPMessageFormatter]   preserve=false
> 19:21:48,190 DEBUG [SOAPMessageFormatter]   isOptimized=false
> 19:21:48,190 DEBUG [SOAPMessageFormatter]   isDoingSWA=false
> 19:21:48,190 DEBUG [Utils] MTOM optimized Threshold value =0
> 19:21:48,193 DEBUG [MTOMXMLStreamWriter] OutputStream =class org.apache.commons.httpclient.ChunkedOutputStream
> 19:21:48,193 DEBUG [MTOMXMLStreamWriter] OMFormat = OMOutputFormat [ mimeBoundary =null rootContentId=null doOptimize=false doingSWA=false isSOAP11=true charSetEncoding=UTF-8 xmlVersion=null contentType=text/xml ignoreXmlDeclaration=false autoCloseWriter=false actionProperty=null optimizedThreshold=0]
> 19:21:48,198 DEBUG [MTOMXMLStreamWriter] Call Stack =DEBUG_FRAME = org.apache.axiom.om.util.CommonUtils.callStackToString(CommonUtils.java:80)
> 	DEBUG_FRAME = org.apache.axiom.om.impl.MTOMXMLStreamWriter.<init>(MTOMXMLStreamWriter.java:94)
> 	DEBUG_FRAME = org.apache.axiom.om.impl.llom.OMNodeImpl.serializeAndConsume(OMNodeImpl.java:485)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.SOAPMessageFormatter.writeTo(SOAPMessageFormatter.java:79)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.AxisRequestEntity.writeRequest(AxisRequestEntity.java:84)
> 	DEBUG_FRAME = org.apache.commons.httpclient.methods.EntityEnclosingMethod.writeRequestBody(EntityEnclosingMethod.java:499)
> 	DEBUG_FRAME = org.apache.commons.httpclient.HttpMethodBase.writeRequest(HttpMethodBase.java:2114)
> 	DEBUG_FRAME = org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1096)
> 	DEBUG_FRAME = org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398)
> 	DEBUG_FRAME = org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)
> 	DEBUG_FRAME = org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)
> 	DEBUG_FRAME = org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:346)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.AbstractHTTPSender.executeMethod(AbstractHTTPSender.java:542)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:199)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:76)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:400)
> 	DEBUG_FRAME = org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:225)
> 	DEBUG_FRAME = org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:435)
> 	DEBUG_FRAME = org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:402)
> 	DEBUG_FRAME = org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:229)
> 	DEBUG_FRAME = org.apache.axis2.client.OperationClient.execute(OperationClient.java:165)
> 	DEBUG_FRAME = com.eni.icteam.page.corporate.ws.sidac.Bexppage_wsWSServiceStub.bexppage_ws_Run(Bexppage_wsWSServiceStub.java:181)
> 	DEBUG_FRAME = com.eni.icteam.page.corporate.sidac.driver.SidacDriver.getDatiSidac(SidacDriver.java:60)
> 	DEBUG_FRAME = com.eni.icteam.page.corporate.sidac.driver.SidacDriverTest.testSidac(SidacDriverTest.java:19)
> 	DEBUG_FRAME = sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 	DEBUG_FRAME = sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
> 	DEBUG_FRAME = sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
> 	DEBUG_FRAME = java.lang.reflect.Method.invoke(Method.java:592)
> 	DEBUG_FRAME = org.junit.internal.runners.TestMethod.invoke(TestMethod.java:59)
> 	DEBUG_FRAME = org.junit.internal.runners.MethodRoadie.runTestMethod(MethodRoadie.java:98)
> 	DEBUG_FRAME = org.junit.internal.runners.MethodRoadie$2.run(MethodRoadie.java:79)
> 	DEBUG_FRAME = org.junit.internal.runners.MethodRoadie.runBeforesThenTestThenAfters(MethodRoadie.java:87)
> 	DEBUG_FRAME = org.junit.internal.runners.MethodRoadie.runTest(MethodRoadie.java:77)
> 	DEBUG_FRAME = org.junit.internal.runners.MethodRoadie.run(MethodRoadie.java:42)
> 	DEBUG_FRAME = org.junit.internal.runners.JUnit4ClassRunner.invokeTestMethod(JUnit4ClassRunner.java:88)
> 	DEBUG_FRAME = org.junit.internal.runners.JUnit4ClassRunner.runMethods(JUnit4ClassRunner.java:51)
> 	DEBUG_FRAME = org.junit.internal.runners.JUnit4ClassRunner$1.run(JUnit4ClassRunner.java:44)
> 	DEBUG_FRAME = org.junit.internal.runners.ClassRoadie.runUnprotected(ClassRoadie.java:27)
> 	DEBUG_FRAME = org.junit.internal.runners.ClassRoadie.runProtected(ClassRoadie.java:37)
> 	DEBUG_FRAME = org.junit.internal.runners.JUnit4ClassRunner.run(JUnit4ClassRunner.java:42)
> 	DEBUG_FRAME = org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:62)
> 	DEBUG_FRAME = org.apache.maven.surefire.suite.AbstractDirectoryTestSuite.executeTestSet(AbstractDirectoryTestSuite.java:140)
> 	DEBUG_FRAME = org.apache.maven.surefire.suite.AbstractDirectoryTestSuite.execute(AbstractDirectoryTestSuite.java:127)
> 	DEBUG_FRAME = org.apache.maven.surefire.Surefire.run(Surefire.java:177)
> 	DEBUG_FRAME = sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> 	DEBUG_FRAME = sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
> 	DEBUG_FRAME = sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
> 	DEBUG_FRAME = java.lang.reflect.Method.invoke(Method.java:592)
> 	DEBUG_FRAME = org.apache.maven.surefire.booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:345)
> 	DEBUG_FRAME = org.apache.maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:1009)
> 19:21:48,198 DEBUG [StAXUtils] About to create XMLOutputFactory implementation with classloader=sun.misc.Launcher$AppClassLoader@92e78c
> 19:21:48,200 DEBUG [StAXUtils] The classloader for javax.xml.stream.XMLOutputFactory is: sun.misc.Launcher$AppClassLoader@92e78c
> 19:21:48,229 DEBUG [StAXUtils] Created XMLOutputFactory = class com.ctc.wstx.stax.WstxOutputFactory for classloader=sun.misc.Launcher$AppClassLoader@92e78c
> 19:21:48,229 DEBUG [StAXUtils] Size of XMLOutputFactory map =1
> 19:21:48,248 DEBUG [StAXUtils] XMLStreamWriter is com.ctc.wstx.sw.SimpleNsStreamWriter
> 19:21:48,255 DEBUG [OMSourcedElementImpl] serialize {http://bexppage_ws.ws.localhost/}bexppage_ws_Run to XMLStreamWriter
> 19:21:48,282 DEBUG [MTOMXMLStreamWriter] Calling MTOMXMLStreamWriter.flush
> 19:21:48,283 DEBUG [MTOMXMLStreamWriter] Calling MTOMXMLStreamWriter.flush
> 19:21:48,283 DEBUG [SOAPMessageFormatter] end writeTo()
> 19:21:48,284 DEBUG [content] >> "244[\r][\n]"
> 19:21:48,284 DEBUG [content] >> "<?xml version='1.0' encoding='UTF-8'?><soapenv:Envelope xmlns:soapenv="http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><ns1:bexppage_ws_Run xmlns:ns1="http://bexppage_ws.ws.localhost/"><ns1:m_UserName>SIDAC WEBSERVICE</ns1:m_UserName><ns1:m_Password>Sidac_009100</ns1:m_Password><ns1:p_user>9100.0</ns1:p_user><ns1:p_ws_call>Y</ns1:p_ws_call><ns1:p_sdate>01/01/2010</ns1:p_sdate><ns1:p_edate>18/03/2010</ns1:p_edate><ns1:p_ssite>001492</ns1:p_ssite><ns1:p_esite>001492</ns1:p_esite><ns1:p_nomefile></ns1:p_nomefile></ns1:bexppage_ws_Run></soapenv:Body></soapenv:Envelope>"
> 19:21:48,284 DEBUG [content] >> "[\r][\n]"
> 19:21:48,284 DEBUG [content] >> "0"
> 19:21:48,284 DEBUG [content] >> "[\r][\n]"
> 19:21:48,284 DEBUG [content] >> "[\r][\n]"
> 19:21:48,285 DEBUG [EntityEnclosingMethod] Request body sent
> 19:21:48,285 DEBUG [HttpConnection] enter HttpConnection.flushRequestOutputStream()
> 19:21:48,285 DEBUG [HttpMethodBase] enter HttpMethodBase.readResponse(HttpState, HttpConnection)
> 19:21:48,286 DEBUG [HttpMethodBase] enter HttpMethodBase.readStatusLine(HttpState, HttpConnection)
> 19:21:48,286 DEBUG [HttpConnection] enter HttpConnection.readLine()
> 19:21:48,288 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,288 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,324 DEBUG [header] << "HTTP/1.1 100 Continue[\r][\n]"
> 19:21:48,324 DEBUG [header] << "HTTP/1.1 100 Continue[\r][\n]"
> 19:21:48,327 DEBUG [HttpMethodBase] enter HttpMethodBase.readResponseHeaders(HttpState,HttpConnection)
> 19:21:48,328 DEBUG [HttpConnection] enter HttpConnection.getResponseInputStream()
> 19:21:48,328 DEBUG [HttpParser] enter HeaderParser.parseHeaders(InputStream, String)
> 19:21:48,328 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,328 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,328 DEBUG [header] << "[\r][\n]"
> 19:21:48,328 DEBUG [HttpMethodBase] enter HttpMethodBase.processResponseHeaders(HttpState, HttpConnection)
> 19:21:48,328 DEBUG [HttpMethodBase] enter HttpMethodBase.processCookieHeaders(Header[], HttpState, HttpConnection)
> 19:21:48,328 INFO  [HttpMethodBase] Discarding unexpected response: HTTP/1.1 100 Continue
> 19:21:48,328 DEBUG [HttpMethodBase] enter HttpMethodBase.readStatusLine(HttpState, HttpConnection)
> 19:21:48,328 DEBUG [HttpConnection] enter HttpConnection.readLine()
> 19:21:48,328 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,328 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,375 DEBUG [header] << "HTTP/1.1 200 OK[\r][\n]"
> 19:21:48,375 DEBUG [header] << "HTTP/1.1 200 OK[\r][\n]"
> 19:21:48,375 DEBUG [HttpMethodBase] enter HttpMethodBase.readResponseHeaders(HttpState,HttpConnection)
> 19:21:48,375 DEBUG [HttpConnection] enter HttpConnection.getResponseInputStream()
> 19:21:48,375 DEBUG [HttpParser] enter HeaderParser.parseHeaders(InputStream, String)
> 19:21:48,375 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,375 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,375 DEBUG [header] << "Server: Microsoft-IIS[\r][\n]"
> 19:21:48,375 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,375 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,375 DEBUG [header] << "Date: Thu, 22 Apr 2010 17:21:48 GMT[\r][\n]"
> 19:21:48,375 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,375 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,376 DEBUG [header] << "Cache-Control: no-store[\r][\n]"
> 19:21:48,376 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,376 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,376 DEBUG [header] << "Content-type: text/html[\r][\n]"
> 19:21:48,376 DEBUG [HttpParser] enter HttpParser.readLine(InputStream, String)
> 19:21:48,376 DEBUG [HttpParser] enter HttpParser.readRawLine()
> 19:21:48,376 DEBUG [header] << "[\r][\n]"
> 19:21:48,376 DEBUG [HttpMethodBase] enter HttpMethodBase.processResponseHeaders(HttpState, HttpConnection)
> 19:21:48,376 DEBUG [HttpMethodBase] enter HttpMethodBase.processCookieHeaders(Header[], HttpState, HttpConnection)
> 19:21:48,377 DEBUG [HttpMethodBase] enter HttpMethodBase.readResponseBody(HttpState, HttpConnection)
> 19:21:48,377 DEBUG [HttpMethodBase] enter HttpMethodBase.readResponseBody(HttpConnection)
> 19:21:48,377 DEBUG [HttpConnection] enter HttpConnection.getResponseInputStream()
> 19:21:48,377 DEBUG [HttpMethodBase] enter HttpMethodBase.canResponseHaveBody(int)
> 19:21:48,377 INFO  [HttpMethodBase] Response content length is not known
> 19:21:48,377 DEBUG [HttpMethodBase] Force-close connection: true
> 19:21:48,379 DEBUG [HTTPSender] Handling response - 200
> 19:21:48,382 DEBUG [HeaderElement] enter HeaderElement.parseElements(String)
> 19:21:48,382 DEBUG [HeaderElement] enter HeaderElement.parseElements(char[])
> 19:21:48,383 DEBUG [HeaderElement] enter HeaderElement.getParameterByName(String)
> 19:21:48,384 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking flowComplete() in Phase "Security"
> 19:21:48,384 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking flowComplete() in Phase "MessageOut"
> 19:21:48,384 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking flowComplete() in Phase "PolicyDetermination"
> 19:21:48,384 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking flowComplete() in Phase "RMPhase"
> 19:21:48,384 DEBUG [Phase] [MessageContext: logID=urn:uuid:C97B59FBD82B4E4DFB1271956907949] Invoking flowComplete() in Phase "OperationOutPhase"
> 19:21:48,390 DEBUG [BuilderUtil] Input contentType (text/html)
> 19:21:48,390 DEBUG [BuilderUtil] CharSetEncoding defaulted (UTF-8)
> 19:21:48,391 DEBUG [TransportUtils] Could not find a Builder for type (text/html).  Using SOAP.
> 19:21:48,396 DEBUG [content] << "<HTML><HEAD><TITLE></TITLE></HEAD><BODY onLoad="document.AUTOSUBMIT.submit();">This page is used to hold your data while you are being authorized for your request.<BR><BR>You will be forwarded to continue the authorization process. If this does not happen automatically, please click the Continue button below.<FORM NAME="AUTOSUBMIT" METHOD="POST" ACTION="http://testntlm.saipem.pri/siteminderagent/ntlm/creds.ntc?CHALLENGE=&SMAGENTNAME=sasv00t2&TARGET=-SM-http%3a%2f%2fsasv00t2%2esaipem%2epri%3a9191%2fsidac"><INPUT TYPE="HIDDEN" NAME="SMPostPreserve" VALUE="XUSQNC2jAdT1iplAB5vVjmWw/68sVdeqwjAV1zfu53l1gJcTwoZXPx4DC3Wyx5By6kLrGiHKeA08CzE3Bi7052YHlHlnFX2Aa183XfRYsSdMxu7J9wO/BtQbaY1lMeSKP+31QFD+jH/97butiDhhGaxWXsO56EgecNKmXY4zAItbdmk8wDJOTabzFWi1JtCJCWMwwW/9J9NI1H4vXfi2Zq3EYlHvpgiEnV0hrlrvUoifJQuPU21YZ3MLZ01v4qTgloFvkN2PYUjIQNgJXe7ORKcsSbYwindCT1qiW8eK0zmKybwrU7kOZeXHDX8edA7gMpRixJU0k/to/yHdL6x/Nhyq5Unofpb2rMsLqnKzMKnnt4spuNpGYguMBdKjIBFvsd4vOeaGIpjBhWAoSnEJ6fw9f5MTCZC3pmLqG1/Xg30mD0SiF0I2VtgpYrPLr41lCyMGa5F3HaMVqvyxG1EBwLnYh0kHHQLS82J4X25sOS3KXjyrfCVI1IfNEEwhi0Vl0ikhzuv3hQjoIQjYPgiWXLmUI4xbxU4kFPBmRg61vZYIxxaulU6sEeLwA1MJ9pN4mr9tzb7T6WtKYuy0DDFkwuwqzbscSX7nabh/NeCMIOUlpUiSKiNbr1oJ4YhWIuSxZl9o2m7YndvvGOioGYSwzskSlstrxW3nx2FWwsXh/0Zo/cE+imHHut6u9GG8Ug1E+YDPHCihlgAKhS+7b97U6FZkdhQ9PnuAAHQoJFyRnXcQioF4gZQwFJMF6sCyOQ2F3r3ejpv9Sw0oxLtWHw+WqWVfI/B6NzcgT0EMfuFRfz2CcoB6JrGcMNNokJTIw69z"><INPUT TYPE="SUBMIT" VALUE="Continue"></FORM></BODY></HTML>[\r][\n]"
> 19:21:48,396 DEBUG [content] << "[\r][\n]"
> 19:21:48,396 DEBUG [StAXUtils] XMLStreamReader is com.ctc.wstx.sr.ValidatingStreamReader
> 19:21:48,401 DEBUG [StAXOMBuilder] START_ELEMENT: 
> 19:21:48,401 DEBUG [StAXOMBuilder]   QName: HTML
> 19:21:48,401 INFO  [BuilderUtil] OMException in getSOAPBuilder
> org.apache.axiom.soap.SOAPProcessingException: First Element must contain the local name, Envelope , but found HTML
> 	at org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder.constructNode(StAXSOAPModelBuilder.java:267)
> I get i strange message from the server in response to the ws call that goes ok
> "This page is used to hold your data while you are being authorized for your request."
> My problem is that while i ask for NTLM i get a BASIC authentication if you look inside the logs

-- 
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.


---------------------------------------------------------------------
To unsubscribe, e-mail: java-dev-unsubscribe@axis.apache.org
For additional commands, e-mail: java-dev-help@axis.apache.org