Oracle FAQ Your Portal to the Oracle Knowledge Grid
HOME | ASK QUESTION | ADD INFO | SEARCH | E-MAIL US
 

Home -> Community -> Usenet -> c.d.o.misc -> Re: Extproc & shared server mode

Re: Extproc & shared server mode

From: Dmitry Pavlov <dmitry.pavlov_at_gmail.com>
Date: 11 Mar 2005 00:26:21 -0800
Message-ID: <1110529581.915470.162290@z14g2000cwz.googlegroups.com> 





"None of them works" -- means I receive the same error in all cases
 ORA-28575: unable to open RPC connection to external procedure agent
And ELIST.log contains error message


 TNS-12519: TNS: no appropriate service handler found



I've turned on the traces (i.e. set TRACE_LEVEL_CLIENT,
TRACE_LEVEL_SERVER



and TRACE_LEVEL_ELIST to 16).


Server traces (svr_*.trc), don't actually differ (comparing them in
shared server mode and in dedicated mode). Client traces don't differ
too, so I do not post them.


Listener traces differ after the string 'nsglfc: Assume establishing a
connection: look for SID'. Here they are (date suppressed):



elist.trc in shared server mode:




[10:31:21:214] nsprecv: packet dump

[10:31:21:214] nsprecv: 00 CC 00 00 01 00 00 00  |........|

[10:31:21:214] nsprecv: 01 38 01 2C 08 01 20 00  |.8.,....|

[10:31:21:214] nsprecv: 7F FF 02 0E 00 00 01 00  |........|

[10:31:21:214] nsprecv: 00 92 00 3A 00 00 08 00  |...:....|

[10:31:21:214] nsprecv: 21 21 00 00 00 00 00 00  |!!......|

[10:31:21:214] nsprecv: 00 00 00 00 0A 84 00 00  |........|

[10:31:21:214] nsprecv: EB 89 00 00 00 00 00 00  |........|

[10:31:21:214] nsprecv: 00 00 28 44 45 53 43 52  |..(DESCR|

[10:31:21:214] nsprecv: 49 50 54 49 4F 4E 3D 28  |IPTION=(|

[10:31:21:214] nsprecv: 41 44 44 52 45 53 53 5F  |ADDRESS_|

[10:31:21:214] nsprecv: 4C 49 53 54 3D 29 28 43  |LIST=)(C|

[10:31:21:214] nsprecv: 4F 4E 4E 45 43 54 5F 44  |ONNECT_D|

[10:31:21:214] nsprecv: 41 54 41 3D 28 53 49 44  |ATA=(SID|

[10:31:21:214] nsprecv: 3D 50 4C 53 45 78 74 50  |=PLSExtP|

[10:31:21:214] nsprecv: 72 6F 63 29 28 50 52 45  |roc)(PRE|

[10:31:21:214] nsprecv: 53 45 4E 54 41 54 49 4F  |SENTATIO|

[10:31:21:214] nsprecv: 4E 3D 52 4F 29 28 53 45  |N=RO)(SE|

[10:31:21:214] nsprecv: 52 56 45 52 3D 53 48 41  |RVER=SHA|

[10:31:21:214] nsprecv: 52 45 44 29 28 43 49 44  |RED)(CID|

[10:31:21:214] nsprecv: 3D 28 50 52 4F 47 52 41  |=(PROGRA|

[10:31:21:214] nsprecv: 4D 3D 29 28 48 4F 53 54  |M=)(HOST|

[10:31:21:214] nsprecv: 3D 56 44 45 56 5C 56 4F  |=VDEV\VO|

[10:31:21:214] nsprecv: 2D 30 31 31 32 29 28 55  |-0112)(U|

[10:31:21:214] nsprecv: 53 45 52 3D 56 44 45 56  |SER=VDEV|

[10:31:21:214] nsprecv: 5C 64 70 61 76 6C 6F 76  |\dpavlov|

[10:31:21:214] nsprecv: 29 29 29 29              |))))    |

[10:31:21:214] nsprecv: normal exit

[10:31:21:214] nscon: got NSPTCN packet

