2014-09-30 85 views
0

我们使用Netty 3.6.2来处理我们的HTTP请求。在繁忙时间,我们正在观察OPEN和BOUND事件之间的显着延迟(35秒)。Netty中的OPEN和BOUND事件之间的巨大延迟

我们已启用日志记录,但日志中没有错误。以下是我们要求的日志


New I/O server boss #9 INFO 2014-09-25 17:55:01,844: com.x.core.httpserver.HttpRequestListener Channel Event Received: [id: 0xbd52f223, /0:0:0:0:0:0:0:1:46143 => /0:0:0:0:0:0:0:1:9191] OPEN 
New I/O server boss #9 DEBUG 2014-09-25 17:55:01,844: org.jboss.netty.handler.logging.LoggingHandler [id: 0xbd52f223, /0:0:0:0:0:0:0:1:46143 => /0:0:0:0:0:0:0:1:9191] OPEN 
New I/O worker #4 INFO 2014-09-25 17:55:36,439: com.x.core.httpserver.HttpRequestListener Channel Event Received: [id: 0xbd52f223, /0:0:0:0:0:0:0:1:46143 => /0:0:0:0:0:0:0:1:9191] BOUND: /0:0:0:0:0:0:0:1:9191 
New I/O worker #4 DEBUG 2014-09-25 17:55:36,439: org.jboss.netty.handler.logging.LoggingHandler [id: 0xbd52f223, /0:0:0:0:0:0:0:1:46143 => /0:0:0:0:0:0:0:1:9191] BOUND: /0:0:0:0:0:0:0:1:9191 
New I/O worker #4 INFO 2014-09-25 17:55:36,439: com.x.core.httpserver.HttpRequestListener Channel Event Received: [id: 0xbd52f223, /0:0:0:0:0:0:0:1:46143 => /0:0:0:0:0:0:0:1:9191] CONNECTED: /0:0:0:0:0:0:0:1:46143 

请看上面的日志行#2和#3之间的时间差。开放和绑定状态之间的延迟约为35秒。任何人都知道为什么会发生这种情况?

+0

也许你以某种方式阻止I/O线程? – 2014-10-01 04:39:33

+0

是的。我们正在朝这个方向进行调查。 – 2014-10-01 04:53:06

+0

@NormanMaurer我们不会阻止老板线程 – 2014-10-01 15:50:45

回答

0

原来我们阻塞了I/O线程。