DB: Oracle 11.2.0.1

OS: Redhat Linux 5.3 64bit

異常:

阳春三月的周末,正准备出门踏青,突然接到用户的电话说一个程序使用中报错ORA-03113,但其它功能程式可正常使用。

检查DB日志alert.log:

Sat Apr 14 10:43:04 2018

Errors in file

/u01/product/diag/rdbms/orcl/orcl/trace/orcl_ora_2189.trc  (incident=386284):

ORA-03137: TTC 协议内部错误: [12333] [12] [48] [48] [] [] [] []

Sat Apr 14 10:43:05 2018

Sweep [inc][386284]: completed

Sat Apr 14 10:43:09 2018

Errors in file

/u01/product/diag/rdbms/orcl/orcl/trace/orcl_ora_2244.trc  (incident=386371):

ORA-03137: TTC 协议内部错误: [12333] [12] [48] [48] [] [] [] []

Sat Apr 14 10:44:05 2018

Sweep [inc][386371]: completed

使用oerr查看报错说明,哇,错误解决要联系Oracle Support Services。。。

$oerr ora 3137

03137, 00000, "TTC protocol internal error :

[%s] [%s] [%s] [%s] [%s] [%s] [%s] [%s]"

// *Cause:

TTC protocol internal error.

// *Action: Contact Oracle Support Services.

还是先自己看看吧,进一步查看报错生产的trc文件:

Trace file

/u01/product/diag/rdbms/orcl/orcl/trace/orcl_ora_2189.trc

Oracle Database 11g Enterprise Edition Release

11.2.0.1.0 - 64bit Production

With the Partitioning, Oracle Label Security, OLAP,

Data Mining,

Oracle Database Vault and Real Application Testing

options

ORACLE_HOME = /u01/product/oracle

System name:  Linux

Node name:     SFCDB

Release:  2.6.18-128.el5

Version:   #1

SMP Wed Dec 17 11:41:38 EST 2008

Machine: x86_64

Instance name: orcl

Redo thread mounted by this instance: 1

Oracle process number: 194

Unix process pid: 2189, image: oracle@SFCDB

*** 2018-04-14 10:43:04.436

*** SESSION ID:(197.17986) 2018-04-14 10:43:04.436

*** CLIENT ID:() 2018-04-14 10:43:04.436

*** SERVICE NAME:(orcl) 2018-04-14 10:43:04.436

*** MODULE NAME:(DFMS.exe) 2018-04-14 10:43:04.436

*** ACTION NAME:() 2018-04-14 10:43:04.436

--- PROTOCOL VIOLATION DETECTED ---

----- Dump Cursor sql_id=9pmx42bttx2stxsc=0x2b48f67503b8cur=0x2b48f6381c50 -----

LibraryHandle:

Address=2bd38090 Hash=f39e8b19 LockMode=N PinMode=0 LoadLockMode=0

Status=VALD

ObjectName:  Name= Select

serial_number from R_SN_LASER_CARVING_PRINT_T

WHERE MO_NUMBER=:MO AND STATE_FLAG='0' ORDER BY SERIAL_NUMBER ASC

FullHashValue=12484201093a22129acfa412f39e8b19 Namespace=SQL AREA(00)

Type=CURSOR(00) Identifier=4087253785 OwnerIdn=91

Statistics:  InvalidationCount=17

ExecutionCount=42034 LoadCount=57 ActiveLocks=1 TotalLockCount=831

TotalPinCount=1

Counters:  BrokenCount=1

RevocablePointer=1 KeepDependency=4 KeepHandle=4 BucketInUse=824

HandleInUse=824

Concurrency:  DependencyMutex=2bd38140(0,

0, 0, 0) Mutex=2bd381b8(197, 6821, 0, 6)

Flags=RON/PIN/TIM/PN0/DBN/[10012841]

WaitersLists:

Lock=2bd38120[2bd38120,2bd38120]

Pin=2bd38130[2bd38100,2bd38100]

Timestamp:  Current=03-30-2018

15:42:57

LibraryObject:  Address=282e40b0

HeapMask=0000-0001-0001 Flags=EXS[0000] Flags2=[0000] PublicFlags=[0000]

ChildTable:  size='16'

Child:  id='0' Table=282e4f60

Reference=282e4a00 Handle=2bd37e90

