Uploaded image for project: 'JDK'
  1. JDK
  2. JDK-8364082

jdk/jfr/event/gc/heapsummary/TestHeapSummaryEventPSParOld.java Eden should be placed first in young

XMLWordPrintable

    • jfr
    • b09
    • generic
    • generic

      The following test failed in the JDK26 CI:

      jdk/jfr/event/gc/heapsummary/TestHeapSummaryEventPSParOld.java

      Here's a snippet from the log file:

      #section:main
      ----------messages:(8/581)----------
      command: main -XX:+UnlockExperimentalVMOptions -XX:-UseFastUnorderedTimeStamps -XX:+UseParallelGC jdk.jfr.event.gc.heapsummary.TestHeapSummaryEventPSParOld
      reason: User specified action: run main/othervm -XX:+UnlockExperimentalVMOptions -XX:-UseFastUnorderedTimeStamps -XX:+UseParallelGC jdk.jfr.event.gc.heapsummary.TestHeapSummaryEventPSParOld
      started: Thu Jul 24 17:32:33 UTC 2025
      Mode: othervm [/othervm specified]
      Additional options from @modules: --add-modules jdk.jfr,java.management
      Process id: 3547548
      finished: Thu Jul 24 17:32:34 UTC 2025
      elapsed time (seconds): 0.435
      ----------configuration:(3/51)----------
      Boot Layer
        add modules: jdk.jfr java.management

      ----------System.out:(498/8976)----------
      Event:jdk.GCHeapSummary {
        startTime = 17:32:34.044 (2025-07-24)
        gcId = 1
        when = "Before GC"
        heapSpace = {
          start = 0xD0000000
          committedEnd = 0xE6480000
          committedSize = 356.5 MB
          reservedEnd = 0x100000000
          reservedSize = 768.0 MB
        }
        heapUsed = 4.7 MB
      }


      Event:jdk.PSHeapSummary {
        startTime = 17:32:34.044 (2025-07-24)
        gcId = 1
        when = "Before GC"
        oldSpace = {
          start = 0xD0000000
          committedEnd = 0xDF800000
          committedSize = 248.0 MB
          reservedEnd = 0xF0000000
          reservedSize = 512.0 MB
        }
        oldObjectSpace = {
          start = 0xD0000000
          end = 0xDF800000
          used = 2.8 MB
          size = 248.0 MB
        }
        youngSpace = {
          start = 0xF0000000
          committedEnd = 0xF7C00000
          committedSize = 124.0 MB
          reservedEnd = 0x100000000
          reservedSize = 256.0 MB
        }
        edenSpace = {
          start = 0xF1F00000
          end = 0xF7C00000
          used = 1.9 MB
          size = 93.0 MB
        }
        fromSpace = {
          start = 0xF0F80000
          end = 0xF1F00000
          used = 0 bytes
          size = 15.5 MB
        }
        toSpace = {
          start = 0xF0000000
          end = 0xF0F80000
          used = 0 bytes
          size = 15.5 MB
        }
      }


      Event:jdk.MetaspaceSummary {
        startTime = 17:32:34.044 (2025-07-24)
        gcId = 1
        when = "Before GC"
        gcThreshold = 21.0 MB
        metaspace = {
          committed = 2.9 MB
          used = 2.7 MB
          reserved = 1.1 GB
        }
        dataSpace = {
          committed = 2.6 MB
          used = 2.5 MB
          reserved = 64.0 MB
        }
        classSpace = {
          committed = 320.0 kB
          used = 235.6 kB
          reserved = 1.0 GB
        }
      }


      Event:jdk.GCHeapSummary {
        startTime = 17:32:34.050 (2025-07-24)
        gcId = 1
        when = "After GC"
        heapSpace = {
          start = 0xD0000000
          committedEnd = 0xE6480000
          committedSize = 356.5 MB
          reservedEnd = 0x100000000
          reservedSize = 768.0 MB
        }
        heapUsed = 2.8 MB
      }


      Event:jdk.PSHeapSummary {
        startTime = 17:32:34.050 (2025-07-24)
        gcId = 1
        when = "After GC"
        oldSpace = {
          start = 0xD0000000
          committedEnd = 0xDF800000
          committedSize = 248.0 MB
          reservedEnd = 0xF0000000
          reservedSize = 512.0 MB
        }
        oldObjectSpace = {
          start = 0xD0000000
          end = 0xDF800000
          used = 2.8 MB
          size = 248.0 MB
        }
        youngSpace = {
          start = 0xF0000000
          committedEnd = 0xF7C00000
          committedSize = 124.0 MB
          reservedEnd = 0x100000000
          reservedSize = 256.0 MB
        }
        edenSpace = {
          start = 0xF1F00000
          end = 0xF7C00000
          used = 0 bytes
          size = 93.0 MB
        }
        fromSpace = {
          start = 0xF0F80000
          end = 0xF1F00000
          used = 0 bytes
          size = 15.5 MB
        }
        toSpace = {
          start = 0xF0000000
          end = 0xF0F80000
          used = 0 bytes
          size = 15.5 MB
        }
      }


      Event:jdk.MetaspaceSummary {
        startTime = 17:32:34.050 (2025-07-24)
        gcId = 1
        when = "After GC"
        gcThreshold = 21.0 MB
        metaspace = {
          committed = 2.9 MB
          used = 2.7 MB
          reserved = 1.1 GB
        }
        dataSpace = {
          committed = 2.6 MB
          used = 2.5 MB
          reserved = 64.0 MB
        }
        classSpace = {
          committed = 320.0 kB
          used = 235.6 kB
          reserved = 1.0 GB
        }
      }


      Event:jdk.GCHeapSummary {
        startTime = 17:32:34.050 (2025-07-24)
        gcId = 2
        when = "Before GC"
        heapSpace = {
          start = 0xD0000000
          committedEnd = 0xE6480000
          committedSize = 356.5 MB
          reservedEnd = 0x100000000
          reservedSize = 768.0 MB
        }
        heapUsed = 4.7 MB
      }


      Event:jdk.PSHeapSummary {
        startTime = 17:32:34.050 (2025-07-24)
        gcId = 2
        when = "Before GC"
        oldSpace = {
          start = 0xD0000000
          committedEnd = 0xDF800000
          committedSize = 248.0 MB
          reservedEnd = 0xF0000000
          reservedSize = 512.0 MB
        }
        oldObjectSpace = {
          start = 0xD0000000
          end = 0xDF800000
          used = 2.8 MB
          size = 248.0 MB
        }
        youngSpace = {
          start = 0xF0000000
          committedEnd = 0xF7C00000
          committedSize = 124.0 MB
          reservedEnd = 0x100000000
          reservedSize = 256.0 MB
        }
        edenSpace = {
          start = 0xF1F00000
          end = 0xF7C00000
          used = 1.9 MB
          size = 93.0 MB
        }
        fromSpace = {
          start = 0xF0F80000
          end = 0xF1F00000
          used = 0 bytes
          size = 15.5 MB
        }
        toSpace = {
          start = 0xF0000000
          end = 0xF0F80000
          used = 0 bytes
          size = 15.5 MB
        }
      }


      Event:jdk.MetaspaceSummary {
        startTime = 17:32:34.050 (2025-07-24)
        gcId = 2
        when = "Before GC"
        gcThreshold = 21.0 MB
        metaspace = {
          committed = 2.9 MB
          used = 2.7 MB
          reserved = 1.1 GB
        }
        dataSpace = {
          committed = 2.6 MB
          used = 2.5 MB
          reserved = 64.0 MB
        }
        classSpace = {
          committed = 320.0 kB
          used = 235.6 kB
          reserved = 1.0 GB
        }
      }


      Event:jdk.GCHeapSummary {
        startTime = 17:32:34.057 (2025-07-24)
        gcId = 2
        when = "After GC"
        heapSpace = {
          start = 0xD0000000
          committedEnd = 0xE6480000
          committedSize = 356.5 MB
          reservedEnd = 0x100000000
          reservedSize = 768.0 MB
        }
        heapUsed = 2.8 MB
      }


      Event:jdk.PSHeapSummary {
        startTime = 17:32:34.057 (2025-07-24)
        gcId = 2
        when = "After GC"
        oldSpace = {
          start = 0xD0000000
          committedEnd = 0xDF800000
          committedSize = 248.0 MB
          reservedEnd = 0xF0000000
          reservedSize = 512.0 MB
        }
        oldObjectSpace = {
          start = 0xD0000000
          end = 0xDF800000
          used = 2.8 MB
          size = 248.0 MB
        }
        youngSpace = {
          start = 0xF0000000
          committedEnd = 0xF7C00000
          committedSize = 124.0 MB
          reservedEnd = 0x100000000
          reservedSize = 256.0 MB
        }
        edenSpace = {
          start = 0xF1F00000
          end = 0xF7C00000
          used = 0 bytes
          size = 93.0 MB
        }
        fromSpace = {
          start = 0xF0F80000
          end = 0xF1F00000
          used = 0 bytes
          size = 15.5 MB
        }
        toSpace = {
          start = 0xF0000000
          end = 0xF0F80000
          used = 0 bytes
          size = 15.5 MB
        }
      }


      Event:jdk.MetaspaceSummary {
        startTime = 17:32:34.057 (2025-07-24)
        gcId = 2
        when = "After GC"
        gcThreshold = 21.0 MB
        metaspace = {
          committed = 2.9 MB
          used = 2.7 MB
          reserved = 1.1 GB
        }
        dataSpace = {
          committed = 2.6 MB
          used = 2.5 MB
          reserved = 64.0 MB
        }
        classSpace = {
          committed = 320.0 kB
          used = 235.6 kB
          reserved = 1.0 GB
        }
      }


      Event:jdk.GCHeapSummary {
        startTime = 17:32:34.057 (2025-07-24)
        gcId = 3
        when = "Before GC"
        heapSpace = {
          start = 0xD0000000
          committedEnd = 0xE6480000
          committedSize = 356.5 MB
          reservedEnd = 0x100000000
          reservedSize = 768.0 MB
        }
        heapUsed = 4.7 MB
      }


      Event:jdk.PSHeapSummary {
        startTime = 17:32:34.057 (2025-07-24)
        gcId = 3
        when = "Before GC"
        oldSpace = {
          start = 0xD0000000
          committedEnd = 0xDF800000
          committedSize = 248.0 MB
          reservedEnd = 0xF0000000
          reservedSize = 512.0 MB
        }
        oldObjectSpace = {
          start = 0xD0000000
          end = 0xDF800000
          used = 2.8 MB
          size = 248.0 MB
        }
        youngSpace = {
          start = 0xF0000000
          committedEnd = 0xF7C00000
          committedSize = 124.0 MB
          reservedEnd = 0x100000000
          reservedSize = 256.0 MB
        }
        edenSpace = {
          start = 0xF1F00000
          end = 0xF7C00000
          used = 1.9 MB
          size = 93.0 MB
        }
        fromSpace = {
          start = 0xF0F80000
          end = 0xF1F00000
          used = 0 bytes
          size = 15.5 MB
        }
        toSpace = {
          start = 0xF0000000
          end = 0xF0F80000
          used = 0 bytes
          size = 15.5 MB
        }
      }


      Event:jdk.MetaspaceSummary {
        startTime = 17:32:34.057 (2025-07-24)
        gcId = 3
        when = "Before GC"
        gcThreshold = 21.0 MB
        metaspace = {
          committed = 2.9 MB
          used = 2.7 MB
          reserved = 1.1 GB
        }
        dataSpace = {
          committed = 2.6 MB
          used = 2.5 MB
          reserved = 64.0 MB
        }
        classSpace = {
          committed = 320.0 kB
          used = 235.6 kB
          reserved = 1.0 GB
        }
      }


      Event:jdk.GCHeapSummary {
        startTime = 17:32:34.066 (2025-07-24)
        gcId = 3
        when = "After GC"
        heapSpace = {
          start = 0xD0000000
          committedEnd = 0xE6480000
          committedSize = 356.5 MB
          reservedEnd = 0x100000000
          reservedSize = 768.0 MB
        }
        heapUsed = 2.8 MB
      }


      Event:jdk.PSHeapSummary {
        startTime = 17:32:34.066 (2025-07-24)
        gcId = 3
        when = "After GC"
        oldSpace = {
          start = 0xD0000000
          committedEnd = 0xDF800000
          committedSize = 248.0 MB
          reservedEnd = 0xF0000000
          reservedSize = 512.0 MB
        }
        oldObjectSpace = {
          start = 0xD0000000
          end = 0xDF800000
          used = 2.8 MB
          size = 248.0 MB
        }
        youngSpace = {
          start = 0xF0000000
          committedEnd = 0xF7C00000
          committedSize = 124.0 MB
          reservedEnd = 0x100000000
          reservedSize = 256.0 MB
        }
        edenSpace = {
          start = 0xF1F00000
          end = 0xF7C00000
          used = 0 bytes
          size = 93.0 MB
        }
        fromSpace = {
          start = 0xF0F80000
          end = 0xF1F00000
          used = 0 bytes
          size = 15.5 MB
        }
        toSpace = {
          start = 0xF0000000
          end = 0xF0F80000
          used = 0 bytes
          size = 15.5 MB
        }
      }


      Event:jdk.MetaspaceSummary {
        startTime = 17:32:34.066 (2025-07-24)
        gcId = 3
        when = "After GC"
        gcThreshold = 21.0 MB
        metaspace = {
          committed = 2.9 MB
          used = 2.7 MB
          reserved = 1.1 GB
        }
        dataSpace = {
          committed = 2.6 MB
          used = 2.5 MB
          reserved = 64.0 MB
        }
        classSpace = {
          committed = 320.0 kB
          used = 235.6 kB
          reserved = 1.0 GB
        }
      }


      ----------System.err:(16/1260)----------
      java.lang.RuntimeException: Eden should be placed first in young expected: 4026531840 but was: 4059037696
      at jdk.test.lib.Asserts.fail(Asserts.java:715)
      at jdk.test.lib.Asserts.assertEquals(Asserts.java:208)
      at jdk.jfr.event.gc.heapsummary.HeapSummaryEventAllGcs.checkPSYoungStartEnd(HeapSummaryEventAllGcs.java:164)
      at jdk.jfr.event.gc.heapsummary.HeapSummaryEventAllGcs.checkPSEventContent(HeapSummaryEventAllGcs.java:138)
      at jdk.jfr.event.gc.heapsummary.HeapSummaryEventAllGcs.test(HeapSummaryEventAllGcs.java:76)
      at jdk.jfr.event.gc.heapsummary.TestHeapSummaryEventPSParOld.main(TestHeapSummaryEventPSParOld.java:37)
      at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
      at java.base/java.lang.reflect.Method.invoke(Method.java:565)
      at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138)
      at java.base/java.lang.Thread.run(Thread.java:1474)

      JavaTest Message: Test threw exception: java.lang.RuntimeException: Eden should be placed first in young expected: 4026531840 but was: 4059037696
      JavaTest Message: shutting down test

      STATUS:Failed.`main' threw exception: java.lang.RuntimeException: Eden should be placed first in young expected: 4026531840 but was: 4059037696
      ----------rerun:(44/8480)*----------

            ayang Albert Yang
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

              Created:
              Updated:
              Resolved: