This discussion is archived
1 Reply Latest reply: Jan 31, 2012 7:46 AM by 914348 RSS

OCSG 5.0.0.1 Policy error 1

914348 Newbie
Currently Being Moderated
Hi,

I am new to OCSG and trying to setup an OSB/OCSG configuration for SMS and MMS. I'm having some problems and any help is appreciated.

I'm using this setup during development:
OSB and OCSG admin servers on 192.168.150.129. Managed servers for OSB, OCSG-AT and OCSG-NT on 192.168.150.130.

I have created an instance of the SMPPService on OCSG-NT and bound it to a local SMSC running on 192.168.150.129:2775. This SEEMS to work fine.

Further I've setup a new project in the sbconsole for SMS and used the WSDL at http://192.168.150.130:10600/parlayx21/sms/SendSms?WSDL to create a ProxyService and a BusinessService pointing towards      
http://192.168.150.130:10600/parlayx21/sms/SendSms. I have then attached a ServiceAccount with the SMSC user settings to the BusinessService.and I'm adding my OCSG admin user/password as Security when I'm triggering the Web Service

Now to the problem.
When I'm trying to send a SMS through the ProxyService test console I get this response:
<soapenv:Fault>
<faultcode>soapenv:Server</faultcode>
<faultstring>BEA-380001: Internal Server Error</faultstring>
<detail>
<con:fault      xmlns:con="http://www.bea.com/wli/sb/context">
<con:errorCode>BEA-380001</con:errorCode>
<con:reason>Internal Server Error</con:reason>
<con:location>
<con:node>RouteNode1</con:node>
<con:path>response-pipeline</con:path>
</con:location>
</con:fault>
</detail>
</soapenv:Fault>

In the OSB managed server log:
####<Jan 31, 2012 9:46:16 AM EST> <Debug> <AlsbPipeline> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:-7290b126:135340a434a:-8000-00000000000001a9> <1328021176584> <BEA-000000> <sms/ProxyServices/SMSGateway1: +PipelineContextImpl.handleError - messageID:2699236373981549535--7290b126.135340a434a.-7fee, t:com.bea.wli.sb.pipeline.PipelineException: Transport error (error code=BEA-380001): Internal Server Error>
####<Jan 31, 2012 9:46:16 AM EST> <Debug> <AlsbPipeline> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:-7290b126:135340a434a:-8000-00000000000001a9> <1328021176584> <BEA-000000> <sms/ProxyServices/SMSGateway1: Unhandled error caught by system-level error handler
com.bea.wli.sb.pipeline.PipelineException: Transport error (error code=BEA-380001): Internal Server Error
at com.bea.wli.sb.pipeline.Node.processMessage(Node.java:79)
at com.bea.wli.sb.pipeline.PipelineContextImpl.execute(PipelineContextImpl.java:1055)
at com.bea.wli.sb.pipeline.Router.processMessage(Router.java:214)
at com.bea.wli.sb.pipeline.MessageProcessor.processResponse(MessageProcessor.java:195)
at com.bea.wli.sb.pipeline.RouterCallback.onError(RouterCallback.java:145)
at com.bea.wli.sb.transports.LoadBalanceFailoverListener.onError(LoadBalanceFailoverListener.java:439)
at com.bea.wli.sb.transports.http.wls.HttpOutboundMessageContextWls$RetrieveHttpResponseWork.handleResponse(HttpOutboundMessageContextWls.java:101)
at weblogic.net.http.AsyncResponseHandler$MuxableSocketHTTPAsyncResponse$RunnableCallback.run(AsyncResponseHandler.java:531)
at weblogic.work.ContextWrap.run(ContextWrap.java:41)
at weblogic.work.SelfTuningWorkManagerImpl$WorkAdapterImpl.run(SelfTuningWorkManagerImpl.java:528)
at weblogic.work.ExecuteThread.execute(ExecuteThread.java:207)
at weblogic.work.ExecuteThread.run(ExecuteThread.java:176)
>

If I'm trying directly through the BusinessService I get this exception:
<env:Fault>
<faultcode>env:Server</faultcode>
<faultstring/>
<detail>
<v2:PolicyException      xmlns:v2="http://www.csapi.org/schema/parlayx/common/v2_1">
<messageId>POL0001</messageId>
<text>
A policy error occurred. Error code is %1
</text>
<variables>1</variables>
</v2:PolicyException>
</detail>
</env:Fault>

