Chinaunix首页 | 论坛 | 博客
  • 博客访问: 2882481
  • 博文数量: 200
  • 博客积分: 2413
  • 博客等级: 大尉
  • 技术积分: 3067
  • 用 户 组: 普通用户
  • 注册时间: 2011-04-01 22:07
文章分类

全部博文(200)

文章存档

2018年(2)

2017年(8)

2016年(35)

2015年(14)

2014年(20)

2013年(24)

2012年(53)

2011年(44)

分类: Oracle

2012-08-20 16:33:46

一台oracle生产库偶尔会宕机,经过分析错误日志以及trace文件发现如下信息

  1. -----alert.log----------
  2. Begin automatic SQL Tuning Advisor run for special tuning task "SYS_AUTO_SQL_TUNING_TASK"
  3. Fri Aug 17 22:00:12 2012
  4. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc (incident=23372):
  5. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  6. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23372/down_j000_52171_i23372.trc
  7. ------------------------

  8. vim /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc
  9. *** 2012-08-17 22:00:21.764
  10. ORA-12012: error on auto execute of job 11300
  11. ORA-01301: error writing to file during flat file build
  12. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5378
  13. ORA-00600: internal error code, arguments: [], [], [], [], [], [], [], []
  14. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5747
  15. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5869
  16. ORA-06512: at "SYS.DBMS_LOGMNR_D", line 12
  17. ORA-06512: at line 2

发现是由于logminer的包引起。通过查询MOS,找到Ora-01301: Error Writing To File During Flat File Build [ID 602149.1]这篇文档,虽然里面的例子是10g版本的,但是有很多相似之处。

大概结论就是:Problems with logminer objects.(logminer 相关的对象有问题),这篇文档里介绍了10g中recreate logminer objects的办法,但是最后一部不适用于11g。


