Oracle-L: RE: TKPROF Question

From: Cary Millsap <cary.millsap_at_hotsos.com>
Date: Fri, 16 May 2003 18:36:42 -0800
Message-ID: <F001.0059BA87.20030516183642@fatcity.com>

Exactly. To be (only very slightly) more precise, the "SQL*Net message to client" event measures the duration of the OS write call upon the socket where SQL*Net runs. A write is fast: put a couple of bytes on the pipe and done. The "SQL*Net message from client" event measures the duration of the OS read call upon the same socket. A read call blocks from the time it is called until the function call returns.

Cary Millsap
Hotsos Enterprises, Ltd.
http://www.hotsos.com

Upcoming events:
- Hotsos Clinic <http://www.hotsos.com/training/clinic101> 101 in London,
Reykjavik, Ottawa, Dallas, Washington, Denver, Sydney
- Visit www.hotsos.com for schedule details...

-----Original Message-----
Djordje
Sent: Tuesday, May 13, 2003 4:13 PM
To: Multiple recipients of list ORACLE-L

The "to" time is how long it takes a message from the server to the client. The "from" time is from the client to the server. So if on the client you have an app that is waiting for user input, the time while the user is having a smoke break will account into the ale time "from" the client.

In 8i they are still in centiseconds, and in 9i they are in microseconds.

Djordje

-----Original Message-----
Sent: Tuesday, May 13, 2003 1:32 PM
To: Multiple recipients of list ORACLE-L

Hi,

Does anyone know how elapsed (ela=) times are accounted for 'SQL*Net message From|to client' event? I am getting a bit confused ... take a look at following snippet ... this is from at recent trace file ...

start --------------------------- /var/opt/oracle/logs/ACPT/acpt1_ora_1065044.trc Oracle9i Enterprise Edition Release 9.2.0.2.0 - 64bit Production With the Partitioning, Real Application Clusters, OLAP and Oracle Data Mining options JServer Release 9.2.0.2.0 - Production ORACLE_HOME = /usr/opt/oracle/from_prod System name: AIX Node name: rhea Release: 1 Version: 5 Instance name: ACPT1 Redo thread mounted by this instance: 1 Oracle process number: 26 Unix process pid: 1065044, image: oracle_at_rhea (TNS V1-V3)
- 2003-05-13 11:28:52.824
- SESSION ID:(30.210) 2003-05-13 11:28:52.823 APPNAME mod='sqlplus_at_rhea (TNS V1-V3)' mh=0 act='' ah=0
  PARSING IN CURSOR #1 len=68 dep=0 uid=0 oct=42 lid=0 tim=1028163801586912 hv=2212335334 ad='1c47abb8' alter session set events '10046 trace name context forever, level 8' END OF STMT EXEC #1:c=0,e=155,p=0,cr=0,cu=0,mis=1,r=0,dep=0,og=4,tim=1028163801585767 WAIT #1: nam='SQL*Net message to client' ela= 4 p1=1650815232 p2=1 p3=0 WAIT #1: nam='SQL*Net message from client' ela= 6560537 p1=1650815232 p2=1 p3=0 WAIT #1: nam='library cache lock' ela= 451 p1=504403158666149384 p2=504403158624270472 p3=1301 WAIT #1: nam='library cache lock' ela= 268 p1=504403158666149384 p2=504403158624270472 p3=1301 WAIT #1: nam='library cache lock' ela= 214 p1=504403158666149384 p2=504403158624270472 p3=1301 WAIT #1: nam='library cache lock' ela= 294 p1=504403158687435888 p2=504403158623466792 p3=1301 WAIT #1: nam='library cache lock' ela= 217 p1=504403158687435888 p2=504403158623466792 p3=1301 WAIT #1: nam='library cache pin' ela= 301 p1=504403158687435888 p2=504403158623763080 p3=201 WAIT #1: nam='row cache lock' ela= 725 p1=8 p2=0 p3=3 WAIT #5: nam='library cache lock' ela= 312 p1=504403158650677704 p2=504403158668902040 p3=1301 WAIT #5: nam='library cache lock' ela= 82 p1=504403158650677704 p2=504403158668902040 p3=1301
end ---------------------------

Why is the difference between ela= time for "to client" and "from client" this big?? I am assuming the ela= times are still in centi-seconds ...

Any help is greatly appreciated.
Raj

Rajendra dot Jamadagni at nospamespn dot com All Views expressed in this email are strictly personal. QOTD: Any clod can have facts, having an opinion is an art !

-- 
Please see the official ORACLE-L FAQ: http://www.orafaq.net
-- 
Author: Cary Millsap
  INET: cary.millsap_at_hotsos.com

Fat City Network Services    -- 858-538-5051 http://www.fatcity.com
San Diego, California        -- Mailing list and web hosting services
---------------------------------------------------------------------
To REMOVE yourself from this mailing list, send an E-Mail message
to: ListGuru_at_fatcity.com (note EXACT spelling of 'ListGuru') and in
the message BODY, include a line containing: UNSUB ORACLE-L
(or the name of mailing list you want to be removed from).  You may
also send the HELP command for other information (like subscribing).

Received on Fri May 16 2003 - 21:36:42 CDT