[10:31:21:214] nsconneg: entry

[10:31:21:214] nsconneg: vsn=312, lov=300, opt=0x801, sdu=8192,

tdu=32767, ntc=0x20e


[10:31:21:214] nsconneg: vsn=312, gbl=0x801, sdu=8192, tdu=32767

[10:31:21:214] nsconneg: normal exit

[10:31:21:214] nscon: got 146 bytes connect data

[10:31:21:214] nscon: exit (0)

[10:31:21:214] nsdo: nsctxrnk=0

[10:31:21:214] nsdo: normal exit

[10:31:21:214] nsevdrcvreq: entry

[10:31:21:214] nsevdansw: exit

[10:31:21:214] nsevwait: event is 0x20, on 3

[10:31:21:214] nsevwait: 1 posted event(s)

[10:31:21:214] nsevwait: exit (0)

[10:31:21:214] nsglhe: entry

[10:31:21:214] nsglhe: Event on cxd 0xbb43e8.

[10:31:21:214] nsglfc: Assume establishing a connection: look for SID

[10:31:21:214] nsglfc: command = establish

[10:31:21:214] nsrefuse: entry

[10:31:21:214] nsdo: entry

[10:31:21:214] nsdo: cid=3, opcode=67, *bl=91, *what=10, uflgs=0x0,

cflgs=0x3


[10:31:21:214] nsdo: rank=64, nsctxrnk=0

[10:31:21:214] nsdo: nsctx: state=2, flg=0x4204, mvd=0

[10:31:21:214] nsdo: gtn=204, gtc=204, ptn=10, ptc=8191

[10:31:21:214] nscon: entry

[10:31:21:214] nscon: sending NSPTRF packet

[10:31:21:214] nspsend: entry

[10:31:21:214] nspsend: plen=103, type=4

[10:31:21:214] ntnwr: failed to write 103 bytes

[10:31:21:214] ntn2err: entry

[10:31:21:214] ntn2err: error: handle=208, op=6, nt[0]=524, nt[1]=997

[10:31:21:214] ntn2err: exit

[10:31:21:214] nsbal: entry

[10:31:21:214] nsbgetfl: entry

[10:31:21:214] nsbgetfl: normal exit

[10:31:21:214] nsmal: entry

[10:31:21:214] nsmal: 48 bytes at 0xbb7370

[10:31:21:214] nsmal: normal exit

[10:31:21:214] nsbal: normal exit

[10:31:21:214] nspsend: normal exit

[10:31:21:214] nscon: exit (0)

[10:31:21:214] nsdo: nsctxrnk=0

[10:31:21:214] nsdo: normal exit

[10:31:21:214] nsrah: entry

[10:31:21:214] nsrah: reading (asynchronously) from transport...

[10:31:21:214] nsrah: ...into overflow area...

[10:31:21:214] ntnrd: failed to read 8208 bytes

[10:31:21:214] ntn2err: entry

[10:31:21:214] ntn2err: error: handle=208, op=5, nt[0]=524, nt[1]=997

[10:31:21:214] ntn2err: exit

[10:31:21:214] nsrah: exit (0)

[10:31:21:214] nsclose: entry

[10:31:21:214] nstimarmed: entry

[10:31:21:214] nstimarmed: no timer allocated

[10:31:21:214] nstimarmed: normal exit

[10:31:21:214] nsdo: entry

[10:31:21:214] nsdo: cid=3, opcode=66, *bl=0, *what=0, uflgs=0x0,

cflgs=0x2


[10:31:21:214] nsdo: rank=64, nsctxrnk=0

[10:31:21:230] nsdo: nsctx: state=2, flg=0x4200, mvd=0

[10:31:21:230] nsevunreg: entry

[10:31:21:230] nsevunreg: cid=3, sgt=0, rdm=2

[10:31:21:230] nsrah: entry

[10:31:21:230] nsrah: re-setting transport read mode

[10:31:21:230] nsrah: cancelling read-ahead

[10:31:21:230] ntn2err: entry

[10:31:21:230] ntn2err: error: handle=208, op=5, nt[0]=507, nt[1]=109