Child:  id='1' Table=282e4f60

Reference=282e4d28 Handle=8755c338

Child:  id='2' Table=282e4f60

Reference=28f1ef18 Handle=628e66f0

Child:  id='3' Table=282e4f60

Reference=382cf368 Handle=87e39fa0

Children:

Child:  childNum='0'

LibraryHandle:  Address=2bd37e90

Hash=0 LockMode=0 PinMode=0 LoadLockMode=0 Status=VALD

Name:  Namespace=SQL AREA(00)

Type=CURSOR(00)

Statistics:  InvalidationCount=0

ExecutionCount=100 LoadCount=19 ActiveLocks=0 TotalLockCount=388

TotalPinCount=15647

Counters:  BrokenCount=1 RevocablePointer=1

KeepDependency=0 KeepHandle=0 BucketInUse=0 HandleInUse=0

Concurrency:

DependencyMutex=2bd37f40(0, 0, 0, 0) Mutex=2bd381b8(197, 6821, 0, 6)

Flags=RON/PIN/PN0/EXP/[10012111]

WaitersLists:

Lock=2bd37f20[2bd37f20,2bd37f20]

Pin=2bd37f30[2bd37f00,2bd37f00]

LibraryObject:  Address=386860b0

HeapMask=0000-0001-0001 Flags=EXS[0000] Flags2=[0000] PublicFlags=[0000]

NamespaceDump:

Child Cursor:  Heap0=0x138686198

Heap6=0x12bd37e90 Heap0 Load Time=04-14-2018 08:57:09 Heap6 Load

Time=04-14-2018 08:57:09

Child:  childNum='1'

LibraryHandle:  Address=8755c338

Hash=0 LockMode=0 PinMode=0 LoadLockMode=0 Status=VALD

Name:  Namespace=SQL AREA(00)

Type=CURSOR(00)

Statistics:  InvalidationCount=0

ExecutionCount=72 LoadCount=15 ActiveLocks=0 TotalLockCount=495

TotalPinCount=22196

Counters:  BrokenCount=1

RevocablePointer=1 KeepDependency=0 KeepHandle=0 BucketInUse=0 HandleInUse=0

Concurrency:

DependencyMutex=8755c3e8(0, 0, 0, 0) Mutex=2bd381b8(197, 6821, 0, 6)

Flags=RON/PIN/PN0/EXP/[10012111]

WaitersLists:

Lock=8755c3c8[8755c3c8,8755c3c8]

Pin=8755c3d8[8755c3a8,8755c3a8]

LibraryObject:  Address=564f97c0

HeapMask=0000-0001-0001 Flags=EXS[0000] Flags2=[0000] PublicFlags=[0000]

NamespaceDump:

Child Cursor:  Heap0=0x1564f98a8

Heap6=0x1227353c0 Heap0 Load Time=04-14-2018 09:46:29 Heap6 Load

Time=04-14-2018 10:02:56

Child:  childNum='2'

LibraryHandle:  Address=628e66f0

Hash=0 LockMode=0 PinMode=0 LoadLockMode=0 Status=VALD

Name:  Namespace=SQL AREA(00)

Type=CURSOR(00)

Statistics:

InvalidationCount=0 ExecutionCount=1810 LoadCount=3 ActiveLocks=0

TotalLockCount=123 TotalPinCount=3063

Counters:  BrokenCount=1

RevocablePointer=1 KeepDependency=0 KeepHandle=0 BucketInUse=0 HandleInUse=0

Concurrency:  DependencyMutex=628e67a0(0,

0, 0, 0) Mutex=2bd381b8(197, 6821, 0, 6)

Flags=RON/PIN/PN0/EXP/[10012111]

WaitersLists:

Lock=628e6780[628e6780,628e6780]

Pin=628e6790[628e6760,628e6760]

LibraryObject:  Address=56bc87c0

HeapMask=0000-0001-0001 Flags=EXS/RIV[0200] Flags2=[0000] PublicFlags=[0000]

NamespaceDump:

Child Cursor:  Heap0=0x156bc88a8

Heap6=0x1273bb830 Heap0 Load Time=04-13-2018 16:50:25 Heap6 Load

Time=04-13-2018 16:50:25

Child:  childNum='3'

LibraryHandle:  Address=87e39fa0

