From oracle-l-bounce@freelists.org Tue Mar 30 05:28:40 2004 Return-Path: Received: from air189.startdedicated.com (root@localhost) by orafaq.com (8.11.6/8.11.6) with ESMTP id i2UBSd627530 for ; Tue, 30 Mar 2004 05:28:39 -0600 X-ClientAddr: 206.53.239.180 Received: from turing.freelists.org (freelists-180.iquest.net [206.53.239.180]) by air189.startdedicated.com (8.11.6/8.11.6) with ESMTP id i2UBSYo27519 for ; Tue, 30 Mar 2004 05:28:35 -0600 Received: from localhost (localhost [127.0.0.1]) by turing.freelists.org (Avenir Technologies Mail Multiplex) with ESMTP id CEE6063497A; Tue, 30 Mar 2004 06:25:04 -0500 (EST) Received: from turing.freelists.org ([127.0.0.1]) by localhost (turing [127.0.0.1]) (amavisd-new, port 10024) with ESMTP id 08174-67; Tue, 30 Mar 2004 06:25:04 -0500 (EST) Received: from turing (localhost [127.0.0.1]) by turing.freelists.org (Avenir Technologies Mail Multiplex) with ESMTP id 24C026349B5; Tue, 30 Mar 2004 06:25:04 -0500 (EST) Received: with ECARTIS (v1.0.0; list oracle-l); Tue, 30 Mar 2004 06:23:57 -0500 (EST) X-Original-To: oracle-l@freelists.org Delivered-To: oracle-l@freelists.org Received: from localhost (localhost [127.0.0.1]) by turing.freelists.org (Avenir Technologies Mail Multiplex) with ESMTP id A92AF6348D6 for ; Tue, 30 Mar 2004 06:23:56 -0500 (EST) Received: from turing.freelists.org ([127.0.0.1]) by localhost (turing [127.0.0.1]) (amavisd-new, port 10024) with ESMTP id 08565-19 for ; Tue, 30 Mar 2004 06:23:56 -0500 (EST) Received: from out006.verizon.net (out006pub.verizon.net [206.46.170.106]) by turing.freelists.org (Avenir Technologies Mail Multiplex) with ESMTP id 2B9BC63492B for ; Tue, 30 Mar 2004 06:23:56 -0500 (EST) Received: from D9RH6821 ([151.200.122.245]) by out006.verizon.net (InterMail vM.5.01.06.06 201-253-122-130-106-20030910) with ESMTP id <20040330113200.GMIL1634.out006.verizon.net@D9RH6821> for ; Tue, 30 Mar 2004 05:32:00 -0600 Message-ID: <1fdc01c4164a$ddfb4740$6401a8c0@D9RH6821> From: "vze1vwnd" To: References: Subject: Re: Interesting Metric Date: Tue, 30 Mar 2004 06:33:47 -0500 MIME-Version: 1.0 Content-Type: multipart/alternative; boundary="----=_NextPart_000_1FD9_01C41620.F4D6AA10" X-Priority: 3 X-MSMail-Priority: Normal X-Mailer: Microsoft Outlook Express 6.00.2800.1158 X-MimeOLE: Produced By Microsoft MimeOLE V6.00.2800.1165 X-Authentication-Info: Submitted using SMTP AUTH at out006.verizon.net from [151.200.122.245] at Tue, 30 Mar 2004 05:31:59 -0600 X-Virus-Scanned: by amavisd-new at freelists.org X-archive-position: 2023 X-ecartis-version: Ecartis v1.0.0 Sender: oracle-l-bounce@freelists.org Errors-To: oracle-l-bounce@freelists.org X-original-sender: walter.kirsch@verizon.net Precedence: normal Reply-To: oracle-l@freelists.org X-list: oracle-l X-Virus-Scanned: by amavisd-new at freelists.org ------=_NextPart_000_1FD9_01C41620.F4D6AA10 Content-Type: text/plain; charset="iso-8859-1" Content-Transfer-Encoding: quoted-printable RE: Latch ContentionDid anyone reply? ----- Original Message -----=20 From: Post, Ethan=20 To: oracle-l@freelists.org=20 Sent: Tuesday, March 02, 2004 2:16 PM Subject: Interesting Metric I have a threaded batch process running in which all the threads are = pretty much doing the same thing. I have another report which shows = total IO, CPU, REDO and more by session. When you look at this report = (basically workload) all of the #'s and times are pretty much the same. = Meaning all of the threads are processing about the same amount of work. = However, if you look below I get these usual spikes in Buffer Busy = waits and they correlate to specific sessions. it looks like the spikes = occur during a checkpoints. It is strange because it looks like just a = couple session accumulate all of the buffer busy time instead of all of = the sessions. =20 Total Latch Buffer Db File Db File D Path D Path = Log Buf Log File SQL*Net SID Seconds Free Busy Sct Read Seq Read Read Write = Enqueue Space Sync to Cli ----- ------- ------- ------- -------- -------- ------- ------- = ------- ------- -------- ------- 10 0 0 0 0 0 0 0 = 0 0 0 0 8 0 0 0 0 0 0 0 = 0 0 0 0 9 1 0 0 1 1 0 0 = 0 0 0 0 41 109 4 15 3 83 0 0 = 0 0 4 0 19 114 2 0 24 44 0 0 = 0 0 44 0 31 125 4 34 3 80 0 0 = 0 0 4 0 25 126 3 17 3 98 0 0 = 0 0 5 0 27 127 4 10 3 106 0 0 = 1 0 4 0 29 151 4 31 2 111 0 0 = 0 0 3 0 38 1784 4 26 3 1747 0 0 = 0 0 3 0 40 1788 4 28 1 1751 0 0 = 0 0 4 0 37 1941 3 1807 2 125 0 0 = 0 0 4 0 32 2053 3 19 3 2024 0 0 = 0 0 4 0 28 3578 3 1874 3 1693 0 0 = 0 0 4 0 34 3798 4 13 3 3775 0 0 = 0 0 4 0 14 4266 4 33 2 4223 0 0 = 0 0 3 0 24 4892 3 9 2 4875 0 0 = 0 0 4 0 26 5090 4 21 2 5058 0 0 = 1 0 4 0 39 5371 5 75 2 5287 0 0 = 0 0 2 0 35 6737 2 13 2 6717 0 0 = 0 0 4 0 23 7075 5 2525 2 4539 0 0 = 0 0 3 0 33 9435 3 24 2 9401 0 0 = 0 0 3 0 30 9835 3 24 3 9802 0 0 = 0 0 3 0 36 10481 4 32 2978 7463 0 0 = 0 0 4 0 ------=_NextPart_000_1FD9_01C41620.F4D6AA10 Content-Type: text/html; charset="iso-8859-1" Content-Transfer-Encoding: quoted-printable RE: = Latch Contention
Did anyone reply?
----- Original Message -----
From:=20 Post, = Ethan=20
Sent: Tuesday, March 02, 2004 = 2:16=20 PM
Subject: Interesting = Metric

