zoukankan      html  css  js  c++  java
  • ORA07445 ERROR on auto execute of job 8913

    巡检时出现  

    Tue Jul 17 22:00:08 2012
    Errors in file e:\oracle\product\10.2.0\admin\zsdb\bdump\zsdb_j000_2032.trc:
    ORA-12012: error on auto execute of job 8887
    ORA-44003: invalid SQL name

    显然这是个 任务执行失败的错误

    查看zsdb_j000_2032.trc 中的日志


    *** ACTION NAME:(AUTO_SPACE_ADVISOR_JOB) 2012-07-17 22:00:08.403
    *** MODULE NAME:(DBMS_SCHEDULER) 2012-07-17 22:00:08.403
    *** SERVICE NAME:(SYS$USERS) 2012-07-17 22:00:08.403
    *** SESSION ID:(142.5672) 2012-07-17 22:00:08.403
    *** 2012-07-17 22:00:08.403
    ORA-12012: error on auto execute of job 8887
    ORA-44003: invalid SQL name

    为了确定该错误对系统的性能是否有性能影响,做了AWR报告结果:

    auto_space_advisor_job_proc,CPU Time消耗高达4226秒:

    call dbms_space.auto_space_advisor_job_proc ( )

    执行花费了大量的时间,3000多秒,进而执行的SQL:

    insert into wri$_adv_objspace_trend_data select timepoint, space_usage, space_alloc, quality from table(dbms_space.object_growth_trend(:1, :2, :3, :4, NULL, NULL, NULL, 'FALSE', :5, 'FALSE'))
        也花费了2514秒的时间,这显然是不正常的。

    在正常情况下,单独跟踪一下SQL*Plus手工执行,可以获得这个SQL的执行统计信息:

    注意到,这个Insert仍然消耗了389秒的时间,逻辑读429,297,性能是存在问题的。在Metalink上存在如下一个Bug:
        Bug 5376783: DBMS_SPACE.OBJECT_GROWTH_TREND CALL TAKES A LOT OF DISK READS

    这个Bug在DBMS_SPACE.OBJECT_GROWTH_TREND进行空间分析时被触发,根本原因在于内部算法在执行空间检查时,耗费了大量的评估IO成本,导致了大量的IO资源使用。

    临时的处理办法是,暂时关闭这个自动任务:

    execute dbms_scheduler.disable('AUTO_SPACE_ADVISOR_JOB');

    这个Bug在10.2.0.2之后的版本中被修正。

    既然Oracle的缺省定时任务可能会带来如此多的问题,我们就很有必要去关注一下系统有哪些缺省的任务,执行情况如何。以下是一个10.2.0.5版本的数据库中一些自动任务的调度设置情况:

    SQL> select job_name,state,enabled,last_start_date from dba_scheduler_jobs;          

     

    JOB_NAME                       STATE           ENABL LAST_START_DATE

    ------------------------------ --------------- ----- -----------------------------------

    AUTO_SPACE_ADVISOR_JOB         SCHEDULED       TRUE  07-AUG-10 06.00.03.792886 AM +08:00

    GATHER_STATS_JOB               SCHEDULED       TRUE  07-AUG-10 06.00.03.783957 AM +08:00

    FGR$AUTOPURGE_JOB              DISABLED        FALSE

    PURGE_LOG                      SCHEDULED       TRUE  07-AUG-10 03.00.00.353023 AM PRC

    MGMT_STATS_CONFIG_JOB          SCHEDULED       TRUE  01-AUG-10 01.01.01.822354 AM +08:00

    MGMT_CONFIG_JOB                SCHEDULED       TRUE  07-AUG-10 06.00.03.767320 AM +08:00

    在以上的调度任务中,GATHER_STATS_JOB是Oracle Database 10g开始引入的自动统计信息收集的任务,该任务缺省的调度是,工作日每晚22:00至凌晨6:00进行分析,周末全天进行分析。在以下输出中,我们可以看到任务无法完成,STOP的情况:

    SQL> SELECT log_id, job_name, status,

      2         TO_CHAR(ACTUAL_START_DATE,'DD-MON-YYYY HH24:MI') start_date,TO_CHAR (log_date, 'DD-MON-YYYY HH24:MI') log_date

      3    FROM dba_scheduler_job_run_details

      4   WHERE job_name = 'GATHER_STATS_JOB' order by 4;

        LOG_ID JOB_NAME             STATUS               START_DATE           LOG_DATE

    ---------- -------------------- -------------------- -------------------- --------------------

          1480 GATHER_STATS_JOB     SUCCEEDED            02-AUG-2010 22:00    03-AUG-2010 00:58

          1561 GATHER_STATS_JOB     STOPPED              03-AUG-2010 22:00    04-AUG-2010 06:00

          1640 GATHER_STATS_JOB     SUCCEEDED            04-AUG-2010 22:00    05-AUG-2010 05:36

          1680 GATHER_STATS_JOB     SUCCEEDED            05-AUG-2010 22:00    05-AUG-2010 22:25

          1741 GATHER_STATS_JOB     SUCCEEDED            06-AUG-2010 22:00    06-AUG-2010 22:27

          1800 GATHER_STATS_JOB     SUCCEEDED            07-AUG-2010 06:00    07-AUG-2010 06:02

           384 GATHER_STATS_JOB     STOPPED              07-JUL-2010 22:00    08-JUL-2010 06:00

           463 GATHER_STATS_JOB     SUCCEEDED            08-JUL-2010 22:00    09-JUL-2010 05:06

           503 GATHER_STATS_JOB     SUCCEEDED            09-JUL-2010 22:00    09-JUL-2010 22:05

           544 GATHER_STATS_JOB     SUCCEEDED            10-JUL-2010 06:00    10-JUL-2010 06:02

           589 GATHER_STATS_JOB     SUCCEEDED            12-JUL-2010 22:00    12-JUL-2010 22:04

           597 GATHER_STATS_JOB     SUCCEEDED            13-JUL-2010 22:00    13-JUL-2010 22:03

    在一些大型数据库中,这个任务不一定能够有效执行,以下是某用户的数据库环境,输出显示,多日数据库都因为ORA-04031错误未能完成统计信息收集采样:

    SQL> SELECT LOG_DATE,RUN_DURATION,JOB_NAME,STATUS,ERROR#

      2  FROM DBA_SCHEDULER_JOB_RUN_DETAILS

      3  WHERE JOB_NAME='GATHER_STATS_JOB'

      4  order by 1 desc;

    LOG_DATE                            RUN_DURATION    JOB_NAME           STATUS          ERROR#

    ----------------------------------- --------------- ------------------ ----------- ----------

    26-MAY-10 10.00.09.290291 PM +08:00 +000 00:00:05   GATHER_STATS_JOB   FAILED           22303

    25-MAY-10 10.00.08.973684 PM +08:00 +000 00:00:06   GATHER_STATS_JOB   FAILED            4031

    24-MAY-10 10.00.22.977244 PM +08:00 +000 00:00:18   GATHER_STATS_JOB   FAILED            4031

    22-MAY-10 06.00.16.950362 AM +08:00 +000 00:00:13   GATHER_STATS_JOB   FAILED            4031

    21-MAY-10 10.00.49.653788 PM +08:00 +000 00:00:47   GATHER_STATS_JOB   FAILED            4031

    20-MAY-10 10.00.14.028432 PM +08:00 +000 00:00:11   GATHER_STATS_JOB   FAILED            4031

    19-MAY-10 10.00.20.828607 PM +08:00 +000 00:00:18   GATHER_STATS_JOB   FAILED            4031

    19-MAY-10 05.54.27.871444 AM +08:00 +000 07:54:25   GATHER_STATS_JOB   SUCCEEDED            0

    18-MAY-10 05.36.01.494920 AM +08:00 +000 07:35:59   GATHER_STATS_JOB   SUCCEEDED            0

    15-MAY-10 07.06.05.793257 AM +08:00 +000 01:06:01   GATHER_STATS_JOB   SUCCEEDED            0

    15-MAY-10 03.56.50.898303 AM +08:00 +000 05:56:48   GATHER_STATS_JOB   SUCCEEDED            0

    在GATHER_STATS_JOB任务不能够有效的执行时,我们必须及时的介入去手工处理,不及时的统计信息可能使数据库产生错误的执行计划。

    正常的AUTO_SPACE_ADVISOR_JOB调度可能应该有着类似以下输出的执行结果:

    SQL> SELECT log_id, job_name, status,TO_CHAR(ACTUAL_START_DATE,'DD-MON-YYYY HH24:MI') start_date,

      2         TO_CHAR (log_date, 'DD-MON-YYYY HH24:MI') log_date

      3    FROM dba_scheduler_job_run_details

      4   WHERE job_name = 'AUTO_SPACE_ADVISOR_JOB' order by 4;

     

        LOG_ID JOB_NAME                  STATUS          START_DATE           LOG_DATE

    ---------- ------------------------- --------------- -------------------- ----------------

          1460 AUTO_SPACE_ADVISOR_JOB    SUCCEEDED       02-AUG-2010 22:00    02-AUG-2010 22:16

          1520 AUTO_SPACE_ADVISOR_JOB    SUCCEEDED       03-AUG-2010 22:00    03-AUG-2010 23:18

          1600 AUTO_SPACE_ADVISOR_JOB    SUCCEEDED       04-AUG-2010 22:00    04-AUG-2010 22:19

          1681 AUTO_SPACE_ADVISOR_JOB    SUCCEEDED       05-AUG-2010 22:00    05-AUG-ORA

  • 相关阅读:
    Redis计数信号量
    一台服务器能支撑多少个TCP连接
    Python常见字符编码间的转换
    浅谈HttpDNS
    用Python写的一个MySQL数据库监测系统
    用Python写的一个MySQL数据库监测系统
    how tomcat works(第九章)
    how tomcat works(第八章)
    how tomcat works(第八章)
    how tomcat works(第九章)
  • 原文地址:https://www.cnblogs.com/jerryxing/p/2619354.html
Copyright © 2011-2022 走看看