The following test failed in the JDK17 CI:
runtime/stringtable/StringTableCleaningTest.java
Here's a snippet from the log file:
#section:main
----------messages:(5/471)----------
command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI runtime.stringtable.StringTableCleaningTest 30
reason: User specified action: run main/othervm -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI runtime.stringtable.StringTableCleaningTest 30
Mode: othervm [/othervm specified]
Additional options from @modules: --add-modules java.base --add-exports java.base/jdk.internal.misc=ALL-UNNAMED
elapsed time (seconds): 31.627
----------configuration:(4/111)----------
Boot Layer
add modules: java.base
add exports: java.base/jdk.internal.misc ALL-UNNAMED
----------System.out:(21/2956)----------
Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+20-1713/linux-aarch64-debug.jdk/jdk-17/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/a4f8fba9-f017-4328-b286-c66b6a97143d-S809/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/c478ef43-74dd-4934-a882-4d42cd0d2df4/runs/173cf0f4-cc30-441c-ba75-86386efa5566/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_runtime/classes/1/runtime/stringtable/StringTableCleaningTest.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+20-1713/src.full/open/test/hotspot/jtreg/runtime/stringtable:/opt/mach5/mesos/work_dir/slaves/a4f8fba9-f017-4328-b286-c66b6a97143d-S809/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/c478ef43-74dd-4934-a882-4d42cd0d2df4/runs/173cf0f4-cc30-441c-ba75-86386efa5566/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_runtime/classes/1/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+20-1713/src.full/open/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/5.1/b01/bundles/jtreg_bin-5.1.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/5.1/b01/bundles/jtreg_bin-5.1.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=8 -Djava.io.tmpdir=/opt/mach5/mesos/work_dir/slaves/a4f8fba9-f017-4328-b286-c66b6a97143d-S809/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/c478ef43-74dd-4934-a882-4d42cd0d2df4/runs/173cf0f4-cc30-441c-ba75-86386efa5566/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_runtime/tmp -XX:+CreateCoredumpOnCrash -XX:+UseZGC -Xlog:gc,gc+start,stringtable*=trace -Xmx1g runtime.stringtable.StringTableCleaningTest$Tester 30 ]
[2021-04-27T09:48:25.950527373Z] Gathering output for process 3160773
[2021-04-27T09:48:56.403991952Z] Waiting for completion for process 3160773
[2021-04-27T09:48:56.404312374Z] Waiting for completion finished for process 3160773
Output and diagnostic info for process 3160773 was saved into 'pid-3160773-output.log'
[2021-04-27T09:48:56.425956399Z] Waiting for completion for process 3160773
[2021-04-27T09:48:56.426207171Z] Waiting for completion finished for process 3160773
--- Output check failed: 1 -----
[0.045s][info][gc] Using The Z Garbage Collector
[0.045s][trace][stringtable] Start size: 65536 (16)
[11.235s][info ][gc,start ] GC(0) Garbage Collection (Warmup)
[11.833s][trace][stringtable] Uncleaned items:476282
[11.834s][debug][stringtable] Concurrent work triggered, live factor: 16.2292 dead factor: 7.26749
[11.834s][debug][stringtable,perf] Concurrent work, live factor: 16.229
[11.834s][trace][stringtable ] Started to grow
[12.255s][info ][gc ] GC(0) Garbage Collection (Warmup) 104M(10%)->66M(6%)
[14.245s][debug][stringtable,perf] Grow, 2.4105156 secs
[14.245s][debug][stringtable ] Grown to size:131072
[29.835s][info ][gc,start ] GC(1) Garbage Collection (Warmup)
[30.511s][info ][gc ] GC(1) Garbage Collection (Warmup) Aborted
----------System.err:(17/1229)----------
java.lang.RuntimeException: Missing Callback in [10, 11]
at runtime.stringtable.StringTableCleaningTest.fail(StringTableCleaningTest.java:67)
at runtime.stringtable.StringTableCleaningTest.findCallback(StringTableCleaningTest.java:181)
at runtime.stringtable.StringTableCleaningTest.check(StringTableCleaningTest.java:212)
at runtime.stringtable.StringTableCleaningTest.checkOutput(StringTableCleaningTest.java:224)
at runtime.stringtable.StringTableCleaningTest.main(StringTableCleaningTest.java:63)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:78)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
at java.base/java.lang.Thread.run(Thread.java:831)
JavaTest Message: Test threw exception: java.lang.RuntimeException: Missing Callback in [10, 11]
runtime/stringtable/StringTableCleaningTest.java
Here's a snippet from the log file:
#section:main
----------messages:(5/471)----------
command: main -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI runtime.stringtable.StringTableCleaningTest 30
reason: User specified action: run main/othervm -Xbootclasspath/a:. -XX:+UnlockDiagnosticVMOptions -XX:+WhiteBoxAPI runtime.stringtable.StringTableCleaningTest 30
Mode: othervm [/othervm specified]
Additional options from @modules: --add-modules java.base --add-exports java.base/jdk.internal.misc=ALL-UNNAMED
elapsed time (seconds): 31.627
----------configuration:(4/111)----------
Boot Layer
add modules: java.base
add exports: java.base/jdk.internal.misc ALL-UNNAMED
----------System.out:(21/2956)----------
Command line: [/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+20-1713/linux-aarch64-debug.jdk/jdk-17/fastdebug/bin/java -cp /opt/mach5/mesos/work_dir/slaves/a4f8fba9-f017-4328-b286-c66b6a97143d-S809/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/c478ef43-74dd-4934-a882-4d42cd0d2df4/runs/173cf0f4-cc30-441c-ba75-86386efa5566/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_runtime/classes/1/runtime/stringtable/StringTableCleaningTest.d:/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+20-1713/src.full/open/test/hotspot/jtreg/runtime/stringtable:/opt/mach5/mesos/work_dir/slaves/a4f8fba9-f017-4328-b286-c66b6a97143d-S809/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/c478ef43-74dd-4934-a882-4d42cd0d2df4/runs/173cf0f4-cc30-441c-ba75-86386efa5566/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_runtime/classes/1/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jdk-17+20-1713/src.full/open/test/lib:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/5.1/b01/bundles/jtreg_bin-5.1.zip/jtreg/lib/javatest.jar:/opt/mach5/mesos/work_dir/jib-master/install/jtreg/5.1/b01/bundles/jtreg_bin-5.1.zip/jtreg/lib/jtreg.jar -XX:MaxRAMPercentage=8 -Djava.io.tmpdir=/opt/mach5/mesos/work_dir/slaves/a4f8fba9-f017-4328-b286-c66b6a97143d-S809/frameworks/1735e8a2-a1db-478c-8104-60c8b0af87dd-0196/executors/c478ef43-74dd-4934-a882-4d42cd0d2df4/runs/173cf0f4-cc30-441c-ba75-86386efa5566/testoutput/test-support/jtreg_open_test_hotspot_jtreg_hotspot_runtime/tmp -XX:+CreateCoredumpOnCrash -XX:+UseZGC -Xlog:gc,gc+start,stringtable*=trace -Xmx1g runtime.stringtable.StringTableCleaningTest$Tester 30 ]
[2021-04-27T09:48:25.950527373Z] Gathering output for process 3160773
[2021-04-27T09:48:56.403991952Z] Waiting for completion for process 3160773
[2021-04-27T09:48:56.404312374Z] Waiting for completion finished for process 3160773
Output and diagnostic info for process 3160773 was saved into 'pid-3160773-output.log'
[2021-04-27T09:48:56.425956399Z] Waiting for completion for process 3160773
[2021-04-27T09:48:56.426207171Z] Waiting for completion finished for process 3160773
--- Output check failed: 1 -----
[0.045s][info][gc] Using The Z Garbage Collector
[0.045s][trace][stringtable] Start size: 65536 (16)
[11.235s][info ][gc,start ] GC(0) Garbage Collection (Warmup)
[11.833s][trace][stringtable] Uncleaned items:476282
[11.834s][debug][stringtable] Concurrent work triggered, live factor: 16.2292 dead factor: 7.26749
[11.834s][debug][stringtable,perf] Concurrent work, live factor: 16.229
[11.834s][trace][stringtable ] Started to grow
[12.255s][info ][gc ] GC(0) Garbage Collection (Warmup) 104M(10%)->66M(6%)
[14.245s][debug][stringtable,perf] Grow, 2.4105156 secs
[14.245s][debug][stringtable ] Grown to size:131072
[29.835s][info ][gc,start ] GC(1) Garbage Collection (Warmup)
[30.511s][info ][gc ] GC(1) Garbage Collection (Warmup) Aborted
----------System.err:(17/1229)----------
java.lang.RuntimeException: Missing Callback in [10, 11]
at runtime.stringtable.StringTableCleaningTest.fail(StringTableCleaningTest.java:67)
at runtime.stringtable.StringTableCleaningTest.findCallback(StringTableCleaningTest.java:181)
at runtime.stringtable.StringTableCleaningTest.check(StringTableCleaningTest.java:212)
at runtime.stringtable.StringTableCleaningTest.checkOutput(StringTableCleaningTest.java:224)
at runtime.stringtable.StringTableCleaningTest.main(StringTableCleaningTest.java:63)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:78)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:568)
at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:127)
at java.base/java.lang.Thread.run(Thread.java:831)
JavaTest Message: Test threw exception: java.lang.RuntimeException: Missing Callback in [10, 11]
- relates to
-
JDK-8282900 runtime/stringtable/StringTableCleaningTest.java verify unavailable at this moment
-
- Resolved
-