大型系统中除错新思路

 大型系统中除错新思路

最近公司在线系统中经常性地发现一个Bug, 会导致数据库中一个核心表的数据发生混乱, 而因为这是个核心业务表,会有成千上万个存储过程，Stored Func，甚至直接是SQL语句对它进行数据Insert, Update。这给系统的维护，除错工作带来了极大的不便之处。

    尝试过N种方法都不能很好的解决这个问题，终于想出了一个办法，整体的思路是这样的：
1. 利用Trigger对这张表进行监控，一旦发现有冲突的数据时抛出异常。
2. 利用SQL Server中的DBCC 对当前会话中的@@SPID所执行的操作进行记录，从而得到引发异常的存储过程名字，参数，甚至是SQL语句，并且保存到一个Trace表中。
3. 周期性的查看Trace表以确定引发异常所执行的SQL语句，再根据源代码定位到出错的位置。

 

首先建立Trace表

CREATE TABLE dbo.DebugTrace(
 EventType nvarchar(30) COLLATE SQL_Latin1_General_CP1_CI_AS NULL,
 Parameters int NULL,
 EventInfo nvarchar(255) COLLATE SQL_Latin1_General_CP1_CI_AS NULL,
 LastModified datetime NOT NULL CONSTRAINT DF_DebugTrace_LastModified  DEFAULT (getdate())
)

 

Trigger的内容如下：

CREATE TRIGGER [dbo].[ProgressValidation] ON [dbo].[Progress] --dbo.Progress是核心业务表
  WITH EXECUTE AS 'sa'      -- 由于用到DBCC，需要有sysadmin的权限。
   FOR INSERT,UPDATE
AS
BEGIN
    SET NOCOUNT ON;

    DECLARE @SP NVARCHAR(100)

    SET @SP=OBJECT_NAME(@@PROCID)    --这里是抛异常给客户端的Trigger的名字

    IF (SELECT COUNT(*)
          FROM dbo.Progress p
         INNER JOIN inserted i
            ON p.EnrollmentId=i.EnrollmentId
           AND i.InstanceId LIKE 'course%'
         WHERE p.InstanceId LIKE 'course%') > 1  --这里是关键，检查数据是否存在冲突
    BEGIN
      RAISERROR (N'Multiple progress occurs! stored procedure:%s',10,1, @SP)
      ROLLBACK TRANSACTION

      --这里开始是利用DBCC INPUTBUFFER操作记录当前会话最后执行的SQL语句

      DECLARE   @sql   NVARCHAR(300)  

      SET   @sql='DBCC INPUTBUFFER('+CAST(@@SPID AS VARCHAR)+')'
  
      INSERT INTO spy(eventType,Parameters,EventInfo)
      EXEC(@sql)

      --这里结束记录

      RETURN
    END

 SET NOCOUNT OFF;
END
GO

 

经过测试使用，发现了引发ERROR的罪魁祸首，哈哈！

EventType    Parameters     EventInfo     LastModified
------------------------------ --------------------------------------

Language Event                 0           Exec usp_addProgress           2009-02-18 01:41:24.547

(1 row(s) affected)

当你排错完毕时，不要忘记把Trigger disable掉哦，毕竟会影响到系统的效率。