One More Weird New Issue - Unmatched Tags

#1

Since upgrading, we’re getting these every 15-30 seconds in the application.log as well… Unless I’m crazy, the error doesn’t identify a page on which this is happening?

Application.log
“ERROR”,“http-nio-8888-exec-18”,“06/01/2019”,“07:40:00”,"",";Start and End Tag has not the same Name [cfoutput-cfif];lucee.runtime.exp.TemplateException: Start and End Tag has not the same Name [cfoutput-cfif]
at lucee.transformer.cfml.tag.CFMLTransformer.tag(CFMLTransformer.java:817)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:376)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.tag(CFMLTransformer.java:765)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:376)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:314)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:306)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:162)
at lucee.runtime.compiler.CFMLCompilerImpl._compile(CFMLCompilerImpl.java:125)
at lucee.runtime.compiler.CFMLCompilerImpl.compile(CFMLCompilerImpl.java:76)
at lucee.runtime.PageSourceImpl._compile(PageSourceImpl.java:402)
at lucee.runtime.PageSourceImpl.compile(PageSourceImpl.java:369)
at lucee.runtime.PageSourceImpl.loadPhysical(PageSourceImpl.java:348)
at lucee.runtime.PageSourceImpl.loadPageThrowTemplateException(PageSourceImpl.java:220)
at lucee.runtime.PageSourceImpl.loadPage(PageSourceImpl.java:967)
at lucee.runtime.PageContextImpl._doInclude(PageContextImpl.java:937)
at lucee.runtime.PageContextImpl._doInclude(PageContextImpl.java:834)
at lucee.runtime.listener.ClassicAppListener._onRequest(ClassicAppListener.java:64)
at lucee.runtime.listener.MixedAppListener.onRequest(MixedAppListener.java:43)
at lucee.runtime.PageContextImpl.execute(PageContextImpl.java:2409)
at lucee.runtime.PageContextImpl._execute(PageContextImpl.java:2399)
at lucee.runtime.PageContextImpl.executeCFML(PageContextImpl.java:2374)
at lucee.runtime.engine.Request.exe(Request.java:43)
at lucee.runtime.engine.CFMLEngineImpl._service(CFMLEngineImpl.java:1037)
at lucee.runtime.engine.CFMLEngineImpl.serviceCFML(CFMLEngineImpl.java:983)
at lucee.loader.engine.CFMLEngineWrapper.serviceCFML(CFMLEngineWrapper.java:102)
at lucee.loader.servlet.CFMLServlet.service(CFMLServlet.java:62)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:230)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.filters.CorsFilter.handleNonCORS(CorsFilter.java:419)
at org.apache.catalina.filters.CorsFilter.doFilter(CorsFilter.java:169)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:198)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:474)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:140)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:87)
at org.apache.catalina.valves.RemoteIpValve.invoke(RemoteIpValve.java:677)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:349)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:783)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:66)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:798)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1434)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:745)

Exception.log
“ERROR”,“http-nio-8888-exec-18”,“06/01/2019”,“07:40:00”,"",";Start and End Tag has not the same Name [cfoutput-cfif];lucee.runtime.exp.TemplateException: Start and End Tag has not the same Name [cfoutput-cfif]
at lucee.transformer.cfml.tag.CFMLTransformer.tag(CFMLTransformer.java:817)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:376)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.tag(CFMLTransformer.java:765)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:376)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:314)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:306)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:162)
at lucee.runtime.compiler.CFMLCompilerImpl._compile(CFMLCompilerImpl.java:125)
at lucee.runtime.compiler.CFMLCompilerImpl.compile(CFMLCompilerImpl.java:76)
at lucee.runtime.PageSourceImpl._compile(PageSourceImpl.java:402)
at lucee.runtime.PageSourceImpl.compile(PageSourceImpl.java:369)
at lucee.runtime.PageSourceImpl.loadPhysical(PageSourceImpl.java:348)
at lucee.runtime.PageSourceImpl.loadPageThrowTemplateException(PageSourceImpl.java:220)
at lucee.runtime.PageSourceImpl.loadPage(PageSourceImpl.java:967)
at lucee.runtime.PageContextImpl._doInclude(PageContextImpl.java:937)
at lucee.runtime.PageContextImpl._doInclude(PageContextImpl.java:834)
at lucee.runtime.listener.ClassicAppListener._onRequest(ClassicAppListener.java:64)
at lucee.runtime.listener.MixedAppListener.onRequest(MixedAppListener.java:43)
at lucee.runtime.PageContextImpl.execute(PageContextImpl.java:2409)
at lucee.runtime.PageContextImpl._execute(PageContextImpl.java:2399)
at lucee.runtime.PageContextImpl.executeCFML(PageContextImpl.java:2374)
at lucee.runtime.engine.Request.exe(Request.java:43)
at lucee.runtime.engine.CFMLEngineImpl._service(CFMLEngineImpl.java:1037)
at lucee.runtime.engine.CFMLEngineImpl.serviceCFML(CFMLEngineImpl.java:983)
at lucee.loader.engine.CFMLEngineWrapper.serviceCFML(CFMLEngineWrapper.java:102)
at lucee.loader.servlet.CFMLServlet.service(CFMLServlet.java:62)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:230)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.filters.CorsFilter.handleNonCORS(CorsFilter.java:419)
at org.apache.catalina.filters.CorsFilter.doFilter(CorsFilter.java:169)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:198)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:474)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:140)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:87)
at org.apache.catalina.valves.RemoteIpValve.invoke(RemoteIpValve.java:677)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:349)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:783)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:66)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:798)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1434)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:745)

