2017-01-31 11 views
0

scala/playアプリケーションでは、通常約1秒の応答が必要です。リクエストの約2〜4%は約秒に応答し、webproxyは要求をタイムアウトします(504)。 61秒はタイムアウトのように疑わしく見えます。Playフレームワーク60秒遅れのある情報をログに記録

ログから詳細情報を取得しようとしていますが、61秒間は無音状態です。私はの再生io.nettyをレベルDEBUGに設定しようとしましたが、何も見つかりませんでした。 第2のギャップに次のリクエストが続く応答が

2017-01-31 13:12:08,624 - [DEBUG] - from com.xxx.api.controllers.Api in monolith-akka.actor.default-dispatcher-31 
new Result created - .. .. 
2017-01-31 13:13:09,892 - [DEBUG] - from com.xxx.controllers.Api in monolith-akka.actor.default-dispatcher-34 
Upload media - .. .. 

のように見えます

2017-01-31 13:13:09,931 - [DEBUG] - from com.xxx.api.controllers.Api in monolith-akka.actor.default-dispatcher-34 
new Result created - .. .. 
2017-01-31 13:13:11,318 - [DEBUG] - from com.xxx.api.controllers.Api in monolith- 
akka.actor.default-dispatcher-34 
Upload media - .. .. 

のように次の要求( 1.4第2のギャップ)に続いて成功した応答が見える誰もが何か提案を持っています13:12:08と13:13:09の間に何が起こっているのかを教えてくれるlogback.xmlの設定について。 IはCONF/logback.xmlにトレースするレベルをログに設定

+0

どこにログにコードがありますか? – nmat

+0

'uploadMedia()'は 'routes'設定から参照されるコントローラ実装メソッドです。 _Uploadメディア.._はメソッドの最初のステートメント、_new結果は.._がメソッドの最後のステートメントです。 –

+0

私は見つけることができるすべてのログでTRACEにレベルを設定して、遅延をPlayフレームワーク内で発生していることを示す次の2行に絞りました。 'XX:X5:netty' ' XXで受信された網状イベントループ-1 \t HTTPリクエストに45640 \t play.core.server.netty.PlayRequestHandler:X6:モノリスで45630 \t play.api.mvc.Action -akka.actor.default-dispatcher-23 \tリクエストでアクションを呼び出す –

答えて

0

<logger name="play" level="TRACE" />

ログは60秒の遅延が再生フレームワーク内のどこかで発生していることを示しています。私は今問題としてこれを報告しました6943

関連する問題