Page 1 of 1

Maintenance Jobs not running

Posted: Fri Mar 02, 2012 7:59 am
by gdecaires
I'm getting the Maintenance Jobs not running message in my installation. It's a postgres install on version 5.0.4.

I turned on debugging and am getting the following:

---------------[ Fri, 02 Mar 2012 10:56:01 -0400 (PID: 14627) ]---------------
DEBUG [L154] [255ms]: TTDate::setTimeZone(): Setting TimeZone: System/Localtime
DEBUG [L529] [259ms]: Install::checkPHPVersion(): Comparing with Version: 5.2.6-1+lenny13
DEBUG [L406] [281ms]: TTi18n::chooseBestLocale(): Choosing Best Locale...
DEBUG [L481] [281ms]: TTi18n::chooseBestLocale(): Unable to find and set a locale.
DEBUG [L340] [301ms]: CronJobFactory::isScheduledToRun(): Name: AddPayPeriod Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [303ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 12:00 AM AST Based on Current Epoch:
DEBUG [L247] [303ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [303ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [303ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [303ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [304ms]: CronJobFactory::isScheduledToRun(): Name: AddUserDate Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [305ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 12:15 AM AST Based on Current Epoch:
DEBUG [L247] [305ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [305ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [305ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [305ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [306ms]: CronJobFactory::isScheduledToRun(): Name: calcExceptions Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [307ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 12:30 AM AST Based on Current Epoch:
DEBUG [L247] [307ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [307ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [307ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [307ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [308ms]: CronJobFactory::isScheduledToRun(): Name: AddRecurringPayStubAmendment Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [310ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 12:45 AM AST Based on Current Epoch:
DEBUG [L247] [310ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [310ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [310ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [310ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [311ms]: CronJobFactory::isScheduledToRun(): Name: AddRecurringHoliday Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [312ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 12:55 AM AST Based on Current Epoch:
DEBUG [L247] [312ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [313ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [313ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [313ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [314ms]: CronJobFactory::isScheduledToRun(): Name: UserCount Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [315ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 1:15 AM AST Based on Current Epoch:
DEBUG [L247] [315ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [315ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [315ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [315ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [316ms]: CronJobFactory::isScheduledToRun(): Name: AddRecurringScheduleShift Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [317ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 31-Dec-69 8:20 PM AST Based on Current Epoch:
DEBUG [L247] [317ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [317ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [317ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [317ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [318ms]: CronJobFactory::isScheduledToRun(): Name: CheckForUpdate Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [319ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 2:12 AM AST Based on Current Epoch:
DEBUG [L247] [319ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [319ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [319ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [319ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [320ms]: CronJobFactory::isScheduledToRun(): Name: AddAccrualPolicyTime Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [321ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 1:30 AM AST Based on Current Epoch:
DEBUG [L247] [321ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [321ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [321ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [321ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [322ms]: CronJobFactory::isScheduledToRun(): Name: UpdateCurrencyRates Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [323ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 1:45 AM AST Based on Current Epoch:
DEBUG [L247] [323ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [324ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [324ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [324ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [325ms]: CronJobFactory::isScheduledToRun(): Name: TimeClockSync Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [326ms]: Cron::getNextScheduleDate(): Next Scheduled Date: Based on Current Epoch:
DEBUG [L247] [326ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [326ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [326ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [326ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [327ms]: CronJobFactory::isScheduledToRun(): Name: MiscDaily Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [329ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 1:55 AM AST Based on Current Epoch:
DEBUG [L247] [329ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [329ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [329ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [329ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [330ms]: CronJobFactory::isScheduledToRun(): Name: MiscWeekly Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [335ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 04-Jan-70 1:55 AM AST Based on Current Epoch:
DEBUG [L247] [335ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [335ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [335ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [335ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [336ms]: CronJobFactory::isScheduledToRun(): Name: calcQuickExceptions Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [337ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 31-Dec-69 8:07 PM AST Based on Current Epoch:
DEBUG [L247] [337ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [337ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [337ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [337ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [338ms]: CronJobFactory::isScheduledToRun(): Name: GeoCode Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [339ms]: Cron::getNextScheduleDate(): Next Scheduled Date: 01-Jan-70 2:15 AM AST Based on Current Epoch:
DEBUG [L247] [339ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [339ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [339ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [339ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L340] [340ms]: CronJobFactory::isScheduledToRun(): Name: ScheduledReport Current Epoch: 02-Mar-12 10:56 AM AST Last Run Date:
DEBUG [L225] [341ms]: Cron::getNextScheduleDate(): Next Scheduled Date: Based on Current Epoch:
DEBUG [L247] [341ms]: Cron::isScheduledToRun(): JOB is SCHEDULED TO RUN NOW!
DEBUG [L1291] [341ms]: Misc::getSystemLoad(): Load Average: 0.15
DEBUG [L1309] [341ms]: Misc::isSystemLoadValid(): Load average within valid limits: Current: 0.15 Max: 9999
DEBUG [L411] [341ms]: CronJobFactory::Execute(): Job is currently running, skipping...
DEBUG [L63] [341ms]: [Function](): CRON: Jobs Executed: 16 of 16
---------------[ Fri, 02 Mar 2012 10:56:01 -0400 (PID: 14627) ]---------------

Please help

Re: Maintenance Jobs not running

Posted: Fri Mar 02, 2012 11:40 am
by shaunw
What edition of TimeTrex are you using?

Re: Maintenance Jobs not running

Posted: Fri Mar 02, 2012 2:23 pm
by gdecaires
5.0.4

Re: Maintenance Jobs not running

Posted: Fri Mar 02, 2012 2:30 pm
by shaunw
5.0.4 is the version, not the Edition.

Re: Maintenance Jobs not running

Posted: Thu May 10, 2012 10:07 pm
by relbud
Hi,

I am having the same issue since updating to 5.0.6 standard edition.

Everything was running until the upgrade, I then noticed that write permissions were incorrect for the "cache" directory which I corrected. The cache directory is being populated, the cron job is running every minute and always saying that all 16 jobs have been run.

The cron table in the postgresql database is not being updated.

Any ideas?

thanks a lot in advance!

Ariel

Re: Maintenance Jobs not running

Posted: Thu May 10, 2012 11:24 pm
by shaunw
Please enable debugging mode as per the FAQ: http://forums.timetrex.com/viewtopic.php?f=6&t=89 and post it here.