我正在使用raven和getsentry在django中记录消息,但日志记录似乎延迟了代码的执行。例如:
# ...view code
tic = datetime.datetime.now()
logging.warning('foo warning')
toc = datetime.datetime.now()
print "log time %s, %s, %s" % (tic, toc, (toc - tic).total_seconds())
# more view code...
给出输出:
log time 2013-09-25 12:03:56.541091, 2013-09-25 12:03:57.139420, 0.598329
也就是说,在这种情况下,它将代码的执行延迟了 600 毫秒。这是意料之中的事情吗?我本以为消息会在单独的线程中异步发送,这样主代码就不会延迟。此外,我对 app.getsentry.com 的ping时间为125ms,因此即使消息是同步发送的,600ms仍然显得异常大。我可以更改一些配置以加快速度吗?
设置文件:
LOGGING = {
'version': 1,
'disable_existing_loggers': True,
'handlers': {
'sentry': {
'level': 'INFO',
'class': 'raven.contrib.django.raven_compat.handlers.SentryHandler',
},
},
'loggers': {
'': {
'handlers': ['sentry'],
'level': 'INFO',
'propagate': True,
},
}
}
=== 编辑 ===
感谢 Filip Dupanović 指出 threading+ 协议。可悲的是,由于在启动工人时复制了线程,它们在 gunicorn 中对我不起作用。我通过在 gunicorn 配置文件中添加一个 post_fork 钩子来修复它,如下所示:
import logging
from raven.contrib.django.handlers import SentryHandler
from raven.transport.threaded import ThreadedHTTPTransport
def post_fork(server, worker):
LOG = logging.getLogger()
for handler in LOG.handlers:
if isinstance(handler, SentryHandler):
for url, transport in handler.client._registry._transports.items():
if isinstance(transport, ThreadedHTTPTransport):
if hasattr(transport, '_worker'):
server.log.info("deleting sentry thread worker attribute")
delattr(transport, '_worker')
else:
server.log.info("sentry thread worker not present, nothing to do.")
Obv 这是一个黑客,虽然它对我有用,但我不知道它是否在其他任何地方都有效。
如果您使用托管的哨兵服务,您可能会通过切换到 Raven 完全支持的threaded+http
传输而受益。查看 Raven 的文档,了解如何在服务名称中正确配置传输。
您可能还想尝试切换到其他一些专用并发传输或 UDP 协议。虽然您无法将 ICMP 请求延迟与 TCP 进行比较,但是的,增加的开销简直太可怕了,可以解决,所以不要担心!