Cache issues only sometimes like a 0.5% chance of happening if not smaller

[Andrew Scott]

I have seen this a number of times now, and I am not sure why. But I can tell you that change no code, refresh the page and it works again. Refresh the page or just browse normally and every now and then this will happen.

 

If it helps this is ColdFusion 9.01 patched to the latest hotfix, but I have seen it on ColdFusion 9.01 without any hotfix.

 

Application Execution Exception

Error Type: AbstractAppender.NotImplementedException : [N/A]
Error Messages: This appender 'coldbox.system.logging.appenders.AsyncRollingFileAppender' must implement the 'logMessage()' method.

 

 

 

Regards,

Andrew Scott

http://www.andyscott.id.au/

 

 

 

 

[Luis Majano]

I think this one is a coldfusion cfthread issue as it seems it has called the base classes logMessage() instead of the concrete class asyncRollingFileAppender.  I think cfthread is loosing scope under load for some reason.

Don't know how to tackle this one.

Luis F. Majano
President
Ortus Solutions, Corp

ColdBox Platform: http://www.coldbox.org
Linked In: http://www.linkedin.com/pub/3/731/483
Blog: http://www.luismajano.com
IECFUG Manager: http://www.iecfug.com

On Thu, Sep 9, 2010 at 10:40 PM, Andrew Scott <and...@andyscott.id.au> wrote:

NotImplementedException

[Luis Majano]

Ok, Andrew, let's do this test just to see if it works.

Open the following file: coldbox.system.logging.appenders.AsyncFileAppender and go to line 84 where this is

<!--- Thread this puppy --->



<cfthread name="#threadName#" entry="#entry#"> 



  <cfset append(attributes.entry)>



</cfthread>








Now, change it to this:











<!--- Thread this puppy --->



<cfthread name="#threadName#" entry="#entry#"> 



  <cfset variables.append(attributes.entry)>



</cfthread>

Try that and let's see what happens.

Luis F. Majano
President
Ortus Solutions, Corp

ColdBox Platform: http://www.coldbox.org
Linked In: http://www.linkedin.com/pub/3/731/483
Blog: http://www.luismajano.com
IECFUG Manager: http://www.iecfug.com

[Andrew Scott]

Kk, haven’t noticed anything so far. But I just want to say there is no load on this, this was just me browsing my dev machine checking the links on a few pages. I got it to happen about 1-20 page hits about 5 times, but so far with those changes. No error as yet.

 

 

 

Regards,

Andrew Scott

http://www.andyscott.id.au/

 

 

 

 

--
You received this message because you are subscribed to the Google Groups "ColdBox Platform" group.
To post to this group, send email to col...@googlegroups.com
To unsubscribe from this group, send email to coldbox-u...@googlegroups.com
For more options, visit this group at http://groups-beta.google.com/group/coldbox
For News, visit http://blog.coldbox.org
For Documentation, visit http://wiki.coldbox.org

[Andrew Scott]

Spoke to soon.

 

Framework Initialization/Configuration Exception

Error Type: Object : [N/A]
Error Messages: The logMessage method was not found.
Either there are no methods with the specified method name and argument types or the logMessage method is overloaded with argument types that ColdFusion cannot decipher reliably. ColdFusion found 0 methods that match the provided arguments. If this is a Java object and you verified that the method exists, use the javacast function to reduce ambiguity.

 

 

 

Regards,

Andrew Scott

http://www.andyscott.id.au/

 

 

 

 

From: col...@googlegroups.com [mailto:col...@googlegroups.com] On Behalf Of Luis Majano

Sent: Friday, 10 September 2010 4:13 PM
To: col...@googlegroups.com
Subject: Re: [coldbox:5685] Cache issues only sometimes like a 0.5% chance of happening if not smaller

 

Ok, Andrew, let's do this test just to see if it works.

--

[Luis Majano]

Andrew,

Do you have config auto reload turned on?

Luis F. Majano
President
Ortus Solutions, Corp

ColdBox Platform: http://www.coldbox.org
Linked In: http://www.linkedin.com/pub/3/731/483
Blog: http://www.luismajano.com
IECFUG Manager: http://www.iecfug.com

[Andrew Scott]

No I don’t.

 

This might seem a bit out of left field, but I am thinking that it is cached related. I had it happen, after I had not browsed the app for a few minutes. As I stated earlier this is in development and I am the only one hitting the site, and I have also see other messages that are cache related that I have posted to here as well.

 

But this is a guess on my part.

[Luis Majano]

Well, the appenders are not using the cache.  That is just logbox via cfthread

How can I recreate this?

Luis F. Majano
President
Ortus Solutions, Corp

ColdBox Platform: http://www.coldbox.org
Linked In: http://www.linkedin.com/pub/3/731/483
Blog: http://www.luismajano.com
IECFUG Manager: http://www.iecfug.com

