sybase Error: 624, Severity: 21, State: 1

数据库版本：
Adaptive Server Enterprise/12.5.0.3/EBF 11449 ESD#4/P/NT (IX86)/OS 4.0/rel12503
/
         1939/32-bit/OPT/Sat Sep 20 22:28:57 2003

errolog输出：

00:00000:00006:2009/10/16 11:22:27.51 kernel  shutdownproc: shutting down SQL Server!
00:00000:00006:2009/10/16 11:22:27.62 kernel  XP Server is not running.
00:00000:00006:2009/10/16 11:22:27.76 server  SQL Server shutdown by request.
00:00000:00006:2009/10/16 11:22:27.78 kernel  ueshutdown: exiting
00:00000:00006:2009/10/16 11:22:27.78 kernel  shutdown waiting for engine pid 1308 to exit...
00:00000:00006:2009/10/16 11:22:27.78 kernel  engine pid 1308 exit completed
00:00000:00000:2009/10/16 11:22:30.70 kernel  Warning: There is no valid license for ASE server product. Server is booting with all the option features disabled.
00:00000:00000:2009/10/16 11:22:30.70 kernel  Using config area from primary master device.
00:00000:00000:2009/10/16 11:22:30.70 kernel  Warning: Using default file 'c:/sybase/DYQCserver.cfg' since a configuration file was not specified. Specify a configuration file name in the RUNSERVER file to avoid this message.
00:00000:00000:2009/10/16 11:22:30.79 kernel  Using 100000 file descriptors.
00:00000:00000:2009/10/16 11:22:30.79 kernel  Adaptive Server Enterprise/12.5.0.3/EBF 11449 ESD#4/P/NT (IX86)/OS 4.0/rel12503/1939/32-bit/OPT/Sat Sep 20 22:28:57 2003
00:00000:00000:2009/10/16 11:22:30.79 kernel  Confidential property of Sybase, Inc.
00:00000:00000:2009/10/16 11:22:30.79 kernel  Copyright 1987, 2003
00:00000:00000:2009/10/16 11:22:30.79 kernel  Sybase, Inc.  All rights reserved.
00:00000:00000:2009/10/16 11:22:30.79 kernel  Unpublished rights reserved under U.S. copyright laws.
00:00000:00000:2009/10/16 11:22:30.79 kernel 
00:00000:00000:2009/10/16 11:22:30.79 kernel  This software contains confidential and trade secret information of Sybase,
00:00000:00000:2009/10/16 11:22:30.79 kernel  Inc.   Use,  duplication or disclosure of the software and documentation by
00:00000:00000:2009/10/16 11:22:30.79 kernel  the  U.S.  Government  is  subject  to  restrictions set forth in a license
00:00000:00000:2009/10/16 11:22:30.79 kernel  agreement  between  the  Government  and  Sybase,  Inc.  or  other  written
00:00000:00000:2009/10/16 11:22:30.79 kernel  agreement  specifying  the  Government's rights to use the software and any
00:00000:00000:2009/10/16 11:22:30.79 kernel  applicable FAR provisions, for example, FAR 52.227-19.
00:00000:00000:2009/10/16 11:22:30.79 kernel  Sybase, Inc. One Sybase Drive, Dublin, CA 94568, USA
00:00000:00000:2009/10/16 11:22:30.79 kernel  Using 'c:/sybase/DYQCserver.cfg' for configuration information.
00:00000:00000:2009/10/16 11:22:30.79 kernel  Logging ASE messages in file 'c:/sybase/ASE-12_5/install/errorlog'.
00:00000:00000:2009/10/16 11:22:30.81 kernel  Initializing MSDTC Connection
00:00000:00000:2009/10/16 11:22:31.82 kernel  MSDTC Initialization succeeded
00:00000:00000:2009/10/16 11:22:31.82 kernel  kdcl_sess_open: connectivity library supports master/query syntax.
00:00000:00000:2009/10/16 11:22:31.82 kernel  Directory Control Layer (DCL) using directory driver: InterfacesDriver
00:00000:00000:2009/10/16 11:22:31.82 kernel  SQL Server booted with TCP_NODELAY enabled.
00:00000:00000:2009/10/16 11:22:31.82 kernel  SQL Server NT process id is 0xbfc.
00:00000:00000:2009/10/16 11:22:31.82 kernel  SQL Server was started as a Service.
00:00000:00000:2009/10/16 11:22:31.82 kernel  SSL Plus v3.0.9 security modules loaded successfully.
00:00000:00000:2009/10/16 11:22:31.82 kernel  Network and device connection limit is 99992.
00:00000:00000:2009/10/16 11:22:31.92 server  Number of blocks left for proc headers: 3232.
00:00000:00000:2009/10/16 11:22:31.92 server  Proc header memory allocated 808 pages for each per engine cache
00:00000:00000:2009/10/16 11:22:31.92 server  Memory allocated for the default data cache cachelet 1: 8192 Kb
00:00000:00000:2009/10/16 11:22:31.92 server  Size of the 8K memory pool: 8192 Kb
00:00000:00000:2009/10/16 11:22:31.92 server  Memory allocated for the tempdbcache cachelet 1: 20480 Kb
00:00000:00000:2009/10/16 11:22:31.92 server  Size of the 8K memory pool: 20480 Kb
00:00000:00000:2009/10/16 11:22:31.92 kernel  Initializing virtual device 0, 'e:/data/master.dat' with dsync 'on'.
00:00000:00000:2009/10/16 11:22:31.92 kernel  Virtual device 0 started using asynchronous i/o.
00:00000:00000:2009/10/16 11:22:31.92 kernel  Worker Thread Manager is not enabled for use in SQL Server.
00:00000:00000:2009/10/16 11:22:31.92 kernel  Either the config parameter 'use security services' is set to 0, or ASE does not support use of external security mechanisms on this platform. The Security Control Layer will not be initialized. No external security mechanisms will be supported.
00:00000:00000:2009/10/16 11:22:31.93 kernel  engine 0, os pid 288  online
00:00000:00000:2009/10/16 11:22:31.93 server  No active traceflags
00:00000:00001:2009/10/16 11:22:31.93 kernel  libomni1 - Component Integration Services loaded; version 'libomni1 - Component Integration Services/12.5.0.3/EBF 11449 ESD#4/P/NT (IX86)/OS 4.0/rel12503/1939/32-bit/OPT/Sat Sep 20 22:28:57 2003'.
00:00000:00001:2009/10/16 11:22:31.93 kernel  libomni1 - Component Integration Services: using 'Sybase Client-Library/12.5/P-EBF10830 ESD#8-1/PC Intel/BUILD125-016-1/OPT/Wed Dec 04 19:38:23 2002'
00:00000:00001:2009/10/16 11:22:31.93 server  Opening Master Database ...
00:00000:00001:2009/10/16 11:22:31.93 server  Loading SQL Server's default sort order and character set
00:00000:00001:2009/10/16 11:22:31.93 server  Loaded default Unilib conversion handle.
00:00000:00001:2009/10/16 11:22:31.95 server  Recovering database 'master'.
00:00000:00001:2009/10/16 11:22:32.00 server  Checking external objects.
00:00000:00001:2009/10/16 11:22:32.00 server  Database 'master' is now online.
00:00000:00001:2009/10/16 11:22:32.00 server  The transaction log in the database 'master' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:32.00 server  Warning: ASE_HA has no valid license and therefore is not initialized.
00:00000:00001:2009/10/16 11:22:32.00 server  server is unnamed
00:00000:00001:2009/10/16 11:22:32.00 server  Activating disk 'escourt5_data'.
00:00000:00001:2009/10/16 11:22:32.00 kernel  Initializing virtual device 16, 'e:/data/escourt5_data.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 16 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'escourt5_data2'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 18, 'e:/data/escourt5_data2.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 18 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'escourt5_data3'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 19, 'e:/data/escourt5_data3.dev' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 19 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'escourt5_data4'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 23, 'e:/data/escourt5_data4.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 23 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'escourt5_log'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 17, 'e:/data/escourt5_log.dat' with dsync 'off'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 17 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'esdata1'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 2, 'e:/data/esdata1' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 2 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'esoa_dat'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 3, 'E:/oadata/esoa_dat.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 3 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'esoa_log'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 4, 'E:/oadata/esoa_log.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 4 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'esshare5_data1'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 20, 'e:/data/esshare5_data1.dat' with dsync 'off'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 20 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'esshare5_log'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 21, 'e:/data/esshare5_log.dat' with dsync 'off'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 21 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'sysprocsdev'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 1, 'e:/data/sybprocs.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 1 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.01 server  Activating disk 'tempdbdev'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Initializing virtual device 22, 'e:/data/tempdbdev.dat' with dsync 'on'.
00:00000:00001:2009/10/16 11:22:32.01 kernel  Virtual device 22 started using asynchronous i/o.
00:00000:00001:2009/10/16 11:22:32.06 server  Recovering database 'sybsystemdb'.
00:00000:00001:2009/10/16 11:22:32.09 server  Boot Count: 526
00:00000:00001:2009/10/16 11:22:32.09 server  Checking external objects.
00:00000:00001:2009/10/16 11:22:32.10 server  The transaction log in the database 'sybsystemdb' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:32.10 server  Database 'sybsystemdb' is now online.
00:00000:00001:2009/10/16 11:22:32.10 server  Recovering database 'model'.
00:00000:00001:2009/10/16 11:22:32.15 server  Checking external objects.
00:00000:00001:2009/10/16 11:22:32.15 server  The transaction log in the database 'model' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:32.15 server  Database 'model' is now online.
00:00000:00001:2009/10/16 11:22:32.15 server  The logical pagesize of the server is 8 Kb.
00:00000:00001:2009/10/16 11:22:32.15 server  0 dump conditions detected at boot time
00:00000:00001:2009/10/16 11:22:32.15 server  Resident Node id: e1d38702e5f8
00:00000:00001:2009/10/16 11:22:32.15 server  Transaction coordinator initialized.
00:00000:00001:2009/10/16 11:22:32.15 server  Clearing temp db
00:00000:00001:2009/10/16 11:22:34.81 server  The transaction log in the database 'tempdb' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:34.82 server  Database 'tempdb' is now online.
00:00000:00001:2009/10/16 11:22:34.82 server  Recovering database 'sybsystemprocs'.
00:00000:00001:2009/10/16 11:22:34.90 server  Checking external objects.
00:00000:00001:2009/10/16 11:22:34.90 server  The transaction log in the database 'sybsystemprocs' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:34.90 server  Database 'sybsystemprocs' is now online.
00:00000:00002:2009/10/16 11:22:34.90 kernel  network name 10.28.227.1, type ether, port 8888, filter NONE
00:00000:00001:2009/10/16 11:22:34.92 server  Recovering database 'esoa'.
00:00000:00001:2009/10/16 11:22:34.96 server  Checking external objects.
00:00000:00001:2009/10/16 11:22:34.96 server  The transaction log in the database 'esoa' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:34.98 server  Database 'esoa' is now online.
00:00000:00001:2009/10/16 11:22:34.98 server  Recovering database 'esshare5'.
00:00000:00001:2009/10/16 11:22:35.00 server  Checking external objects.
00:00000:00001:2009/10/16 11:22:35.00 server  The transaction log in the database 'esshare5' will use I/O size of 8 Kb.
00:00000:00001:2009/10/16 11:22:35.00 server  Database 'esshare5' is now online.
00:00000:00001:2009/10/16 11:22:35.01 server  Recovering database 'escourt5'.
00:00000:00001:2009/10/16 11:22:35.01 server  Error: 624, Severity: 21, State: 1
00:00000:00001:2009/10/16 11:22:35.01 server  Adaptive Server failed to retrieve a row via its RID in database 'escourt5' because the requested RID has a higher number than the last RID on the page. Rid pageid = 0x1c88a8; row num = 0x27. Page pointer = 0x261CA000, pageno = 1869992, status = 0x1, objectid = 8, indexid = 0, level = 0.
00:00000:00001:2009/10/16 11:22:35.01 server  Error: 3414, Severity: 21, State: 1
00:00000:00001:2009/10/16 11:22:35.01 server  Database 'escourt5' (dbid 6): Recovery failed. Check the SQL Server errorlog for further information as to the cause.
00:00000:00001:2009/10/16 11:22:35.01 server  Recovery complete.
00:00000:00001:2009/10/16 11:22:35.01 server  SQL Server's default unicode sort order is 'binary'.
00:00000:00001:2009/10/16 11:22:35.01 server  SQL Server's default sort order is:
00:00000:00001:2009/10/16 11:22:35.01 server   'bin_iso_1' (ID = 50)
00:00000:00001:2009/10/16 11:22:35.01 server  on top of default character set:
00:00000:00001:2009/10/16 11:22:35.01 server   'iso_1' (ID = 1).
00:00000:00001:2009/10/16 11:22:35.01 server  Master device size: 300 megabytes, or 153600 virtual pages. (A virtual page is 2048 bytes.)
01:00000:00000:2009/10/16 11:22:35.01 kernel  Network and device connection limit is 99992.
01:00000:00000:2009/10/16 11:22:35.01 kernel  engine 1, os pid 1308  online

