Yesterday I blogged about an issue RIAForge was having. What was supposed to be a once a day email about project updates magically turned into a three a day email. Here is the update.
I turned on the scheduler logger to see if I noticed anything odd. Unfortunately - nothing odd showed up there:
"Information" ,"scheduler-2", "11/20/07" ,"00:05:00", ,"C:\ColdFusion8\logs\scheduler.log initialized"
"Information" ,"scheduler-2" ,"11/20/07" ,"00:05:00" ,,"[RIAForge] Executing at Tue Nov 20 00:05:00 EST 2007"
"Information" ,"scheduler-2" ,"11/20/07" ,"00:05:03",,"[RIAForge] Rescheduling for :Wed Nov 21 00:05:00 EST 2007 Now: Tue Nov 20
Since I never messed with the scheduled task, this is what I expected. So why is the template running three times? And in what seems to be hourly increments?
For my next test I'm going to add some debugging to the code that does the email. I'm going to have it log the time and a few CGI variables.
I shared the code for RIAForge a few months back so it's possible someone is bored and is firing the event manually. I'll probably also add the 'url hack' I use for other scheduled tasks. Basically, if url.something doesn't exist, don't run. This is also handy for me as it tends to protect me from accidentally running the code myself.
p.s. I assume folks find this investigation interesting, so I'll keep posting updates.
Archived Comments
I had that problem once, turned out to be a simple error in the Query and nothing to do with the task. Might want to try that
If there was an error in the query, I'd expect multiple copies at once. Not over a span of 3 hours. But you have a point. It doesn't hurt to log this too.
"I assume folks find this investigation interesting, so I'll keep posting updates."
Yes, keep the updates coming. :)
so, has anyone find out whats going on ?
most of my task rescheduled for 20second later, in ColdFusion 8, does anyone know the reason ??
please see below:
24/10/2008 23:58 Information scheduler-14
[TASK NAME] Rescheduling for :Fri Oct 24 23:58:35 EST 2008 Now: Fri Oct 24 23:58:11 EST 2008
24/10/2008 23:58 Information scheduler-0
[TASK NAME] Rescheduling for :Fri Oct 24 23:58:35 EST 2008 Now: Fri Oct 24 23:58:04 EST 2008