tkprof 9.2.0.6 TOTALS FOR ALL NON-RECURSIVE STATEMENTS

[Débéa]

Bonjour,

Voici la fin d'un tkprof :

Code :

1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
 
********************************************************************************
 
OVERALL TOTALS FOR ALL NON-RECURSIVE STATEMENTS
 
call     count       cpu    elapsed       disk      query    current        rows
------- ------  -------- ---------- ---------- ---------- ----------  ----------
Parse     5933      0.08       0.59          0          0          0           0
Execute  12615      0.14       2.00        186       1484       1936        1482
Fetch    12987      0.26       3.51       1437      32705          6        8928
------- ------  -------- ---------- ---------- ---------- ----------  ----------
total    31535      0.48       6.12       1623      34189       1942       10410
 
Misses IN library cache during parse: 10
 
 
OVERALL TOTALS FOR ALL RECURSIVE STATEMENTS
 
call     count       cpu    elapsed       disk      query    current        rows
------- ------  -------- ---------- ---------- ---------- ----------  ----------
Parse        9      0.00       0.00          0          0          0           0
Execute     11      0.01       0.00          0          0          0           0
Fetch       13      0.00       0.01          2         29          0           9
------- ------  -------- ---------- ---------- ---------- ----------  ----------
total       33      0.01       0.01          2         29          0           9
 
Misses IN library cache during parse: 1

Quelqu'un peut-il m'expliquer la différence entre OVERALL TOTALS FOR ALL NON-RECURSIVE STATEMENTS et OVERALL TOTALS FOR ALL RECURSIVE STATEMENTS ?

Est-ce que le temps total passé est bien 6,12 secondes ? Car mon traitement dure 5 minutes. Cela voudrait donc dire que le temps perdu n'est pas lié à la base de données ?

Merci par avance pour vos réponses,

[orafrance]

si tu fais une trace de level 8 ou 12 tu auras des infos précieuses sur les waits

[Débéa]

Comment faire ?

[orafrance]

http://orafrance.developpez.com/dbahelp/#L3

http://oracle.developpez.com/guide/tuning/tkprof/

[Débéa]

Envoyé par orafrance

si tu fais une trace de level 8 ou 12 tu auras des infos précieuses sur les waits

J'ai fait ce que tu m'as suggeré. Voici le resultat avec les waits :

Code :

1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
 
OVERALL TOTALS FOR ALL NON-RECURSIVE STATEMENTS
 
call     count       cpu    elapsed       disk      query    current        rows
------- ------  -------- ---------- ---------- ---------- ----------  ----------
Parse     3399      0.29       2.86          0        106          0           0
Execute   8183      0.07       1.11        135        853       1113         851
Fetch     8874      1.14      13.20       1354      21925          6        7030
------- ------  -------- ---------- ---------- ---------- ----------  ----------
total    20456      1.50      17.18       1489      22884       1119        7881
 
Misses IN library cache during parse: 15
 
Elapsed times include waiting ON following events:
  Event waited ON                             Times   Max. Wait  Total Waited
  ----------------------------------------   Waited  ----------  ------------
  SQL*Net message FROM client                  9729      120.69        132.73
  SQL*Net message TO client                    9728        0.00          0.01
  db file sequential READ                       552        0.03          1.87
  log file sync                                   1        0.00          0.00
  SQL*Net more DATA TO client                  4242        0.00          0.16
  db file scattered READ                         63        0.02          0.23
  direct path WRITE                               4        0.00          0.00
  direct path READ                               21        0.00          0.00
  SQL*Net more DATA FROM client                 851        0.00          0.01

Dans les waits, "Times" est exprimé en quoi ?

Si j'ai tout compris, le elapsed time contient les waits !
Donc, je peux considérer que le temps total pour executer les ordres SQL pendant le tkprof est ici de 17.18 secondes (waits compris) ?
Le traitement batch lancé qui a généré cette trace a duré environ 5 minutes. Je peux,donc, conclure que ce batch n'est pas ralenti par la base de données mais qu'il passe son temps à faire je ne sais quoi sur le serveur d'application.

Je dis vraie ?

[orafrance]

comment est lancé ton batch, via SQL*Plus ? Il te rend la main au bout de 5 minutes c'est ça ? Il fait quoi ce batch ?

times waited c'est le nombre de fois où Oracle a attendu.

[Débéa]

Envoyé par orafrance

comment est lancé ton batch, via SQL*Plus ? Il te rend la main au bout de 5 minutes c'est ça ? Il fait quoi ce batch ?

times waited c'est le nombre de fois où Oracle a attendu.

C'est un traitement lancé par un programme (ADONIX) le soir. Il utilise du ODBC et a été développé je ne sais pas comment. Il est executé sur un serveur d'application windows et la bdd est sur un autre serveur.

[orafrance]

visiblement le driver ODBC génére de l'attente ou alors c'est ADONIX... parce qu'effectivement tkprof n'indique pas une durée aussi longue

[pifor]

Quelqu'un peut-il m'expliquer la différence entre OVERALL TOTALS FOR ALL NON-RECURSIVE STATEMENTS et OVERALL TOTALS FOR ALL RECURSIVE STATEMENTS

Les "NON-RECURSIVE STATEMENTS", c'est le code SQL directement soumis par l'application à Oracle alors que les "RECURSIVE STATEMENTS" sont le code SQL indirectement généré par le code SQL applicatif:

• SQL exécuté par les triggers
• mise à jour du dictionnaire de la base
• SQL exécuté pour vérifier les contraintes
• etc.