诡异的间隔为1秒的Timer线程长达2分钟不工作的问题

fanxuetang

最近在做优化一个线上数据服务器的工作，该服务器为运行在CentOS4.6上的用C++写的多线程程序， 程序有1个接收UDP网络数据包的线程，2个处理数据包的线程，1个发送UDP数据包的线程，1个epoll的线程实现TCP的收和发以及1个间隔为1秒的timer线程，这个线程定时打印一些统计信息到日志里。通过分析大概跑了一天的日志，发现其中有些异常的地方，日志里曾出现过一些长达2分钟的中断，比如03:28:03，03:28:04然后一下子跳到了03:30:03，而这个时间段也发现处理数据包的线程处理能力明显大幅度降低。

timer线程类似于
while(1)
{
    write log();
    sleep(1);
}

刚开始怀疑可能是usleep（它不是线程安全的）的问题，改成nanosleep以后问题依旧出现
又想到会不会是NTP时间同步引起时间的跳跃，之后也排除了它的影响，因为NTP是每天的20时进行的，而问题是在3:30发生的
后来又做了很多的调整，可还是出现这个问题，困惑的很，请大家帮忙分析一下。。。

redor

阻塞了

fanxuetang

2楼的能说的详细一些么？一个线程不可能2分钟都不被调度吧。

xinglp

系统太忙,sleep(1)只能保证1s之后返回,但是不保证1s以后多久,可能是0s,也可能是0.3s,也可能是三年五载

yby123

原帖由 xinglp 于 2009-5-22 16:29 发表
系统太忙,sleep(1)只能保证1s之后返回,但是不保证1s以后多久,可能是0s,也可能是0.3s,也可能是三年五载

精辟！ 阿娇！！！ 哈哈哈

fanxuetang

其实2分钟没有输出日志只是一种表象，而数据处理线程在这段时间内几乎丧失了处理能力，我真正关心的是什么原因导致了这种情况呢

blackuhlan

这种情况可能难于查找哦，考虑写个中断服务看看，就是超时到的处理函数。我不知道多线程可不可以哈，多进程是肯定可以的哈。

[ 本帖最后由 blackuhlan 于 2009-5-22 16:59 编辑 ]

maxxfire

也有可能其它进程抢用了大量CPU。
比如在windows下，当扫描病毒或玩3D游戏时，如果电脑配置不够好，经常会导致其它程序如mp3播放器卡死。。

urapple

楼主大大，你给的代码
while(1)
{
    write log();
    sleep(1);
}
就这几行来看，sleep（1）不要去怀疑，这个是系统控制的。一定会准时完成，
那就剩writelog了。查writelog吧。一定是它消耗了时间。不要把问题想的太复杂。
仔细看看writelog里，存在哪些隐患。

fanxuetang

回9楼：
write log()很简单就是往文件里写几行字而已，不可能有什么问题的