[10:31:21:230] ntn2err: exit

[10:31:21:230] nsrah: normal exit

[10:31:21:230] nsevunreg: 2 registered connection(s)

[10:31:21:230] nsevunreg: exit (0)

[10:31:21:230] nsbfr: entry

[10:31:21:230] nsbaddfl: entry

[10:31:21:230] nsbaddfl: normal exit

[10:31:21:230] nsbfr: normal exit

[10:31:21:230] nsbfr: entry

[10:31:21:230] nsbaddfl: entry

[10:31:21:230] nsbaddfl: normal exit

[10:31:21:230] nsbfr: normal exit

[10:31:21:230] nsdo: nsctxrnk=0

[10:31:21:230] nsdo: normal exit

[10:31:21:230] nsclose: closing transport

[10:31:21:230] ntndisc: entry

[10:31:21:230] sntndisc: Error: Inconsistent trace parameters line:

11442696


[10:31:21:230] ntndisc: exit

[10:31:21:230] nsclose: global context check-out (from slot 3) complete

[10:31:21:230] nsnadisc: entry

[10:31:21:230] nsbfr: entry

[10:31:21:230] nsbaddfl: entry

[10:31:21:230] nsbaddfl: normal exit

[10:31:21:230] nsbfr: normal exit

[10:31:21:230] nsbfr: entry

[10:31:21:230] nsbaddfl: entry

[10:31:21:230] nsbaddfl: normal exit

[10:31:21:230] nsbfr: normal exit

[10:31:21:230] nsmfr: entry

[10:31:21:230] nsmfr: 2348 bytes at 0xbb5b90

[10:31:21:230] nsmfr: normal exit

[10:31:21:230] nsmfr: entry

[10:31:21:230] nsmfr: 504 bytes at 0xbb5990

[10:31:21:230] nsmfr: normal exit

[10:31:21:230] nsclose: normal exit

[10:31:21:230] nsrefuse: exit (0)

[10:31:21:230] nsglecmd: Deallocating cxd 0xbb43e8.

[10:31:21:230] nsglhe: exit

[10:31:21:230] nsevwait: entry

[10:31:21:230] nsevwait: 2 registered connection(s)

[10:31:21:230] nsevwait: 0 pre-posted event(s)

[10:31:21:230] nsevwait: waiting for transport event (0 thru 2)...




elist.trc in dedicated mode:




[10:50:14:816] nsprecv: packet dump

[10:50:14:816] nsprecv: 00 CF 00 00 01 00 00 00  |........|

[10:50:14:816] nsprecv: 01 38 01 2C 08 01 20 00  |.8.,....|

[10:50:14:816] nsprecv: 7F FF 02 0E 00 00 01 00  |........|

[10:50:14:816] nsprecv: 00 95 00 3A 00 00 08 00  |...:....|

[10:50:14:816] nsprecv: 21 21 00 00 00 00 00 00  |!!......|

[10:50:14:816] nsprecv: 00 00 00 00 07 2C 00 01  |.....,..|

[10:50:14:816] nsprecv: 12 D0 00 00 00 00 00 00  |........|

