Hi Dave,

On 12/10/2007, Dave <[EMAIL PROTECTED]> wrote:
> On 10/11/07, Jonathan Chen <[EMAIL PROTECTED]> wrote:
> > On 12/10/2007, Dave <[EMAIL PROTECTED]> wrote:
> > > On 10/10/07, Jonathan Chen <[EMAIL PROTECTED]> wrote:
> > > > I've been running 4.0 RC7 with PostgreSQL on Geronimo2 for almost a
> > > > week now, and I'm noticing that it doesn't appear to reset the
> > > > "Today's Hits" with the frontpage-theme; nor the count on [Create &
> > > > Edit] -> [Referrers] -> "Hits Counted Today" on a user's login. Is
> > > > anyone else seeing this?
> > >
> > > Could this be a caching issue? Are the values being reset in the
> > > database? What happens if you clear the cache. Do you see any evidence
> > > in the logs that the tasks are running?
> >
> > I had a look in the database, and I noticed that referer.reftime is
> > null for all the rows in the table. Perhaps this could be the cause
> > for the non-expiry?
>
> Hmm... I don't think that would stop the reset. I guess it is more
> likely that the reset is not running or hitting some other error.
>
> Are you seeing the task manager startup like so:
>
> INFO  2007-10-11 17:01:03,115 ThreadManagerImpl:initialize -
> Initializing task: ResetHitCountsTask
> INFO  2007-10-11 17:01:03,181 ThreadManagerImpl:initialize -
> Initializing task: TurnoverReferersTask
> INFO  2007-10-11 17:01:03,197 ThreadManagerImpl:initialize -
> Initializing task: PingQueueTask
> INFO  2007-10-11 17:01:03,228 ThreadManagerImpl:initialize -
> Initializing task: RefreshRollerPlanetTask
> INFO  2007-10-11 17:01:03,260 ThreadManagerImpl:initialize -
> Initializing task: SyncWebsitesTask

Yes.

> For more debug output, turn up debugging on task manager like so:
>     log4j.category.org.apache.roller.weblogger.business.runnable=DEBUG
>
> And watch what happens when tasks start and stop.

I've attached a log snippet below. It looks like the
ResetHitsCountTask is Launched, but fails to aquire a lease, and then
when it retries it decides that it can't run and decides to wait until
next midnight - but that's only an uninformed view. I hope the logs
can tell you exactly what's happening here.

Cheers.
-- 
Jonathan Chen <[EMAIL PROTECTED]>