#2

Any ideas? It’s still happening 5-6 times a minute but no references to what template is causing the error in either Application or Exception.log. Could it be something internal? It didn’t happen until the upgrade.

“ERROR”,“http-nio-8888-exec-99”,“06/04/2019”,“20:03:47”,"",";Start and End Tag has not the same Name [cfoutput-cfif];lucee.runtime.exp.TemplateException: Start and End Tag has not the same Name [cfoutput-cfif]
at lucee.transformer.cfml.tag.CFMLTransformer.tag(CFMLTransformer.java:817)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:376)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.tag(CFMLTransformer.java:765)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:376)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.body(CFMLTransformer.java:384)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:314)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:306)
at lucee.transformer.cfml.tag.CFMLTransformer.transform(CFMLTransformer.java:162)
at lucee.runtime.compiler.CFMLCompilerImpl._compile(CFMLCompilerImpl.java:125)
at lucee.runtime.compiler.CFMLCompilerImpl.compile(CFMLCompilerImpl.java:76)
at lucee.runtime.PageSourceImpl._compile(PageSourceImpl.java:402)
at lucee.runtime.PageSourceImpl.compile(PageSourceImpl.java:369)
at lucee.runtime.PageSourceImpl.loadPhysical(PageSourceImpl.java:315)
at lucee.runtime.PageSourceImpl.loadPageThrowTemplateException(PageSourceImpl.java:220)
at lucee.runtime.PageSourceImpl.loadPage(PageSourceImpl.java:967)
at lucee.runtime.PageContextImpl._doInclude(PageContextImpl.java:937)
at lucee.runtime.PageContextImpl._doInclude(PageContextImpl.java:834)
at lucee.runtime.listener.ClassicAppListener._onRequest(ClassicAppListener.java:64)
at lucee.runtime.listener.MixedAppListener.onRequest(MixedAppListener.java:43)
at lucee.runtime.PageContextImpl.execute(PageContextImpl.java:2409)
at lucee.runtime.PageContextImpl._execute(PageContextImpl.java:2399)
at lucee.runtime.PageContextImpl.executeCFML(PageContextImpl.java:2374)
at lucee.runtime.engine.Request.exe(Request.java:43)
at lucee.runtime.engine.CFMLEngineImpl._service(CFMLEngineImpl.java:1037)
at lucee.runtime.engine.CFMLEngineImpl.serviceCFML(CFMLEngineImpl.java:983)
at lucee.loader.engine.CFMLEngineWrapper.serviceCFML(CFMLEngineWrapper.java:102)
at lucee.loader.servlet.CFMLServlet.service(CFMLServlet.java:62)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:729)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:230)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.filters.CorsFilter.handleNonCORS(CorsFilter.java:419)
at org.apache.catalina.filters.CorsFilter.doFilter(CorsFilter.java:169)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:198)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:474)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:140)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:87)
at org.apache.catalina.valves.RemoteIpValve.invoke(RemoteIpValve.java:677)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:349)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:783)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:66)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:798)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1434)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:745)

#3

I have filed a bug about the logged error message not including template information.
https://luceeserver.atlassian.net/browse/LDEV-2305

if you wrap a try catch around your code, you can see the template in the detail exception.

otherwise, you should be able to find the url of any request that is throwing a 500 error from your webserver logs and work back from there

#4

Thank you for the bug filing. Unfortunately I’m not seeing anything in our Apache error logs that matches up at all with these errors. Any Lucee errors seem to only be in the Lucee logs.

We’ve got more than 1500 templates, so I don’t think wrapping catches would be feasible without being able to narrow down where it might be occurring…

#5

OnError in application.cfc?

#6

Depending on your traffic (if its not too high) I would try checking out the webservers logfiles and cross reference requests time wirh the time of the error message. But of course, depends on how much traffic you have. But that could help guessing a little.

#7

Unfortunately (or fortunately!) we get at least a few hundred pages hit every second which is what made it such a needle in a hay stack to find this error. The good news is that we found the page in question via a Google Webmaster Tools (or whatever it’s called this week) report on Crawl errors and fixed the stupid coding error.

1 Like
#8

One trick I just remembered is to create a mapping and attempt to compile it into an archive via the admin. It will stop and report back on any compilation errors.

Lucee since 5.3.2 does this as part of the build process to validate thay all cfc/cfm’s shipped as part of a release are valid.