通用日志系统开发【转】

1.前言

中大型软件项目中，日志系统是不可或缺的组成部分。尤其随着软件规模越来越大，内部结构越来越复杂，日志调试成为一种重要的调试方法。本文介绍了一个通用，高效，简洁的日志系统的设计思路。

文章分两部分，一部分是负责日志记录的CTLog类，另一部分是负责日志显示CTLogEdit类。

2.记录类CTLog

谈到通用日志系统，首先要考虑到三个问题：第一个是日志本身面向的对象要广泛，也就是日志要给谁看，都要记录什么样的信息。第二就是要考虑如何减少记录操作，将日志记录对整个系统的占用降到最低。最后，还要考虑如何管理日志，减少因为记录信息过多而造成对硬盘空间的浪费。

2.1日志分级

面对第一个问题，最好的解决方案就是提供日志分级系统。针对不同人的需求记录不同等级的信息。在这里我提供的建议是四级系统，我把它们写入一个enum中，如下所示：

enum TLOGPRIORITY

{

TLP_DEBUG = 0,

TLP_DETAIL,

TLP_NORMAL,

TLP_ERROR

};

其中，TLP_ERROR是最高等级，代表记录软件的各种异常信息，这也是最应该被反映在你的日志当中的。

TLP_NORMAL记录的是软件中的关键信息，类似于记录开始，初始化，连接握手开始等等。这些信息也是应该被你的软件用户所知情的。

TLP_DETAIL则记录了软件后台各种更加详细的信息，比如何时开启工作线程，何时销毁数据对象，通信握手具体进行到哪一步之类。此类信息，可以帮助你很好验证软件的功能是否实现，提供debug依据。

TLP_DEBUG是最低的等级，我个人不建议没事使用这一等级。它提供了在某些特殊情况下的动态调试，可以作为安插在代码中的记录标签，用于那些静态跟踪无能为力的场合。这是调试的终极手段。

2.2记录线程

提高日志效率的本质就是尽量减少对硬盘的操作次数。为了达到这个目的，我们可以使用开辟缓冲区的方法，并且用另外一个线程定时从缓冲中将信息写入文件中。在CTLog中，负责提取数据的是线程函数TLogThread，代码如下：

UINT CTLog::TLogThread(LPVOID wParam)