首先判断错误为页损坏或者索引损坏，根据
Adaptive Server failed to retrieve a row via its RID in database 'escourt5' because the requested RID has a higher number than the last RID on the page. Rid pageid = 0x1c88a8; row num = 0x27. Page pointer = 0x261CA000, pageno = 1869992, status = 0x1, objectid = 8, indexid = 0, level = 0.
判断其中:objectid = 8 表示日志段有问题

解决方法一：截断日志
先把sysdatabases 的status 修改成-32768  然后重新启动数据库
登陆数据库
1>dump transaction escourt5 with truncate_only
2>go
Msg 921, Level 14, State 1:
Line 1:
Database 'escourt5' has not been recovered yet - please wait and try again.
1> dump transaction escourt5 with no_log
2> go
Msg 921, Level 14, State 1:
Line 1:
Database 'escourt5' has not been recovered yet - please wait and try again.
说明这种发不起作用
解决方法二:重做日志
1> sp_role "grant","sybase_ts_role",sa
2> go
All the roles specified to be granted in the grant role statement have already
been granted to grantee 'sa'.
Authorization updated.
(return status = 0)
1> use master
2> go
1> dbcc rebuild_log(escourt5,1,1)
2> go
DBCC execution completed. If DBCC printed error messages, contact a user with
System Administrator (SA) role.
1> shutdown with nowait
2> go
Server SHUTDOWN by request.
The SQL Server is terminating this process.
重启服务后把status修改成0后再重启服务。
服务启动正常
最好是通过dbcc checkdb(databasename)检查一下数据一致性。
如果没有问题，恢复成功！