[10:50:14:816] nsprecv: 00 00 28 44 45 53 43 52  |..(DESCR|

[10:50:14:816] nsprecv: 49 50 54 49 4F 4E 3D 28  |IPTION=(|

[10:50:14:816] nsprecv: 41 44 44 52 45 53 53 5F  |ADDRESS_|

[10:50:14:816] nsprecv: 4C 49 53 54 3D 29 28 43  |LIST=)(C|

[10:50:14:816] nsprecv: 4F 4E 4E 45 43 54 5F 44  |ONNECT_D|

[10:50:14:816] nsprecv: 41 54 41 3D 28 53 49 44  |ATA=(SID|

[10:50:14:816] nsprecv: 3D 50 4C 53 45 78 74 50  |=PLSExtP|

[10:50:14:816] nsprecv: 72 6F 63 29 28 50 52 45  |roc)(PRE|

[10:50:14:816] nsprecv: 53 45 4E 54 41 54 49 4F  |SENTATIO|

[10:50:14:816] nsprecv: 4E 3D 52 4F 29 28 53 45  |N=RO)(SE|

[10:50:14:816] nsprecv: 52 56 45 52 3D 44 45 44  |RVER=DED|

[10:50:14:816] nsprecv: 49 43 41 54 45 44 29 28  |ICATED)(|

[10:50:14:816] nsprecv: 43 49 44 3D 28 50 52 4F  |CID=(PRO|

[10:50:14:816] nsprecv: 47 52 41 4D 3D 29 28 48  |GRAM=)(H|

[10:50:14:816] nsprecv: 4F 53 54 3D 56 44 45 56  |OST=VDEV|

[10:50:14:816] nsprecv: 5C 56 4F 2D 30 31 31 32  |\VO-0112|

[10:50:14:816] nsprecv: 29 28 55 53 45 52 3D 56  |)(USER=V|

[10:50:14:816] nsprecv: 44 45 56 5C 64 70 61 76  |DEV\dpav|

[10:50:14:816] nsprecv: 6C 6F 76 29 29 29 29     |lov)))) |

[10:50:14:816] nsprecv: normal exit

[10:50:14:816] nscon: got NSPTCN packet

[10:50:14:816] nsconneg: entry

[10:50:14:816] nsconneg: vsn=312, lov=300, opt=0x801, sdu=8192,

tdu=32767, ntc=0x20e


[10:50:14:816] nsconneg: vsn=312, gbl=0x801, sdu=8192, tdu=32767

[10:50:14:816] nsconneg: normal exit

[10:50:14:816] nscon: got 149 bytes connect data

[10:50:14:816] nscon: exit (0)

[10:50:14:816] nsdo: nsctxrnk=0

[10:50:14:816] nsdo: normal exit

[10:50:14:816] nsevdrcvreq: entry

[10:50:14:816] nsevdansw: exit

[10:50:14:816] nsevwait: event is 0x20, on 3

[10:50:14:816] nsevwait: 1 posted event(s)

[10:50:14:816] nsevwait: exit (0)

[10:50:14:816] nsglhe: entry

[10:50:14:816] nsglhe: Event on cxd 0xbb43e8.

[10:50:14:816] nsglfc: Assume establishing a connection: look for SID

[10:50:14:816] nsglfc: command = establish

[10:50:14:816] nsbequeath: entry

[10:50:14:816] nsc2addr: entry

[10:50:14:816] nlpcaini: entry

[10:50:14:816] nlpcaini: prg = ExtProc

[10:50:14:816] nlpcaini: arg[0] = ExtProcPLSExtProc

[10:50:14:816] nlpcaini: arg[1] = (LOCAL=NO)

[10:50:14:816] nlpcaini: env[0] = AGTCTL_ADMIN=C:\

[10:50:14:816] nlpcaini: exit

[10:50:14:816] nsc2addr: normal exit

[10:50:14:816] nsbeqaddr: entry

[10:50:14:816] nsbeqaddr: connecting...

[10:50:14:816] ntpcon: entry

[10:50:14:816] ntpcon: toc = 1

[10:50:14:816] sntpcall: entry

[10:50:14:816] snlpcss: entry

[10:50:14:816] snlpcss: exit

[10:50:14:816] sntpcall: Attempting to open pipe \\.\PIPE\ORANTP334.820

[10:50:14:863] sntpcall: Successfully established pipe 220 to child

[10:50:14:863] sntpcall: Attempting to open pipe

\\.\PIPE\ORANTP334.820.w


[10:50:14:863] sntpcall: Successfully established pipe 240 to child

[10:50:14:863] sntpcall: exit

[10:50:14:863] ntpcon: NT layer IPC connection has been established

[10:50:14:863] ntpcon: exit

[10:50:14:863] nsbeqaddr: doing connect handshake...

[10:50:14:863] nsbequeath: doing connect handshake...




sorry for my English :(



regards,

                                                        Dmitry


Received on Fri Mar 11 2005 - 02:26:21 CST












Original text of this message













  HOME |
  ASK QUESTION |
  ADD INFO |
  SEARCH |
  E-MAIL US