elapsed time 10046 trace - cheeyoung/sqlplus-public GitHub Wiki

Example 1

it takes 174.826,746 seconds between EXEC and 1st FETCH

CURSOR #11529215046017450040
  PARSING IN tim=5972912833568 hv=4083251573
  PARSE tim=5972912833566

  EXEC tim=5972912843091
  FETCH tim=5973087669837

174.826,746 (seconds)‬ = 5973087669837 (tim(estamp) of 1st FETCH) - 5972912843091 (tim(estamp) of EXEC)

...
   116  PARSING IN CURSOR #11529215046017450040 len=459 dep=0 uid=94 oct=3 lid=94 tim=5972912833568 hv=4083251573 ad='c00000033e8340c0' sqlid='9qygfnrtq2ybp'
   117  SELECT ...
...
   120  FROM ...
   121  WHERE ... = :b1
...
   127  ORDER BY ... DESC
   128  END OF STMT
   129  PARSE #11529215046017450040:c=0,e=398,p=0,cr=0,cu=0,mis=1,r=0,dep=0,og=1,plh=0,tim=5972912833566
   130  WAIT #11529215046017450040: nam='PGA memory operation' ela= 5 p1=65536 p2=1 p3=0 obj#=-1 tim=5972912836217
...
   208  WAIT #11529215046017450040: nam='PGA memory operation' ela= 4 p1=65536 p2=1 p3=0 obj#=-1 tim=5972912841435
...
   229  WAIT #11529215046017450040: nam='PGA memory operation' ela= 9 p1=65536 p2=2 p3=0 obj#=-1 tim=5972912842299
   230  BINDS #11529215046017450040:
   231
   232   Bind#0
   233    oacdty=01 mxl=128(40) mxlc=00 mal=00 scl=00 pre=00
   234    oacflg=03 fl2=1000000 frm=01 csi=840 siz=512 off=0
   235    kxsbbbfp=9ffffffffcb0fe00  bln=128  avl=07  flg=05
.
.
.
   252  EXEC #11529215046017450040:c=10000,e=9410,p=0,cr=9,cu=0,mis=1,r=0,dep=0,og=1,plh=3609504412,tim=5972912843091
   253  WAIT #11529215046017450040: nam='SQL*Net message to client' ela= 1 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=5972912843123
   254
   255  *** 2020-01-06T14:56:57.803713+09:00
   256  FETCH #11529215046017450040:c=169590000,e=174826689,p=0,cr=34,cu=0,mis=0,r=1,dep=0,og=1,plh=3609504412,tim=5973087669837
   257  WAIT #11529215046017450040: nam='SQL*Net message from client' ela= 481 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=5973087670581
   258  WAIT #11529215046017450040: nam='SQL*Net message to client' ela= 1 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=5973087670650
   259  FETCH #11529215046017450040:c=0,e=320,p=0,cr=16,cu=0,mis=0,r=1,dep=0,og=1,plh=3609504412,tim=5973087670955
...