{

CTLog* pLog = (CTLog*)wParam;

while(pLog->m_bRun)

{

Sleep(3000);

EnterCriticalSection(&pLog->m_csTLog);

if (pLog->m_strTLogBuffer.GetLength())

{

pLog->m_pFile->WriteString(pLog->m_strTLogBuffer);

pLog->m_pFile->Flush();

pLog->m_strTLogBuffer.Empty();

}

LeaveCriticalSection(&pLog->m_csTLog);

if (pLog->m_pFile->m_hFile != INVALID_HANDLE_VALUE)

{

if (pLog->m_pFile->GetLength() >= pLog->m_ullMaxFileSize)

{

pLog->OpenNewFile();

}

EnterCriticalSection(&pLog->m_csTLog);

if (pLog->m_pFile->m_hFile != INVALID_HANDLE_VALUE)

{

pLog->m_pFile->WriteString(pLog->m_strTLogBuffer + _T("/r/n"));

pLog->m_pFile->Flush();

}

LeaveCriticalSection(&pLog->m_csTLog);

return 0;

}

该线程每三秒钟会唤醒一次，从CTLog中的缓冲区m_strTLogBuffer中提取字符流写入硬盘，然后将缓冲清空。需要注意的是，所有这些操作都应该在临界段中完成。

2.3日志管理

前面提到的最后一个问题就是如果日志数量太多了该怎么办？很多信息都是没用的了。答案很简单，把它删掉！为了方便删除，我们可以限制每个日志文件的大小，超过一定大小就重新开启一个新文件记录，并为旧日志打上时间戳。这样，你就可以根据文件建立时间很方便的删掉不需要的记录了。

前文中日志线程TLogThread会在每次唤醒时检查文件大小，如果超过限制，就会调用OpenNewFile重新开启新记录，该函数代码如下：

void CTLog::OpenNewFile()

{

EnterCriticalSection(&m_csTLog);

m_pFile->Close();

CFileStatus fs;

CFile::GetStatus(m_strTLogFilePath + _T("//debug.log"), fs);

CFile::Rename(m_strTLogFilePath + _T("//debug.log"), m_strTLogFilePath + _T("//debug_") + fs.m_ctime.Format(_T("%Y%m%d_%H%M%S")) + _T(".log"));

m_pFile->Open(m_strTLogFilePath + _T("//debug.log"), CFile::modeCreate | CFile::modeReadWrite |CFile::typeBinary | CFile::shareDenyNone, NULL);

m_pFile->Write("/377/376", 2);

LeaveCriticalSection(&m_csTLog);

}

这个函数会在后台将当前的文件按照建立时间改名，并重新建立一个名为debug.log的文件，作为当前日志的写入文件。

2.4记录信息

记录信息和线程函数的操作正相反，只是向缓冲区中添加字符串。为了增加灵活性，我没有在记录函数中增加时间戳和自动换行符，这些可以根据你自己的需要安排。

需要注意的一点是，插入动作同样需要在临界段中完成。

BOOL CTLog::TLogLine(LPCTSTR lpTLogLine, TLOGPRIORITY tlp)

{

if (tlp < m_TLogPriority)

{

return FALSE;

}

if (_tcslen(lpTLogLine))

{

EnterCriticalSection(&m_csTLog);

m_strTLogBuffer += lpTLogLine;

LeaveCriticalSection(&m_csTLog);

return TRUE;

}

else

{

return FALSE;

}

3.日志显示类CTLogEdit

第二节讲述的记录类，往往我们的程序中还需要一个特定的窗体来同步显示日志记录，这样我们就需要一个经过重载的文本框来提供显示支持。在这里CTLogEdit类重载自CRichEditCtrl。

作为一个日志显示的控件，我们同样需要首先考虑三个问题：第一，该控件最好支持按照日志分级来给记录着色。第二，尽可能的减小显示开销，避免闪烁，而且最好能限制显示的行数。最后，可以支持自动滚屏，显示最新的数据。

3.1文字着色

关于文字着色，我们可以利用父类中CRichEditCtrl的setsel函数和SetSelectionCharFormat函数。在CHARFORMAT2中记录字符的颜色信息，通过setsel选定某一行字符，然后调用SetSelectionCharFormat来替换颜色值。

我在这里将着色部分封装成函数SetLogLineColor，代码如下：

void CTLogEdit::SetLogLineColor(long lPos, TLOGPRIORITY tlp)

{

SetSel(lPos, lPos);

CHARFORMAT2 cf;

memset(&cf, 0, sizeof(CHARFORMAT2));

cf.dwMask |= CFM_COLOR;

cf.dwEffects &= ~CFE_AUTOCOLOR;

switch (tlp)

{

case TLP_DEBUG:

{

cf.crTextColor = TLP_DEBUG_COLOR;

break;

}

case TLP_DETAIL:

{

cf.crTextColor = TLP_DETAIL_COLOR;

break;

}

case TLP_NORMAL:

{

cf.crTextColor = TLP_NORMAL_COLOR;

break;

}

case TLP_ERROR:

{

cf.crTextColor = TLP_ERROR_COLOR;

break;

}

SetSelectionCharFormat(cf);

}

3.2提高显示效率

日志显示跟记录一样同样存在效率问题，尽可能减少显示次数也是我们要做的工作。这里思路和CTLog是一致的，都是向缓冲区写入数据，然后依靠另外的线程将信息提取出来显示。所不同的是，这里缓冲区就不能单单记录字符，还要将着色信息一并保存。我的做法是将日志字符跟日志等级信息封装在一起，放入一个缓冲队列中。数据结构如下：

typedef struct _TLOGITEM

{

CString line;

TLOGPRIORITY tlp;

} TLOGITEM, *PTLOGITEM;

记录函数TLogLine会将信息存入一个双向队列m_TLogItemQue，该成员对象属于CPtrList类型。同样，这个操作也是在临界段中完成的。

void CTLogEdit::TLogLine(LPCTSTR lpTLogLine, TLOGPRIORITY tlp)

{

EnterCriticalSection(&m_csTLogEdit);

PTLOGITEM pItem = new TLOGITEM;

pItem->line = lpTLogLine;

pItem->tlp = tlp;

m_TLogItemQue.AddTail(pItem);

LeaveCriticalSection(&m_csTLogEdit);

}

剩下来所有的显示操作都在单独的线程TLogEditThread中完成，这个线程会每隔一秒种从缓冲队列中提取出记录信息，并将之着色显示出来。代码如下：

UINT CTLogEdit::TLogEditThread(LPVOID wParam)

{

CTLogEdit* pEdit = (CTLogEdit*)wParam;

PTLOGITEM pItem;

long pos;

while(pEdit->m_bRun)

{

Sleep(1000);

while(!pEdit->m_TLogItemQue.IsEmpty())

{

EnterCriticalSection(&pEdit->m_csTLogEdit);

pItem = (PTLOGITEM)pEdit->m_TLogItemQue.RemoveHead();

LeaveCriticalSection(&pEdit->m_csTLogEdit);

pos = pEdit->GetTextLength();

pEdit->SetLogLineColor(pos, pItem->tlp);

pEdit->ReplaceSel(pItem->line);

pEdit->LimitLine();

delete pItem;

if (pEdit->m_bAutoScroll)

{

pEdit->SendMessage(WM_VSCROLL, SB_BOTTOM);

}

return 0;

}

这里还有一个加快显示的技巧。由于每次插入的数据在最后，因此，我们只要用setsel选中当前对话框文本的最后，并且调用ReplaceSel替换成新的字符串就可以了。记住，不要使用SetWindowText之类的函数，那样只会使你的程序效率降低。

另外出于减小内存消耗的考虑，我们不可能无休止的让日志显示在文本框中，因此有必要对整个文本框的显示行数进行控制。这里我将之封装成函数LimitLine，代码如下：

void CTLogEdit::LimitLine()

{

if (GetLineCount() - 1 > m_nLineLimit)

{

SetSel(0, LineLength(0) + 1);

Clear();

}

这个函数会通过调用GetLineCount得到当前行数，如果超过限制，则选中最上面一行，并调用Clear清除掉。

3.3自动卷动

相比之下，实现这个功能是比较简单的。在前面的TLogEditThread中，通过向滚动条发送WM_VSCROLL消息，并将之定位SB_BOTTOM完成了这个效果。

4.总结

总体来说，一个高效日志系统需要我们提供分级，多线程写入和显示功能。将这两个类配和起来使用，能很好实现设计要求。

另外，为了方便使用，还可以在程序中建立一个全局或者静态函数，将CTLog和CTLogEdit的写入函数封装起来加以调用。你甚至还可以再定义若干个宏，可以达到更加方便的效果J。

转：http://blog.csdn.net/vector03/article/details/6419199