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

JFR: Incorrect time unit for MethodTiming event

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Fixed
    • Icon: P4 P4
    • 25
    • 25
    • hotspot
    • jfr
    • b26
    • x86_64
    • windows

      The following test failed in the JDK25 CI:

      jdk/jfr/event/tracing/TestMethodTiming.java

      Here's a snippet from the log file:

      #section:main
      ----------messages:(8/381)----------
      command: main jdk.jfr.event.tracing.TestMethodTiming
      reason: User specified action: run main/othervm jdk.jfr.event.tracing.TestMethodTiming
      started: Mon Jun 02 22:57:05 UTC 2025
      Mode: othervm [/othervm specified]
      Additional options from @modules: --add-modules jdk.jfr,java.management
      Process id: 32624
      finished: Mon Jun 02 22:57:09 UTC 2025
      elapsed time (seconds): 3.686
      ----------configuration:(3/54)----------
      Boot Layer
        add modules: jdk.jfr java.management

      ----------System.out:(24/555)----------
      jdk.jfr.event.tracing.TestMethodTiming$TimeMeasureEvent {
        startTime = 22:57:09.293 (2025-06-02)
        duration = 11.6 ms
        id = "min"
        eventThread = "MainThread" (javaThreadId = 26)
      }


      jdk.jfr.event.tracing.TestMethodTiming$TimeMeasureEvent {
        startTime = 22:57:09.293 (2025-06-02)
        duration = 11.9 ms
        id = "max"
        eventThread = "MainThread" (javaThreadId = 26)
      }


      jdk.MethodTiming {
        startTime = 22:57:09.305 (2025-06-02)
        method = jdk.jfr.event.tracing.TestMethodTiming.takeNap()
        invocations = 1
        average = 1.19 ms
      }


      ----------System.err:(12/833)----------
      java.lang.Exception: Expected duration to be at least PT0.01164653S, was PT0.001185481S
      at jdk.jfr.event.tracing.TestMethodTiming.testDuration(Unknown Source)
      at jdk.jfr.event.tracing.TestMethodTiming.main(Unknown Source)
      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.Exception: Expected duration to be at least PT0.01164653S, was PT0.001185481S
      JavaTest Message: shutting down test

      STATUS:Failed.`main' threw exception: java.lang.Exception: Expected duration to be at least PT0.01164653S, was PT0.001185481S
      ----------rerun:(45/6074)*----------

            egahlin Erik Gahlin
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            6 Start watching this issue

              Created:
              Updated:
              Resolved: