python - 扭曲的 python 日志记录问题/困惑？

Question

我有一个基于 http://twistedmatrix.com/documents/current/_downloads/emailserver.tac 的 SMTP 服务器

这包含“custom_esmtp.py”，其中包含在twisted的smtp.py中找到的一些类的重载版本 - 包含它本身是为了允许没有重载版本的类。

默认情况下，上述 3 个文件中没有 log.startLogging 行。但是，我确实得到了一些基本的日志输出到标准输出:

> # twistd -ny mailserver.tac
2014-10-29 15:35:53+0000 [-] Log opened.
2014-10-29 15:35:53+0000 [-] twistd 14.0.0 (/usr/bin/python 2.6.6) starting up.
2014-10-29 15:35:53+0000 [-] reactor class: twisted.internet.epollreactor.EPollReactor.
2014-10-29 15:35:53+0000 [-] ConsoleSMTPFactory starting on 25
2014-10-29 15:35:53+0000 [-] Starting factory <__builtin__.ConsoleSMTPFactory instance at 0x31d67a0>
2014-10-29 15:35:55+0000 [mySMTP,0,127.0.0.1] Receiving myESMTP message for delivery: from=user1@nonpurdomain1.mta.test to=['user1@prefix-subject.domain.reg.test']

我认为这是某种标准级别的扭曲日志记录 - 但有待纠正。

但是，如果我添加:

> log.startLogging(sys.stdout)

到 emailserver.tac 的主要方法(当然还有所需的导入语句) - 然后我得到大量的数千个日志条目，它们似乎只是空日志行的日期/时间戳:

[-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 [-] 2014-10-29 15:15:20+0000 

任何人都可以提供发生的原因/发生的事情吗？ [-] 的意义是什么 - 我假设没有连接的客户端...但是当有连接时，这会变成显示的 3 个值 - 第二个值是什么？

有点迷失在这里，并希望了解此日志记录是如何工作的，以便我可以调整它以满足我们的要求。

谢谢!

Answer 1

你可以尝试这样的事情:

log.discardLogs()
log.startLogging(sys.stdout)

首先，twistd runner 在其内部调用 log.startLogging(...) 。第二件事是，每次调用 log.startLogging(...) 时，它都会将初始消息写入打开的日志流。

因为您在 Debug模式 (-n) 下运行 twind，twistd 会执行与您执行 log.startLogging(sys.stdout) 相同的调用。因此，当 log.startLogging(...) 被调用两次时，第二次调用会尝试写入也由第一个记录器写入的初始消息，并且会发生您所看到的效果。

但是，您实际上不需要调用 log.startLogging(...)，您应该使用 twind 选项之一:

-l, --logfile=   log to a specified file, - for stdout
--logger=        A fully-qualified name to a log observer factory to use
                   for the initial log observer. Takes precedence over
                   --logfile and --syslog (when available).

此外，当您使用 twind 时，您没有机会从日志中删除前三个字符串。

2014-10-29 15:35:53+0000 [-] Log opened.
2014-10-29 15:35:53+0000 [-] twistd 14.0.0 (/usr/bin/python 2.6.6) starting up.
2014-10-29 15:35:53+0000 [-] reactor class: twisted.internet.epollreactor.EPollReactor.

但是可以通过设置协议(protocol)噪声属性来静音工厂输出:

ConsoleSMTPFactory.protocol.noisy = False

我希望它能对您有所帮助并让您对扭曲日志有一些了解。