特定のレポートへのアクセス時にアプリケーションのタイムアウトが発生する

Question

アプリケーションは、このメソッドを呼び出し、reportsDAO.generateMsgFiveDaysCompltdReportの完了後に、実行にどれくらいの時間がかかったかを示します。ログで私は68-75秒間見ることができた。ただし、このメソッドを繰り返し呼び出しても、アプリケーションのタイムアウトが繰り返し発生します。私は、reportsDAO.generateMsgFiveDaysCompltdReportの前と後に "要求された"と "完了した"ロガーステートメントのために繰り返し呼び出しを知っています。それはスレッドのハングやDB接続の問題のためですか？私はSIT/UATまたはDEV環境で同じ問題を再現することができません。

ログ：

[12/12/16 15:32:21:983 EST] 00000049 SystemOut  O 12/12/2016 15:32:21,983 INFO (com.anthem.central.sm.delegate.ReportsDelegate:618) - Requested the report Messages+Turnaround+in+Business+Days+by+NPI+or+Queue for input criteria [ProfileId:VPurimetla2207, Start Date: 12%2F08%2F2016, End Date: 12%2F09%2F2016, Selected Queue: null] 
[12/12/16 15:32:28:463 EST] 0000004f SystemOut  O 12/12/2016 15:32:28,460 INFO (com.anthem.central.sm.delegate.ReportsDelegate:618) - Completed the report Messages+Turnaround+in+Business+Days+by+NPI+or+Queue for input criteria [ProfileId:VPurimetla2207, Start Date: 12%2F08%2F2016, End Date: 12%2F09%2F2016, Selected Queue: null] and total time taken is: 66.67 Sec. 
[12/12/16 15:32:57:293 EST] 0000004a SystemOut  O 12/12/2016 15:32:57,292 INFO (com.anthem.central.sm.action.ValidateUserAction:164) - User has logged on%0A+%28CustomInfo+%3A+%29%0A+%5Brequest+params%3A+none%5D%0A+%3Cuser%3A+HHarriman2642%3E+%7BsessionId%3A+cEKjYeADwPUwmrNRtAoTR5T%7D 
[12/12/16 15:33:00:466 EST] 0000004a SystemOut  O 12/12/2016 15:33:00,465 INFO (com.anthem.central.sm.dao.QuestionDAO:641) - QuestionDAO.sendClaimsMessage: ICN=ICN%23006390263 msgId=14172673 queueId=202 systemName=BXWGS patientID=LCB863763363 
[12/12/16 15:33:11:959 EST] 0000004f SystemOut  O 12/12/2016 15:33:11,958 INFO (com.anthem.central.sm.dao.QuestionDAO:641) - QuestionDAO.sendClaimsMessage: ICN=ICN%23006390267 msgId=14172677 queueId=90 systemName=NASCOPAR patientID=UGG9219580610001 
[12/12/16 15:33:22:147 EST] 0000004a SystemOut  O 12/12/2016 15:33:22,147 INFO (com.anthem.central.sm.delegate.ReportsDelegate:618) - Requested the report Messages+Turnaround+in+Business+Days+by+NPI+or+Queue for input criteria [ProfileId:VPurimetla2207, Start Date: 12%2F08%2F2016, End Date: 12%2F09%2F2016, Selected Queue: null] 
[12/12/16 15:33:24:478 EST] 00000049 SystemOut  O 12/12/2016 15:33:24,477 INFO (com.anthem.central.sm.delegate.ReportsDelegate:618) - Completed the report Messages+Turnaround+in+Business+Days+by+NPI+or+Queue for input criteria [ProfileId:VPurimetla2207, Start Date: 12%2F08%2F2016, End Date: 12%2F09%2F2016, Selected Queue: null] and total time taken is: 62.49 Sec. 
[12/12/16 15:33:27:687 EST] 00000049 SystemOut  O 12/12/2016 15:33:27,687 INFO (com.anthem.central.sm.dao.QuestionDAO:641) - QuestionDAO.sendClaimsMessage: ICN=ICN%23006390268 msgId=14172681 queueId=502 systemName=SEVA patientID=YRZ958M62248 
[12/12/16 15:34:22:245 EST] 0000003a SystemOut  O 12/12/2016 15:34:22,244 INFO (com.anthem.central.sm.delegate.ReportsDelegate:618) - Requested the report Messages+Turnaround+in+Business+Days+by+NPI+or+Queue for input criteria [ProfileId:VPurimetla2207, Start Date: 12%2F08%2F2016, End Date: 12%2F09%2F2016, Selected Queue: null] 
[12/12/16 15:34:28:404 EST] 0000004a SystemOut  O 12/12/2016 15:34:28,404 INFO (com.anthem.central.sm.delegate.ReportsDelegate:618) - Completed the report Messages+Turnaround+in+Business+Days+by+NPI+or+Queue for input criteria [ProfileId:VPurimetla2207, Start Date: 12%2F08%2F2016, End Date: 12%2F09%2F2016, Selected Queue: null] and total time taken is: 66.26 Sec. 
[12/12/16 15:34:50:717 EST] 0000004f SystemOut  O 12/12/2016 15:34:50,716 INFO (com.anthem.central.sm.action.ValidateUserMPPSSOAction:147) - prevProfileID hamde2pfs%23 found for DHamlin8008 
[12/12/16 15:34:50:720 EST] 0000004f SystemOut  O 12/12/2016 15:34:50,719 INFO (com.anthem.central.sm.action.ValidateUserMPPSSOAction:212) - User has logged on%0A+%28CustomInfo+%3A+%29%0A+%5Brequest+params%3A+TargetXML%3DPD94bWwgdmVyc2lvbj0iMS4wIiBlbmNvZGluZz0iVVRGLTgiPz48VXNlcj48UHJvdmlkZXJTdGF0ZT5DQTwvUHJvdmlkZXJTdGF0ZT48U1NPSWQ%2BYWthNDAwMzEzODE0MzQ8L1NTT0lkPjxIZWFsdGhQbGFuVXNlcklkPmhhbWRlMnBmczwvSGVhbHRoUGxhblVzZXJJZD48Um9sZT5VU0VSPC9Sb2xlPjxEZWVwbGlua0lkPjwvRGVlcGxpbmtJZD48L1VzZXI%2B%2C+FirstName%3DY807Mmp0%2BuxqPSZGBmCLdQ%3D%3D%2C+LastName%3D2%2Fi%2BFEH6qyKDYDHatADmNA%3D%3D%2C+Email%3DLFKtdhJnLi8tV4k6hkDnO2XTL%2F8GigkELIsfpFEoxvg%3D%5D%0A+%3Cuser%3A+DHamlin8008%3E+%7BsessionId%3A+4sf5VL9IA5I-PF8c3Wgpzw8%7D 

Answer 1

それが繰り返しアプリケーションのタイムアウトを引き起こしても、このMethodeのを呼び出し続けますが。私は、reportsDAO.generateMsgFiveDaysCompltdReportの前と後に "要求された"と "完了した"ロガーステートメントのために繰り返し呼び出しを知っています。

これは、何かがgenerateMsgFiveDaysCompltdReportメソッドを複数回呼び出すことを示しています。あなたが私たちに与えたもので、なぜこれが起こっているのかは分かりません。あなたのメソッドを呼び出すコードがループや再帰的な文の途中にないのは確実ですか？

アプリケーションにデバッガが接続されている場合は、呼び出しスタックを調べると、余分な呼び出しがどこから来たのかが分かります。

Answer 2

非常に遅く投稿して申し訳ありません。私はStackOverflowの新機能です

原因：私は問題を自分で解決しましたが、ここに投稿するのを忘れていました。 WebsphereのServerIOTimeout設定が60に設定されています.60秒以内に応答を受信しなかった場合、Webサーバーは要求を再度開始します。私の要求には、約70秒以上かかる問題を引き起こしたデータベースクエリが含まれているためです。クエリが20秒で実行されているため、低い環境で問題を再現できませんでした（データ量は非常に少ない）

解決策：serverIOtimeout設定を180秒に上げて解決しました。