11.2.0.1\u7684ASM\u51fa\u73b0ORA-600[kfgFinalize_2]\u9519\u8bef\u3002
\n\u9519\u8bef\u4fe1\u606f\u4e3a\uff1a<\/p>\n
Fri Jun 17 09:59:51 2011\r\nNOTE: No asm libraries found in the system\r\n* instance_number obtained from CSS = 2, checking for the existence of node 0... \r\n* node 0 does not exist. instance_number = 2 \r\nStarting ORACLE instance (normal)\r\nsskgpgetexecname failed to get name\r\nLICENSE_MAX_SESSION = 0\r\nLICENSE_SESSIONS_WARNING = 0\r\nInterface type 1 en1 192.168.138.0 configured from GPnP Profile for use as a cluster interconnect\r\nInterface type 1 en0 10.121.128.0 configured from GPnP Profile for use as a public interface\r\nPicked latch-free SCN scheme 3\r\nUsing LOG_ARCHIVE_DEST_1 parameter default value as \/u01\/app\/grid\/dbs\/arch\r\nAutotune of undo retention is turned on. \r\nLICENSE_MAX_USERS = 0\r\nSYS auditing is disabled\r\nStarting up:\r\nOracle Database 11g Enterprise Edition Release 11.2.0.1.0 - 64bit Production\r\nWith the Real Application Clusters and Automatic Storage Management options.\r\nUsing parameter settings in server-side spfile +CRS\/jhzw-cluster\/asmparameterfile\/registry.253.732844175\r\nSystem parameters with non-default values:\r\n large_pool_size = 12M\r\n instance_type = \"asm\"\r\n remote_login_passwordfile= \"EXCLUSIVE\"\r\n asm_diskgroups = \"DATA\"\r\n asm_diskgroups = \"FRA\"\r\n asm_power_limit = 1\r\n diagnostic_dest = \"\/u01\/grid\"\r\nCluster communication is configured to use the following interface(s) for this instance\r\n 192.168.138.187\r\ncluster interconnect IPC version:Oracle UDP\/IP (generic)\r\nIPC Vendor 1 proto 2\r\nFri Jun 17 09:59:59 2011\r\nPMON started with pid=2, OS id=258330 \r\nFri Jun 17 09:59:59 2011\r\nVKTM started with pid=3, OS id=311588 at elevated priority\r\nVKTM running at (10)millisec precision with DBRM quantum (100)ms\r\nFri Jun 17 09:59:59 2011\r\nGEN0 started with pid=4, OS id=319784 \r\nFri Jun 17 10:00:00 2011\r\nDIAG started with pid=5, OS id=282666 \r\nFri Jun 17 10:00:00 2011\r\nPING started with pid=6, OS id=323882 \r\nFri Jun 17 10:00:00 2011\r\nPSP0 started with pid=7, OS id=327980 \r\nFri Jun 17 10:00:00 2011\r\nDIA0 started with pid=8, OS id=286766 \r\nFri Jun 17 10:00:00 2011\r\nLMON started with pid=9, OS id=332080 \r\nFri Jun 17 10:00:02 2011\r\nLMD0 started with pid=10, OS id=278586 \r\nFri Jun 17 10:00:03 2011\r\nLMS0 started with pid=11, OS id=290872 at elevated priority\r\nFri Jun 17 10:00:03 2011\r\nLMHB started with pid=12, OS id=299072 \r\nFri Jun 17 10:00:03 2011\r\nMMAN started with pid=13, OS id=336182 \r\nFri Jun 17 10:00:03 2011\r\nDBW0 started with pid=14, OS id=303170 \r\nFri Jun 17 10:00:03 2011\r\nLGWR started with pid=15, OS id=348478 \r\nFri Jun 17 10:00:03 2011\r\nCKPT started with pid=16, OS id=352578 \r\nFri Jun 17 10:00:03 2011\r\nSMON started with pid=17, OS id=311366 \r\nFri Jun 17 10:00:03 2011\r\nRBAL started with pid=18, OS id=307272 \r\nFri Jun 17 10:00:03 2011\r\nGMON started with pid=19, OS id=315464 \r\nFri Jun 17 10:00:04 2011\r\nMMON started with pid=20, OS id=340278 \r\nFri Jun 17 10:00:04 2011\r\nMMNL started with pid=21, OS id=319562 \r\nlmon registered with NM - instance number 2 (internal mem no 1)\r\nReconfiguration started (old inc 0, new inc 12)\r\nASM instance \r\nList of instances:\r\n 1 2 (myinst: 2) \r\n Global Resource Directory frozen\r\n* allocate domain 0, invalid = TRUE \r\n Communication channels reestablished\r\n * domain 0 valid = 1 according to instance 1 \r\n* allocate domain 1, invalid = TRUE \r\n * domain 1 valid = 1 according to instance 1 \r\n* allocate domain 2, invalid = TRUE \r\n * domain 2 valid = 1 according to instance 1 \r\n* allocate domain 3, invalid = TRUE \r\n * domain 3 valid = 1 according to instance 1 \r\n Master broadcasted resource hash value bitmaps\r\n Non-local Process blocks cleaned out\r\n LMS 0: 0 GCS shadows cancelled, 0 closed, 0 Xw survived\r\n Set master node info \r\n Submitted all remote-enqueue requests\r\n Dwn-cvts replayed, VALBLKs dubious\r\n All grantable enqueues granted\r\n Submitted all GCS remote-cache requests\r\n Fix write in gcs resources\r\nReconfiguration complete\r\nFri Jun 17 10:00:06 2011\r\nLCK0 started with pid=22, OS id=327758 \r\nFri Jun 17 10:00:09 2011\r\nORACLE_BASE not set in environment. It is recommended\r\nthat ORACLE_BASE be set in the environment\r\nFri Jun 17 10:00:12 2011\r\nSQL> ALTER DISKGROUP ALL MOUNT \/* asm agent *\/ \r\nNOTE: Diskgroups listed in ASM_DISKGROUPS are\r\n \t DATA\r\n \t FRA\r\nNOTE: Diskgroup used for Voting files is:\r\n \t CRS\r\nDiskgroup with spfile:CRS\r\nDiskgroup used for OCR is:CRS\r\nNOTE: cache registered group CRS number=1 incarn=0xfdaebf4e\r\nNOTE: cache began mount (not first) of group CRS number=1 incarn=0xfdaebf4e\r\nNOTE: cache registered group DATA number=2 incarn=0xfe4ebf4f\r\nNOTE: cache began mount (not first) of group DATA number=2 incarn=0xfe4ebf4f\r\nNOTE: cache registered group FRA number=3 incarn=0xfe5ebf50\r\nNOTE: cache began mount (not first) of group FRA number=3 incarn=0xfe5ebf50\r\nNOTE: Assigning number (1,2) to disk (\/dev\/rhdisk10)\r\nNOTE: Assigning number (1,0) to disk (\/dev\/rhdisk8)\r\nNOTE: Assigning number (1,1) to disk (\/dev\/rhdisk9)\r\nNOTE: Assigning number (2,1) to disk (\/dev\/rhdisk12)\r\nNOTE: Assigning number (2,0) to disk (\/dev\/rhdisk6)\r\nNOTE: Assigning number (3,0) to disk (\/dev\/rhdisk7)\r\nkfdp_query(CRS): 4 \r\nFri Jun 17 10:00:14 2011\r\nkfdp_queryBg(): 4 \r\nNOTE: cache opening disk 0 of grp 1: CRS_0000 path:\/dev\/rhdisk8\r\nNOTE: F1X0 found on disk 0 au 2 fcn 0.0\r\nNOTE: cache opening disk 1 of grp 1: CRS_0001 path:\/dev\/rhdisk9\r\nNOTE: F1X0 found on disk 1 au 2 fcn 0.0\r\nNOTE: cache opening disk 2 of grp 1: CRS_0002 path:\/dev\/rhdisk10\r\nNOTE: F1X0 found on disk 2 au 2 fcn 0.0\r\nNOTE: cache mounting (not first) normal redundancy group 1\/0xFDAEBF4E (CRS)\r\nFri Jun 17 10:00:14 2011\r\nkjbdomatt send to inst 1\r\nFri Jun 17 10:00:14 2011\r\nNOTE: attached to recovery domain 1\r\nFri Jun 17 10:00:14 2011\r\nNOTE: LGWR attempting to mount thread 2 for diskgroup 1 (CRS)\r\nNOTE: LGWR found thread 2 open - signalling ORA-15133\r\nWARNING: instance recovery required during mount\r\nkfdp_query(DATA): 5 \r\nkfdp_queryBg(): 5 \r\nNOTE: cache opening disk 0 of grp 2: DATA_0000 path:\/dev\/rhdisk6\r\nNOTE: F1X0 found on disk 0 au 2 fcn 0.61290\r\nNOTE: cache opening disk 1 of grp 2: DATA_0001 path:\/dev\/rhdisk12\r\nNOTE: cache mounting (not first) external redundancy group 2\/0xFE4EBF4F (DATA)\r\nkjbdomatt send to inst 1\r\nNOTE: attached to recovery domain 2\r\nNOTE: LGWR attempting to mount thread 2 for diskgroup 2 (DATA)\r\nNOTE: LGWR found thread 2 closed at ABA 12.1279\r\nNOTE: LGWR mounted thread 2 for diskgroup 2 (DATA)\r\nNOTE: LGWR opening thread 2 at fcn 0.1600788 ABA 13.1280\r\nNOTE: cache mounting group 2\/0xFE4EBF4F (DATA) succeeded\r\nNOTE: cache ending mount (success) of group DATA number=2 incarn=0xfe4ebf4f\r\nkfdp_query(FRA): 6 \r\nkfdp_queryBg(): 6 \r\nNOTE: cache opening disk 0 of grp 3: FRA_0000 path:\/dev\/rhdisk7\r\nNOTE: F1X0 found on disk 0 au 2 fcn 0.0\r\nNOTE: cache mounting (not first) external redundancy group 3\/0xFE5EBF50 (FRA)\r\nkjbdomatt send to inst 1\r\nNOTE: attached to recovery domain 3\r\nNOTE: LGWR attempting to mount thread 2 for diskgroup 3 (FRA)\r\nNOTE: LGWR found thread 2 closed at ABA 12.91\r\nNOTE: LGWR mounted thread 2 for diskgroup 3 (FRA)\r\nNOTE: LGWR opening thread 2 at fcn 0.2439 ABA 13.92\r\nNOTE: cache mounting group 3\/0xFE5EBF50 (FRA) succeeded\r\nNOTE: cache ending mount (success) of group FRA number=3 incarn=0xfe5ebf50\r\nFri Jun 17 10:00:17 2011\r\nkfdp_query(DATA): 7 \r\nkfdp_queryBg(): 7 \r\nNOTE: Instance updated compatible.asm to 11.2.0.0.0 for grp 2\r\nSUCCESS: diskgroup DATA was mounted\r\nkfdp_query(FRA): 8 \r\nkfdp_queryBg(): 8 \r\nNOTE: Instance updated compatible.asm to 11.2.0.0.0 for grp 3\r\nSUCCESS: diskgroup FRA was mounted\r\nkfdp_query(CRS): 10 \r\nkfdp_queryBg(): 10 \r\nNOTE: cache opening disk 0 of grp 1: CRS_0000 path:\/dev\/rhdisk8\r\nNOTE: F1X0 found on disk 0 au 2 fcn 0.0\r\nNOTE: cache opening disk 1 of grp 1: CRS_0001 path:\/dev\/rhdisk9\r\nNOTE: F1X0 found on disk 1 au 2 fcn 0.0\r\nNOTE: cache opening disk 2 of grp 1: CRS_0002 path:\/dev\/rhdisk10\r\nNOTE: F1X0 found on disk 2 au 2 fcn 0.0\r\nNOTE: cache mounting (not first) (retry) normal redundancy group 1\/0xFDAEBF4E (CRS)\r\nNOTE: LGWR attempting to mount thread 2 for diskgroup 1 (CRS)\r\nNOTE: LGWR found thread 2 open - signalling ORA-15133\r\nWARNING: instance recovery required during mount\r\n.\r\n.\r\n.\r\nFri Jun 17 10:06:55 2011\r\nkfdp_query(CRS): 406 \r\nkfdp_queryBg(): 406 \r\nNOTE: cache opening disk 0 of grp 1: CRS_0000 path:\/dev\/rhdisk8\r\nNOTE: F1X0 found on disk 0 au 2 fcn 0.0\r\nNOTE: cache opening disk 1 of grp 1: CRS_0001 path:\/dev\/rhdisk9\r\nNOTE: F1X0 found on disk 1 au 2 fcn 0.0\r\nNOTE: cache opening disk 2 of grp 1: CRS_0002 path:\/dev\/rhdisk10\r\nNOTE: F1X0 found on disk 2 au 2 fcn 0.0\r\nNOTE: cache mounting (not first) (retry) normal redundancy group 1\/0xFDAEBF4E (CRS)\r\nNOTE: LGWR attempting to mount thread 2 for diskgroup 1 (CRS)\r\nNOTE: LGWR found thread 2 open - signalling ORA-15133\r\nWARNING: instance recovery required during mount\r\nErrors in file \/u01\/grid\/diag\/asm\/+asm\/+ASM2\/trace\/+ASM2_ora_340052.trc (incident=11385):\r\nORA-00600: internal error code, arguments: [kfgFinalize_2], [], [], [], [], [], [], [], [], [], [], []\r\nIncident details in: \/u01\/grid\/diag\/asm\/+asm\/+ASM2\/incident\/incdir_11385\/+ASM2_ora_340052_i11385.trc\r\nFri Jun 17 10:07:01 2011\r\nTrace dumping is performing id=[cdmp_20110617100701]\r\nORA-00600: internal error code, arguments: [kfgFinalize_2], [], [], [], [], [], [], [], [], [], [], []\r\nERROR: ALTER DISKGROUP ALL MOUNT \/* asm agent *\/\r\nNOTE: cache dismounting (clean) group 1\/0xFDAEBF4E (CRS) \r\nNOTE: lgwr not being msg'd to dismount\r\nFri Jun 17 10:07:02 2011\r\nkjbdomdet send to inst 1\r\ndetach from dom 1, sending detach message to inst 1\r\nFri Jun 17 10:07:02 2011\r\nNOTE: detached from domain 1\r\nNOTE: cache dismounted group 1\/0xFDAEBF4E (CRS) \r\nNOTE: cache ending mount (fail) of group CRS number=1 incarn=0xfdaebf4e\r\nkfdp_dismount(): 407 \r\nFri Jun 17 10:07:02 2011\r\nkfdp_dismountBg(): 407 \r\nNOTE: De-assigning number (1,0) from disk (\/dev\/rhdisk8)\r\nNOTE: De-assigning number (1,1) from disk (\/dev\/rhdisk9)\r\nNOTE: De-assigning number (1,2) from disk (\/dev\/rhdisk10)\r\nERROR: diskgroup CRS was not mounted\r\nNOTE: cache deleting context for group CRS 1\/-38879410\r\nFri Jun 17 10:07:02 2011\r\nShutting down instance (abort)\r\nLicense high water mark = 2\r\nUSER (ospid: 307518): terminating the instance\r\nInstance terminated by USER, pid = 307518\r\nFri Jun 17 10:07:03 2011\r\nInstance shutdown complete<\/pre>\n\u5728\u5b9e\u4f8b\u5f02\u5e38\u5d29\u6e83\u540e\uff0c\u5c1d\u8bd5\u542f\u52a8ASM\u5b9e\u4f8b\u65f6\uff0cASM\u5c1d\u8bd5\u8fdb\u884c\u5b9e\u4f8b\u56de\u590d\uff0c\u5e76\u5bfc\u81f4\u4e86\u9519\u8bef\uff0cOracle\u5728\u4e0d\u65ad\u7684\u8fdb\u884c\u591a\u6b21\u5c1d\u8bd5\u540e\uff0c\u51fa\u73b0\u4e86\u8fd9\u4e2aORA-600\u7684\u9519\u8bef\uff0c\u5e76\u6700\u7ec8\u5bfc\u81f4\u4e86\u5b9e\u4f8b\u7684\u5f02\u5e38\u5173\u95ed\u3002
\n\u67e5\u8be2MOS\uff0c\u53d1\u73b0\u5b58\u5728\u51e0\u4e2a\u548c\u5f53\u524d\u7c7b\u4f3c\u7684\u9519\u8bef\u4fe1\u606f\uff0c\u9519\u8bef\u51fd\u6570\u90fd\u662fkfgFinalize_2\uff0c\u4e0d\u8fc7\u7edd\u5927\u90e8\u5206\u9519\u8bef\u90fd\u660e\u786e\u572811.2.0.1\u4e2d\u88abFIXED\u3002\u7ecf\u6392\u9664\u548c\u6587\u6863Bug 6771400 – ASM fails to mount a disk group with OERI[kfgfinalize_2] [ID 6771400.8]\u63cf\u8ff0\u7684\u6700\u4e3a\u89e3\u51b3\uff0c\u8be5\u9519\u8bef\u786e\u8ba4\u5f71\u54cd\u7684\u7248\u672c\u662f10.2.0.3\u548c10.2.0.4\uff0c\u572810.2.0.5\u548c11.1.0.6\u4e2d\u88abFIXED\uff0c\u8be5bug\u5e76\u6ca1\u6709\u63d0\u53ca11.2\u7248\u672c\uff0c\u56e0\u6b64\u4e0d\u786e\u8ba4\u5f53\u524d\u95ee\u9898\u662f\u5426\u572811.2.0.1\u7248\u672c\u51fa\u73b0\uff0c\u4e0d\u8fc7\u4ece\u5176\u4ed6\u8868\u76f8\u4e0a\u770b\uff0c\u5f53\u524d\u95ee\u9898\u5c5e\u4e8e\u8fd9\u4e2abug\u7684\u53ef\u80fd\u6027\u5f88\u5927\u3002
\n\u8fd9\u4e2a\u95ee\u9898\u53d1\u751f\u5728ASM\u5f02\u5e38\u5d29\u6e83\u540e\uff0c\u53ef\u80fd\u4f1a\u5bfc\u81f4ASM\u5b9e\u4f8b\u7b2c\u4e00\u6b21\u91cd\u542f\u51fa\u73b0\u5f02\u5e38\uff0c\u968f\u540e\u7684\u624b\u5de5\u542f\u52a8\u5e76\u672a\u53d1\u751f\u5f02\u5e38\uff0c\u4e14\u8be5\u95ee\u9898\u51fa\u73b0\u6982\u7387\u5f88\u4f4e\uff0c\u53ef\u4ee5\u5ffd\u7565\u6389\u8be5\u9519\u8bef\u3002<\/p>\n","protected":false},"excerpt":{"rendered":"
11.2.0.1\u7684ASM\u51fa\u73b0ORA-600[kfgFinalize_2]\u9519\u8bef\u3002 \u9519\u8bef\u4fe1\u606f\u4e3a\uff1a Fri Jun 17 09:59:51 2011 NOTE: No asm libraries found in the system * instance_number obtained from CSS = 2, checking for the existence of node 0… * node 0 does not exist. instance_number = 2 Starting ORACLE … Continue reading