Hash=0 LockMode=N PinMode=S LoadLockMode=0 Status=VALD

Name:  Namespace=SQL AREA(00)

Type=CURSOR(00)

Statistics:  InvalidationCount=17

ExecutionCount=1 LoadCount=19 ActiveLocks=1 TotalLockCount=44

TotalPinCount=1379

Counters:  BrokenCount=18

RevocablePointer=18 KeepDependency=0 KeepHandle=0 BucketInUse=0 HandleInUse=0

Concurrency:

DependencyMutex=87e3a050(0, 0, 0, 0) Mutex=2bd381b8(197, 6821, 0, 6)

Flags=RON/PIN/PN0/EXP/[10012111]

WaitersLists:

Lock=87e3a030[87e3a030,87e3a030]

Pin=87e3a040[87e3a010,87e3a010]

LibraryObject:  Address=28c070b0 HeapMask=0000-0001-0001

Flags=EXS[0000] Flags2=[0000] PublicFlags=[0000]

DataBlocks:

Block:  #='0' name=CCUR^f39e8b19

pins=0 Change=NONE

Heap=62727f48 Pointer=28c07198 Extent=28c07030 Flags=I/-/P/A/-/-

FreedLocation=0 Alloc=6.078125 Size=7.898438 LoadTime=5587806980

Block:  #='6' name=SQLA^f39e8b19

pins=0 Change=NONE

Heap=382cf208 Pointer=3d58d7e0 Extent=3d58cb80 Flags=I/-/P/A/-/E

FreedLocation=0 Alloc=11.820312 Size=15.820312 LoadTime=0

NamespaceDump:

Child Cursor:  Heap0=0x128c07198

Heap6=0x13d58d7e0 Heap0 Load Time=04-14-2018 10:43:04 Heap6 Load

Time=04-14-2018 10:43:04

NamespaceDump:

Parent

Cursor:  sql_id=9pmx42bttx2st

parent=0x1282e4198 maxchild=4 plk=y ppn=n

Current

Cursor Sharing Diagnostics Nodes:

Child

Node: 2  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 1  ID=40reason=Bind mismatch(33) size=2x4

init ranges in first pass: 1

selectivity: 0

Aged

Out Cursor Sharing Diagnostic Nodes:

Child

Node: 3  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 2  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(3) size=2x4

invalidation window(kglobitm): 1523507948

ksugctm(): 1523508173

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 1  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(3) size=2x4

invalidation window(kglobitm): 1523245310

ksugctm(): 1523246431

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(3) size=2x4

invalidation window(kglobitm): 1523163964

ksugctm(): 1523163994

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 2  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(3) size=2x4

invalidation window(kglobitm): 1523055454

ksugctm(): 1523061100

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child Node: 0

ID=34 reason=Rolling Invalidate Window Exceeded(3) size=2x4

invalidation window(kglobitm): 1522536383

ksugctm(): 1522539662

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(3) size=2x4

invalidation window(kglobitm): 1522500785

ksugctm(): 1522501236

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

Child

Node: 1  ID=34 reason=Rolling Invalidate

Window Exceeded(2) size=0x0

already processed:

Child

Node: 0  ID=40 reason=Bind mismatch(25)

size=0x0

extended cursor sharing:

kkscs=0x1282e46a0 nxt=0x1282e4a98 flg=11 cld=0 hd=0x12bd37e90

par=0x1282e4198

Mutex

0x1282e46a0(0, 0) idn 3000000000

ct=39

hsh=0 unp=(nil) unn=0 hvl=28f1efd8 nhv=0 ses=(nil)

hep=0x1282e4730 flg=80 ld=0 ob=(nil) ptr=(nil) fex=(nil)

kkscs=0x1282e4a98 nxt=0x128f1ec88 flg=14 cld=1 hd=0x18755c338

par=0x1282e4198

Mutex

0x1282e4a98(0, 0) idn 0

ct=27

hsh=0 unp=(nil) unn=0 hvl=282e4f40 nhv=1 ses=0x185997c88

hsv[0]=0

hep=0x1282e4b28 flg=80 ld=1 ob=0x1564f97c0 ptr=0x1227353c0

fex=0x122734760

kkscs=0x128f1ec88 nxt=0x1382cf0d8 flg=18 cld=2 hd=0x1628e66f0

par=0x1282e4198

