java - logback 不同日志的相同时间戳

Question

我在 logback 的日志配置中使用以下日志模式属性。

<property name="FILE_LOG_PATTERN" value="%d{yyyy-MM-dd HH:mm:ss.SSS}  %5p ${PID:- } --- [%t] : [%X{requestContext}] [%X{transactionId}] - %m%n"/>

不幸的是，当我记录请求和响应时，时间戳完全相同。但是当我手动检查时，响应时间超过2秒

2016-09-12 09:57:39.925  DEBUG 5955 --- [http-nio-1980-exec-1] : Request: 
2016-09-12 09:57:39.925  DEBUG 5955 --- [http-nio-1980-exec-1] : Response:

由于我的代码没有添加日志记录时间，我相信我遗漏了一些东西。它可能是什么？

logback 也需要长达 30 秒的时间来记录某些内容。但我相信这是因为队列。与上述问题无关。

Answer 1

我找不到解决方案。所以我使用两个记录器来记录请求和响应。不幸的是它不起作用。所以，最后，我将日志过滤器分成了两个不同的类。我不确定它是否记录了正确的时间。但至少现在时间不一样了。