I have a threaded batch process running in = which all=20 the threads are pretty much doing the same thing.  I have another = report=20 which shows total IO, CPU, REDO and more by session.  When you = look at=20 this report (basically workload) all of the #'s and times are pretty = much the=20 same.  Meaning all of the threads are processing about the same = amount of=20 work.  However, if you look below I get these usual spikes in = Buffer Busy=20 waits and they correlate to specific sessions.  it looks like the = spikes=20 occur during a checkpoints.  It is strange because it looks like = just a=20 couple session accumulate all of the buffer busy time instead of all = of the=20 sessions. 
 
 
        Total  =20 Latch  Buffer  Db File  Db File  D Path  D=20 Path         Log Buf Log File=20 SQL*Net
  SID Seconds    Free    = Busy=20 Sct Read Seq Read    Read   Write = Enqueue  =20 Space     Sync  to Cli
----- ------- = -------=20 ------- -------- -------- ------- ------- ------- ------- --------=20 -------
   10      =20 0       = 0      =20 0       =20 0       =20 0       = 0      =20 0       = 0      =20 0       =20 0       0
   =20 8       = 0      =20 0      =20 0       =20 0       =20 0       = 0      =20 0       = 0      =20 0       =20 0       0
   =20 9       = 1      =20 0      =20 0       =20 1       =20 1       = 0      =20 0       = 0      =20 0       =20 0       0
  =20 41     109      =20 4      = 15       =20 3       = 83      =20 0       = 0      =20 0      =20 0       =20 4       0
  =20 19     114      =20 2       = 0      =20 24       = 44      =20 0       = 0      =20 0       = 0      =20 44       0
  =20 31     125      =20 4      = 34       =20 3       = 80      =20 0       = 0      =20 0      =20 0       =20 4       0
  =20 25     126      =20 3      = 17       =20 3       = 98      =20 0       = 0      =20 0      =20 0       =20 5       0
  =20 27     127      =20 4      = 10       =20 3      = 106      =20 0       = 0      =20 1      =20 0       =20 4       0
  =20 29     151      =20 4      = 31       =20 2      = 111      =20 0       = 0      =20 0      =20 0       =20 3       0
   = 38   =20 1784       = 4     =20 26        3     = 1747       = 0      =20 0       = 0      =20 0       =20 3       0
   = 40   =20 1788       = 4     =20 28        1     = 1751       = 0      =20 0       = 0      =20 0       =20 4       0
   = 37   =20 1941       3   =20 1807        = 2     =20 125       = 0      =20 0       = 0      =20 0       =20 4       0
   = 32   =20 2053       = 3     =20 19        3     = 2024       = 0      =20 0       = 0      =20 0       =20 4       0
   = 28   =20 3578       3   =20 1874        = 3    =20 1693       = 0      =20 0       = 0      =20 0       =20 4       0
   = 34   =20 3798       = 4     =20 13        3     = 3775       = 0      =20 0       = 0      =20 0       =20 4       0
   = 14   =20 4266       = 4     =20 33        2     = 4223       = 0      =20 0       = 0      =20 0       =20 3       0
   = 24   =20 4892       = 3      =20 9        2    =20 4875       = 0      =20 0       = 0      =20 0       =20 4       0
   = 26   =20 5090       = 4     =20 21        2     = 5058       = 0      =20 0       = 1      =20 0       =20 4       0
   = 39   =20 5371       = 5     =20 75        2     = 5287       = 0      =20 0       = 0      =20 0       =20 2       0
   = 35   =20 6737       = 2     =20 13        2     = 6717       = 0      =20 0       = 0      =20 0       =20 4       0
   = 23   =20 7075       5   =20 2525        = 2    =20 4539       = 0      =20 0       = 0      =20 0       =20 3       0
   = 33   =20 9435       = 3     =20 24        2     = 9401       = 0      =20 0       = 0      =20 0       =20 3       0
   = 30   =20 9835       = 3     =20 24        3     = 9802       = 0      =20 0       = 0      =20 0       =20 3       0
   36   = 10481       = 4     =20 32     2978    =20 7463       = 0      =20 0       = 0      =20 0       =20 4      =20 0
------=_NextPart_000_1FD9_01C41620.F4D6AA10-- ---------------------------------------------------------------- Please see the official ORACLE-L FAQ: http://www.orafaq.com ---------------------------------------------------------------- To unsubscribe send email to: oracle-l-request@freelists.org put 'unsubscribe' in the subject line. -- Archives are at http://www.freelists.org/archives/oracle-l/ FAQ is at http://www.freelists.org/help/fom-serve/cache/1.html -----------------------------------------------------------------