Mutex

0x128f1ec88(0, 0) idn 100000000

ct=24

hsh=0 unp=(nil) unn=0 hvl=282e4ff8 nhv=0 ses=(nil)

hep=0x128f1ed18 flg=80 ld=1 ob=0x156bc87c0 ptr=0x1273bb830

fex=0x1273babd0

kkscs=0x1382cf0d8 nxt=(nil) flg=18 cld=3 hd=0x187e39fa0 par=0x1282e4198

Mutex

0x1382cf0d8(0, 0) idn 100000000

ct=39

hsh=0 unp=(nil) unn=0 hvl=28f1eff8 nhv=0 ses=(nil)

hep=0x1382cf168 flg=80 ld=1 ob=0x128c070b0 ptr=0x13d58d7e0

fex=0x13d58cb80

cursor instantiation=0x2b48f67503b8 used=1523673783

exec_id=16819249 exec=1

child#3(0x187e39fa0) pcs=0x1382cf0d8

clk=0x18ac132b8 ci=0x128c07198 pn=0x18a2c3760 ctx=0x13d58d7e0

kgsccflg=0

llk[0x2b48f67503c0,0x2b48f67503c0] idx=0

xscflg=c0110676 fl2=5d000008 fl3=42222008

fl4=180

sharing failure(s)=800000040000

----- Bind Info (kkscoacd) -----

Bind#0

oacdty=01

mxl=128(72) mxlc=00 mal=00 scl=00 pre=00

oacflg=03

fl2=1000010 frm=01 csi=873 siz=128 off=0

kxsbbbfp=2b48f6768b68

bln=128  avl=00  flg=05

Frames pfr

0x2b48f6768f90 siz=5448 efr 0x2b48f6768ed0 siz=5432

kxscphp=0x2b48f6390290 siz=984 inu=376 nps=328

kxscbhp=0x2b48f67397e8 siz=984 inu=272 nps=152

kxscwhp=0x2b48f67398d8 siz=4056 inu=1000

nps=608

Starting SQL statement dump

SQL Information

user_id=91 user_name=MPROGRAM module=DFMS.exe

action=

sql_id=9pmx42bttx2st plan_hash_value=-307866389

problem_type=4

----- Current SQL Statement for this session

(sql_id=9pmx42bttx2st) -----

Select

serial_number from R_SN_LASER_CARVING_PRINT_T

WHERE MO_NUMBER=:MO AND STATE_FLAG='0' ORDER BY SERIAL_NUMBER ASC

sql_text_length=121

sql= Select serial_number from

R_SN_LASER_CARVING_PRINT_T  WHERE

MO_NUMBER=:MO AND STATE_FLAG='0' ORDER BY SERIAL_NUMBER ASC

Compilation Environment Dump

............

====================== END SQL Statement Dump

======================

ttcdrvdmplocation: msg-12 ln-1004 reporting 12333

Dumping 'Buffer dump info:' addr=0x146a3b60

size=267 bytes

Dump of memory from 0x146a3b60 to 0x146a3c6c

0146A3B60 01636911 00000001 00000006 69645E03  [.ic..........^di]

0146A3B70 00000080 01000000 00000168 00000C01  [........h.......]

0146A3B80 00010000 00000000 00000000 01000000  [................]

0146A3B90 00000001 00000000 00000101 40FE0000  [...............@]

0146A3BA0 6C655320 20746365 69726573 6E5F6C61  [ Select serial_n]

0146A3BB0 65626D75 72662072 52206D6F 5F4E535F  [umber from R_SN_]

0146A3BC0 4553414C 41435F52 4E495652 52505F47  [LASER_CARVING_PR]

0146A3BD0 5F544E49 57202054 45524548 5F4F4D20  [INT_T

WHERE MO_]

0146A3BE0 4D554E38 3D524542 204F4D3A 20444E41  [8NUMBER=:MO AND ]

0146A3BF0 54415453 4C465F45 273D4741 4F202730  [STATE_FLAG='0' O]

0146A3C00 52454452 20594220 49524553 4E5F4C41  [RDER BY SERIAL_N]

0146A3C10 45424D55 53412052 00010043 00000000  [UMBER ASC.......]

0146A3C20 00000000 00000000 00000000 00000000  [................]

0146A3C30 00000000 00010000 00000000 00000000  [................]