经过搜索,找到了11g的办法.How To Rebuild LogMiner Metadata Tables [ID 550197.1]   
  1. On 11g (Release 1 and Release 2)

  2. SQL> connect / as sysdba
  3. SQL> drop table SYSTEM.LOGMNR_SESSION$ purge;

  4. NOTE: you will need to recreate the LOGMNR_SESSION$ view manually

  5. CREATE TABLE SYSTEM.LOGMNR_SESSION$ (
  6. session# number,
  7. client# number,
  8. session_name varchar2(128) not null,
  9. db_id number,
  10. resetlogs_change# number,
  11. session_attr number,
  12. session_attr_verbose varchar2(400),
  13. start_scn number,
  14. end_scn number,
  15. spill_scn number,
  16. spill_time date,
  17. oldest_scn number,
  18. resume_scn number,
  19. global_db_name varchar2(128) default null,
  20. reset_timestamp number,
  21. branch_scn number,
  22. version varchar2(64),
  23. redo_compat varchar2(20),
  24. spare1 number,
  25. spare2 number,
  26. spare3 number,
  27. spare4 number,
  28. spare5 number,
  29. spare6 date,
  30. spare7 varchar2(1000),
  31. spare8 varchar2(1000),
  32. constraint logmnr_session_pk primary key (session#)
  33. using index tablespace SYSTEM logging,
  34. constraint logmnr_session_uk1 unique (session_name)
  35. using index tablespace SYSTEM logging enable validate)
  36. tablespace SYSTEM logging
  37. /

  38. SQL> @?/rdbms/admin/dbmslm.sql
  39. SQL> @?/rdbms/admin/prvtlm.plb
  40. SQL> @?/rdbms/admin/dbmslmd.sql
  41. SQL> @?/rdbms/admin/prvtlmd.plb
  42. SQL> @?/rdbms/admin/prvtlmcs.plb
  43. SQL> @?/rdbms/admin/prvtlmcb.plb
  44. SQL> @?/rdbms/admin/utlrp.sql

  45. If you continue to see invalid objects after these steps, you may have to rerun the utlrp.sql step a number of times.

  46.  utlrp.sql可以查看无效对性或者错误对象

按照上面的办法重建了logminer的相关对象,至于是否有效还需观察。   


===========================================================
附件altert.log
  1. Client address: (ADDRESS=(PROTOCOL=tcp)(HOST=::ffff:219.142.212.235)(PORT=56731))
  2. Fri Aug 17 15:00:37 2012
  3. Thread 1 advanced to log sequence 1616
  4.   Current log# 2 seq# 1616 mem# 0: /var/u01/app/oradata/down/redo02.log
  5. Fri Aug 17 22:00:00 2012
  6. Setting Resource Manager plan SCHEDULER[0x2C0D]:DEFAULT_MAINTENANCE_PLAN via scheduler window
  7. Setting Resource Manager plan DEFAULT_MAINTENANCE_PLAN via parameter
  8. Fri Aug 17 22:00:02 2012
  9. Fri Aug 17 22:00:02 2012
  10. Logminer Bld: Lockdown Complete. DB_TXN_SCN is UnwindToSCN (LockdownSCN) is 7607211731
  11. Fri Aug 17 22:00:02 2012
  12. Begin automatic SQL Tuning Advisor run for special tuning task "SYS_AUTO_SQL_TUNING_TASK"
  13. Fri Aug 17 22:00:12 2012
  14. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc (incident=23372):
  15. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  16. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23372/down_j000_52171_i23372.trc
  17. Fri Aug 17 22:00:15 2012
  18. Trace dumping is performing id=[cdmp_20120817220015]
  19. Some DDE async actions failed or were cancelled
  20. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc (incident=23373):
  21. ORA-00700: soft internal error, arguments: [kgerev1], [600], [600], [700], [], [], [], []
  22. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23373/down_j000_52171_i23373.trc
  23. Fri Aug 17 22:00:15 2012
  24. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j002_52175.trc (incident=23468):
  25. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  26. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23468/down_j002_52175_i23468.trc
  27. Trace dumping is performing id=[cdmp_20120817220017]
  28. Fri Aug 17 22:00:17 2012
  29. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_ora_55281.trc (incident=23444):
  30. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  31. ORA-25228: timeout or end-of-fetch during message dequeue from SYS.ALERT_QUE
  32. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23444/down_ora_55281_i23444.trc
  33. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j002_52175.trc (incident=23469):
  34. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  35. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23469/down_j002_52175_i23469.trc
  36. Fri Aug 17 22:00:18 2012
  37. Sweep Incident[23372]: completed
  38. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc (incident=23374):
  39. ORA-00600: internal error code, arguments: [], [], [], [], [], [], [], []
  40. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23374/down_j000_52171_i23374.trc
  41. Fri Aug 17 22:00:18 2012
  42. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j003_52177.trc (incident=23492):
  43. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  44. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23492/down_j003_52177_i23492.trc
  45. SYS_AUTO_SQL_TUNING_TASK exiting with error "600" for execution "EXEC_1_19". See DBA_ADVISOR_EXECUTIONS for more details.
  46. End automatic SQL Tuning Advisor run for special tuning task "SYS_AUTO_SQL_TUNING_TASK"
  47. Trace dumping is performing id=[cdmp_20120817220019]
  48. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j002_52175.trc (incident=23470):
  49. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  50. ORA-06512: at "SYS.PRVT_ADVISOR", line 2293
  51. ORA-06512: at "SYS.DBMS_ADVISOR", line 241
  52. ORA-06512: at "SYS.DBMS_SQLTUNE", line 643
  53. ORA-06512: at line 4
  54. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23470/down_j002_52175_i23470.trc
  55. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j003_52177.trc:
  56. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  57. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_m001_52227.trc (incident=23532):
  58. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  59. ORA-00448: normal completion of background process
  60. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23532/down_m001_52227_i23532.trc
  61. Trace dumping is performing id=[cdmp_20120817220020]
  62. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j002_52175.trc:
  63. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  64. ORA-06512: at "SYS.PRVT_ADVISOR", line 2293
  65. ORA-06512: at "SYS.DBMS_ADVISOR", line 241
  66. ORA-06512: at "SYS.DBMS_SQLTUNE", line 643
  67. ORA-06512: at line 4
  68. ORA-600 : opidrv aborting process M001 ospid (52227_140020947867392)
  69. Fri Aug 17 22:00:21 2012
  70. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_m002_52230.trc (incident=23540):
  71. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  72. ORA-00448: normal completion of background process
  73. ORA-600 : opidrv aborting process M002 ospid (52230_139972686960384)
  74. Fri Aug 17 22:00:21 2012
  75. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_ora_52237.trc (incident=23548):
  76. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  77. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_ora_52237.trc:
  78. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  79. Trace dumping is performing id=[cdmp_20120817220021]
  80. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc:
  81. ORA-12012: error on auto execute of job 11300
  82. ORA-01301: error writing to file during flat file build
  83. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5378
  84. ORA-00600: internal error code, arguments: [], [], [], [], [], [], [], []
  85. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5747
  86. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5869
  87. ORA-06512: at "SYS.DBMS_LOGMNR_D", line 12
  88. ORA-06512: at line 2
  89. ORA-06512: at "SYS.DBMS_HM", line 286
  90. Fri Aug 17 22:00:22 2012
  91. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_j003_52177.trc (incident=25615):
  92. ORA-00603: ORACLE server session terminated by fatal error
  93. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  94. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_25615/down_j003_52177_i25615.trc
  95. Errors in file /var/u01/app/diag/rdbms/down/down/incident/incdir_25615/down_j003_52177_i25615.trc:
  96. ORA-00603: ORACLE server session terminated by fatal error
  97. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  98. Fri Aug 17 22:00:22 2012
  99. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_ora_52237.trc (incident=25623):
  100. ORA-00603: ORACLE server session terminated by fatal error
  101. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  102. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_25623/down_ora_52237_i25623.trc
  103. Errors in file /var/u01/app/diag/rdbms/down/down/incident/incdir_25623/down_ora_52237_i25623.trc:
  104. ORA-00603: ORACLE server session terminated by fatal error
  105. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  106. Fri Aug 17 22:00:23 2012
  107. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_m003_52276.trc (incident=23556):
  108. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  109. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_m003_52276.trc (incident=23557):
  110. ORA-00600: internal error code, arguments: [kewrose_1], [600], [ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  111. ], [], [], [], [], []
  112. Incident details in: /var/u01/app/diag/rdbms/down/down/incident/incdir_23557/down_m003_52276_i23557.trc
  113. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_m003_52276.trc:
  114. ORA-00600: internal error code, arguments: [kewrose_1], [600], [ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  115. ], [], [], [], [], []
  116. Fri Aug 17 22:00:25 2012
  117. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_dbrm_29873.trc (incident=23252):
  118. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  119. Errors in file /var/u01/app/diag/rdbms/down/down/trace/down_dbrm_29873.trc:
  120. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []
  121. DBRM (ospid: 29873): terminating the instance due to error 56710
  122. Instance terminated by DBRM, pid = 29873
  123. Sat Aug 18 09:43:04 2012
  124. Starting ORACLE instance (normal)
  125. LICENSE_MAX_SESSION = 0
  126. LICENSE_SESSIONS_WARNING = 0
  127. Picked latch-free SCN scheme 3
  128. Autotune of undo retention is turned on.
  129. IMODE=BR
  130. ILAT =36
  131. LICENSE_MAX_USERS = 0
  132. SYS auditing is disabled
  133. Starting up ORACLE RDBMS Version: 11.1.0.6.0.
  134. Using parameter settings in server-side spfile /var/u01/app/product/11.1.0/db_1/dbs/spfiledown.ora
  135. System parameters with non-default values:

trace文件
  1. Trace file /var/u01/app/diag/rdbms/down/down/trace/down_j000_52171.trc
  2. Oracle Database 11g Enterprise Edition Release 11.1.0.6.0 - 64bit Production
  3. With the Partitioning, OLAP, Data Mining and Real Application Testing options
  4. ORACLE_HOME = /var/u01/app/product/11.1.0/db_1
  5. System name: Linux
  6. Node name: to-01
  7. Release: 2.6.32-71.el6.x86_64
  8. Version: #1 SMP Fri May 20 03:51:51 BST 2011
  9. Machine: x86_64
  10. Instance name: to
  11. Redo thread mounted by this instance: 1
  12. Oracle process number: 20
  13. Unix process pid: 52171, image: oracle@dxt-boss-01 (J000)


  14. *** 2012-08-17 22:00:12.965
  15. *** SESSION ID:(281.50978) 2012-08-17 22:00:12.966
  16. *** CLIENT ID:() 2012-08-17 22:00:12.966
  17. *** SERVICE NAME:(SYS$USERS) 2012-08-17 22:00:12.966
  18. *** MODULE NAME:(DBMS_SCHEDULER) 2012-08-17 22:00:12.966
  19. *** ACTION NAME:(HM_CREATE_OFFLINE_DICTIONARY) 2012-08-17 22:00:12.966

  20. Incident 23372 created, dump file: /var/u01/app/diag/rdbms/down/down/incident/incdir_23372/down_j000_52171_i23372.trc
  21. ORA-00600: internal error code, arguments: [kgkprrpicknext1], [17], [1], [], [], [], [], []


  22. *** 2012-08-17 22:00:15.773
  23. Incident 23373 created, dump file: /var/u01/app/diag/rdbms/down/down/incident/incdir_23373/down_j000_52171_i23373.trc
  24. ORA-00700: soft internal error, arguments: [kgerev1], [600], [600], [700], [], [], [], []


  25. *** 2012-08-17 22:00:18.874
  26. Incident 23374 created, dump file: /var/u01/app/diag/rdbms/down/down/incident/incdir_23374/down_j000_52171_i23374.trc
  27. ORA-00600: internal error code, arguments: [], [], [], [], [], [], [], []


  28. *** 2012-08-17 22:00:21.763
  29. IR ADR Errors: 604 1301 6512 600 6512 6512 6512 6512

  30. *** 2012-08-17 22:00:21.764
  31. ORA-12012: error on auto execute of job 11300
  32. ORA-01301: error writing to file during flat file build
  33. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5378
  34. ORA-00600: internal error code, arguments: [], [], [], [], [], [], [], []
  35. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5747
  36. ORA-06512: at "SYS.DBMS_LOGMNR_INTERNAL", line 5869
  37. ORA-06512: at "SYS.DBMS_LOGMNR_D", line 12
  38. ORA-06512: at line 2
  39. ORA-06512: at "SYS.DBMS_HM", line 286
  40. *** CLIENT ID:() 2012-08-17 22:00:21.872

  41. kgsksysstop: from KGSKWT_INTSTATECHNG6 retry TRUE mode
  42. ~

==================MOS文档=====================
How To Rebuild LogMiner Metadata Tables [ID 550197.1]
Ora-01301: Error Writing To File During Flat File Build [ID 602149.1]
阅读(5980) | 评论(0) | 转发(0) |
给主人留下些什么吧!~~