1 Reply Latest reply: Jan 31, 2012 9:46 AM by 914348 RSS

    OCSG 5.0.0.1 Policy error 1

    914348
      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
          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)