You are viewing a plain text version of this content. The canonical link for it is here.
Posted to java-user@axis.apache.org by Ateeq Mirza <at...@gmail.com> on 2011/12/05 05:13:34 UTC
Rampart is not able to sign and encrypt the request
Hi all,
For past few days, I'm trying to implement the Rampart client for one
WS-Secure Web Service , yet so far I'm unsuccessful. I've tested this web
service using soapui and it works fine. Rampart neither signs nor encrypts,
but just sends the plain xml which results in the error.
I've followed these steps
1) I've patched the JRE with Java Cryptography Extension (JCE) Unlimited
Strength Jurisdiction Policy Files.
2)Used BouncyCastle, and configured java.security file to include it as one
of the security providers.
3) Programmatically created RampartConfig object as shown here
http://blog.thilinamb.com/2009/12/how-to-build-rampart-config.html
4)Copied all jars from <RAMPART_HOME>/lib to <AXIS2_HOME>/lib (I'm running
a JUNIT testcase, all these jars are included in the classpath)
Environment Setup
*AXIS2.1.4*
*Rampart 1.4.1*
Policy File
*<?xml version="1.0"?>*
*<wsp:Policy*
* xmlns:wsp="http://schemas.xmlsoap.org/ws/2004/09/policy"*
* xmlns:sp="http://docs.oasis-open.org/ws-sx/ws-securitypolicy/200512"*
* >*
* <wsp:ExactlyOne>*
* <wsp:All>*
* <sp:AsymmetricBinding>*
* <wsp:Policy>*
* <sp:InitiatorSignatureToken>*
* <wsp:Policy>*
* <sp:X509Token*
* sp:IncludeToken="
http://docs.oasis-open.org/ws-sx/ws-securitypolicy/200512/IncludeToken/AlwaysToRecipient
">*
* <wsp:Policy>*
* <sp:WssX509V3Token11/>*
* </wsp:Policy>*
* </sp:X509Token>*
* </wsp:Policy>*
* </sp:InitiatorSignatureToken>*
* <sp:RecipientEncryptionToken>*
* <wsp:Policy>*
* <sp:X509Token*
* sp:IncludeToken="
http://docs.oasis-open.org/ws-sx/ws-securitypolicy/200512/IncludeToken/Never
">*
* <wsp:Policy>*
* <sp:WssX509V3Token11/>*
* </wsp:Policy>*
* </sp:X509Token>*
* </wsp:Policy>*
* </sp:RecipientEncryptionToken>*
* <sp:AlgorithmSuite>*
* <wsp:Policy>*
* <sp:Basic256/>*
* </wsp:Policy>*
* </sp:AlgorithmSuite>*
* <sp:Layout>*
* <wsp:Policy>*
* <sp:Lax/>*
* </wsp:Policy>*
* </sp:Layout>*
* <sp:IncludeTimestamp/>*
* <sp:ProtectTokens/>*
* <sp:OnlySignEntireHeadersAndBody/>*
* </wsp:Policy>*
* </sp:AsymmetricBinding>*
* <sp:Wss11>*
* <wsp:Policy>*
* <sp:MustSupportRefKeyIdentifier/>*
* <sp:MustSupportRefIssuerSerial/>*
* <sp:MustSupportRefThumbprint/>*
* <sp:MustSupportRefEncryptedKey/>*
* <sp:RequireSignatureConfirmation/>*
* </wsp:Policy>*
* </sp:Wss11> *
* </wsp:All>*
* </wsp:ExactlyOne>*
*</wsp:Policy>*
Client Code
*public static void testWSSClient() throws Exception {*
* *
* ConfigurationContext configurationContext=ConfigurationContextFactory*
* .createConfigurationContextFromFileSystem(<PATH_TO_REPOSITORY>,
<PATH_AXIS2_XML>);*
*
*
* *
* SomeStub secureStub = new*
* SomeStub(configurationContext,config.getProperty(WSDL_URL));*
* *
* ServiceClient client =secureStub._getServiceClient();*
* *
* Policy policy=getRampartConfig();*
* client.getOptions().setProperty(RampartMessageData.KEY_RAMPART_POLICY,
policy);*
* *
* client.engageModule("rampart"); *
* *
* *
* *
* LoadCPSResponseE response=secureStub.loadXXX(SomeData);*
* *
* //OMElement response =
client.sendReceive(getPayload("987FF876543FFAADDCCAAFFF"));*
* System.out.println( "The Response is "+response.getXXXResponse());*
* *
* }*
*
*
*private static Policy getRampartConfig() throws Exception {*
* *
* RampartConfig rampartConfig = new RampartConfig();*
* rampartConfig.setUser(config.getProperty("keystorealias"));*
* rampartConfig.setEncryptionUser(config.getProperty("keystorealias"));*
* rampartConfig.setUserCertAlias(config.getProperty("keystorealias")); *
* rampartConfig.setPwCbClass("com.connectoradminws.client.PWCBHandler");*
* *
* CryptoConfig sigCrypto = new CryptoConfig();*
* *
* sigCrypto.setProvider("org.apache.ws.security.components.crypto.Merlin");*
* *
* Properties props = new Properties();*
* props.setProperty("org.apache.ws.security.crypto.merlin.keystore.type", *
* config.getProperty("keystoretype"));*
* props.setProperty("org.apache.ws.security.crypto.merlin.file",*
* config.getProperty("clientkeystore"));*
* props.setProperty("org.apache.ws.security.crypto.merlin.keystore.password",
*
* config.getProperty("keystorepass"));*
* *
* sigCrypto.setProp(props);*
* *
* rampartConfig.setSigCryptoConfig(sigCrypto);*
* rampartConfig.setEncrCryptoConfig(sigCrypto);*
* *
* rampartConfig.setTimestampTTL("300");*
* *
* Policy policy = loadPolicy(
Thread.currentThread().getContextClassLoader().getResource("policy.xml").getFile());
*
*
*
* policy.addAssertion(rampartConfig);*
* *
* return policy; *
* *
* }*
Error:-
*- No services directory was found under D:\client-repo.*
*- Deploying module: addressing-1.41 -
file:/D:/client-repo/modules/addressing-1.41.mar*
*- Deploying module: metadataExchange-1.41 -
file:/D:/client-repo/modules/mex-1.41.mar*
*- Deploying module: rahas - file:/D:/client-repo/modules/rahas.mar*
*- Deploying module: rampart - file:/D:/client-repo/modules/rampart.mar*
*- Deploying module: metadataExchange - file:/C:/axis2/lib/mex-1.4.1.jar*
*Exception in thread "main" org.apache.axis2.AxisFault: No id attribute on
element http://schemas.xmlsoap.org/soap/envelope/:Body*
* at
org.apache.axis2.util.Utils.getInboundFaultFromMessageContext(Utils.java:512)
*
* at
org.apache.axis2.description.OutInAxisOperationClient.handleResponse(OutInAxisOperation.java:370)
*
* at
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:416)
*
* at
org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
*
Logs:-
*{http://docs.oasis-open.org/ws-sx/ws-securitypolicy/200512}Wss11 type
assertions>*
*2011-12-05 10:32:53,980 DEBUG
[org.apache.axis2.description.AxisDescription] - <can't find any module to
process {
http://docs.oasis-open.org/ws-sx/ws-securitypolicy/200512}AsymmetricBinding
type
assertions>*
*2011-12-05 10:32:53,980 DEBUG
[org.apache.axis2.description.AxisDescription] - <can't find any module to
process {http://docs.oasis-open.org/ws-sx/ws-securitypolicy/200512}Wss11 type
assertions>*
*2011-12-05 10:32:53,980 DEBUG [org.apache.axiom.om.util.StAXUtils] -
<XMLStreamReader is com.ctc.wstx.sr.ValidatingStreamReader>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] -
<==================>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] - <
Property set on object org.apache.axis2.client.Options@ca0115>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] - < Key
=rampartPolicy>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] - < Value
Class = org.apache.neethi.Policy>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] - < Value
Classloader = sun.misc.Launcher$AppClassLoader@11b86e7>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] - <Call
Stack = DEBUG_FRAME =
org.apache.axis2.util.JavaUtils.callStackToString(JavaUtils.java:564)*
* DEBUG_FRAME =
org.apache.axis2.client.Options.debugPropertySet(Options.java:1665)*
* DEBUG_FRAME =
org.apache.axis2.client.Options.setProperty(Options.java:867)*
* DEBUG_FRAME =
com.gemalto.ggs.ida.connectortsmadminws.client.TSMConnectorClient.testWSSClient(TSMConnectorClient.java:59)
*
* DEBUG_FRAME =
com.gemalto.ggs.ida.connectortsmadminws.client.TSMConnectorClient.main(TSMConnectorClient.java:44)
*
*>*
*2011-12-05 10:32:53,995 DEBUG [org.apache.axis2.client.Options] -
<==================>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.description.AxisService] -
<Get operation for {
http://services.connector.backend.tsm.gemalto.com/}loadCPS>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.description.AxisService] -
<Found axis operation:
org.apache.axis2.description.OutInAxisOperation@10a2d64>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
<==================>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
< Property set on object org.apache.axis2.context.ServiceContext@14c194d>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
< Key =rampartPolicy>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
< Value Class = org.apache.neethi.Policy>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
< Value Classloader = sun.misc.Launcher$AppClassLoader@11b86e7>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
<Call Stack = DEBUG_FRAME =
org.apache.axis2.util.JavaUtils.callStackToString(JavaUtils.java:564)*
* DEBUG_FRAME =
org.apache.axis2.context.AbstractContext.debugPropertySet(AbstractContext.java:416)
*
* DEBUG_FRAME =
org.apache.axis2.context.AbstractContext.setProperty(AbstractContext.java:182)
*
* DEBUG_FRAME =
org.apache.axis2.client.ServiceClient.createClient(ServiceClient.java:668)*
* DEBUG_FRAME =
com.gemalto.tsm.backend.connector.services.ConnectorTSMAdminWSServiceStub.loadCPS(ConnectorTSMAdminWSServiceStub.java:35419)
*
* DEBUG_FRAME =
com.gemalto.ggs.ida.connectortsmadminws.client.TSMConnectorClient.testWSSClient(TSMConnectorClient.java:68)
*
* DEBUG_FRAME =
com.gemalto.ggs.ida.connectortsmadminws.client.TSMConnectorClient.main(TSMConnectorClient.java:44)
*
*>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.context.AbstractContext] -
<==================>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] -
<==================>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] - <
Property set on object org.apache.axis2.client.Options@1112783>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] - < Key
=whttp:queryParameterSeparator>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] - < Value
=&>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] - < Value
Class = java.lang.String>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] - < Value
Classloader = null>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] - <Call
Stack = DEBUG_FRAME =
org.apache.axis2.util.JavaUtils.callStackToString(JavaUtils.java:564)*
* DEBUG_FRAME =
org.apache.axis2.client.Options.debugPropertySet(Options.java:1665)*
* DEBUG_FRAME =
org.apache.axis2.client.Options.setProperty(Options.java:867)*
* DEBUG_FRAME =
org.apache.axis2.client.Stub.addPropertyToOperationClient(Stub.java:180)*
* DEBUG_FRAME =
com.gemalto.tsm.backend.connector.services.ConnectorTSMAdminWSServiceStub.loadCPS(ConnectorTSMAdminWSServiceStub.java:35425)
*
*
*
*>*
*2011-12-05 10:32:54,011 DEBUG [org.apache.axis2.client.Options] -
<==================>*
*2011-12-05 10:32:54,042 DEBUG
[org.apache.axis2.context.ConfigurationContext] - <registerOperationContext
(false): org.apache.axis2.context.OperationContext@7bb290 with key:
urn:uuid:E8AB1360E56F4196E81323052374439>*
*2011-12-05 10:32:54,042 DEBUG
[org.apache.axis2.description.OutInAxisOperationClient] - <Entry:
OutInAxisOperationClient::execute, true>*
*2011-12-05 10:32:54,042 DEBUG
[org.apache.axis2.description.OutInAxisOperationClient] -
<OutInAxisOperationClient: useAsyncOption null>*
*2011-12-05 10:32:54,042 DEBUG
[org.apache.axis2.context.ConfigurationContext] - <registerOperationContext
(false): org.apache.axis2.context.OperationContext@7bb290 with key:
urn:uuid:E8AB1360E56F4196E81323052374439>*
*2011-12-05 10:32:54,042 DEBUG
[org.apache.axis2.context.ConfigurationContext] - <msgContext:
[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] action: "">
*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
pre-condition for Phase "soapmonitorPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
phase "soapmonitorPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
post-conditions for phase "soapmonitorPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
pre-condition for Phase "OperationOutPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
phase "OperationOutPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
post-conditions for phase "OperationOutPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
pre-condition for Phase "RMPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
phase "RMPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
post-conditions for phase "RMPhase">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
pre-condition for Phase "PolicyDetermination">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
phase "PolicyDetermination">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
post-conditions for phase "PolicyDetermination">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
pre-condition for Phase "Security">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
phase "Security">*
*2011-12-05 10:32:54,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
Handler 'SecurityOutHandler' in Phase 'Security'>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.rampart.handler.WSDoAllSender] -
<WSDoAllSender: enter invoke()>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
<==================>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
< Property set on object org.apache.axis2.context.MessageContext@1e59128>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
< Key =RECV_RESULTS>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
< Value Class = null>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
< Value Classloader = null>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
<Call Stack = DEBUG_FRAME =
org.apache.axis2.util.JavaUtils.callStackToString(JavaUtils.java:564)*
* DEBUG_FRAME =
org.apache.axis2.context.AbstractContext.debugPropertySet(AbstractContext.java:416)
*
* DEBUG_FRAME =
org.apache.axis2.context.AbstractContext.setProperty(AbstractContext.java:182)
*
* DEBUG_FRAME =
org.apache.rampart.handler.WSDoAllSender.processBasic(WSDoAllSender.java:111)
*
* DEBUG_FRAME =
org.apache.rampart.handler.WSDoAllSender.processMessage(WSDoAllSender.java:64)
*
* DEBUG_FRAME =
org.apache.rampart.handler.WSDoAllHandler.invoke(WSDoAllHandler.java:72)*
* DEBUG_FRAME = org.apache.axis2.engine.Phase.invoke(Phase.java:317)*
* DEBUG_FRAME =
org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)*
* DEBUG_FRAME = org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:429)
*
* DEBUG_FRAME =
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:401)
*
* DEBUG_FRAME =
org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
*
* DEBUG_FRAME =
org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)*
* DEBUG_FRAME =
com.gemalto.tsm.backend.connector.services.ConnectorTSMAdminWSServiceStub.loadCPS(ConnectorTSMAdminWSServiceStub.java:35451)
*
* DEBUG_FRAME =
com.gemalto.ggs.ida.connectortsmadminws.client.TSMConnectorClient.testWSSClient(TSMConnectorClient.java:68)
*
* DEBUG_FRAME =
com.gemalto.ggs.ida.connectortsmadminws.client.TSMConnectorClient.main(TSMConnectorClient.java:44)
*
*>*
*2011-12-05 10:32:54,058 DEBUG [org.apache.axis2.context.AbstractContext] -
<==================>*
*2011-12-05 10:32:54,074 DEBUG [org.apache.axiom.om.util.StAXUtils] -
<Created XMLOutputFactory = class com.ctc.wstx.stax.WstxOutputFactory for
classloader=sun.misc.Launcher$AppClassLoader@11b86e7>*
*2011-12-05 10:32:54,074 DEBUG [org.apache.axiom.om.util.StAXUtils] - <Size
of XMLOutputFactory map =1>*
*2011-12-05 10:32:54,089 DEBUG [org.apache.axiom.om.util.StAXUtils] -
<XMLStreamWriter is com.ctc.wstx.sw.SimpleNsStreamWriter>*
*2011-12-05 10:32:54,089 DEBUG [org.apache.rampart.MESSAGE] -
<*********************** WSDoAllSender sent out *
*<?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Body><ns2:loadCPS
xmlns:ns2="http://services.connector.backend.tsm.gemalto.com/
"><cpsContent>987FF876543FFAADDCCAAFFF</cpsContent></ns2:loadCPS></soapenv:Body></soapenv:Envelope>>
*
*2011-12-05 10:32:54,089 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
Handler 'Apache Rampart outflow handler' in Phase 'Security'>*
*2011-12-05 10:32:54,136 DEBUG
[org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder] - <Build the
OMElelment EnvelopeBy the StaxSOAPModelBuilder>*
*2011-12-05 10:32:54,136 DEBUG
[org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder] - <Build the
OMElelment HeaderBy the StaxSOAPModelBuilder>*
*2011-12-05 10:32:54,136 DEBUG
[org.apache.axiom.om.impl.llom.OMSourcedElementImpl] - <forceExpand:
expanding element {
http://services.connector.backend.tsm.gemalto.com/}loadCPS>*
*2011-12-05 10:32:54,136 DEBUG
[org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder] - <Build the
OMElelment BodyBy the StaxSOAPModelBuilder>*
*2011-12-05 10:32:54,136 DEBUG
[org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder] - <Build the
OMElelment loadCPSBy the StaxSOAPModelBuilder>*
*2011-12-05 10:32:54,136 DEBUG
[org.apache.axiom.soap.impl.builder.StAXSOAPModelBuilder] - <Build the
OMElelment cpsContentBy the StaxSOAPModelBuilder>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - <==================>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - < Parameter add on
object org.apache.axis2.description.ParameterIncludeImpl@ef2c60>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - < Key =CLIENT_SIDE>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - < Value Class = null>
*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - < Value Classloader
= null>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - <Call Stack =
DEBUG_FRAME =
org.apache.axis2.util.JavaUtils.callStackToString(JavaUtils.java:564)*
* DEBUG_FRAME =
org.apache.axis2.description.ParameterIncludeImpl.debugParameterAdd(ParameterIncludeImpl.java:316)
*
* DEBUG_FRAME =
org.apache.axis2.description.ParameterIncludeImpl.addParameter(ParameterIncludeImpl.java:106)
*
* DEBUG_FRAME =
org.apache.axis2.description.AxisDescription.addParameter(AxisDescription.java:104)
*
* DEBUG_FRAME =
org.apache.rampart.RampartMessageData.<init>(RampartMessageData.java:186)*
* DEBUG_FRAME =
org.apache.rampart.MessageBuilder.build(MessageBuilder.java:61)*
* DEBUG_FRAME =
org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)*
* DEBUG_FRAME = org.apache.axis2.engine.Phase.invoke(Phase.java:317)*
* DEBUG_FRAME =
org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:264)*
* DEBUG_FRAME = org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:429)
*
* DEBUG_FRAME =
org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:401)
*
* DEBUG_FRAME =
org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:228)
*
* DEBUG_FRAME =
org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)*
*
*
*>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.axis2.description.ParameterIncludeImpl] - <==================>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.rampart.policy.RampartPolicyBuilder] - <Unknown top level PED
found: org.apache.neethi.builders.xml.XmlPrimtiveAssertion>*
*2011-12-05 10:32:54,152 DEBUG
[org.apache.rampart.policy.RampartPolicyBuilder] - <Unknown top level PED
found: org.apache.neethi.builders.xml.XmlPrimtiveAssertion>*
*2011-12-05 10:32:54,402 DEBUG [org.apache.xml.security.Init] -
<Canonicalizer.register(http://www.w3.org/TR/2001/REC-xml-c14n-20010315,
org.apache.xml.security.c14n.implementations.Canonicalizer20010315OmitComments)>
*
*2011-12-05 10:32:54,402 DEBUG [org.apache.xml.security.Init] -
<Canonicalizer.register(
http://www.w3.org/TR/2001/REC-xml-c14n-20010315#WithComments,
org.apache.xml.security.c14n.implementations.Canonicalizer20010315WithComments)>
*
*2011-12-05 10:32:54,402 DEBUG [org.apache.xml.security.Init] -
<Canonicalizer.register(http://www.w3.org/2001/10/xml-exc-c14n#,
org.apache.xml.security.c14n.implementations.Canonicalizer20010315ExclOmitComments)>
*
*2011-12-05 10:32:54,402 DEBUG [org.apache.xml.security.Init] -
<Canonicalizer.register(http://www.w3.org/2001/10/xml-exc-c14n#WithComments,
org.apache.xml.security.c14n.implementations.Canonicalizer20010315ExclWithComments)>
*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/2000/09/xmldsig#base64,
org.apache.xml.security.transforms.implementations.TransformBase64Decode)>*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/TR/2001/REC-xml-c14n-20010315,
org.apache.xml.security.transforms.implementations.TransformC14N)>*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(
http://www.w3.org/TR/2001/REC-xml-c14n-20010315#WithComments,
org.apache.xml.security.transforms.implementations.TransformC14NWithComments)>
*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/2001/10/xml-exc-c14n#,
org.apache.xml.security.transforms.implementations.TransformC14NExclusive)>*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/2001/10/xml-exc-c14n#WithComments,
org.apache.xml.security.transforms.implementations.TransformC14NExclusiveWithComments)>
*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/TR/1999/REC-xpath-19991116,
org.apache.xml.security.transforms.implementations.TransformXPath)>*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/2000/09/xmldsig#enveloped-signature,
org.apache.xml.security.transforms.implementations.TransformEnvelopedSignature)>
*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/TR/1999/REC-xslt-19991116,
org.apache.xml.security.transforms.implementations.TransformXSLT)>*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/2002/04/xmldsig-filter2,
org.apache.xml.security.transforms.implementations.TransformXPath2Filter)>*
*2011-12-05 10:32:54,417 DEBUG [org.apache.xml.security.Init] -
<Transform.register(http://www.w3.org/2002/06/xmldsig-filter2,
org.apache.xml.security.transforms.implementations.TransformXPath2Filter)>*
*2011-12-05 10:32:54,417 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Init() called>*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(http://www.w3.org/2000/09/xmldsig#dsa-sha1,
org.apache.xml.security.algorithms.implementations.SignatureDSA)>*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2000/09/xmldsig#dsa-sha1
org.apache.xml.security.algorithms.implementations.SignatureDSA>*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(http://www.w3.org/2000/09/xmldsig#rsa-sha1,
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA1)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2000/09/xmldsig#rsa-sha1
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA1>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(http://www.w3.org/2000/09/xmldsig#hmac-sha1,
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA1)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2000/09/xmldsig#hmac-sha1
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA1>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(http://www.w3.org/2001/04/xmldsig-more#rsa-md5,
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSAMD5)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#rsa-md5
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSAMD5>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#rsa-ripemd160,
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSARIPEMD160)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#rsa-ripemd160
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSARIPEMD160>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#rsa-sha256,
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA256)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#rsa-sha256
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA256>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#rsa-sha384,
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA384)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#rsa-sha384
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA384>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#rsa-sha512,
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA512)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#rsa-sha512
org.apache.xml.security.algorithms.implementations.SignatureBaseRSA$SignatureRSASHA512>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#ecdsa-sha1,
org.apache.xml.security.algorithms.implementations.SignatureECDSA$SignatureECDSASHA1)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#ecdsa-sha1
org.apache.xml.security.algorithms.implementations.SignatureECDSA$SignatureECDSASHA1>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(http://www.w3.org/2001/04/xmldsig-more#hmac-md5,
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacMD5)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#hmac-md5
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacMD5>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#hmac-ripemd160,
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacRIPEMD160)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#hmac-ripemd160
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacRIPEMD160>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#hmac-sha256,
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA256)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#hmac-sha256
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA256>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#hmac-sha384,
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA384)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#hmac-sha384
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA384>
*
*2011-12-05 10:32:54,433 DEBUG [org.apache.xml.security.Init] -
<SignatureAlgorithm.register(
http://www.w3.org/2001/04/xmldsig-more#hmac-sha512,
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA512)>
*
*2011-12-05 10:32:54,433 DEBUG
[org.apache.xml.security.algorithms.SignatureAlgorithm] - <Try to register
http://www.w3.org/2001/04/xmldsig-more#hmac-sha512
org.apache.xml.security.algorithms.implementations.IntegrityHmac$IntegrityHmacSHA512>
*
*2011-12-05 10:32:54,480 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.utils.resolver.implementations.ResolverDirectHTTP:
A simple resolver for requests to HTTP space>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.utils.resolver.implementations.ResolverLocalFilesystem:
A simple resolver for requests to the local file system>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.utils.resolver.implementations.ResolverFragment: A
simple resolver for requests of same-document URIs>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.utils.resolver.implementations.ResolverXPointer: A
simple resolver for requests of XPointer fragents>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.RSAKeyValueResolver:
Can extract RSA public keys>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.DSAKeyValueResolver:
Can extract DSA public keys>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.X509CertificateResolver:
Can extract public keys from X509 certificates>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.X509SKIResolver:
Uses an X509v3 SubjectKeyIdentifier extension to retrieve a certificate
from the storages>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.RetrievalMethodResolver:
Resolves keys and certificates using ResourceResolvers>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.X509SubjectNameResolver:
Uses an X509 SubjectName to retrieve a certificate from the storages>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Register
Resolver:
org.apache.xml.security.keys.keyresolver.implementations.X509IssuerSerialResolver:
Uses an X509 IssuerName and IssuerSerial to retrieve a certificate from the
storages>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind prefixes:>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind ds to http://www.w3.org/2000/09/xmldsig#>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind xenc to http://www.w3.org/2001/04/xmlenc#>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind experimental to http://www.xmlsecurity.org/experimental#>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind dsig-xpath-old to http://www.w3.org/2002/04/xmldsig-filter2>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind dsig-xpath to http://www.w3.org/2002/06/xmldsig-filter2>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind ec to http://www.w3.org/2001/10/xml-exc-c14n#>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <Now I try
to bind xx to
http://www.nue.et-inf.uni-siegen.de/~geuer-pollmann/#xpathFilter>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <XX_init
296 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - < XX_prng
0 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_parsing 171 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_i18n 31 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_c14n 16 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_jcemapper 16 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_keyInfo 0 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_keyResolver 0 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_prefixes 0 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_resourceresolver 15 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_sigalgos 16 ms>*
*2011-12-05 10:32:54,495 DEBUG [org.apache.xml.security.Init] - <
XX_configure_reg_transforms 15 ms>*
*2011-12-05 10:32:54,980 DEBUG [org.apache.ws.security.WSSConfig] - <The
provider JuiCE could not be added:
org.apache.security.juice.provider.JuiCEProviderOpenSSL>*
*2011-12-05 10:32:55,042 DEBUG [org.apache.axiom.om.util.StAXUtils] -
<XMLStreamWriter is com.ctc.wstx.sw.SimpleNsStreamWriter>*
*2011-12-05 10:32:55,042 DEBUG [org.apache.rampart.MESSAGE] -
<*********************** RampartSender sent out *
*<?xml version='1.0' encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
http://schemas.xmlsoap.org/soap/envelope/"><soapenv:Header>*
*</soapenv:Header><soapenv:Body><ns2:loadCPS xmlns:ns2="
http://services.connector.backend.tsm.gemalto.com/
"><cpsContent>987FF876543FFAADDCCAAFFF</cpsContent></ns2:loadCPS></soapenv:Body></soapenv:Envelope>>
*
*2011-12-05 10:32:55,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
post-conditions for phase "Security">*
*2011-12-05 10:32:55,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
pre-condition for Phase "MessageOut">*
*2011-12-05 10:32:55,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Invoking
phase "MessageOut">*
*2011-12-05 10:32:55,042 DEBUG [org.apache.axis2.engine.Phase] -
<[MessageContext: logID=urn:uuid:E8AB1360E56F4196E81323052374440] Checking
post-conditions for phase "MessageOut">*
*......................................*
*..................................*
*
*
*2011-12-05 10:32:55,745 DEBUG [org.apache.rampart.MESSAGE] -
<*********************** RampartReceiver received *
*<?xml version='1.0' encoding='utf-8'?><env:Envelope xmlns:env="
http://schemas.xmlsoap.org/soap/envelope/"><env:Body><env:Fault xmlns:wsse="
http://docs.oasis-open.org/wss/2004/01/oasis-200401-wss-wssecurity-secext-1.0.xsd"><faultcode>wsse:InvalidSecurity</faultcode><faultstring>No
id attribute on element http://schemas.xmlsoap.org/soap/envelope/:Body
</faultstring></env:Fault></env:Body></env:Envelope>>*
*2011-12-05 10:32:55,761 DEBUG [org.apache.rampart.RampartEngine] - <Enter
process(MessageContext msgCtx)>*
Please help in resolving this issue,
Regards,
Mirza