--- Roller debug log ---
DEBUG 2007-10-16 00:00:00,050 GeronimoLog:debug - Current time = Tue
Oct 16 00:00:00 NZDT 2007
DEBUG 2007-10-16 00:00:00,052 GeronimoLog:debug - Started - Tue Oct 16
00:00:00 NZDT 2007
DEBUG 2007-10-16 00:00:00,055 GeronimoLog:debug -
ScheduledEntriesTask: next allowed run time = Sat Sep 29 17:11:00 NZST
2007
DEBUG 2007-10-16 00:00:00,056 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:00:00,056 GeronimoLog:debug -
ScheduledEntriesTask: LAUNCHING task
DEBUG 2007-10-16 00:00:00,058 GeronimoLog:debug -
ScheduledEntriesTask: Attempting to acquire lease
DEBUG 2007-10-16 00:00:00,066 GeronimoLog:debug -
ScheduledEntriesTask: Lease NOT acquired, cannot continue
DEBUG 2007-10-16 00:00:00,068 GeronimoLog:debug - ResetHitCountsTask:
next allowed run time = Sat Sep 29 00:00:00 NZST 2007
DEBUG 2007-10-16 00:00:00,069 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:00:00,069 GeronimoLog:debug - ResetHitCountsTask:
LAUNCHING task
DEBUG 2007-10-16 00:00:00,072 GeronimoLog:debug -
TurnoverReferersTask: next allowed run time = Sat Sep 29 00:00:00 NZST
2007
DEBUG 2007-10-16 00:00:00,073 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:00:00,073 GeronimoLog:debug -
TurnoverReferersTask: LAUNCHING task
DEBUG 2007-10-16 00:00:00,077 GeronimoLog:debug - PingQueueTask: next
allowed run time = Sat Sep 29 13:18:56 NZST 2007
DEBUG 2007-10-16 00:00:00,077 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:00:00,078 GeronimoLog:debug - PingQueueTask: LAUNCHING task
DEBUG 2007-10-16 00:00:00,078 GeronimoLog:debug - Finished
DEBUG 2007-10-16 00:00:00,079 GeronimoLog:debug - sleeping - 59970
DEBUG 2007-10-16 00:00:00,079 GeronimoLog:debug - ResetHitCountsTask:
Attempting to acquire lease
DEBUG 2007-10-16 00:00:00,081 GeronimoLog:debug -
TurnoverReferersTask: Attempting to acquire lease
DEBUG 2007-10-16 00:00:00,089 GeronimoLog:debug - PingQueueTask:
Attempting to acquire lease
DEBUG 2007-10-16 00:00:00,094 GeronimoLog:debug -
TurnoverReferersTask: Lease NOT acquired, cannot continue
DEBUG 2007-10-16 00:00:00,108 GeronimoLog:debug - PingQueueTask: Lease
NOT acquired, cannot continue
DEBUG 2007-10-16 00:00:00,113 GeronimoLog:debug - ResetHitCountsTask:
Lease NOT acquired, cannot continue
DEBUG 2007-10-16 00:00:43,416 GeronimoLog:debug - Completed: 0 secs
DEBUG 2007-10-16 00:00:43,417 GeronimoLog:debug -
HitCountQueueProcessor SLEEPING for 180000 milliseconds ...
DEBUG 2007-10-16 00:01:00,051 GeronimoLog:debug - Current time = Tue
Oct 16 00:01:00 NZDT 2007
DEBUG 2007-10-16 00:01:00,051 GeronimoLog:debug - Started - Tue Oct 16
00:01:00 NZDT 2007
DEBUG 2007-10-16 00:01:00,057 GeronimoLog:debug -
ScheduledEntriesTask: next allowed run time = Sat Sep 29 17:11:00 NZST
2007
DEBUG 2007-10-16 00:01:00,058 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:01:00,058 GeronimoLog:debug -
ScheduledEntriesTask: LAUNCHING task
DEBUG 2007-10-16 00:01:00,061 GeronimoLog:debug - ResetHitCountsTask:
next allowed run time = Sat Sep 29 00:00:00 NZST 2007
DEBUG 2007-10-16 00:01:00,062 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:01:00,062 GeronimoLog:debug - ResetHitCountsTask:
LAUNCHING task
DEBUG 2007-10-16 00:01:00,066 GeronimoLog:debug -
TurnoverReferersTask: next allowed run time = Sat Sep 29 00:00:00 NZST
2007
DEBUG 2007-10-16 00:01:00,066 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:01:00,067 GeronimoLog:debug -
TurnoverReferersTask: LAUNCHING task
DEBUG 2007-10-16 00:01:00,070 GeronimoLog:debug - PingQueueTask: next
allowed run time = Sat Sep 29 13:18:56 NZST 2007
DEBUG 2007-10-16 00:01:00,071 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:01:00,071 GeronimoLog:debug - PingQueueTask: LAUNCHING task
DEBUG 2007-10-16 00:01:00,072 GeronimoLog:debug - Finished
DEBUG 2007-10-16 00:01:00,073 GeronimoLog:debug - sleeping - 59976
DEBUG 2007-10-16 00:01:00,071 GeronimoLog:debug -
TurnoverReferersTask: Attempting to acquire lease
DEBUG 2007-10-16 00:01:00,080 GeronimoLog:debug - PingQueueTask:
Attempting to acquire lease
DEBUG 2007-10-16 00:01:00,071 GeronimoLog:debug - ResetHitCountsTask:
Attempting to acquire lease
DEBUG 2007-10-16 00:01:00,094 GeronimoLog:debug - ResetHitCountsTask:
Lease NOT acquired, cannot continue
DEBUG 2007-10-16 00:01:00,096 GeronimoLog:debug -
TurnoverReferersTask: Lease NOT acquired, cannot continue
DEBUG 2007-10-16 00:01:00,071 GeronimoLog:debug -
ScheduledEntriesTask: Attempting to acquire lease
DEBUG 2007-10-16 00:01:00,104 GeronimoLog:debug -
ScheduledEntriesTask: Lease NOT acquired, cannot continue
DEBUG 2007-10-16 00:01:00,106 GeronimoLog:debug - PingQueueTask: Lease
NOT acquired, cannot continue
DEBUG 2007-10-16 00:02:00,051 GeronimoLog:debug - Current time = Tue
Oct 16 00:02:00 NZDT 2007
DEBUG 2007-10-16 00:02:00,051 GeronimoLog:debug - Started - Tue Oct 16
00:02:00 NZDT 2007
DEBUG 2007-10-16 00:02:00,055 GeronimoLog:debug -
ScheduledEntriesTask: next allowed run time = Sat Sep 29 17:11:00 NZST
2007
DEBUG 2007-10-16 00:02:00,056 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:02:00,056 GeronimoLog:debug -
ScheduledEntriesTask: LAUNCHING task
DEBUG 2007-10-16 00:02:00,059 GeronimoLog:debug - ResetHitCountsTask:
next allowed run time = Sat Sep 29 00:00:00 NZST 2007
DEBUG 2007-10-16 00:02:00,060 GeronimoLog:debug - MISSED last run,
checking if waiting is necessary
DEBUG 2007-10-16 00:02:00,060 GeronimoLog:debug - WAITING for next
reasonable run time

Reply via email to