Re: "ORA-27300: OS system dependent operation:GetThreadTimes failed" Causes Instance Crash 10.2.0.2

chris.taylor_at_ingrambarge.com wrote:
> Charles Hooper wrote:
> > Just curious to see if anyone has seen this problem before - I could
> > not find anything on Metalink. One of my Oracle instances crashed at
> > 34 seconds past midnight on Saturday - no known jobs run at that time.
> > The server is running Windows 2003 x64, database is Oracle 10.2.0.2.
> > The instance has been extremely stable since put in production in April
> > 2006.
> >
> > The alert log shows this:
> > ---------------------------------
> > Sat Oct 28 00:00:34 2006
> > Process startup failed, error stack:
> > Sat Oct 28 00:00:34 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_psp0_2196.trc:
> > ORA-27300: OS system dependent operation:GetThreadTimes failed with
> > status: 6
> > ORA-27301: OS failure message: The handle is invalid.
> > ORA-27302: failure occurred at: skgpspawn
> >
> > Sat Oct 28 00:00:34 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_psp0_2196.trc:
> > ORA-00600: internal error code, arguments: [784], [0x1A0AB9EE0],
> > [0x195106208], [0], [], [], [], []
> >
> > Sat Oct 28 00:00:35 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_psp0_2196.trc:
> > ORA-00600: internal error code, arguments: [784], [0x1A0AB9EE0],
> > [0x195106208], [0], [], [], [], []
> >
> > PSP0: terminating instance due to error 490
> > Sat Oct 28 00:00:35 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_lgwr_1296.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:00:35 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_ckpt_888.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:00:35 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_pmon_2176.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:00:36 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_mman_2220.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:00:37 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_dbw0_1928.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:00:37 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_j000_4600.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:00:57 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_q003_1108.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:01:02 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_reco_1932.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:01:02 2006
> > Errors in file
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_smon_2044.trc:
> > ORA-00490: PSP process terminated with error
> >
> > Sat Oct 28 00:01:03 2006
> > Instance terminated by PSP0, pid = 2196
> > ---------------------------------
> > Metalink contains this information about the PSP0 process: New
> > background processes introduced in Oracle 10.2... PSP stands for
> > Process SPawner and this process has the job of creating and managing
> > other Oracle processes. NOTE: There is no documentation currently in
> > the Oracle Documentation set on this process.
> >
> > Among a lot of other items in the
> > d:\oracle\product\10.2.0\admin\DB\bdump\vmfg_psp0_2196.trc file, the
> > following appeared several times for all pso_serial#::
> > 047EA02B:55205486 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EA058:552054BE 27 0 10280 1 kst: process state object
> > created on 10-27 23:38:59.483
> > 047EA066:552054BF 27 0 10280 3 kst: process info: ospid=728
> > pso_num=27 pso_serial#=107
> > 047EA066:552054C0 27 0 10420 1 kso: new process: pid=728
> > (legacy spawn)
> > 047EA4A9:55205AF3 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EA4E4:55205B25 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:10.983
> > 047EA4E4:55205B26 27 0 10280 3 kst: process info: ospid=3320
> > pso_num=27 pso_serial#=108
> > 047EA4E4:55205B27 27 0 10420 1 kso: new process: pid=3320
> > (legacy spawn)
> > 047EA63F:55205EFC 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EA67C:55205F0B 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:15.061
> > 047EA67C:55205F0C 27 0 10280 3 kst: process info: ospid=3412
> > pso_num=27 pso_serial#=109
> > 047EA67C:55205F0D 27 0 10420 1 kso: new process: pid=3412
> > (legacy spawn)
> > 047EA7CC:552062E9 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EA7F8:55206303 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:19.014
> > 047EA807:55206304 27 0 10280 3 kst: process info: ospid=1784
> > pso_num=27 pso_serial#=110
> > 047EA807:55206305 27 0 10420 1 kso: new process: pid=1784
> > (legacy spawn)
> > 047EA95C:5520672F 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EA997:55206761 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:23.014
> > 047EA997:55206762 27 0 10280 3 kst: process info: ospid=2660
> > pso_num=27 pso_serial#=111
> > 047EA997:55206763 27 0 10420 1 kso: new process: pid=2660
> > (legacy spawn)
> > 047EAAD6:55206B43 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EAB10:55206B4F 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:26.780
> > 047EAB10:55206B50 27 0 10280 3 kst: process info: ospid=3560
> > pso_num=27 pso_serial#=112
> > 047EAB10:55206B51 27 0 10420 1 kso: new process: pid=3560
> > (legacy spawn)
> > 047EAF51:55207127 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EAF7A:55207176 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:38.264
> > 047EAF8C:55207177 27 0 10280 3 kst: process info: ospid=3416
> > pso_num=27 pso_serial#=113
> > 047EAF8C:55207178 27 0 10420 1 kso: new process: pid=3416
> > (legacy spawn)
> > 047EB0DF:5520753E 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EB113:5520754F 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:42.233
> > 047EB119:55207550 27 0 10280 3 kst: process info: ospid=4964
> > pso_num=27 pso_serial#=114
> > 047EB119:55207551 27 0 10420 1 kso: new process: pid=4964
> > (legacy spawn)
> > 047EB272:55207920 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EB2AC:5520794E 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:46.264
> > 047EB2AC:5520794F 27 0 10280 3 kst: process info: ospid=1376
> > pso_num=27 pso_serial#=115
> > 047EB2AC:55207950 27 0 10420 1 kso: new process: pid=1376
> > (legacy spawn)
> > 047EB407:55207D38 27 0 10280 8 kst: process state object about
> > to be deleted
> > 047EB42A:55207D91 27 0 10280 1 kst: process state object
> > created on 10-27 23:39:50.311
> > 047EB441:55207D92 27 0 10280 3 kst: process info: ospid=4728
> > pso_num=27 pso_serial#=116
> > 047EB441:55207D93 27 0 10420 1 kso: new process: pid=4728
> > (legacy spawn)
> >
> > It looks like Oracle 10.2.x may have a new feature.
> >
> > Charles Hooper
> > PC Support Specialist
> > K&M Machine-Fabricating, Inc.
>
> Search for [784] on Metalink. Found several docs that might be of
> interest.
>
> -10.2.0.x Oracle Database and Networking Patches for Microsoft
> Platforms
> -High Memory Usage On Planning Server Due To Constraint Based
> Optimization Plan
>

Thanks, for the response. I will take another look through Metalink. Metalink was mostly down early this morning. It looks like there have been several 10.2.0.2.x patches.

Charles Hooper
PC Support Specialist
K&M Machine-Fabricating, Inc. Received on Mon Oct 30 2006 - 19:21:31 CST