The following test timed out in the JDK25 CI:
jdk/jfr/api/consumer/TestRecordingFileWrite.java
Here's a snippet from the log file:
#section:main
----------messages:(10/436)----------
command: main jdk.jfr.api.consumer.TestRecordingFileWrite
reason: User specified action: run main/othervm jdk.jfr.api.consumer.TestRecordingFileWrite
started: Tue Jun 03 07:41:58 UTC 2025
Mode: othervm [/othervm specified]
Additional options from @modules: --add-modules jdk.jfr,java.management
Process id: 4187214
Timeout information:
--- Timeout information end.
finished: Tue Jun 03 07:51:25 UTC 2025
elapsed time (seconds): 567.27
----------configuration:(3/51)----------
Boot Layer
add modules: jdk.jfr java.management
----------System.out:(50/1514)----------
jdk.OldObjectSample {
startTime = 07:42:04.270 (2025-06-03)
allocationTime = 07:42:00.499 (2025-06-03)
objectSize = 256.0 kB
objectAge = 3.77 s
lastKnownHeapUsage = 1.6 MB
object = [
java.util.concurrent.ConcurrentHashMap$Node[65536]
]
arrayElements = 65536
root = N/A
eventThread = "MainThread" (javaThreadId = 25)
stackTrace = [
java.util.concurrent.ConcurrentHashMap.initTable() line: 2317
java.util.concurrent.ConcurrentHashMap.putVal(Object, Object, boolean) line: 1029
java.util.concurrent.ConcurrentHashMap.put(Object, Object) line: 1018
jdk.jfr.internal.StringPool.storeString(String, boolean) line: 103
jdk.jfr.internal.StringPool.addString(String, boolean) line: 142
...
]
}
jdk.OldObjectSample {
startTime = 07:42:04.270 (2025-06-03)
allocationTime = 07:42:00.969 (2025-06-03)
objectSize = 106.3 kB
objectAge = 3.30 s
lastKnownHeapUsage = 1.6 MB
object = [
byte[108868]
]
arrayElements = 108868
root = N/A
eventThread = "JFR Periodic Tasks" (javaThreadId = 27)
stackTrace = [
java.util.Arrays.copyOf(byte[], int) line: 3537
java.io.ByteArrayOutputStream.toByteArray() line: 187
jdk.jfr.internal.MetadataRepository.getBinaryRepresentation() line: 283
jdk.jfr.internal.MetadataRepository.storeDescriptorInJVM() line: 253
jdk.jfr.internal.MetadataRepository.flush() line: 367
...
]
}
Original size: 30917523
Scrubbed size: 3402150
Scrubbed event count: 100957
Timeout signalled after 480 seconds
----------System.err:(0/0)----------
----------rerun:(40/7314)*----------
This first sighting is in Tier5 on linux-aarch64-debug, but there have since
been sightings on linux-x64-debug, windows-x64 debug and macosx-x64.
So far, the timeout has not been send in the JDK25 CI on maces-aarch64.
In some cases the test PASSes while the timeout handler is running
and some cases (like this sighting) do not.
jdk/jfr/api/consumer/TestRecordingFileWrite.java
Here's a snippet from the log file:
#section:main
----------messages:(10/436)----------
command: main jdk.jfr.api.consumer.TestRecordingFileWrite
reason: User specified action: run main/othervm jdk.jfr.api.consumer.TestRecordingFileWrite
started: Tue Jun 03 07:41:58 UTC 2025
Mode: othervm [/othervm specified]
Additional options from @modules: --add-modules jdk.jfr,java.management
Process id: 4187214
Timeout information:
--- Timeout information end.
finished: Tue Jun 03 07:51:25 UTC 2025
elapsed time (seconds): 567.27
----------configuration:(3/51)----------
Boot Layer
add modules: jdk.jfr java.management
----------System.out:(50/1514)----------
jdk.OldObjectSample {
startTime = 07:42:04.270 (2025-06-03)
allocationTime = 07:42:00.499 (2025-06-03)
objectSize = 256.0 kB
objectAge = 3.77 s
lastKnownHeapUsage = 1.6 MB
object = [
java.util.concurrent.ConcurrentHashMap$Node[65536]
]
arrayElements = 65536
root = N/A
eventThread = "MainThread" (javaThreadId = 25)
stackTrace = [
java.util.concurrent.ConcurrentHashMap.initTable() line: 2317
java.util.concurrent.ConcurrentHashMap.putVal(Object, Object, boolean) line: 1029
java.util.concurrent.ConcurrentHashMap.put(Object, Object) line: 1018
jdk.jfr.internal.StringPool.storeString(String, boolean) line: 103
jdk.jfr.internal.StringPool.addString(String, boolean) line: 142
...
]
}
jdk.OldObjectSample {
startTime = 07:42:04.270 (2025-06-03)
allocationTime = 07:42:00.969 (2025-06-03)
objectSize = 106.3 kB
objectAge = 3.30 s
lastKnownHeapUsage = 1.6 MB
object = [
byte[108868]
]
arrayElements = 108868
root = N/A
eventThread = "JFR Periodic Tasks" (javaThreadId = 27)
stackTrace = [
java.util.Arrays.copyOf(byte[], int) line: 3537
java.io.ByteArrayOutputStream.toByteArray() line: 187
jdk.jfr.internal.MetadataRepository.getBinaryRepresentation() line: 283
jdk.jfr.internal.MetadataRepository.storeDescriptorInJVM() line: 253
jdk.jfr.internal.MetadataRepository.flush() line: 367
...
]
}
Original size: 30917523
Scrubbed size: 3402150
Scrubbed event count: 100957
Timeout signalled after 480 seconds
----------System.err:(0/0)----------
----------rerun:(40/7314)*----------
This first sighting is in Tier5 on linux-aarch64-debug, but there have since
been sightings on linux-x64-debug, windows-x64 debug and macosx-x64.
So far, the timeout has not been send in the JDK25 CI on maces-aarch64.
In some cases the test PASSes while the timeout handler is running
and some cases (like this sighting) do not.
- caused by
-
JDK-8356698 JFR: @Contextual
-
- Resolved
-
- links to
-
Commit(master) openjdk/jdk/a653ff48
-
Review(master) openjdk/jdk/25633