Looks like (or at least one possible guess and I definitely mean guess)
is that the server sent info to the client with no delay, but had to
wait on response from the client. Was there some part of this activity
that waits on input from the client (like set pause on in sqlplus)?
>>> Rajendra.Jamadagni_at_espn.com 05/13/03 12:31PM >>>
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: Darrell Landrum
INET: DLANDRUM_at_zalecorp.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 Tue May 13 2003 - 16:02:15 CDT
