Jobs running at exactly same time fail

Hi, we're still getting occasional (weekly) failures on some simple jobs.

This is the same issue I raised here a while ago http://www.softtreetech.com/support/phpBB2/viewtopic.php?t=22340

I've recreated the problem in a test environment:

Two queues, 'alpha' and 'bravo'

Two jobs, 'one' and 'two'. Both jobs are set to run every minute starting at midnight. Both jobs are JavaScript with '// dummy' as the script. Job one runs in queue alpha, job two in bravo.

The first time after about 15 minutes of running happily one of them exited with code -1. The second time it took 40 minutes. Obviously there's some conflict when running jobs concurrently.

Multiplatform edition 4.4 319 on Windows XP.

In production these jobs are triggered by other events so I can't prevent them from running concurrently.

Here's the debug log from a successful run at 10:04 and failure at 10:05:

Code:

2010-10-22 10:04:00,172 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - JVM version: 1.5.0_22-b03
2010-10-22 10:04:00,172 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : start
2010-10-22 10:04:00,172 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : job on demand: runtime id=519
2010-10-22 10:04:00,172 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : start
2010-10-22 10:04:00,172 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating business objects
2010-10-22 10:04:00,252 [main] DEBUG com.softtreetech.jscheduler.business.AbstractBusiness - System started from C:\Program Files\24x7_Scheduler\master.bat
2010-10-22 10:04:00,312 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - JVM version: 1.5.0_22-b03
2010-10-22 10:04:00,312 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : start
2010-10-22 10:04:00,312 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : job on demand: runtime id=520
2010-10-22 10:04:00,312 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : start
2010-10-22 10:04:00,312 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating business objects
2010-10-22 10:04:00,432 [main] DEBUG com.softtreetech.jscheduler.business.AbstractBusiness - System started from C:\Program Files\24x7_Scheduler\master.bat
2010-10-22 10:04:00,562 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating UI controller
2010-10-22 10:04:00,642 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : initializing business objects
2010-10-22 10:04:00,712 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating UI controller
2010-10-22 10:04:00,862 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : initializing business objects
2010-10-22 10:05:00,188 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - JVM version: 1.5.0_22-b03
2010-10-22 10:05:00,188 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : start
2010-10-22 10:05:00,188 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : job on demand: runtime id=521
2010-10-22 10:05:00,188 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : start
2010-10-22 10:05:00,188 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating business objects
2010-10-22 10:05:00,258 [main] DEBUG com.softtreetech.jscheduler.business.AbstractBusiness - System started from C:\Program Files\24x7_Scheduler\master.bat
2010-10-22 10:05:00,348 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - JVM version: 1.5.0_22-b03
2010-10-22 10:05:00,348 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : start
2010-10-22 10:05:00,348 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - main(...) : job on demand: runtime id=522
2010-10-22 10:05:00,348 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : start
2010-10-22 10:05:00,348 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating business objects
2010-10-22 10:05:00,468 [main] DEBUG com.softtreetech.jscheduler.business.AbstractBusiness - System started from C:\Program Files\24x7_Scheduler\master.bat
2010-10-22 10:05:00,518 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating UI controller
2010-10-22 10:05:00,668 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : initializing business objects
2010-10-22 10:05:00,809 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : creating UI controller
2010-10-22 10:05:00,989 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : initializing business objects
2010-10-22 10:05:01,019 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : Premature end of file.
2010-10-22 10:05:01,019 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : Setting shutdown event hook
2010-10-22 10:05:01,019 [main] FATAL com.softtreetech.jscheduler.JSchedulerStarter - startup() :
java.lang.IllegalStateException: pref db is not opened.
at com.softtreetech.jscheduler.business.preferences.AbstractPrefDatabase.checkOpened(Unknown Source)
at com.softtreetech.jscheduler.business.preferences.AbstractPrefDatabase.getIdsByType(Unknown Source)
at com.softtreetech.jscheduler.business.preferences.SettingsImpl.getOptions(Unknown Source)
at com.softtreetech.jscheduler.business.license.LicenseCheckerImpl.isExpired(Unknown Source)
at com.softtreetech.jscheduler.JSchedulerStarter.startup(Unknown Source)
at com.softtreetech.jscheduler.JSchedulerStarter.main(Unknown Source)
2010-10-22 10:05:01,049 [main] DEBUG com.softtreetech.jscheduler.business.Master - shutdown() start
2010-10-22 10:05:01,049 [main] DEBUG com.softtreetech.jscheduler.business.runner.JobExecutorImpl - killAll() start
2010-10-22 10:05:01,049 [main] DEBUG com.softtreetech.jscheduler.business.Master - shutdown() end

Thank you very much. This is very helpful. The trace log indicates some I/O conflict reading/writing preferences.xml file that shouldn't occur.
2010-10-22 10:05:01,019 [main] DEBUG com.softtreetech.jscheduler.JSchedulerStarter - startup() : Premature end of file.

We will look into this.