0146A3C40 00000000 00000000 03010000 00480000  [..............H.]

0146A3C50 00000000 00100000 00000000 00000000  [................]

0146A3C60 00010369 07000000 3030300C           [i........000]

Dumping 'Buffer dump info:' addr=0x146a3c6b size=10

bytes

Dump of memory from 0x146a3c68 to 0x146a3c78

0146A3C60                   3030300C 30393436          [.0006490]

0146A3C70 34303431 49565231                    [14041RVI]

Dumping 'Buffer dump info:' addr=0x146a4380

size=198 bytes

Dump of memory from 0x146a4380 to 0x146a4448

0146A4380 42011710 22121248 A412093A 8B199ACF  [...BH..":.......]

0146A4390 7678F39E 2C0B0E04 00001E05 00000100  [..xv...,........]

0146A43A0 80015100 001E0000 00000000 00000000  [.Q..............]

0146A43B0 00000000 00000000 1E010369 01000000  [........i.......]

0146A43C0 00000D0D 45530D00 4C414952 4D554E5F  [......SERIAL_NUM]

0146A43D0 00524542 00000000 07000000 07000000  [BER.............]

0146A43E0 0E047678 08052C0B 12B00006 0AE7368C  [xv...,.......6..]

0146A43F0 00050000 00000000 00000000 00000000  [................]

0146A4400 00000000 01040000 00000000 00000000  [................]

0146A4410 00000000 1B000500 00000300 00000008  [................]

0146A4420 00000000 00000000 00000000 00000000  [................]

0146A4430 00006400 00000001 00000000 00000000  [.d..............]

0146A4440 00000000 2D410000                    [......A-]

hstflg:

0x40202d91

hstcflg: 0x00000000

hstpro:  6

hstccs:

(DESCRIPTION=(ADDRESS=(PROTOCOL=TCP)(HOST=192.168.0.100)(PORT=1526))(CONNECT_DATA=(SERVER=DEDICATED)(SERVICE_NAME=orcl)(CID=(PROGRAM=D:\lasercarving_NEW\DFMS.exe)(HOST=HG-PC)(USER=hg))))

--- dump of hsttti ---

00A9C7A90 00 04 01 0C 0E 09 0B 0F 04 0A 03 03 01 00

00 0A  [................]

00A9C7AA0 00 00 00 00 00 00 00 01 01 01 01 01 01 01

01 01  [................]

00A9C7AB0 06 06 00 00 00 00 00 07 03 03 00 00 00 00

00 00  [................]

00A9C7AC0 00 00 00 00 00 00 00 00 00 00 13 00 00 00

00 00  [................]

00A9C7AD0 00 00 00 00 0C 00 00 00 00 00 14 00 00 00

00 00  [................]

00A9C7AE0 00 00 00 00 00 00 00 00 00 00 00 0D 00 00

11 11  [................]

00A9C7AF0 04 09 00 00 00 00 05 00 22 00 12 00 13 13

15 15  [........".......]

00A9C7B00 17 17 17 17 21 03 00 00 03 13 13 13 00 00

00 00  [....!...........]

00A9C7B10 00 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7B20 00 00 04 2E 00 00 00 00 0F 0F 0F 1F 20 00

00 00  [............ ...]

00A9C7B30 00 00 00 00 00 00 00 00 00 00 00 00 0F 00

00 00  [................]

00A9C7B40 00 00 01 01 01 01 01 01 2A 2A 2A 2A 2A 2B

2B 00  [........*****++.]

00A9C7B50 00 00 00 23 23 23 00 00 00 00 00 00 00 00

00 00  [...###..........]

00A9C7B60 22 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  ["...............]

00A9C7B70 00 00 00 00 00 00 00 35 2A 00 00 00 00 00

00 00  [.......5*.......]

00A9C7B80 00 13 00 00 00 00 00 00 00 00 00 00 00 00

00 36  [...............6]

00A9C7B90 00 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7BA0 00 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7BB0 00 00 03 01 03 01 01 00 00 00 03 03 03 01

03 03  [................]

00A9C7BC0 03 03 02 01 03 03 03 03 03 03 00 03 03 03

03 01  [................]

00A9C7BD0 03 03 03 03 00 00 00 03 03 03 00 03 00 03

03 03  [................]

00A9C7BE0 03 03 01 03 03 03 03 01 00 03 01 00 03 01

00 00  [................]

00A9C7BF0 00 00 03 03 00 00 00 03 00 00 00 03 00 00

00 00  [................]

00A9C7C00 00 00 00 00 00 00 00 00 00 00 00 00 03 03

03 03  [................]

00A9C7C10 03 03 03 03 03 03 03 01 00 03 03 01 01 03

03 03  [................]

00A9C7C20 03 03 00 00 03 03 03 03 00 00 00 00 00 03

03 03  [................]

00A9C7C30 03 03 03 03 03 03 03 03 03 03 03 03 00 03

03 03  [................]

00A9C7C40 03 03 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7C50 00 03 03 00 00 00 03 03 03 03 03 03 03 03

03 03  [................]

00A9C7C60 00 00 03 03 03 03 03 03 03 03 03 03 03 03

03 03  [................]

00A9C7C70 03 03 03 03 03 03 03 00 00 00 03 03 03 03

03 03  [................]

00A9C7C80 00 00 03 00 03 03 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7C90 00 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7CA0 00 00 00 00 1A 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7CB0 00 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7CC0 00 00 00 00 00 00 00 00 00 00 00 00 00 00

00 00  [................]

00A9C7CD0 00 00 00 00 00 00 00 00 00 00                    [..........]

ttclxlccst:

873

ttclxrccst:

873

ttclxlncst:

2000

ttclxrncst:

2000

ttclxccl2nr:

1

ttclxccn2lr:

1

ttclxncl2nr:

1

ttclxncn2lr:

1

ttclxrccminbpc: 1

ttclxrccmaxbpc: 4

ttclxrncminbpc: 2

ttclxrncmaxbpc: 2

ttclxflags:

0x23

prev funcode: 0x5e

*** 2018-04-14 10:43:04.494

DDE: Problem Key 'ORA 3137 [12333]' was flood

controlled (0x2) (incident: 386284)

ORA-03137:

TTC :

[12333] [12] [48] [48] [] [] [] []

初步分析:

trc 文件中红色部分,基本说明绑定变量的SQL:因为Rolling Invalidate Window Exceeded(2) &Bind mismatch(33)最终导致sharing failure(s)=800000040000

常见Rolling Invalidate Window Exceeded原因:

常见Bind mismatch原因:

临时处理:

初步认为此块问题是SQL在Library cache中生成cursor失败相关,尝试刷新share pool:alter system flush shared_pool  (也可以使用dbms_sahred_pool.purge清理cursor)

刷新share pool后程式可以正常使用

长期处理:

查看官方 OERR: ORA-3137 "TTC protocol internal error : [n] []" Master Note (文档 ID 1388487.1)

引起ORA-3137报错的原因BUG很多种,根本解决还需要升级DB版本(部分问题只需要升级DB JDBC版本)

ID 1388487.1内容:Support Notes for ORA-3137

Client / server message exchanges use an Oracle specific protocol (TTC). ORA-3137 is reported if something unexpected is seen that does not conform to the expected protocol. The arguments in the error indicate what sort of issue was seen. Specifically "arg1" may be a number or a string indicating the problem seen, and arg2 onwards may give additional information about the error. The error can be raised by the client or server side of a connection.

ORA-3137 was introduced in 11g and replaces some earlier ORA-600 errors.

eg: A problem in 11g which reports ORA-3137 may have reported an ORA-600 with a similar first argument in 10g and earlier releases.

eg: An issue causing ORA-3137 [12333] in 11g may have reported as ORA-600 [12333] in 10g.

Some common example arguments are:

[12333]

This is one of the most common forms of the error. It indicates that we are about to read an new function request from the message but the function code seen is not a valid code. This can typically happen if the current message position has gotten out of sync for some reason.

[1010]

Similar to 12333 this typically implies that the message asked to execute some invalid operation.

[12209]

The message asked to map a cursor but the cursor number requested to be mapped is not valid.

Troubleshooting

As the error is typically related to some problem in the message exchange then for investigation purposes it is usually helpful to know:

Client version and product (eg: OCI, JDBC Thin, Pro, JDBC OCI etc..)

Server version

Details of patches applied at either end

Client and server traces and incident traces produced

Details of the logic / SQL of the code executing in the session around the failure time

If a problem is reproducible then it can be helpful to have NET trace from the client and server side for the problem dialogue as often an error depends on some sequence of events earlier in the message exchange. See Note:219968.1 for details of NET trace options.

When reporting ORA-3137 to Oracle collect evidence as described in the following document:

Note:1668523.1 - Checklist of Evidence to Supply for ORA-3137 Issues

Search Links for ORA-03137

The links below can be used to locate ORA-3137 in the documentation, and to search for documents that give more information about the error.

Database Bugs Related to ORA-03137

This section lists bugs that have been linked to error "ORA-3137" . Check any bug description carefully as this error can need a client side fix, a server side fix, or both depending on the issue.

You can restrict the list below to issues likely to affect one of the following versions by clicking the relevant button:

The list below shows bugs affecting any version.

There are 19 bugs listed.

NB

Prob

Bug

Fixed

Description

III

12.1.0.2.DBBP11, 12.2.0.1

ORA-3137 "TTC protocol internal error" [kpoal8-3] from 8i client to 12c server

IIII

12.2.0.1

Network related error like ORA-12592 or ORA-3137 or ORA-3106 may be signaled

IIII

12.2.0.1

ORA-3137 (varying arguments) / ORA-1460 (usually with ORA-1002) on the Database When Using Multii-Threaded OCI Application

II

12.1.0.2, 12.2.0.1

ORA-3137 [1010] from FGA on HS

III

12.1.0.2, 12.2.0.1

ORA-3113 / ORA-3137 when using "with function" and bind variables

IIII

11.2.0.3.11, 11.2.0.3.BP24, 11.2.0.4, 12.1.0.1

ORA-3137 [3149] on server due to bad bind attempt in client

III

11.2.0.2.8, 11.2.0.2.BP18, 11.2.0.3.BP11, 11.2.0.4, 12.1.0.1

ORA-3137 [12333] / ORA-600 [knclprstr:str] with fix 12337012 present at Streams target when using TIMESTAMP data

II

11.2.0.3, 12.1.0.1

ORA-3137:[12333] or ORA-3106 when long binds are used in updates that affect no rows

III

11.2.0.3, 12.1.0.1

ORA-3137 [12333] or bind variable interpreted as NULL using SQL with binds

IIII

11.1.0.7.8, 11.2.0.1.BP12, 11.2.0.2, 12.1.0.1

ORA-3137 [12333] or ORA-600 [kpobav-1] When Using Bind Peeking - superceded

II

11.2.0.3, 12.1.0.1

ORA-3137 [12333] using DRCP

III

11.2.0.2, 12.1.0.1

"No more data" / ORA-3137 using end to end metrics with JDBC Thin

IIII

11.2.0.2.8, 11.2.0.2.BP18, 11.2.0.3, 12.1.0.1

The wrong cursor may be executed by JDBC thin following a query timeout / ORA-3137 [12333]

IIII

11.2.0.2, 12.1.0.1

Additional diagnostics for ORA-3137 [12333] / OERI:12333

III

11.2.0.2, 12.1.0.1

ORA-3137 / ORA-600 [12333] from INSERT .. RETURNING / Procedure with OUT parameter

IIII

11.1.0.7.3, 11.2.0.1

ORA-3137 [12333] due to bind data not read from wire

II

11.2.0.1

Unexpected errors (ORA-3137 [12209]) after incorrect OCIStmtRelease following OCISessionRelease with DRCP

II

10.2.0.5, 11.2.0.1

OERI [12333] / ORA-3137 possible from multi table insert SQL with long binds

II

10.2.0.5, 11.1.0.7

OERI:12333 / client hang using OCILob() in multithreaded OCI client

'*' indicates that an alert exists for that issue.

'+' indicates a particularly notable issue / bug.

See Note:1944526.1 for details of other symbols used

注:本文以实际案例整理而成,因为笔者水平有限,文中如有不准确之处请包涵,如转载请注明原文出处

Logo

魔乐社区(Modelers.cn) 是一个中立、公益的人工智能社区,提供人工智能工具、模型、数据的托管、展示与应用协同服务,为人工智能开发及爱好者搭建开放的学习交流平台。社区通过理事会方式运作,由全产业链共同建设、共同运营、共同享有,推动国产AI生态繁荣发展。

更多推荐