In the OSB managed server log:
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045205> <BEA-000000> <WssAuditor initilizing>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045206> <BEA-000000> <auditingEnbled set to false>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045206> <BEA-000000> <auditingEnbled set to false>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045206> <BEA-000000> <WssAuditor successfully started>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbTestConsole> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045206> <BEA-000000> <Got SOAP Message Factory from the Provider: weblogic.xml.saaj.MessageFactoryImpl@1c58b737>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSources> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045206> <BEA-000000> <+MetaTransformer.transform(com.bea.wli.sb.sources.XmlObjectSource,com.bea.wli.sb.sources.SAAJSource)>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSources> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045206> <BEA-000000> <-MetaTransformer.transform()>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045208> <BEA-000000> <WssInboundHandler.processRequest>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045208> <BEA-000000> <target operation: sendSms>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045208> <BEA-000000> <invoking WssClientHandler.handleRequest>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbSecurityWss> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045208> <BEA-000000> <storing the new message in the router message context>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045210> <BEA-000000> <+TransportManagerImpl.sendMessageAsync>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbMonitoring> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045210> <BEA-000000> <Delegate for BusinessService sms/BusinessServices/SendSmsBS:Transport.response-time not found>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbMonitoring> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045210> <BEA-000000> <Delegate for BusinessService sms/BusinessServices/SendSmsBS:Operation.sendSms.elapsed-time not found>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbMonitoring> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045210> <BEA-000000> <Delegate for BusinessService sms/BusinessServices/SendSmsBS:Transport.uri.http://192.168.150.130:10600/parlayx21/sms/SendSms.response-time not found>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045211> <BEA-000000> <com.bea.wli.sb.transports.http.wls.HttpOutboundMessageContextWls: Request MetaData: <xml-fragment xmlns:tran="http://www.bea.com/wli/sb/transports" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:http="http://www.bea.com/wli/sb/transports/http">
<tran:headers xsi:type="http:HttpRequestHeaders">
<http:Content-Type>text/xml; charset=utf-8</http:Content-Type>
<http:SOAPAction>""</http:SOAPAction>
</tran:headers>
<tran:encoding>utf-8</tran:encoding>
<http:query-parameters/>
</xml-fragment>>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045211> <BEA-000000> <Sending outbound request to http://192.168.150.130:10600/parlayx21/sms/SendSms? with QOS: best effort only...>
####<Jan 31, 2012 10:00:45 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '4' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:736ae200:1352ec63730:-8000-00000000000013de> <1328022045211> <BEA-000000> <-TransportManagerImpl.sendMessageAsync>
####<Jan 31, 2012 10:00:51 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '3' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:-7290b126:135340a434a:-8000-000000000000022f> <1328022051260> <BEA-000000> <Business service returned status code: 500>
####<Jan 31, 2012 10:00:51 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '3' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:-7290b126:135340a434a:-8000-000000000000022f> <1328022051261> <BEA-000000> <HttpOutboundMessageContext: Response MetaData: <xml-fragment xmlns:tran="http://www.bea.com/wli/sb/transports" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance" xmlns:http="http://www.bea.com/wli/sb/transports/http">
<tran:headers xsi:type="http:HttpResponseHeaders">
<tran:user-header name="X-Powered-By" value="Servlet/2.5 JSP/2.1"/>
<http:Content-Type>text/xml; charset=utf-8</http:Content-Type>
<http:Date>Tue, 31 Jan 2012 15:00:45 GMT</http:Date>
<http:Transfer-Encoding>chunked</http:Transfer-Encoding>
</tran:headers>
<tran:response-code>1</tran:response-code>
<tran:response-message>Internal Server Error</tran:response-message>
<tran:encoding>utf-8</tran:encoding>
<http:http-response-code>500</http:http-response-code>
</xml-fragment>>
####<Jan 31, 2012 10:00:51 AM EST> <Debug> <AlsbTransports> <localhost.localdomain> <osb_domain> <[ACTIVE] ExecuteThread: '3' for queue: 'weblogic.kernel.Default (self-tuning)'> <<anonymous>> <> <11d1def534ea1be0:-7290b126:135340a434a:-8000-000000000000022f> <1328022051261> <BEA-000000> <LoadBalanceFailoverListener.onError: Work Manager: null@null@weblogic.kernel.Default>


