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

Home -> Community -> Mailing Lists -> Oracle-L -> Re: Interpreting tkprof output???

Re: Interpreting tkprof output???

From: Ken Friday <ken.friday_at_TELDTA.COM>
Date: Thu, 11 Jan 1996 16:13:27 -0600
Message-Id: <9601112238.AA20980@alice.jcc.com>

     Amy,

     To answer your last question; because it was executed 30 times.

     The column headings are explained in the TKPROF output header. The
     rows are as follows:

     Parse is specific to parsing the SQL (syntax, table access, etc.) If
     possible you want to avoid parsing by retaining the cursor.

     Execute is the number of times the statement is executed (inserts,
     deletes, query, update).

     Fetch is   the actual returning of rows. Note you can have multiple
     fetches per execute. Also, if rows = fetches your not using array
     processing.

     This is documented in the "Application Developer's Guide".


______________________________ Reply Separator _________________________________
Subject: Interpreting tkprof output???
Author: "ORACLE database mailing list." <ORACLE-L%ccvm.sunysb.edu_at_internet.teldta.com> at TDSMAIL Date: 1/11/96 1:53 PM

Does anyone know how to interpret tkprof output? We are

    trying to determine why a program is so slow and this is     the output we get. Is it explained somewhere how to     interpret this? Probably in the Oracle Tuning and DBA     handbook, right?

TKPROF: Release 7.1.3.0.0 - Production on Thu Jan 11 09:20:46 1996

Copyright (c) Oracle Corporation 1979, 1994. All rights reserved.


count    = number of times OCI procedure was executed
cpu      = cpu time in seconds executing
elapsed  = elapsed time in seconds executing
disk     = number of physical reads of buffers from disk
query    = number of buffers gotten for consistent read
current  = number of buffers gotten in current mode (usually for update)
rows     = number of rows processed by the fetch or execute call
******************************************************************************

BEGIN FR_SUPPLY_ITEM_PKG.DOES_ROW_EXIST(:b1,:b2,:b3);END;

call count cpu elapsed disk query current rows
-------- ------- -------- --------- -------- -------- ------- ----------

Parse          37      0.02       0.02        0        0       0           0
Execute        66      0.24       0.28        3      228       0          66
Fetch           0      0.00       0.00        0        0       0           0


-------- ------- -------- --------- -------- -------- ------- ----------
total 103 0.26 0.30 3 228 0 66

Misses in library cache during parse: 0 Optimizer hint: CHOOSE
Parsing user id: 26 (ZM00484)


BEGIN FR_SUPPLY_ITEM_PKG.ADD_TO_SI(:b1,:b2,:b3,:b4,:b5,:b6,:b7,:b8,:b9,:b10,
  :b11,:b12,:b13,:b14,:b15,:b16,:b17,:b18,:b19,:b20,:b21,:b22,:b23,:b24,:b25,
  :b26,:b27,:b28,:b29,:b30,:b31,:b32,:b33,:b34,:b35,:b36,:b37,:b38,:b39,:b40,
  :b41,:b42,:b43,:b44,:b45,:b46,:b47,:b48,:b49,:b50,:b51,:b52);END;


call        count       cpu    elapsed     disk    query current        rows

-------- ------- -------- --------- -------- -------- ------- ----------
Parse 32 0.01 0.01 0 0 0 0 Execute 30 0.23 0.28 0 60 90 30 Fetch 0 0.00 0.00 0 0 0 0
-------- ------- -------- --------- -------- -------- ------- ----------
total 62 0.24 0.29 0 60 90 30

Misses in library cache during parse: 0 Optimizer hint: CHOOSE
Parsing user id: 26 (ZM00484)


BEGIN FR_SUPPLY_ITEM_DEMAND_PKG.ADD_ONE(:b1,:b2,:b3,:b4,:b5,:b6,:b7,:b8,:b9,   :b10,:b11);END;

call count cpu elapsed disk query current rows
-------- ------- -------- --------- -------- -------- ------- ----------

Parse          30      0.01       0.02        0        0       0           0
Execute        30      0.21       0.26        0       60      32          30
Fetch           0      0.00       0.00        0        0       0           0


-------- ------- -------- --------- -------- -------- ------- ----------
total 60 0.22 0.28 0 60 32 30

Misses in library cache during parse: 0 Optimizer hint: CHOOSE
Parsing user id: 26 (ZM00484)


BEGIN FR_STOCK_FISC_PKG.DOES_ROW_EXIST(:b1,:b2,:b3,:b4,:b5,:b6);END;

call count cpu elapsed disk query current rows
-------- ------- -------- --------- -------- -------- ------- ----------

Parse          30      0.00       0.00        0        0       0           0
Execute        64      0.18       0.26        9      255       0          64
Fetch           0      0.00       0.00        0        0       0           0


-------- ------- -------- --------- -------- -------- ------- ----------
total 94 0.18 0.26 9 255 0 64

Misses in library cache during parse: 0 Optimizer hint: CHOOSE
Parsing user id: 26 (ZM00484)


What is it trying to tell me? The ADD routines are only

    supposed to add one row - why does it say 30 under the     rows column? Thanks.

    Amy Received on Thu Jan 11 1996 - 17:39:04 CST

Original text of this message

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