I suspect the paths to your key stores to be wrong.

TestRampartPolicy/secured-services/client.jks  is not available form the
classpath of the webapp.

Try with **processes/**TestRampartPolicy/secured-services/client.jks

On Fri, Oct 9, 2009 at 9:02 AM, Jens Müller <[email protected]> wrote:

> On 09.10.2009 17:43, Jens Müller wrote:
> > On 08.10.2009 16:27, Jens Müller wrote:
> >> I have the following config:
> >>
> >> * Apache Tomcat 6.0.20
> >>  * Apache Axis2 1.5
> >>   * Apache Rampart 1.5 RC1 (installed according to
> >>
> http://wso2.org/library/knowledge-base/run-rampart-samples-apache-tomcat)
> >>  * Apache Ode 1.3.3
> >>
> >
> > OK, I changed the sample.axis03 to this:
>
> After providing the password callback handler class, I get this:
>
> Any ideas?
>
> > DEBUG - GeronimoLog.debug(66) | ODE initializing
> > DEBUG - GeronimoLog.debug(66) | BPEL SERVER initializing
> > DEBUG - GeronimoLog.debug(66) | Initializing HTTP connection manager
> > DEBUG - GeronimoLog.debug(66) | http.connection-manager.max-per-host=10
> > DEBUG - GeronimoLog.debug(66) | http.connection-manager.max-total=10
> > DEBUG - GeronimoLog.debug(66) | Process store event:
> {ProcessStoreEvent#ACTVIATED:{http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> }
> > DEBUG - GeronimoLog.debug(66) | Unregister process: serviceId={
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>,
> process=null
> > DEBUG - GeronimoLog.debug(66) | register: {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > DEBUG - GeronimoLog.debug(66) | Registering process {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>with
>  server.
> > DEBUG - GeronimoLog.debug(66) | Register process: serviceId={
> http://example.com/Test1/Pool}CanonicServiceForPool1:canonicPort<http://example.com/Test1/Pool%7DCanonicServiceForPool1:canonicPort>,
> process=BpelProcess[{http:
> > //example.com/Test1/Pool}Pool-1 <http://example.com/Test1/Pool%7DPool-1>
> ]
> > DEBUG - GeronimoLog.debug(66) | Activating {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > DEBUG - GeronimoLog.debug(66) | Create AxisService: service={
> http://example.com/Test1/Pool}CanonicServiceForPool1<http://example.com/Test1/Pool%7DCanonicServiceForPool1>port=canonicPort
>  WSDL=Test1-Pool.wsdl B
> > PEL=Test1-Pool.bpel
> > DEBUG - GeronimoLog.debug(66) | Looking for Axis2 service configuration
> file:
> file:/C:/apache-tomcat-6.0.20/webapps/ode/WEB-INF/processes/RampartOdeTest.
> > 2/CanonicServiceForPool1.axis2
> > DEBUG - GeronimoLog.debug(66) | Axis2 service configuration not found:
> file:/C:/apache-tomcat-6.0.20/webapps/ode/WEB-INF/processes/RampartOdeTest.2/Canon
> > icServiceForPool1.axis2
> > DEBUG - GeronimoLog.debug(66) | Destroying service {
> http://example.com/Test1/Pool}CanonicServiceForPool1<http://example.com/Test1/Pool%7DCanonicServiceForPool1>port
>  canonicPort
> > DEBUG - GeronimoLog.debug(66) | Couldn't find service {
> http://example.com/Test1/Pool}CanonicServiceForPool1<http://example.com/Test1/Pool%7DCanonicServiceForPool1>port
>  canonicPort to destroy.
> > DEBUG - GeronimoLog.debug(66) | Created Axis2 service {
> http://example.com/Test1/Pool}CanonicServiceForPool1<http://example.com/Test1/Pool%7DCanonicServiceForPool1>
> > DEBUG - GeronimoLog.debug(66) | Activated {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>myrole
>  poolAndPool1PlkVar: EPR is org.apache.ode.bpel.epr.wsaendpo...@1f9
> > b804
> > DEBUG - GeronimoLog.debug(66) | Activated {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > DEBUG - GeronimoLog.debug(66) | Rehydrating process {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > DEBUG - GeronimoLog.debug(66) | Processing <invoke> element for process {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>:
> partnerlink pool0AndPoolForPortSample03Htt
> > pSoap12EndpointPlkVar --> {
> http://sample03.policy.samples.rampart.apache.org
> }sample03:sample03HttpSoap11Endpoint
> > DEBUG - GeronimoLog.debug(66) | Creating SOAP-bound external service {
> http://sample03.policy.samples.rampart.apache.org}sample03
> > DEBUG - GeronimoLog.debug(66) | Created external service {
> http://sample03.policy.samples.rampart.apache.org}sample03
> > DEBUG - GeronimoLog.debug(66) | Activated {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>partnerrole
>  pool0AndPoolForPortSample03HttpSoap12EndpointPlkVar: EPR is o
> > rg.apache.ode.bpel.epr.wsaendpo...@128453c
> > DEBUG - GeronimoLog.debug(66) | Creating new process DAO for {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>(guid=hqejbhcnphr4nl24ndvkqn)...
> > DEBUG - GeronimoLog.debug(66) | Found ProcessDAO for {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>with
>  GUID hqejbhcnphr4nl24ndvkqn
> > INFO - GeronimoLog.info(79) | Created new process DAO for {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>(guid=hqejbhcnphr4nl24ndvkqn).
> > INFO - GeronimoLog.info(79) | Registered process {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> .
> > DEBUG - GeronimoLog.debug(66) | (Re)scheduling cron scheduled jobs on
> store event: {ProcessStoreEvent#ACTVIATED:{
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> }
> > INFO - GeronimoLog.info(79) | Cancelling PROCESS CRON jobs for: {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > INFO - GeronimoLog.info(79) | Scheduling PROCESS CRON jobs for: {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > DEBUG - GeronimoLog.debug(66) | BPEL SERVER starting.
> > INFO - GeronimoLog.info(79) | BPEL Server Started.
> > DEBUG - GeronimoLog.debug(66) | No deploy-ext.properties found.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration:
> C:\apache-tomcat-6.0.20\webapps\ode\WEB-INF\conf\schedules.xml
> > DEBUG - GeronimoLog.debug(66) | Initializing Deployment Web Service
> > DEBUG - GeronimoLog.debug(66) | Starting scheduler
> > DEBUG - GeronimoLog.debug(66) | Initializing JCA adapter.
> > INFO - GeronimoLog.info(79) | Poller started.
> > INFO - GeronimoLog.info(79) | Process deployment polling started on path
> C:\apache-tomcat-6.0.20\webapps\ode\WEB-INF\processes.
> > INFO - GeronimoLog.info(79) | ODE Service Engine has been started.
> > DEBUG - GeronimoLog.debug(66) | Process store event:
> {ProcessStoreEvent#SCHEDULE_SETTINGS_CHANGED:{
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> }
> > DEBUG - GeronimoLog.debug(66) | Ignoring store event:
> {ProcessStoreEvent#SCHEDULE_SETTINGS_CHANGED:{
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> }
> > DEBUG - GeronimoLog.debug(66) | (Re)scheduling cron scheduled jobs on
> store event: {ProcessStoreEvent#SCHEDULE_SETTINGS_CHANGED:{
> http://example.com/Test1
> > /Pool}Pool-1}
> > INFO - GeronimoLog.info(79) | Cancelling PROCESS CRON jobs for: {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > INFO - GeronimoLog.info(79) | Scheduling PROCESS CRON jobs for: {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > [INFO] Clustering has been disabled
> > [INFO] Deploying module: addressing-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/addressing-1.5.mar
> > [INFO] Deploying module: jaxws-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/axis2-jaxws-mar-1.5.mar
> > [INFO] Deploying module: script-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/axis2-scripting-1.5.mar
> > [INFO] Deploying module: metadataExchange-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/mex-1.5.mar
> > [INFO] Deploying module: mtompolicy-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/mtompolicy-1.5.mar
> > [INFO] Deploying module: ping-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/ping-1.5.mar
> > [INFO] Deploying module: rahas-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/rahas-1.5.mar
> > [INFO] Deploying module: rampart-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/rampart-1.5.mar
> > [INFO] Deploying module: soapmonitor-1.5 -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/modules/soapmonitor-1.5.mar
> > [INFO] Deploying module: metadataExchange -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/lib/mex-1.5-impl.jar
> > [INFO] Deploying Web service: sample03.aar -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/services/sample03.aar
> > [INFO] Deploying Web service: version-1.5.aar -
> file:/C:/apache-tomcat-6.0.20/webapps/axis2/WEB-INF/services/version-1.5.aar
> > 09.10.2009 17:50:50 org.apache.coyote.http11.Http11Protocol start
> > INFO: Starting Coyote HTTP/1.1 on http-8081
> > 09.10.2009 17:50:51 org.apache.jk.common.ChannelSocket init
> > INFO: JK: ajp13 listening on /0.0.0.0:8109
> > 09.10.2009 17:50:51 org.apache.jk.server.JkMain start
> > INFO: Jk running ID=0 time=0/16  config=null
> > 09.10.2009 17:50:51 org.apache.catalina.startup.Catalina start
> > INFO: Server startup in 10286 ms
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > DEBUG - GeronimoLog.debug(66) | Checking for Service using target
> endpoint address :
> http://localhost:8081/ode/processes/RampartOdeTest/Test1/Pool/Pool1
> > DEBUG - GeronimoLog.debug(66) | Found service in registry from name
> RampartOdeTest/Test1/Pool/Pool1: RampartOdeTest/Test1/Pool/Pool1
> > DEBUG - GeronimoLog.debug(66) | The system is checking for the operation
> using the following WSAAction:
> http://example.com/Test1/Pool/ForPool1/EventStart
> > Message
> > DEBUG - GeronimoLog.debug(66) | Received request message for
> RampartOdeTest/Test1/Pool/Pool1.{
> http://example.com/Test1/Pool}EventStartMessage<http://example.com/Test1/Pool%7DEventStartMessage>
> > DEBUG - GeronimoLog.debug(66) | Starting transaction.
> > DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://example.com/Test1/Pool}CanonicServiceForPool1<http://example.com/Test1/Pool%7DCanonicServiceForPool1>-->
>  [BpelProcess[{
> http://example.com/Test1/Pool}Po <http://example.com/Test1/Pool%7DPo>
> > ol-1]]
> > DEBUG - GeronimoLog.debug(66) | ODE routed to operation Operation:
> name=EventStartMessage
> > style=REQUEST_RESPONSE,1
> > Input: name=EventStartMessage
> > Message: 
> > name={http://example.com/Test1/Pool}EventStartMessageRequest<http://example.com/Test1/Pool%7DEventStartMessageRequest>
> > Part: name=body
> > elementName={http://example.com/Test1/Pool}EventStartMessageRequest<http://example.com/Test1/Pool%7DEventStartMessageRequest>
> > Output: name=EventStartMessageResponse
> > Message: 
> > name={http://example.com/Test1/Pool}EventStartMessageResponse<http://example.com/Test1/Pool%7DEventStartMessageResponse>
> > Part: name=body
> > elementName={http://example.com/Test1/Pool}EventStartMessageResponse<http://example.com/Test1/Pool%7DEventStartMessageResponse>from
> >  service {
> http://example.com/Test1/Pool}CanonicServiceForPool1<http://example.com/Test1/Pool%7DCanonicServiceForPool1>
> > DEBUG - GeronimoLog.debug(66) | SET MEX property isTwoWay = true
> > DEBUG - GeronimoLog.debug(66) | Invoking ODE using MEX
> {MyRoleMex#hqejbhcnphr4nogdhmowu8 [Client hqejbhcnphr4nogdhmowu7] calling {
> http://example.com/Test
> > 1/Pool}CanonicServiceForPool1.EventStartMessage(...)}
> > DEBUG - GeronimoLog.debug(66) | Message content:  <?xml version="1.0"
> encoding="UTF-8"?>
> > <message><body><EventStartMessageRequest xmlns="
> http://example.com/Test1/Pool"; xmlns:pool="http://example.com/Test1/Pool";
> xmlns:soapenv="http://schemas.x
> > mlsoap.org/soap/envelope/">?</EventStartMessageRequest></body></message>
> > DEBUG - GeronimoLog.debug(66) | invoke() EPR= null ==> BpelProcess[{
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>
> ]
> > DEBUG - GeronimoLog.debug(66) | Commiting ODE MEX
> {MyRoleMex#hqejbhcnphr4nogdhmowu8 [Client hqejbhcnphr4nogdhmowu7] calling {
> http://example.com/Test1/Poo
> > l}CanonicServiceForPool1.EventStartMessage(...)}
> > DEBUG - GeronimoLog.debug(66) | Commiting transaction.
> > DEBUG - GeronimoLog.debug(66) | handleWorkEvent: InvokeInternal event for
> mexid hqejbhcnphr4nogdhmowu8
> > DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={mexid=hqejbhcnphr4nogdhmowu8, pid={
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>,
> type=INVOKE_INTERNAL
> > })
> > DEBUG - GeronimoLog.debug(66) | InvokeInternal event for mexid
> hqejbhcnphr4nogdhmowu8
> > DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessionId = null
> > DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessionId = null
> > DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.partnerRoleSessionId = null
> > DEBUG - GeronimoLog.debug(66) | INPUTMSG:
> poolAndPool1PlkVar.EventStartMessage: MSG RCVD keys=[] mySessionId=null
> partnerSessionId=null
> > DEBUG - GeronimoLog.debug(66) | INPUTMSG:
> poolAndPool1PlkVar.EventStartMessage: routing failed, CREATING NEW INSTANCE
> > DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
> instance 8551. INDEXED STATE={}
> > DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: USING
> CORRELATOR poolAndPool1PlkVar.EventStartMessage
> > DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: CHECKING
> for NEW INSTANCE match
> > DEBUG - GeronimoLog.debug(66) | INPUTMSGMATCH: Changing process instance
> state from ready to active
> > DEBUG - GeronimoLog.debug(66) | SELECT: PickResponseChannel#9: FOUND
> match for NEW instance mexRef={MyRoleMex#hqejbhcnphr4nogdhmowu8 [Client
> hqejbhcnphr4
> > nogdhmowu7] calling {
> http://example.com/Test1/Pool}CanonicServiceForPool1.EventStartMessage(...)<http://example.com/Test1/Pool%7DCanonicServiceForPool1.EventStartMessage%28...%29>
> }
> > DEBUG - GeronimoLog.debug(66) | INVOKING PARTNER:
> partnerLink={PartnerLinkInstance
> partnerLinkDecl=OPartnerLink#21,scopeInstanceId=8601}, op=echo channel
> > =InvokeResponseChannel#23)
> > DEBUG - GeronimoLog.debug(66) | INVOKE PARTNER (SEP): sessionId=null
> partnerSessionId=null
> > DEBUG - GeronimoLog.debug(66) | SET MEX property activityId = 47
> > DEBUG - GeronimoLog.debug(66) | Routed: svcQname {
> http://sample03.policy.samples.rampart.apache.org}sample03 --> null
> > DEBUG - GeronimoLog.debug(66) | Creating invocation check event in
> 180000ms for mexid hqejbhcnphr4nogdhmowub
> > DEBUG - GeronimoLog.debug(66) | SET MEX property invokeCheckJobId =
> hqejbhcnphr4nogdhmowuc
> > DEBUG - GeronimoLog.debug(66) | Invoking a partner operation: echo
> > DEBUG - GeronimoLog.debug(66) | The service to invoke is the external
> service {http://sample03.policy.samples.rampart.apache.org
> }sample03:sample03HttpSoa
> > p11Endpoint
> > DEBUG - GeronimoLog.debug(66) | Looking for Axis2 service configuration
> file:
> file:/C:/apache-tomcat-6.0.20/webapps/ode/WEB-INF/processes/RampartOdeTest.
> > 2/sample03.axis2
> > DEBUG - GeronimoLog.debug(66) | Configuring service axis_service_for_{
> http://sample03.policy.samples.rampart.apache.org
> }sample03#sample03HttpSoap11Endpoi
> > nt_hqejbhcnphr4nogdhmowud using:
> file:/C:/apache-tomcat-6.0.20/webapps/ode/WEB-INF/processes/RampartOdeTest.2/sample03.axis2
> > DEBUG - GeronimoLog.debug(66) | Create a new ServiceClient for
> axis_service_for_{http://sample03.policy.samples.rampart.apache.org
> }sample03#sample03HttpS
> > oap11Endpoint_hqejbhcnphr4nogdhmowud
> > DEBUG - GeronimoLog.debug(66) | Resolving endpoint reference <?xml
> version="1.0" encoding="UTF-8"?>
> > <service-ref 
> > xmlns="http://docs.oasis-open.org/wsbpel/2.0/serviceref";><EndpointReference
> xmlns="http://www.w3.org/2005/08/addressing";><Metadata><ServiceN
> > ame xmlns="http://www.w3.org/2006/05/addressing/wsdl";
> EndpointName="sample03HttpSoap11Endpoint" xmlns:servicens="
> http://sample03.policy.samples.rampart.a
> > pache.org">servicens:sample03</ServiceName></Metadata><Address>
> http://localhost:8081/axis2/services/sample03.sample03HttpSoap11Endpoint/
> </Address></Endpo
> > intReference></service-ref>
> > DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.partnerRoleSessionId = null
> > DEBUG - GeronimoLog.debug(66) | GET MEX property
> org.apache.ode.bpel.myRoleSessionId = null
> > DEBUG - GeronimoLog.debug(66) | My-Role EPR not specified, SEP will not
> be used.
> > DEBUG - GeronimoLog.debug(66) | Axis2 sending message to
> http://localhost:8081/axis2/services/sample03.sample03HttpSoap11Endpoint/using
>  MEX {PartnerRole
> > Mex#hqejbhcnphr4nogdhmowub [PID 
> > {http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>]
> calling [email protected](...)}
> > DEBUG - GeronimoLog.debug(66) | Message: <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/
> > "><soapenv:Body><echo xmlns="
> http://sample03.policy.samples.rampart.apache.org";>
> >   <ns:args0 xmlns:ns="http://sample03.policy.samples.rampart.apache.org
> ">?</ns:args0>
> > </echo></soapenv:Body></soapenv:Envelope>
> > DEBUG - GeronimoLog.debug(66) | replyAsync mex=hqejbhcnphr4nogdhmowub
> > DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 8551
> > DEBUG - GeronimoLog.debug(66) | Sending stateful TO epr in message header
> using session null
> > DEBUG - GeronimoLog.debug(66) | Sending a message containing wsa
> endpoints in headers for session passing.
> > DEBUG - GeronimoLog.debug(66) | <?xml version='1.0'
> encoding='utf-8'?><soapenv:Envelope xmlns:soapenv="
> http://schemas.xmlsoap.org/soap/envelope/";><soapen
> > v:Header><addr:To xmlns:addr="http://www.w3.org/2005/08/addressing";>
> http://localhost:8081/axis2/services/sample03.sample03HttpSoap11Endpoint/
> </addr:To><a
> > ddr:Action 
> > xmlns:addr="http://www.w3.org/2005/08/addressing";>urn:echo</addr:Action><addr:ReplyTo
> xmlns:addr="http://www.w3.org/2005/08/addressing";><addr:
> > Address>http://www.w3.org/2005/08/addressing/anonymous</addr:Address></addr:ReplyTo><addr:MessageID
> xmlns:addr="http://www.w3.org/2005/08/addressing";>uui
> >
> d:hqejbhcnphr4nogdhmowue</addr:MessageID></soapenv:Header><soapenv:Body><echo
> xmlns="http://sample03.policy.samples.rampart.apache.org";>
> >   <ns:args0 xmlns:ns="http://sample03.policy.samples.rampart.apache.org
> ">?</ns:args0>
> > </echo></soapenv:Body></soapenv:Envelope>
> > WARN - GeronimoLog.warn(96) | Caught Exception while in
> Loader.getResource. This may be innocuous.
> > java.lang.NullPointerException
> >         at sun.misc.MetaIndex.mayContain(MetaIndex.java:225)
> >         at
> sun.misc.URLClassPath$JarLoader.getResource(URLClassPath.java:744)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:168)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:220)
> >         at
> java.lang.ClassLoader.getBootstrapResource(ClassLoader.java:1113)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:974)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:972)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:972)
> >         at
> org.apache.catalina.loader.WebappClassLoader.getResource(WebappClassLoader.java:1124)
> >         at org.apache.ws.security.util.Loader.getResource(Loader.java:94)
> >         at
> org.apache.ws.security.components.crypto.AbstractCrypto.<init>(AbstractCrypto.java:66)
> >         at
> org.apache.ws.security.components.crypto.Merlin.<init>(Merlin.java:65)
> >         at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
> Method)
> >         at
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
> >         at
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
> >         at
> java.lang.reflect.Constructor.newInstance(Constructor.java:513)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:211)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > WARN - GeronimoLog.warn(96) | Caught Exception while in
> Loader.getResource. This may be innocuous.
> > java.lang.NullPointerException
> >         at sun.misc.MetaIndex.mayContain(MetaIndex.java:225)
> >         at
> sun.misc.URLClassPath$JarLoader.getResource(URLClassPath.java:744)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:168)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:220)
> >         at
> java.lang.ClassLoader.getBootstrapResource(ClassLoader.java:1113)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:974)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:972)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:972)
> >         at
> org.apache.catalina.loader.WebappClassLoader.getResource(WebappClassLoader.java:1124)
> >         at org.apache.ws.security.util.Loader.getResource(Loader.java:62)
> >         at
> org.apache.ws.security.util.Loader.getResource(Loader.java:102)
> >         at
> org.apache.ws.security.components.crypto.AbstractCrypto.<init>(AbstractCrypto.java:66)
> >         at
> org.apache.ws.security.components.crypto.Merlin.<init>(Merlin.java:65)
> >         at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
> Method)
> >         at
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
> >         at
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
> >         at
> java.lang.reflect.Constructor.newInstance(Constructor.java:513)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:211)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > java.lang.reflect.InvocationTargetException
> >         at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
> Method)
> >         at
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
> >         at
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
> >         at
> java.lang.reflect.Constructor.newInstance(Constructor.java:513)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:211)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > Caused by: java.lang.NullPointerException
> >         at sun.misc.MetaIndex.mayContain(MetaIndex.java:225)
> >         at
> sun.misc.URLClassPath$JarLoader.getResource(URLClassPath.java:744)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:168)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:220)
> >         at
> java.lang.ClassLoader.getBootstrapResource(ClassLoader.java:1113)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:974)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:972)
> >         at java.lang.ClassLoader.getSystemResource(ClassLoader.java:1075)
> >         at org.apache.ws.security.util.Loader.getResource(Loader.java:76)
> >         at
> org.apache.ws.security.util.Loader.getResource(Loader.java:102)
> >         at
> org.apache.ws.security.components.crypto.AbstractCrypto.<init>(AbstractCrypto.java:66)
> >         at
> org.apache.ws.security.components.crypto.Merlin.<init>(Merlin.java:65)
> >         ... 25 more
> > ERROR - GeronimoLog.error(108) | Unable to instantiate (1):
> org.apache.ws.security.components.crypto.Merlin
> > java.lang.reflect.InvocationTargetException
> >         at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
> Method)
> >         at
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
> >         at
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
> >         at
> java.lang.reflect.Constructor.newInstance(Constructor.java:513)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:211)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > Caused by: java.lang.NullPointerException
> >         at sun.misc.MetaIndex.mayContain(MetaIndex.java:225)
> >         at
> sun.misc.URLClassPath$JarLoader.getResource(URLClassPath.java:744)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:168)
> >         at sun.misc.URLClassPath.getResource(URLClassPath.java:220)
> >         at
> java.lang.ClassLoader.getBootstrapResource(ClassLoader.java:1113)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:974)
> >         at java.lang.ClassLoader.getResource(ClassLoader.java:972)
> >         at java.lang.ClassLoader.getSystemResource(ClassLoader.java:1075)
> >         at org.apache.ws.security.util.Loader.getResource(Loader.java:76)
> >         at
> org.apache.ws.security.util.Loader.getResource(Loader.java:102)
> >         at
> org.apache.ws.security.components.crypto.AbstractCrypto.<init>(AbstractCrypto.java:66)
> >         at
> org.apache.ws.security.components.crypto.Merlin.<init>(Merlin.java:65)
> >         ... 25 more
> > java.lang.InstantiationException:
> org.apache.ws.security.components.crypto.Merlin
> >         at java.lang.Class.newInstance0(Class.java:340)
> >         at java.lang.Class.newInstance(Class.java:308)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:219)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > ERROR - GeronimoLog.error(108) | Unable to instantiate (2):
> org.apache.ws.security.components.crypto.Merlin
> > java.lang.InstantiationException:
> org.apache.ws.security.components.crypto.Merlin
> >         at java.lang.Class.newInstance0(Class.java:340)
> >         at java.lang.Class.newInstance(Class.java:308)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:219)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > ERROR - GeronimoLog.error(108) | Error sending message
> (mex={PartnerRoleMex#hqejbhcnphr4nogdhmowub [PID {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>]
> calling or
> > [email protected](...)}):
> org.apache.ws.security.components.crypto.Merlin cannot create instance
> > java.lang.RuntimeException:
> org.apache.ws.security.components.crypto.Merlin cannot create instance
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.loadClass(CryptoFactory.java:224)
> >         at
> org.apache.ws.security.components.crypto.CryptoFactory.getInstance(CryptoFactory.java:93)
> >         at
> org.apache.rampart.util.RampartUtil.getSignatureCrypto(RampartUtil.java:235)
> >         at
> org.apache.rampart.builder.BindingBuilder.getSignatureBuider(BindingBuilder.java:294)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignature(AsymmetricBindingBuilder.java:596)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.doSignBeforeEncrypt(AsymmetricBindingBuilder.java:385)
> >         at
> org.apache.rampart.builder.AsymmetricBindingBuilder.build(AsymmetricBindingBuilder.java:95)
> >         at
> org.apache.rampart.MessageBuilder.build(MessageBuilder.java:131)
> >         at
> org.apache.rampart.handler.RampartSender.invoke(RampartSender.java:64)
> >         at org.apache.axis2.engine.Phase.invoke(Phase.java:292)
> >         at org.apache.axis2.engine.AxisEngine.invoke(AxisEngine.java:212)
> >         at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:377)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:374)
> >         at
> org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:211)
> >         at
> org.apache.axis2.client.OperationClient.execute(OperationClient.java:163)
> >         at
> org.apache.ode.axis2.SoapExternalService$1$1.call(SoapExternalService.java:201)
> >         at
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:303)
> >         at java.util.concurrent.FutureTask.run(FutureTask.java:138)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:885)
> >         at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
> >         at java.lang.Thread.run(Thread.java:619)
> > DEBUG - GeronimoLog.debug(66) | replyWithFailure
> mex=hqejbhcnphr4nogdhmowub failureType=COMMUNICATION_ERROR description=Error
> sending message (mex={Partn
> > erRoleMex#hqejbhcnphr4nogdhmowub [PID {
> http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>]
> calling [email protected](...)}):
> org.apache.
> > ws.security.components.crypto.Merlin cannot create instance details=null
> > DEBUG - GeronimoLog.debug(66) | create work event for
> mex=hqejbhcnphr4nogdhmowub
> > DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-2,5,main]:
> lock(iid=8551, time=1MICROSECONDS)
> > DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-2,5,main]:
> lock(iid=8551, time=1MICROSECONDS)-->GRANTED
> > DEBUG - GeronimoLog.debug(66) | >>
> handleWorkEvent(jobData={mexid=hqejbhcnphr4nogdhmowub, iid=8551,
> type=INVOKE_RESPONSE, channel=23})
> > DEBUG - GeronimoLog.debug(66) | BpelRuntimeContextImpl created for
> instance 8551. INDEXED STATE={{OScope 'Task-1' id=46}::12=[ACTIVE(...)],
> {OScope 'Task
> > -1' id=46}::11=[ACTIVITYGUARD(...)],
> OSequence#26-sequence-activity-line-16::1=[ACTIVITYGUARD(...)], {OScope
> '__PROCESS_SCOPE:Pool' id=3}::0=[ACTIVE(...)
> > ], OInvoke#47-Task-1::14=[INVOKE(...)],
> OInvoke#47-Task-1::13=[ACTIVITYGUARD(...)], {OScope '__PROCESS_SCOPE:Pool'
> id=3}::0=[SCOPE(...)], {OScope 'Task-1
> > ' id=46}::12=[SCOPE(...)],
> OSequence#26-sequence-activity-line-16::2=[SEQUENCE(self=(OSequence#26-sequence-activity-line-16,TerminationChannel#3,ParentSc
> > opeChannel#5), linkframe=org.apache.ode.bpel.runtime.linkfr...@123fab3,
> remaining=[{OScope 'Task-1' id=46}, {OAssign : Message_End_Event,
> joinCondition=n
> > ull}, OReply#59-Message_End_Event-1])]}
> > DEBUG - GeronimoLog.debug(66) | InvokeResponse event for iid 8551
> > DEBUG - GeronimoLog.debug(66) | Invoking message response for mexid
> hqejbhcnphr4nogdhmowub and channel 23
> > DEBUG - GeronimoLog.debug(66) | Triggering response
> > ERROR - GeronimoLog.error(104) | Failure during invoke: Error sending
> message (mex={PartnerRoleMex#hqejbhcnphr4nogdhmowub [PID {
> http://example.com/Test1/
> > Pool}Pool-1] calling 
> > [email protected](...)}):
> org.apache.ws.security.components.crypto.Merlin cannot create instance
> > INFO - GeronimoLog.info(79) | ActivityRecovery: Registering activity 13,
> failure reason: Error sending message
> (mex={PartnerRoleMex#hqejbhcnphr4nogdhmowu
> > b [PID 
> > {http://example.com/Test1/Pool}Pool-1<http://example.com/Test1/Pool%7DPool-1>]
> calling [email protected](...)}):
> org.apache.ws.security.components.crypto.M
> > erlin cannot create instance on channel 24
> > DEBUG - GeronimoLog.debug(66) | Setting execution state on instance 8551
> > DEBUG - GeronimoLog.debug(66) | Thread[ODEServer-2,5,main]:
> unlock(iid=8551)
> > DEBUG - GeronimoLog.debug(66) | Received myrole mex response callback
> > DEBUG - GeronimoLog.debug(66) | Handling response for MEX
> {MyRoleMex#hqejbhcnphr4nogdhmowu8 [Client hqejbhcnphr4nogdhmowu7] calling {
> http://example.com/T
> > est1/Pool}CanonicServiceForPool1.EventStartMessage(...)}
> > DEBUG - GeronimoLog.debug(66) | Starting transaction.
> > DEBUG - GeronimoLog.debug(66) | Failure response message: null
> > WARN - GeronimoLog.warn(96) | MEX produced a fault
> {MyRoleMex#hqejbhcnphr4nogdhmowu8 [Client hqejbhcnphr4nogdhmowu7] calling {
> http://example.com/Test1/Po
> > ol}CanonicServiceForPool1.EventStartMessage(...)}
> > org.apache.ode.axis2.OdeFault: Message exchange failure due to: Error
> sending message (mex={PartnerRoleMex#hqejbhcnphr4nogdhmowub [PID {
> http://example.co
> > m/Test1/Pool}Pool-1] calling
> [email protected](...)}):
> org.apache.ws.security.components.crypto.Merlin cannot create insta
> > nce
> >         at
> org.apache.ode.axis2.util.SoapMessageConverter.createOdeFault(SoapMessageConverter.java:570)
> >         at
> org.apache.ode.axis2.ODEService.onResponse(ODEService.java:282)
> >         at
> org.apache.ode.axis2.ODEService.onAxisMessageExchange(ODEService.java:189)
> >         at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:69)
> >         at
> org.apache.ode.axis2.hooks.ODEMessageReceiver.invokeBusinessLogic(ODEMessageReceiver.java:52)
> >         at
> org.apache.axis2.receivers.AbstractMessageReceiver.receive(AbstractMessageReceiver.java:96)
> >         at
> org.apache.axis2.engine.AxisEngine.receive(AxisEngine.java:145)
> >         at
> org.apache.axis2.transport.http.HTTPTransportUtils.processHTTPPostRequest(HTTPTransportUtils.java:275)
> >         at
> org.apache.axis2.transport.http.AxisServlet.doPost(AxisServlet.java:120)
> >         at javax.servlet.http.HttpServlet.service(HttpServlet.java:637)
> >         at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
> >         at
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
> >         at
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
> >         at
> org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
> >         at
> org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
> >         at
> org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:128)
> >         at
> org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
> >         at
> org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
> >         at
> org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
> >         at
> org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:849)
> >         at
> org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:583)
> >         at
> org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:454)
> >         at java.lang.Thread.run(Thread.java:619)
> > DEBUG - GeronimoLog.debug(66) | Releasing mex hqejbhcnphr4nogdhmowu8
> > DEBUG - GeronimoLog.debug(66) | Comitting transaction.
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> > INFO - GeronimoLog.info(79) | Refreshing SYSTEM CRON jobs.
> > INFO - GeronimoLog.info(79) | SYSTEM CRON configuration found cron jobs:
> []
> >
> >
> >
> >
> >
>
>

Reply via email to