java.lang.IllegalArgumentException: endRule without matching beginRule: P/org.eclipse.tomcat with markcompact + eclipse(dacapo2006) #317
Description
First seen in mmtk/mmtk-core#1364. The PR is about log bit refactoring, and the failure was in mark compact which doesn't use log bits. So I assume they were not connected.
We enabled reference processing not long before mmtk/mmtk-core#1364, so it might be related with reference processing.
+++ /home/runner/work/mmtk-core/mmtk-core/mmtk-openjdk/.github/scripts/../../repos/openjdk/build/linux-x86_64-normal-server-fastdebug/jdk/bin/java -XX:+UseThirdPartyHeap -server -XX:MetaspaceSize=100M -Xms92M -Xmx92M -jar /home/runner/work/mmtk-core/mmtk-core/mmtk-openjdk/.github/scripts/../../dacapo/dacapo-2006-10-MR2.jar eclipse
[2025-08-14T23:34:36Z INFO mmtk::memory_manager] Initialized MMTk with MarkCompact (FixedHeapSize(96468992))
[2025-08-14T23:34:39Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:34:40Z INFO mmtk::scheduler::scheduler] End of GC (1525/23552 pages, took 996 ms)
===== DaCapo eclipse starting =====
<setting up workspace...>
<creating projects..............................................................>
[2025-08-14T23:34:42Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23556/23552 pages)
[2025-08-14T23:34:44Z INFO mmtk::scheduler::scheduler] End of GC (3735/23552 pages, took 2736 ms)
<running tests at level 0...>
<performing build tests...>
[2025-08-14T23:34:45Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23561/23552 pages)
[2025-08-14T23:34:48Z INFO mmtk::scheduler::scheduler] End of GC (4936/23552 pages, took 2870 ms)
org.apache.ant (not open) opening cleaning building
org.junit (not open) opening cleaning building
[2025-08-14T23:34:50Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23554/23552 pages)
[2025-08-14T23:34:50Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23554/23552 pages)
[2025-08-14T23:34:52Z INFO mmtk::scheduler::scheduler] End of GC (3922/23552 pages, took 1943 ms)
[2025-08-14T23:34:54Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23560/23552 pages)
[2025-08-14T23:34:54Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23560/23552 pages)
[2025-08-14T23:34:56Z INFO mmtk::scheduler::scheduler] End of GC (4826/23552 pages, took 2162 ms)
org.eclipse.osgi (not open) opening cleaning building
<performing type hierarchy tests...>
Hierarchy: org.eclipse.help.internal HelpPlugin
[2025-08-14T23:34:58Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23553/23552 pages)
[2025-08-14T23:35:00Z INFO mmtk::scheduler::scheduler] End of GC (4218/23552 pages, took 2109 ms)
[2025-08-14T23:35:02Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23555/23552 pages)
[2025-08-14T23:35:04Z INFO mmtk::scheduler::scheduler] End of GC (4570/23552 pages, took 2333 ms)
[2025-08-14T23:35:06Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23554/23552 pages)
[2025-08-14T23:35:08Z INFO mmtk::scheduler::scheduler] End of GC (4188/23552 pages, took 2492 ms)
[2025-08-14T23:35:09Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23553/23552 pages)
[2025-08-14T23:35:12Z INFO mmtk::scheduler::scheduler] End of GC (4388/23552 pages, took 2331 ms)
[2025-08-14T23:35:13Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23559/23552 pages)
[2025-08-14T23:35:15Z INFO mmtk::scheduler::scheduler] End of GC (4017/23552 pages, took 2347 ms)
[2025-08-14T23:35:16Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23557/23552 pages)
[2025-08-14T23:35:18Z INFO mmtk::scheduler::scheduler] End of GC (4300/23552 pages, took 2381 ms)
[2025-08-14T23:35:19Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23554/23552 pages)
[2025-08-14T23:35:22Z INFO mmtk::scheduler::scheduler] End of GC (4401/23552 pages, took 2424 ms)
[2025-08-14T23:35:23Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23555/23552 pages)
[2025-08-14T23:35:25Z INFO mmtk::scheduler::scheduler] End of GC (3876/23552 pages, took 2308 ms)
[2025-08-14T23:35:26Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23561/23552 pages)
[2025-08-14T23:35:28Z INFO mmtk::scheduler::scheduler] End of GC (4337/23552 pages, took 2347 ms)
[2025-08-14T23:35:28Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:35:31Z INFO mmtk::scheduler::scheduler] End of GC (3746/23552 pages, took 2379 ms)
[2025-08-14T23:35:31Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23554/23552 pages)
[2025-08-14T23:35:34Z INFO mmtk::scheduler::scheduler] End of GC (4335/23552 pages, took 2385 ms)
[2025-08-14T23:35:34Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23553/23552 pages)
[2025-08-14T23:35:37Z INFO mmtk::scheduler::scheduler] End of GC (4505/23552 pages, took 2426 ms)
[2025-08-14T23:35:37Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23554/23552 pages)
[2025-08-14T23:35:40Z INFO mmtk::scheduler::scheduler] End of GC (5773/23552 pages, took 2543 ms)
[2025-08-14T23:35:40Z INFO mmtk::mmtk] User triggering collection
[2025-08-14T23:35:41Z INFO mmtk::scheduler::scheduler] End of GC (3569/23552 pages, took 1527 ms)
[2025-08-14T23:35:42Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23554/23552 pages)
[2025-08-14T23:35:44Z INFO mmtk::scheduler::scheduler] End of GC (4255/23552 pages, took 2253 ms)
[2025-08-14T23:35:45Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23556/23552 pages)
[2025-08-14T23:35:47Z INFO mmtk::scheduler::scheduler] End of GC (4096/23552 pages, took 2335 ms)
[2025-08-14T23:35:47Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23555/23552 pages)
[2025-08-14T23:35:50Z INFO mmtk::scheduler::scheduler] End of GC (3928/23552 pages, took 2352 ms)
[2025-08-14T23:35:51Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:35:53Z INFO mmtk::scheduler::scheduler] End of GC (3849/23552 pages, took 2300 ms)
[2025-08-14T23:35:53Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23555/23552 pages)
[2025-08-14T23:35:56Z INFO mmtk::scheduler::scheduler] End of GC (3578/23552 pages, took 2317 ms)
[2025-08-14T23:35:56Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23555/23552 pages)
[2025-08-14T23:35:58Z INFO mmtk::scheduler::scheduler] End of GC (3915/23552 pages, took 2205 ms)
[2025-08-14T23:35:59Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:36:01Z INFO mmtk::scheduler::scheduler] End of GC (3761/23552 pages, took 2296 ms)
[2025-08-14T23:36:02Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23559/23552 pages)
[2025-08-14T23:36:04Z INFO mmtk::scheduler::scheduler] End of GC (4306/23552 pages, took 2253 ms)
[2025-08-14T23:36:05Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23553/23552 pages)
[2025-08-14T23:36:07Z INFO mmtk::scheduler::scheduler] End of GC (3673/23552 pages, took 2256 ms)
<performing AST tests...>
AST creation: org.eclipse.jdt.internal.compiler.parser
[2025-08-14T23:36:08Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:36:08Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23555/23552 pages)
[2025-08-14T23:36:08Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:36:10Z INFO mmtk::scheduler::scheduler] End of GC (4886/23552 pages, took 2315 ms)
<performing completion tests...>
Completion: Completion>Name>Empty
Completion: Completion>Name>Empty>No Method
<performing search tests...>
Searching: indexing
[2025-08-14T23:36:12Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23555/23552 pages)
[2025-08-14T23:36:14Z INFO mmtk::scheduler::scheduler] End of GC (4279/23552 pages, took 2073 ms)
[2025-08-14T23:36:14Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23554/23552 pages)
[2025-08-14T23:36:17Z INFO mmtk::scheduler::scheduler] End of GC (3755/23552 pages, took 2267 ms)
[2025-08-14T23:36:18Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23556/23552 pages)
[2025-08-14T23:36:20Z INFO mmtk::scheduler::scheduler] End of GC (4342/23552 pages, took 2339 ms)
[2025-08-14T23:36:21Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23553/23552 pages)
[2025-08-14T23:36:23Z INFO mmtk::scheduler::scheduler] End of GC (4414/23552 pages, took 2377 ms)
[2025-08-14T23:36:23Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23553/23552 pages)
[2025-08-14T23:36:26Z INFO mmtk::scheduler::scheduler] End of GC (4547/23552 pages, took 2392 ms)
[2025-08-14T23:36:27Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:36:29Z INFO mmtk::scheduler::scheduler] End of GC (4310/23552 pages, took 2466 ms)
[2025-08-14T23:36:30Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23554/23552 pages)
[2025-08-14T23:36:32Z INFO mmtk::scheduler::scheduler] End of GC (4600/23552 pages, took 2388 ms)
[2025-08-14T23:36:33Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:36:35Z INFO mmtk::scheduler::scheduler] End of GC (4555/23552 pages, took 2488 ms)
[2025-08-14T23:36:36Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23576/23552 pages)
[2025-08-14T23:36:38Z INFO mmtk::scheduler::scheduler] End of GC (4321/23552 pages, took 2373 ms)
[2025-08-14T23:36:38Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23556/23552 pages)
[2025-08-14T23:36:41Z INFO mmtk::scheduler::scheduler] End of GC (4007/23552 pages, took 2364 ms)
[2025-08-14T23:36:41Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23559/23552 pages)
[2025-08-14T23:36:44Z INFO mmtk::scheduler::scheduler] End of GC (4219/23552 pages, took 2386 ms)
[2025-08-14T23:36:44Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23553/23552 pages)
[2025-08-14T23:36:46Z INFO mmtk::scheduler::scheduler] End of GC (4464/23552 pages, took 2411 ms)
[2025-08-14T23:36:47Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23559/23552 pages)
[2025-08-14T23:36:49Z INFO mmtk::scheduler::scheduler] End of GC (4670/23552 pages, took 2448 ms)
[2025-08-14T23:36:50Z INFO mmtk::mmtk] User triggering collection
[2025-08-14T23:36:52Z INFO mmtk::scheduler::scheduler] End of GC (3964/23552 pages, took 2121 ms)
[2025-08-14T23:36:52Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:36:54Z INFO mmtk::scheduler::scheduler] End of GC (4284/23552 pages, took 2257 ms)
[2025-08-14T23:36:55Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23554/23552 pages)
[2025-08-14T23:36:57Z INFO mmtk::scheduler::scheduler] End of GC (4223/23552 pages, took 2312 ms)
[2025-08-14T23:36:57Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23553/23552 pages)
[2025-08-14T23:37:00Z INFO mmtk::scheduler::scheduler] End of GC (4026/23552 pages, took 2378 ms)
[2025-08-14T23:37:00Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23555/23552 pages)
[2025-08-14T23:37:02Z INFO mmtk::scheduler::scheduler] End of GC (3993/23552 pages, took 2290 ms)
[2025-08-14T23:37:03Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23564/23552 pages)
[2025-08-14T23:37:05Z INFO mmtk::scheduler::scheduler] End of GC (3667/23552 pages, took 2304 ms)
[2025-08-14T23:37:06Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23559/23552 pages)
[2025-08-14T23:37:08Z INFO mmtk::scheduler::scheduler] End of GC (4066/23552 pages, took 2229 ms)
[2025-08-14T23:37:08Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23553/23552 pages)
[2025-08-14T23:37:10Z INFO mmtk::scheduler::scheduler] End of GC (3814/23552 pages, took 2275 ms)
[2025-08-14T23:37:11Z INFO mmtk::util::heap::gc_trigger] [POLL] los: Triggering collection (23554/23552 pages)
[2025-08-14T23:37:13Z INFO mmtk::scheduler::scheduler] End of GC (4434/23552 pages, took 2275 ms)
[2025-08-14T23:37:13Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23555/23552 pages)
[2025-08-14T23:37:16Z INFO mmtk::scheduler::scheduler] End of GC (3916/23552 pages, took 2288 ms)
[2025-08-14T23:37:16Z INFO mmtk::util::heap::gc_trigger] [POLL] mc: Triggering collection (23558/23552 pages)
[2025-08-14T23:37:19Z INFO mmtk::scheduler::scheduler] End of GC (3471/23552 pages, took 2249 ms)
java.lang.IllegalArgumentException: endRule without matching beginRule: P/org.eclipse.tomcat
at org.eclipse.core.internal.runtime.Assert.isLegal(Assert.java:58)
at org.eclipse.core.internal.jobs.ImplicitJobs.end(ImplicitJobs.java:114)
at org.eclipse.core.internal.jobs.JobManager.endRule(JobManager.java:487)
at org.eclipse.core.internal.resources.WorkManager.checkOut(WorkManager.java:120)
at org.eclipse.core.internal.resources.Workspace.endOperation(Workspace.java:928)
at org.eclipse.core.internal.resources.Resource.delete(Resource.java:689)
at org.eclipse.core.internal.resources.Project.delete(Project.java:329)
at dacapo.eclipse.EclipseTests.runtests(EclipseTests.java:123)
at dacapo.eclipse.HarnessRunner.run(HarnessRunner.java:21)
at org.eclipse.core.internal.runtime.PlatformActivator$1.run(PlatformActivator.java:226)
at org.eclipse.core.runtime.adaptor.EclipseStarter.run(EclipseStarter.java:376)
at dacapo.eclipse.EclipseHarness.iterate(EclipseHarness.java:35)
at dacapo.Benchmark.run(Benchmark.java:126)
at dacapo.TestHarness.runBenchmark(TestHarness.java:302)
at dacapo.TestHarness.main(TestHarness.java:242)
at Harness.main(Harness.java:5)
Digest validation failed for stderr.log, expecting 0xda39a3ee5e6b4b0d3255bfef95601890afd80709 found 0xf8e24dd55e2446aea629ec085db9fb0eaca0fa5c
===== DaCapo eclipse FAILED =====
Validation FAILED for eclipse default