Discussion:
server stops with recovering during startup
(too old to reply)
Luc Van der Veurst
2007-10-25 17:14:00 UTC
Permalink
Hello,

I'm in trouble :-). We had disk problems, and I have to recover some
databases.
When I start the server, it seems that the recovery stops at some point in
time
and the server generates a stacktrace.

Any idea on how to proceed ?
Thanks,
Luc.

Version:

00:00000:00000:2007/10/25 18:58:53.43 kernel Adaptive Server
Enterprise/12.5.3/EBF 13054 ESD#5/P/Sun_svr4/OS 5.8/ase1253/1939/32-bit/FBO/
Tue Dec 6 07:15:03 2005

Stacktrace, that's also the end of the errorlog :

00:00000:00001:2007/10/25 18:58:56.86 server Database 'temp_db' is now
online.
00:00000:00001:2007/10/25 18:58:56.86 server Clearing temp db
00:00000:00001:2007/10/25 18:58:57.12 server The transaction log in the
database 'tempd_sa_db' will use I/O size of 2 Kb.
00:00000:00001:2007/10/25 18:58:57.15 server Database 'tempd_sa_db' is now
online.
00:00000:00001:2007/10/25 18:58:57.17 kernel current process (0x90009)
infected with 11
00:00000:00001:2007/10/25 18:58:57.17 kernel Address 0x0025be98
(des_boot_sysdes_xlate+0x178), siginfo (code, address) = (1, 0xd8eb2ce4)
00:00000:00001:2007/10/25 18:58:57.17 kernel
************************************
00:00000:00001:2007/10/25 18:58:57.17 kernel SQL causing error :
00:00000:00001:2007/10/25 18:58:57.17 kernel
************************************
00:00000:00001:2007/10/25 18:58:57.17 server SQL Text:
00:00000:00001:2007/10/25 18:58:57.17 kernel curdb = 1 tempdb = 2 pstat =
0x1000
00:00000:00001:2007/10/25 18:58:57.17 kernel lasterror = 926 preverror = 0
transtate = 1
00:00000:00001:2007/10/25 18:58:57.17 kernel curcmd = 0 program =
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00869a38
pcstkwalk+0x28(0x00000000, 0xddfafbdc, 0x0000270f, 0x00000002, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00869924
ucstkgentrace+0x1ac(0xea1a91b0, 0xf022dce0, 0x0000270f, 0x00000000,
0x0000000
0)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0080cee0
ucbacktrace+0xa8(0x00000000, 0x00000001, 0x0000001e, 0xea1b7c9c, 0xdc400000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0017f36c
terminate_process+0xefc(0xea1a91b0, 0x00e9c400, 0x00000000, 0x00006ee4,
0x000
00000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0082d294
kisignal+0x1ac(0x0001ac00, 0x0001ac00, 0x0159e400, 0x00000000, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0xff365bac
__sighndlr+0xc(0x0000000b, 0xddfb0d40, 0xddfb0a88, 0x0082d0e8, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0xff35f804
call_user_handler+0x234(0x0000000b, 0xddfb0d40, 0xddfb0a88, 0x00000000,
0x000
00000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0xff35f9b4
sigacthandler+0x64(0x0000000b, 0xddfb0d40, 0xddfb0a88, 0xddfb0e2c,
0x00e9c400
)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0025be54
des_boot_sysdes_xlate+0x134(0xe3c8dc88, 0x00ea68e4, 0x00000020, 0xe3d90900,
0
x0000180e)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x001dbdc0
hdl_backout_msg installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x002520a4
des__bootsystables+0x10c(0xe3d90900, 0x0000001b, 0xf022af18, 0x00000000,
0x00
000001)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00250a50
des_sysbuild+0xb0(0x00001000, 0x00000100, 0x00ea6800, 0x00002800,
0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00241088
db_fill+0x15c(0xe3d90900, 0x00000000, 0xffffffff, 0x00000001, 0x00244f20)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x001dbdc0
hdl_backout_msg installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x002475c0
dbt__fill+0x254(0xe3d90900, 0x00000000, 0x00000000, 0x00000000, 0xffffffff)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00244f20
dbt_get+0x1b8(0x01512c00, 0x00ed9400, 0x0159f400, 0x01510800, 0x00000014)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0023efdc
dbcontext_change+0x1c(0x00000000, 0x0000000f, 0x00000000, 0x00000000,
0x00000
000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0023f60c
usedb+0x48(0x00000000, 0x0000000f, 0x00000000, 0x00000000, 0x0000001d)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00417f78
boot__recover_and_online+0x28(0xf3d33000, 0x00000001, 0x00e9c400,
0x00419c7c,
0xea1aed1c)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x00422914
rec__caller_hdlr installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00419f58
rec__boot_recover_dbs+0x34c(0xf3d33000, 0xddfb1684, 0x00000002, 0xfffffffc,
0
xea1aed1c)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x004168a4
rec_run_parallel_recovery+0x248(0xf3d33000, 0xddfb1684, 0x00001400,
0xea1a91b
0, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x00422914
rec__caller_hdlr installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00419910
dorecover+0x1d4(0x00000001, 0xe3d47b80, 0x00000000, 0xdc796300, 0x00e9c400)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00182054
ds__recoverdbs+0x540(0x00001fc0, 0x00001c00, 0x00001fc2, 0x015a6800,
0x00e9c4
00)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0017d17c
dsinit+0x930(0x00000032, 0x00000001, 0x00000000, 0x00000000, 0x00003000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0087fc20
_coldstart(0x00000000, 0x0017c84c, 0x00000000, 0x00000000, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel end of stack trace, spid 1,
kpid 589833, suid 0
00:00000:00001:2007/10/25 18:58:57.18 server Recovery has restored the
value of 'local async prefetch limit' for '16K' pool in 'default d
ata cache' from '80' to 'DEFAULT'.
00:00000:00001:2007/10/25 18:58:57.18 server Recovery has restored the
value of 'local async prefetch limit' for '2K' pool in 'default da
ta cache' from '80' to 'DEFAULT'.
00:00000:00001:2007/10/25 18:58:57.19 server The wash size of the 16K
buffer pool in cache default data cache has been changed from 8000
Kb to 160 Kb due to a change in the size of the pool.
00:00000:00001:2007/10/25 18:58:57.20 server background task error 18558:
Unable to delete the '16K' pool in cache 'default data cache'.
00:00000:00001:2007/10/25 18:58:57.20 server background task error 18559:
This pool has been marked unavailable. You can remove it comple
tely by retrying sp_poolconfig when the cache is not in use or by restarting
the Server.
00:00000:00001:2007/10/25 18:58:57.21 server Recovery has restored the
original size for '16K' pool and '2K' pool in 'default data cache'
Luc Van der Veurst
2007-10-25 17:25:20 UTC
Permalink
I managed to get past this error. Doing a dropdb, hope it goes well :-).

Luc.
Post by Luc Van der Veurst
Hello,
I'm in trouble :-). We had disk problems, and I have to recover some
databases.
When I start the server, it seems that the recovery stops at some point in
time
and the server generates a stacktrace.
Any idea on how to proceed ?
Thanks,
Luc.
00:00000:00000:2007/10/25 18:58:53.43 kernel Adaptive Server
Enterprise/12.5.3/EBF 13054 ESD#5/P/Sun_svr4/OS
5.8/ase1253/1939/32-bit/FBO/
Tue Dec 6 07:15:03 2005
00:00000:00001:2007/10/25 18:58:56.86 server Database 'temp_db' is now
online.
00:00000:00001:2007/10/25 18:58:56.86 server Clearing temp db
00:00000:00001:2007/10/25 18:58:57.12 server The transaction log in the
database 'tempd_sa_db' will use I/O size of 2 Kb.
00:00000:00001:2007/10/25 18:58:57.15 server Database 'tempd_sa_db' is
now online.
00:00000:00001:2007/10/25 18:58:57.17 kernel current process (0x90009)
infected with 11
00:00000:00001:2007/10/25 18:58:57.17 kernel Address 0x0025be98
(des_boot_sysdes_xlate+0x178), siginfo (code, address) = (1, 0xd8eb2ce4)
00:00000:00001:2007/10/25 18:58:57.17 kernel
************************************
00:00000:00001:2007/10/25 18:58:57.17 kernel
************************************
00:00000:00001:2007/10/25 18:58:57.17 kernel curdb = 1 tempdb = 2 pstat =
0x1000
00:00000:00001:2007/10/25 18:58:57.17 kernel lasterror = 926 preverror =
0 transtate = 1
00:00000:00001:2007/10/25 18:58:57.17 kernel curcmd = 0 program =
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00869a38
pcstkwalk+0x28(0x00000000, 0xddfafbdc, 0x0000270f, 0x00000002, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00869924
ucstkgentrace+0x1ac(0xea1a91b0, 0xf022dce0, 0x0000270f, 0x00000000,
0x0000000
0)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0080cee0
ucbacktrace+0xa8(0x00000000, 0x00000001, 0x0000001e, 0xea1b7c9c, 0xdc400000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0017f36c
terminate_process+0xefc(0xea1a91b0, 0x00e9c400, 0x00000000, 0x00006ee4,
0x000
00000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0082d294
kisignal+0x1ac(0x0001ac00, 0x0001ac00, 0x0159e400, 0x00000000, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0xff365bac
__sighndlr+0xc(0x0000000b, 0xddfb0d40, 0xddfb0a88, 0x0082d0e8, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0xff35f804
call_user_handler+0x234(0x0000000b, 0xddfb0d40, 0xddfb0a88, 0x00000000,
0x000
00000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0xff35f9b4
sigacthandler+0x64(0x0000000b, 0xddfb0d40, 0xddfb0a88, 0xddfb0e2c,
0x00e9c400
)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0025be54
des_boot_sysdes_xlate+0x134(0xe3c8dc88, 0x00ea68e4, 0x00000020,
0xe3d90900, 0
x0000180e)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x001dbdc0
hdl_backout_msg installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x002520a4
des__bootsystables+0x10c(0xe3d90900, 0x0000001b, 0xf022af18, 0x00000000,
0x00
000001)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00250a50
des_sysbuild+0xb0(0x00001000, 0x00000100, 0x00ea6800, 0x00002800,
0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00241088
db_fill+0x15c(0xe3d90900, 0x00000000, 0xffffffff, 0x00000001, 0x00244f20)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x001dbdc0
hdl_backout_msg installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x002475c0
dbt__fill+0x254(0xe3d90900, 0x00000000, 0x00000000, 0x00000000, 0xffffffff)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00244f20
dbt_get+0x1b8(0x01512c00, 0x00ed9400, 0x0159f400, 0x01510800, 0x00000014)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0023efdc
dbcontext_change+0x1c(0x00000000, 0x0000000f, 0x00000000, 0x00000000,
0x00000
000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0023f60c
usedb+0x48(0x00000000, 0x0000000f, 0x00000000, 0x00000000, 0x0000001d)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00417f78
boot__recover_and_online+0x28(0xf3d33000, 0x00000001, 0x00e9c400,
0x00419c7c,
0xea1aed1c)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x00422914
rec__caller_hdlr installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00419f58
rec__boot_recover_dbs+0x34c(0xf3d33000, 0xddfb1684, 0x00000002,
0xfffffffc, 0
xea1aed1c)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x004168a4
rec_run_parallel_recovery+0x248(0xf3d33000, 0xddfb1684, 0x00001400,
0xea1a91b
0, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel [Handler pc: 0x00422914
rec__caller_hdlr installed by the following function:-]
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00419910
dorecover+0x1d4(0x00000001, 0xe3d47b80, 0x00000000, 0xdc796300, 0x00e9c400)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x00182054
ds__recoverdbs+0x540(0x00001fc0, 0x00001c00, 0x00001fc2, 0x015a6800,
0x00e9c4
00)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0017d17c
dsinit+0x930(0x00000032, 0x00000001, 0x00000000, 0x00000000, 0x00003000)
00:00000:00001:2007/10/25 18:58:57.17 kernel pc: 0x0087fc20
_coldstart(0x00000000, 0x0017c84c, 0x00000000, 0x00000000, 0x00000000)
00:00000:00001:2007/10/25 18:58:57.17 kernel end of stack trace, spid 1,
kpid 589833, suid 0
00:00000:00001:2007/10/25 18:58:57.18 server Recovery has restored the
value of 'local async prefetch limit' for '16K' pool in 'default d
ata cache' from '80' to 'DEFAULT'.
00:00000:00001:2007/10/25 18:58:57.18 server Recovery has restored the
value of 'local async prefetch limit' for '2K' pool in 'default da
ta cache' from '80' to 'DEFAULT'.
00:00000:00001:2007/10/25 18:58:57.19 server The wash size of the 16K
buffer pool in cache default data cache has been changed from 8000
Kb to 160 Kb due to a change in the size of the pool.
Unable to delete the '16K' pool in cache 'default data cache'.
This pool has been marked unavailable. You can remove it comple
tely by retrying sp_poolconfig when the cache is not in use or by
restarting the Server.
00:00000:00001:2007/10/25 18:58:57.21 server Recovery has restored the
original size for '16K' pool and '2K' pool in 'default data cache'
Loading...