Uploaded image for project: 'Axis2'
  1. Axis2
  2. AXIS2-4693

NTLM preemprt authenticate with BASIC

    XMLWordPrintableJSON

Details

    • Bug
    • Status: Open
    • Major
    • Resolution: Unresolved
    • 1.5.1
    • None
    • client-api, transports
    • None
    • Windows 7
      java jdk 1.5.0.22

    Description

      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_user>9100.0</ns1_user><ns1_ws_call>Y</ns1_ws_call><ns1_sdate>01/01/2010</ns1_sdate><ns1_edate>18/03/2010</ns1_edate><ns1_ssite>001492</ns1_ssite><ns1_esite>001492</ns1_esite><ns1_nomefile></ns1_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

      Attachments

        Activity

          People

            Unassigned Unassigned
            stefano.ghezzi@icteam.it Stefano Ghezzi
            Votes:
            0 Vote for this issue
            Watchers:
            0 Start watching this issue

            Dates

              Created:
              Updated: