Skip to main content
Inspiring
May 30, 2013
Question

Do these stack trace results offer any insight?

  • May 30, 2013
  • 1 reply
  • 681 views

I have two scripts that have been running happily for a couple of years.  The last couple of days they have thrown "The request has exceeded the allowable time limit Tag" -- one for a cfquery and another for a cfftp.  Can anyone tell me if these cfdumps contain any useful information that would help me identify why they timed out?  There are no entries in the application.log or exception.log related to these two incidents.

MessageThe request has exceeded the allowable time limit Tag: cfftp
StackTracecoldfusion.runtime.RequestTimedOutException: The request has exceeded the allowable time limit Tag: cfftp at coldfusion.tagext.net.FtpTag.checkTimeout(FtpTag.java:650) at coldfusion.tagext.net.FtpTag.doStartTag(FtpTag.java:674) at coldfusion.runtime.CfJspPage._emptyTcfTag(CfJspPage.java:2661) at cfsendLLfile2ecfm923917397.runPage(E:\Inetpub\wwwroot\scheduledTasks\processLMS\sendLLfile.cfm:27) at coldfusion.runtime.CfJspPage.invoke(CfJspPage.java:196) at coldfusion.filter.CFVariablesScopeFilter.invoke(CFVariablesScopeFilter.java:63) at coldfusion.tagext.lang.ModuleTag.doStartTag(ModuleTag.java:280) at coldfusion.runtime.CfJspPage._emptyTcfTag(CfJspPage.java:2661) at cfreadLL2ecfm124999075.runPage(E:\Inetpub\wwwroot\scheduledTasks\processLMS\readLL.cfm:43) at coldfusion.runtime.CfJspPage.invoke(CfJspPage.java:196) at coldfusion.tagext.lang.IncludeTag.doStartTag(IncludeTag.java:370) at coldfusion.filter.CfincludeFilter.invoke(CfincludeFilter.java:65) at coldfusion.filter.ApplicationFilter.invoke(ApplicationFilter.java:279) at coldfusion.filter.RequestMonitorFilter.invoke(RequestMonitorFilter.java:48) at coldfusion.filter.MonitoringFilter.invoke(MonitoringFilter.java:40) at coldfusion.filter.PathFilter.invoke(PathFilter.java:86) at coldfusion.filter.ExceptionFilter.invoke(ExceptionFilter.java:70) at coldfusion.filter.ClientScopePersistenceFilter.invoke(ClientScopePersistenceFilter.java:28) at coldfusion.filter.BrowserFilter.invoke(BrowserFilter.java:38) at coldfusion.filter.NoCacheFilter.invoke(NoCacheFilter.java:46) at coldfusion.filter.GlobalsFilter.invoke(GlobalsFilter.java:38) at coldfusion.filter.DatasourceFilter.invoke(DatasourceFilter.java:22) at coldfusion.CfmServlet.service(CfmServlet.java:175) at coldfusion.bootstrap.BootstrapServlet.service(BootstrapServlet.java:89) at jrun.servlet.FilterChain.doFilter(FilterChain.java:86) at coldfusion.monitor.event.MonitoringServletFilter.doFilter(MonitoringServletFilter.java:42) at coldfusion.bootstrap.BootstrapFilter.doFilter(BootstrapFilter.java:46) at jrun.servlet.FilterChain.doFilter(FilterChain.java:94) at jrun.servlet.FilterChain.service(FilterChain.java:101) at jrun.servlet.ServletInvoker.invoke(ServletInvoker.java:106) at jrun.servlet.JRunInvokerChain.invokeNext(JRunInvokerChain.java:42) at jrun.servlet.JRunRequestDispatcher.invoke(JRunRequestDispatcher.java:286) at jrun.servlet.ServletEngineService.dispatch(ServletEngineService.java:543) at jrun.servlet.jrpp.JRunProxyService.invokeRunnable(JRunProxyService.java:203) at jrunx.scheduler.ThreadPool$DownstreamMetrics.invokeRunnable(ThreadPool.java:320) at jrunx.scheduler.ThreadPool$ThreadThrottle.invokeRunnable(ThreadPool.java:428) at jrunx.scheduler.ThreadPool$UpstreamMetrics.invokeRunnable(ThreadPool.java:266) at jrunx.scheduler.WorkerThread.run(WorkerThread.java:66)

MessageThe request has exceeded the allowable time limit Tag: CFQUERY
StackTracecoldfusion.runtime.RequestTimedOutException: The request has exceeded the allowable time limit Tag: CFQUERY at coldfusion.sql.Executive.getRowSet(Executive.java:446) at coldfusion.sql.Executive.executeQuery(Executive.java:1252) at coldfusion.sql.Executive.executeQuery(Executive.java:1008) at coldfusion.sql.Executive.executeQuery(Executive.java:939) at coldfusion.sql.SqlImpl.execute(SqlImpl.java:325) at coldfusion.tagext.sql.QueryTag.executeQuery(QueryTag.java:831) at coldfusion.tagext.sql.QueryTag.doEndTag(QueryTag.java:521) at cfreadLL2ecfm124999075.runPage(E:\Inetpub\wwwroot\scheduledTasks\processLMS\readLL.cfm:2) at coldfusion.runtime.CfJspPage.invoke(CfJspPage.java:196) at coldfusion.tagext.lang.IncludeTag.doStartTag(IncludeTag.java:370) at coldfusion.filter.CfincludeFilter.invoke(CfincludeFilter.java:65) at coldfusion.filter.ApplicationFilter.invoke(ApplicationFilter.java:279) at coldfusion.filter.RequestMonitorFilter.invoke(RequestMonitorFilter.java:48) at coldfusion.filter.MonitoringFilter.invoke(MonitoringFilter.java:40) at coldfusion.filter.PathFilter.invoke(PathFilter.java:86) at coldfusion.filter.ExceptionFilter.invoke(ExceptionFilter.java:70) at coldfusion.filter.ClientScopePersistenceFilter.invoke(ClientScopePersistenceFilter.java:28) at coldfusion.filter.BrowserFilter.invoke(BrowserFilter.java:38) at coldfusion.filter.NoCacheFilter.invoke(NoCacheFilter.java:46) at coldfusion.filter.GlobalsFilter.invoke(GlobalsFilter.java:38) at coldfusion.filter.DatasourceFilter.invoke(DatasourceFilter.java:22) at coldfusion.CfmServlet.service(CfmServlet.java:175) at coldfusion.bootstrap.BootstrapServlet.service(BootstrapServlet.java:89) at jrun.servlet.FilterChain.doFilter(FilterChain.java:86) at coldfusion.monitor.event.MonitoringServletFilter.doFilter(MonitoringServletFilter.java:42) at coldfusion.bootstrap.BootstrapFilter.doFilter(BootstrapFilter.java:46) at jrun.servlet.FilterChain.doFilter(FilterChain.java:94) at jrun.servlet.FilterChain.service(FilterChain.java:101) at jrun.servlet.ServletInvoker.invoke(ServletInvoker.java:106) at jrun.servlet.JRunInvokerChain.invokeNext(JRunInvokerChain.java:42) at jrun.servlet.JRunRequestDispatcher.invoke(JRunRequestDispatcher.java:286) at jrun.servlet.ServletEngineService.dispatch(ServletEngineService.java:543) at jrun.servlet.jrpp.JRunProxyService.invokeRunnable(JRunProxyService.java:203) at jrunx.scheduler.ThreadPool$DownstreamMetrics.invokeRunnable(ThreadPool.java:320) at jrunx.scheduler.ThreadPool$ThreadThrottle.invokeRunnable(ThreadPool.java:428) at jrunx.scheduler.ThreadPool$UpstreamMetrics.invokeRunnable(ThreadPool.java:266) at jrunx.scheduler.WorkerThread.run(WorkerThread.java:66)
This topic has been closed for replies.

1 reply

BKBK
Community Expert
Community Expert
June 2, 2013

The cfquery and  cfftp may not necessarily have anything to do with the time-out. They appear in the error message most likely because they were the tags being executed when the time-out occurred. 

The dumps tell me a RequestTimedOutException occurred. In all likelihood, the requests in question each exceeded the timeout value that you set in the Administrator. So, open the Administrator, go to Server Settings > Settings and confirm that the value for 'Timeout Requests after seconds' is what you expect.

The dumps also tell me the pages that are timing out are, respectively,

E:\Inetpub\wwwroot\scheduledTasks\processLMS\sendLLfile.cfm

E:\Inetpub\wwwroot\scheduledTasks\processLMS\readLL.cfm

Check the code of these pages. Long-running loops are perhaps the most frequent causes of timeout. In particular, identify loops that involve cfquery and cfftp, respectively. Under which condition do the loops end? Is there a possibility they run more times than you expect?