[Luis Majano]

I just build a load test on jmeter of 200 users hitting an ap every 1 second for 5 rounds with a simple handler just using the log.info()

no config auto reload, no debug mode.

Nothing.

Luis F. Majano
President
Ortus Solutions, Corp

ColdBox Platform: http://www.coldbox.org
Linked In: http://www.linkedin.com/pub/3/731/483
Blog: http://www.luismajano.com
IECFUG Manager: http://www.iecfug.com

[Andrew Scott]

That is a very good question, I am still trying to find a method to replicate it reliably.

[Andrew Scott]

Like I said it is certainly not a load problem, as I am the only user testing on this server. And one case I had touched the browser for a few mins, then when I clicked on a link in the application I got the last message posted.

 

Maybe it is a combination of my config settings, worst case I can zip up my application and get you to try it.

 

Now the thing is that I am personally not using any logging at this stage, so it has to be a system log problem as well. Next time I can duplicate it I’ll get the stack trace for you.

[Andrew Scott]

Ok here is the stack trace to this error, not sure if it helps or not.

 

Application Execution Exception

Error Type: Autowire.AutowireException : [N/A]
Error Messages: Error autowiring system.modules.blog.controllers.blog. This appender 'coldbox.system.logging.appenders.AsyncRollingFileAppender' must implement the 'logMessage()' method.
coldfusion.runtime.CustomException: This appender 'coldbox.system.logging.appenders.AsyncRollingFileAppender' must implement the 'logMessage()' method. at coldfusion.tagext.lang.ThrowTag.doStartTag(ThrowTag.java:142) at coldfusion.runtime.CfJspPage._emptyTcfTag(CfJspPage.java:2722) at cfAbstractAppender2ecfc424774562$funcLOGMESSAGE.runFunction(D:\projects\SpringField Release\coldbox\system\logging\AbstractAppender.cfc:161) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:220) at coldfusion.runtime.CfJspPage._invokeUDF(CfJspPage.java:2582) at coldfusion.runtime.CfJspPage._invoke(CfJspPage.java:2383) at cfAsyncRollingFileAppender2ecfc1005236113$funcLOGMESSAGE.runFunction(D:\projects\SpringField Release\coldbox\system\logging\appenders\AsyncRollingFileAppender.cfc:61) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:220) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:491) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:337) at coldfusion.runtime.CfJspPage._invoke(CfJspPage.java:2360) at cfLogger2ecfc696828893$funcLOGMESSAGE.runFunction(D:\projects\SpringField Release\coldbox\system\logging\Logger.cfc:327) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:517) at coldfusion.runtime.CfJspPage._invokeUDF(CfJspPage.java:2547) at cfLogger2ecfc696828893$funcDEBUG.runFunction(D:\projects\SpringField Release\coldbox\system\logging\Logger.cfc:231) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:220) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:491) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:337) at coldfusion.runtime.CfJspPage._invoke(CfJspPage.java:2360) at cfBeanFactory2ecfc1930679405$funcAUTOWIRE.runFunction(D:\projects\SpringField Release\coldbox\system\plugins\BeanFactory.cfc:659) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:517) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:496) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:355) at coldfusion.runtime.CfJspPage._invoke(CfJspPage.java:2301) at cfAutowire2ecfc2074090926$funcPROCESSAUTOWIRE.runFunction(D:\projects\SpringField Release\coldbox\system\interceptors\Autowire.cfc:139) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:220) at coldfusion.runtime.CfJspPage._invokeUDF(CfJspPage.java:2582) at cfAutowire2ecfc2074090926$funcAFTERHANDLERCREATION.runFunction(D:\projects\SpringField Release\coldbox\system\interceptors\Autowire.cfc:93) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:472) at coldfusion.filter.SilentFilter.invoke(SilentFilter.java:47) at coldfusion.runtime.UDFMethod$ReturnTypeFilter.invoke(UDFMethod.java:405) at coldfusion.runtime.UDFMethod$ArgumentCollectionFilter.invoke(UDFMethod.java:368) at coldfusion.filter.FunctionAccessFilter.invoke(FunctionAccessFilter.java:55) at coldfusion.runtime.UDFMethod.runFilterChain(UDFMethod.java:321) at coldfusion.runtime.UDFMethod.invoke(UDFMethod.java:517) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:496) at coldfusion.runtime.TemplateProxy.invoke(TemplateProxy.java:355) at coldfusion.runtime.CfJspPage._invoke(CfJspPage.java:2301) at

 

 

 

Regards,

Andrew Scott

http://www.andyscott.id.au/

 

 

 

 

From: col...@googlegroups.com [mailto:col...@googlegroups.com] On Behalf Of Luis Majano

Sent: Friday, 10 September 2010 4:13 PM

--