There is latency at the start of a call. The log files show that there is a connection timeout when trying to access the followings:
a)
https://xx.xx.xx.xx/axis2/services/VPAppLogService
b) VPAppRuntimeVars:getAppVarsAxis2()
5014967 [VPBatchLogWriterThread:
https://xx.xx.xx.xx/axis2/services/VPAppLogService] WARN - BatchLogWriter:run() - BatchLogWriter thread is EXITING!!!
ERROR - VPAppRuntimeVars:getAppVarsAxis2() - Caught Exception FAILED with AxisFault faultCode: null error: Connection timed out: connect send to vpms url:
https://xx.xx.xx.xx/axis2/services/VPAppVarsService Application Name: From AE Server: SERVENAME NOTE: It could be caused by this VPMS is not online or some other network issues.
org.apache.axis2.AxisFault: Connection timed out: connect
at org.apache.axis2.AxisFault.makeFault(AxisFault.java:430)
at org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:193)
at org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:75)
at org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:389)
at org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:222)
at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:435)
at org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:402)
at org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:229)
at org.apache.axis2.client.OperationClient.execute(OperationClient.java:165)
at com.avaya.xml.ws.vpappvars.voiceportal.VPAppVarsServiceStub.getAppRuntimeVars(VPAppVarsServiceStub.java:192)
at com.avaya.vp.appruntimevars.AppRuntimeVarsAxis2.getAppVars(AppRuntimeVarsAxis2.java:93)
at com.avaya.vp.appruntimevars.VPAppRuntimeVars.getAppRuntimeVarsFromVPMS(VPAppRuntimeVars.java:187)
at com.avaya.vp.appruntimevars.VPAppRuntimeVars.getAppRuntimeVars(VPAppRuntimeVars.java:60)
at com.avaya.vp.appruntimevars.VPAppRuntimeVars.getGlobalAppRuntimeVars(VPAppRuntimeVars.java:83)
at com.avaya.runtimecommon.platforms.vp.PlatformParams.checkForUpdate(PlatformParams.java:52)
at com.avaya.sce.runtimecommon.SCESession.getSession(SCESession.java:543)
at com.avaya.sce.runtimecommon.SCESession.getSession(SCESession.java:591)
at com.avaya.sce.runtime.SCEServlet.requestHandler(SCEServlet.java:198)
at com.avaya.sce.runtime.SCEServlet.doGet(SCEServlet.java:181)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
at org.apache.coyote.http11.Http11AprProcessor.process(Http11AprProcessor.java:879)
at org.apache.coyote.http11.Http11AprProtocol$Http11ConnectionHandler.process(Http11AprProtocol.java:600)
at org.apache.tomcat.util.net.AprEndpoint$Worker.run(AprEndpoint.java:1703)
at java.lang.Thread.run(Thread.java:662)
VPAppRuntimeVars:getAppVarsAxis2() - Caught Exception FAILED with AxisFault faultCode: null error: Connection timed out: connect send to vpms url:
https://xx.xx.xx.xx/axis2/services/VPAppVarsService Application Name: From AE Server: SERVERNAME NOTE: It could be caused by this VPMS is not online or some other network issues.
org.apache.axis2.AxisFault: Connection timed out: connect
at org.apache.axis2.AxisFault.makeFault(AxisFault.java:430)
at org.apache.axis2.transport.http.HTTPSender.sendViaPost(HTTPSender.java:193)
at org.apache.axis2.transport.http.HTTPSender.send(HTTPSender.java:75)
at org.apache.axis2.transport.http.CommonsHTTPTransportSender.writeMessageWithCommons(CommonsHTTPTransportSender.java:389)
at org.apache.axis2.transport.http.CommonsHTTPTransportSender.invoke(CommonsHTTPTransportSender.java:222)
at org.apache.axis2.engine.AxisEngine.send(AxisEngine.java:435)
at org.apache.axis2.description.OutInAxisOperationClient.send(OutInAxisOperation.java:402)
at org.apache.axis2.description.OutInAxisOperationClient.executeImpl(OutInAxisOperation.java:229)
at org.apache.axis2.client.OperationClient.execute(OperationClient.java:165)
at com.avaya.xml.ws.vpappvars.voiceportal.VPAppVarsServiceStub.getAppRuntimeVars(VPAppVarsServiceStub.java:192)
at com.avaya.vp.appruntimevars.AppRuntimeVarsAxis2.getAppVars(AppRuntimeVarsAxis2.java:93)
at com.avaya.vp.appruntimevars.VPAppRuntimeVars.getAppRuntimeVarsFromVPMS(VPAppRuntimeVars.java:187)
at com.avaya.vp.appruntimevars.VPAppRuntimeVars.getAppRuntimeVars(VPAppRuntimeVars.java:60)
at com.avaya.vp.appruntimevars.VPAppRuntimeVars.getGlobalAppRuntimeVars(VPAppRuntimeVars.java:83)
at com.avaya.runtimecommon.platforms.vp.PlatformParams.checkForUpdate(PlatformParams.java:52)
at com.avaya.runtimecommon.platforms.vp.License.<init>(License.java:49)
at com.avaya.runtimecommon.platforms.vp.Toolkit.createLicense(Toolkit.java:46)
at com.avaya.sce.runtimecommon.License.getInstance(License.java:98)
at com.avaya.sce.runtime.Entry.handleRequest(Entry.java:184)
at com.avaya.sce.runtime.AppDocument.processRequest(AppDocument.java:241)
at com.avaya.sce.runtime.SCEServlet.requestHandler(SCEServlet.java:282)
at com.avaya.sce.runtime.SCEServlet.doGet(SCEServlet.java:181)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:293)
at org.apache.coyote.http11.Http11AprProcessor.process(Http11AprProcessor.java:879)
at org.apache.coyote.http11.Http11AprProtocol$Http11ConnectionHandler.process(Http11AprProtocol.java:600)
at org.apache.tomcat.util.net.AprEndpoint$Worker.run(AprEndpoint.java:1703)
at java.lang.Thread.run(Thread.java:662)
This seems to happen when we restart the tomcat instance that serves the OAD application and sometimes without restarting the Tomcat instance.
Questions
1) What does the runtime do at start of a call? And how often does it do it (frequency)?
2) What are 'VPAppLogService' and 'VPAppRuntimeVars:getAppVarsAxis2()' used for?
3) Why are we experiencing this latency?