In the OCSG managed server out:
org.csapi.schema.parlayx.common.v2_1.PolicyException
at com.bea.wlcp.wlng.px21.common.ExceptionType.createEx(ExceptionType.java:61)
at com.bea.wlcp.wlng.px21.common.ExceptionType.createEx(ExceptionType.java:45)
at com.bea.wlcp.wlng.px21.common.PxRequestFactory.convertEx(PxRequestFactory.java:70)
at com.bea.wlcp.wlng.px21.common.PxRequestFactory.convertEx(PxRequestFactory.java:54)
at com.bea.wlcp.wlng.px21.plugin.SendSmsPluginFactory.convertEx(SendSmsPluginFactory.java:265)
at com.bea.wlcp.wlng.util.EJBHelper.processRequest(EJBHelper.java:52)
at com.bea.wlcp.wlng.px21.ejb.SendSmsEjbImpl.sendSms(SendSmsEjbImpl.java:79)
at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl.sendSms(SendSms_25ojqb_EOImpl.java:283)
at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl_WLSkel.invoke(Unknown Source)
at weblogic.rmi.internal.BasicServerRef.invoke(BasicServerRef.java:589)
at weblogic.rmi.cluster.ClusterableServerRef.invoke(ClusterableServerRef.java:230)
at weblogic.rmi.internal.BasicServerRef$1.run(BasicServerRef.java:477)
at weblogic.security.acl.internal.AuthenticatedSubject.doAs(AuthenticatedSubject.java:363)
at weblogic.security.service.SecurityManager.runAs(SecurityManager.java:147)
at weblogic.rmi.internal.BasicServerRef.handleRequest(BasicServerRef.java:473)
at weblogic.rmi.internal.wls.WLSExecuteRequest.run(WLSExecuteRequest.java:118)
at weblogic.work.ExecuteThread.execute(ExecuteThread.java:201)
at weblogic.work.ExecuteThread.run(ExecuteThread.java:173)
  • 1. Re: OCSG 5.0.0.1 Policy error 1
    914348 Newbie
    Currently Being Moderated
    In the OCSG default.log:
    31 Jan 2012 10:05:11,584 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.storage.common.DbLockManager - Got db lock: -180666158|com.bea.wlcp.wlng.plugin.terminallocation.mlp.store.TerminalLocationStoreImpl
    31 Jan 2012 10:05:11,587 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.storage.common.DbLockManager - Removed rows: 1
    31 Jan 2012 10:05:11,589 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.plugin.terminallocation.mlp.timer.TimerHandler - Cleanup timer started. delay: 30000
    31 Jan 2012 10:05:12,971 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Try to send PDU Request: (enquirelink: (pdu: 0 15 0 232) )
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]PDU sequence number reseted: 232 --> 51
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.networking.ChannelProcessorTimer - Cleanup timer started. delay(in milliseconds): 20000
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Sending PDU Request: (enquirelink: (pdu: 0 15 0 51) )
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - Will try to write 16 bytes.
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 16 bytes written.
    31 Jan 2012 10:05:12,972 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 16 bytes read.
    31 Jan 2012 10:05:12,972 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Receive PDU success, PDU: (enquirelink_resp: (pdu: 16 80000015 0 51) )
    31 Jan 2012 10:05:12,972 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 0 bytes read.
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc5686] DEBUG oracle.ocsg.protocol.networking.ChannelProcessorTimer - Cleanup timer started. delay(in milliseconds): 60000
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc5686] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Removing request from cache since response returned, SequenceNumber: 51
    31 Jan 2012 10:05:12,972 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc5686] DEBUG oracle.ocsg.protocol.smpp.south.SouthPduTask - [ConnectionId: c_192.168.150.129:2775_482745820]Receive ENQUIRE_LINK_RESP, do nothing.
    31 Jan 2012 10:05:12,972 [[ACTIVE] ExecuteThread: '21' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - Interest operations set to 1
    31 Jan 2012 10:05:38,415 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.plugin.presence.sip.utils.TimerHandler - Cleanup timer started. delay: 300000
    31 Jan 2012 10:05:41,591 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.storage.common.DbLockManager - Got db lock: -180666158|com.bea.wlcp.wlng.plugin.terminallocation.mlp.store.TerminalLocationStoreImpl
    31 Jan 2012 10:05:41,593 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.storage.common.DbLockManager - Removed rows: 1
    31 Jan 2012 10:05:41,614 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.plugin.terminallocation.mlp.timer.TimerHandler - Cleanup timer started. delay: 30000
    31 Jan 2012 10:06:09,771 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_481581280]Try to send PDU Request: (enquirelink: (pdu: 0 15 0 233) )
    31 Jan 2012 10:06:09,771 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1ccceefd] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_481581280]PDU sequence number reseted: 233 --> 52
    31 Jan 2012 10:06:09,771 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1ccceefd] DEBUG oracle.ocsg.protocol.networking.ChannelProcessorTimer - Cleanup timer started. delay(in milliseconds): 20000
    31 Jan 2012 10:06:09,771 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1ccceefd] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_481581280]Sending PDU Request: (enquirelink: (pdu: 0 15 0 52) )
    31 Jan 2012 10:06:09,771 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1ccceefd] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - Will try to write 16 bytes.
    31 Jan 2012 10:06:09,771 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1ccceefd] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 16 bytes written.
    31 Jan 2012 10:06:09,943 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 16 bytes read.
    31 Jan 2012 10:06:09,943 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_481581280]Receive PDU success, PDU: (enquirelink_resp: (pdu: 16 80000015 0 52) )
    31 Jan 2012 10:06:09,943 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 0 bytes read.
    31 Jan 2012 10:06:09,943 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc0525] DEBUG oracle.ocsg.protocol.networking.ChannelProcessorTimer - Cleanup timer started. delay(in milliseconds): 60000
    31 Jan 2012 10:06:09,943 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc0525] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_481581280]Removing request from cache since response returned, SequenceNumber: 52
    31 Jan 2012 10:06:09,943 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc0525] DEBUG oracle.ocsg.protocol.smpp.south.SouthPduTask - [ConnectionId: c_192.168.150.129:2775_481581280]Receive ENQUIRE_LINK_RESP, do nothing.
    31 Jan 2012 10:06:09,943 [[ACTIVE] ExecuteThread: '21' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - Interest operations set to 1
    31 Jan 2012 10:06:11,618 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.storage.common.DbLockManager - Got db lock: -180666158|com.bea.wlcp.wlng.plugin.terminallocation.mlp.store.TerminalLocationStoreImpl
    31 Jan 2012 10:06:11,621 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.storage.common.DbLockManager - Removed rows: 1
    31 Jan 2012 10:06:11,624 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.plugin.terminallocation.mlp.timer.TimerHandler - Cleanup timer started. delay: 30000
    31 Jan 2012 10:06:12,974 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Try to send PDU Request: (enquirelink: (pdu: 0 15 0 234) )
    31 Jan 2012 10:06:12,974 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]PDU sequence number reseted: 234 --> 52
    31 Jan 2012 10:06:12,974 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.networking.ChannelProcessorTimer - Cleanup timer started. delay(in milliseconds): 20000
    31 Jan 2012 10:06:12,974 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Sending PDU Request: (enquirelink: (pdu: 0 15 0 52) )
    31 Jan 2012 10:06:12,974 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - Will try to write 16 bytes.
    31 Jan 2012 10:06:12,974 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbd0205] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 16 bytes written.
    31 Jan 2012 10:06:12,975 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 16 bytes read.
    31 Jan 2012 10:06:12,975 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Receive PDU success, PDU: (enquirelink_resp: (pdu: 16 80000015 0 52) )
    31 Jan 2012 10:06:12,975 [[ACTIVE] ExecuteThread: '7' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - 0 bytes read.
    31 Jan 2012 10:06:12,975 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc5686] DEBUG oracle.ocsg.protocol.networking.ChannelProcessorTimer - Cleanup timer started. delay(in milliseconds): 60000
    31 Jan 2012 10:06:12,975 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc5686] DEBUG oracle.ocsg.protocol.smpp.SMPPChannelProcessor - [ConnectionId: c_192.168.150.129:2775_482745820]Removing request from cache since response returned, SequenceNumber: 52
    31 Jan 2012 10:06:12,975 [weblogic.work.j2ee.J2EEWorkManager$WorkWithListener@1cbc5686] DEBUG oracle.ocsg.protocol.smpp.south.SouthPduTask - [ConnectionId: c_192.168.150.129:2775_482745820]Receive ENQUIRE_LINK_RESP, do nothing.
    31 Jan 2012 10:06:12,975 [[ACTIVE] ExecuteThread: '21' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.protocol.networking.ChannelBridgeImpl - Interest operations set to 1
    31 Jan 2012 10:06:40,899 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.oauth2.interceptor.OAuth2Interceptor - OAuth2Interceptor invoke
    31 Jan 2012 10:06:40,899 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG oracle.ocsg.oauth2.interceptor.OAuth2Interceptor - Unknown token type: null
    31 Jan 2012 10:06:40,899 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] WARN com.bea.wlcp.wlng.util.EJBHelper - Failed to process request
    com.bea.wlcp.wlng.api.plugin.DenyPluginException: Application instance does not exist
    at com.bea.wlcp.wlng.interceptor.EnforceApplicationState.invoke(EnforceApplicationState.java:36)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at com.bea.wlcp.wlng.interceptor.ValidateRequestUsingRequestFactory.invoke(ValidateRequestUsingRequestFactory.java:41)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at oracle.ocsg.oauth2.interceptor.OAuth2Interceptor.invoke(OAuth2Interceptor.java:98)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at com.bea.wlcp.wlng.interceptor.CreatePluginList.invoke(CreatePluginList.java:60)
    at com.bea.wlcp.wlng.plugin.PluginManagerImpl.invokeInterceptors(PluginManagerImpl.java:121)
    at com.bea.wlcp.wlng.plugin.PluginManagerImpl.processRequest(PluginManagerImpl.java:96)
    at com.bea.wlcp.wlng.util.EJBHelper.processRequest(EJBHelper.java:42)
    at com.bea.wlcp.wlng.px21.ejb.SendSmsEjbImpl.sendSms(SendSmsEjbImpl.java:79)
    at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl.sendSms(SendSms_25ojqb_EOImpl.java:283)
    at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl_WLSkel.invoke(Unknown Source)
    at weblogic.rmi.internal.BasicServerRef.invoke(BasicServerRef.java:590)
    at weblogic.rmi.cluster.ClusterableServerRef.invoke(ClusterableServerRef.java:230)
    at weblogic.rmi.internal.BasicServerRef$1.run(BasicServerRef.java:478)
    at weblogic.security.acl.internal.AuthenticatedSubject.doAs(AuthenticatedSubject.java:363)
    at weblogic.security.service.SecurityManager.runAs(SecurityManager.java:147)
    at weblogic.rmi.internal.BasicServerRef.handleRequest(BasicServerRef.java:473)
    at weblogic.rmi.internal.wls.WLSExecuteRequest.run(WLSExecuteRequest.java:119)
    at weblogic.work.ExecuteThread.execute(ExecuteThread.java:201)
    at weblogic.work.ExecuteThread.run(ExecuteThread.java:173)
    31 Jan 2012 10:06:40,899 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.px21.common.PxRequestFactory - Internal exception
    com.bea.wlcp.wlng.api.plugin.DenyPluginException: Application instance does not exist
    at com.bea.wlcp.wlng.interceptor.EnforceApplicationState.invoke(EnforceApplicationState.java:36)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at com.bea.wlcp.wlng.interceptor.ValidateRequestUsingRequestFactory.invoke(ValidateRequestUsingRequestFactory.java:41)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at oracle.ocsg.oauth2.interceptor.OAuth2Interceptor.invoke(OAuth2Interceptor.java:98)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at com.bea.wlcp.wlng.interceptor.CreatePluginList.invoke(CreatePluginList.java:60)
    at com.bea.wlcp.wlng.plugin.PluginManagerImpl.invokeInterceptors(PluginManagerImpl.java:121)
    at com.bea.wlcp.wlng.plugin.PluginManagerImpl.processRequest(PluginManagerImpl.java:96)
    at com.bea.wlcp.wlng.util.EJBHelper.processRequest(EJBHelper.java:42)
    at com.bea.wlcp.wlng.px21.ejb.SendSmsEjbImpl.sendSms(SendSmsEjbImpl.java:79)
    at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl.sendSms(SendSms_25ojqb_EOImpl.java:283)
    at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl_WLSkel.invoke(Unknown Source)
    at weblogic.rmi.internal.BasicServerRef.invoke(BasicServerRef.java:590)
    at weblogic.rmi.cluster.ClusterableServerRef.invoke(ClusterableServerRef.java:230)
    at weblogic.rmi.internal.BasicServerRef$1.run(BasicServerRef.java:478)
    at weblogic.security.acl.internal.AuthenticatedSubject.doAs(AuthenticatedSubject.java:363)
    at weblogic.security.service.SecurityManager.runAs(SecurityManager.java:147)
    at weblogic.rmi.internal.BasicServerRef.handleRequest(BasicServerRef.java:473)
    at weblogic.rmi.internal.wls.WLSExecuteRequest.run(WLSExecuteRequest.java:119)
    at weblogic.work.ExecuteThread.execute(ExecuteThread.java:201)
    at weblogic.work.ExecuteThread.run(ExecuteThread.java:173)
    31 Jan 2012 10:06:40,899 [[ACTIVE] ExecuteThread: '16' for queue: 'weblogic.kernel.Default (self-tuning)'] DEBUG com.bea.wlcp.wlng.px21.common.PxRequestFactory - Policy denial with code: 1
    com.bea.wlcp.wlng.api.plugin.DenyPluginException: Application instance does not exist
    at com.bea.wlcp.wlng.interceptor.EnforceApplicationState.invoke(EnforceApplicationState.java:36)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at com.bea.wlcp.wlng.interceptor.ValidateRequestUsingRequestFactory.invoke(ValidateRequestUsingRequestFactory.java:41)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at oracle.ocsg.oauth2.interceptor.OAuth2Interceptor.invoke(OAuth2Interceptor.java:98)
    at com.bea.wlcp.wlng.interceptor.ContextImpl.invokeNext(ContextImpl.java:87)
    at com.bea.wlcp.wlng.interceptor.CreatePluginList.invoke(CreatePluginList.java:60)
    at com.bea.wlcp.wlng.plugin.PluginManagerImpl.invokeInterceptors(PluginManagerImpl.java:121)
    at com.bea.wlcp.wlng.plugin.PluginManagerImpl.processRequest(PluginManagerImpl.java:96)
    at com.bea.wlcp.wlng.util.EJBHelper.processRequest(EJBHelper.java:42)
    at com.bea.wlcp.wlng.px21.ejb.SendSmsEjbImpl.sendSms(SendSmsEjbImpl.java:79)
    at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl.sendSms(SendSms_25ojqb_EOImpl.java:283)
    at com.bea.wlcp.wlng.px21.ejb.SendSms_25ojqb_EOImpl_WLSkel.invoke(Unknown Source)
    at weblogic.rmi.internal.BasicServerRef.invoke(BasicServerRef.java:590)
    at weblogic.rmi.cluster.ClusterableServerRef.invoke(ClusterableServerRef.java:230)
    at weblogic.rmi.internal.BasicServerRef$1.run(BasicServerRef.java:478)
    at weblogic.security.acl.internal.AuthenticatedSubject.doAs(AuthenticatedSubject.java:363)
    at weblogic.security.service.SecurityManager.runAs(SecurityManager.java:147)
    at weblogic.rmi.internal.BasicServerRef.handleRequest(BasicServerRef.java:473)
    at weblogic.rmi.internal.wls.WLSExecuteRequest.run(WLSExecuteRequest.java:119)
    at weblogic.work.ExecuteThread.execute(ExecuteThread.java:201)
    at weblogic.work.ExecuteThread.run(ExecuteThread.java:173)

Legend

  • Correct Answers - 10 points
  • Helpful Answers - 5 points