The following test timed out in the JDK18 CI:
gc/stringdedup/TestStringDeduplicationPrintOptions.java#G1
Here's a snippet from the log file:
#section:driver
----------messages:(9/412)----------
command: driver gc.stringdedup.TestStringDeduplicationPrintOptions G1
reason: User specified action: run driver gc.stringdedup.TestStringDeduplicationPrintOptions G1
Mode: agentvm
Agent id: 46
Additional opens to unnamed modules from @modules: java.base/jdk.internal.misc java.base/java.lang
Timeout refired 1200 times
Timeout information:
--- Timeout information end.
elapsed time (seconds): 1287.854
----------configuration:(20/1838)*----------
<snip>
----------System.out:(18/4374)*----------
Command line: [c:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\windows-x64-debug.jdk\\jdk-18\\fastdebug\\bin\\java.exe -cp T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\gc\\stringdedup\\TestStringDeduplicationPrintOptions_G1.d;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\src.full\\open\\test\\hotspot\\jtreg\\gc\\stringdedup;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\test\\lib;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\javatest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jtreg.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\junit.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\hamcrest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\testng.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jcommander.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\guice.jar -XX:MaxRAMPercentage=4.16667 -Djava.io.tmpdir=t:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\tmp -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:-DoEscapeAnalysis -XX:+UseG1GC -Xmn50m -Xms100m -Xmx100m -XX:+UnlockDiagnosticVMOptions --add-opens=java.base/java.lang=ALL-UNNAMED -XX:+VerifyAfterGC -XX:+UseStringDeduplication -XX:StringDeduplicationAgeThreshold=3 gc.stringdedup.TestStringDeduplicationTools$DeduplicationTest 10 5 3 YoungGC ]
[2021-09-24T19:27:12.540826Z] Gathering output for process 2124
Begin: DeduplicationTest
Creating strings: total=10, unique=5
Creating strings: total=10, unique=10
Begin: Young GC 1/6
End: Young GC 1/6
Creating strings: total=10, unique=10
Begin: Young GC 2/6
End: Young GC 2/6
Verifying strings: total=10, uniqueFound=5, uniqueExpected=5
Deduplication completed (as fast as 0 iterations)
End: DeduplicationTest
[2021-09-24T19:37:43.153991100Z] Waiting for completion for process 2124
[2021-09-24T19:37:47.889926200Z] Waiting for completion finished for process 2124
Command line: [c:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\windows-x64-debug.jdk\\jdk-18\\fastdebug\\bin\\java.exe -cp T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\gc\\stringdedup\\TestStringDeduplicationPrintOptions_G1.d;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\src.full\\open\\test\\hotspot\\jtreg\\gc\\stringdedup;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\test\\lib;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\javatest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jtreg.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\junit.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\hamcrest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\testng.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jcommander.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\guice.jar -XX:MaxRAMPercentage=4.16667 -Djava.io.tmpdir=t:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\tmp -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:-DoEscapeAnalysis -XX:+UseG1GC -Xmn50m -Xms100m -Xmx100m -XX:+UnlockDiagnosticVMOptions --add-opens=java.base/java.lang=ALL-UNNAMED -XX:+VerifyAfterGC -Xlog:stringdedup -XX:+UseStringDeduplication -XX:StringDeduplicationAgeThreshold=3 gc.stringdedup.TestStringDeduplicationTools$DeduplicationTest 10 5 3 YoungGC ]
[2021-09-24
result: Error. Agent error: java.lang.Exception: Agent 46 timed out with a timeout of 1200 seconds; check console log for any additional details
gc/stringdedup/TestStringDeduplicationPrintOptions.java#G1
Here's a snippet from the log file:
#section:driver
----------messages:(9/412)----------
command: driver gc.stringdedup.TestStringDeduplicationPrintOptions G1
reason: User specified action: run driver gc.stringdedup.TestStringDeduplicationPrintOptions G1
Mode: agentvm
Agent id: 46
Additional opens to unnamed modules from @modules: java.base/jdk.internal.misc java.base/java.lang
Timeout refired 1200 times
Timeout information:
--- Timeout information end.
elapsed time (seconds): 1287.854
----------configuration:(20/1838)*----------
<snip>
----------System.out:(18/4374)*----------
Command line: [c:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\windows-x64-debug.jdk\\jdk-18\\fastdebug\\bin\\java.exe -cp T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\gc\\stringdedup\\TestStringDeduplicationPrintOptions_G1.d;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\src.full\\open\\test\\hotspot\\jtreg\\gc\\stringdedup;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\test\\lib;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\javatest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jtreg.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\junit.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\hamcrest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\testng.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jcommander.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\guice.jar -XX:MaxRAMPercentage=4.16667 -Djava.io.tmpdir=t:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\tmp -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:-DoEscapeAnalysis -XX:+UseG1GC -Xmn50m -Xms100m -Xmx100m -XX:+UnlockDiagnosticVMOptions --add-opens=java.base/java.lang=ALL-UNNAMED -XX:+VerifyAfterGC -XX:+UseStringDeduplication -XX:StringDeduplicationAgeThreshold=3 gc.stringdedup.TestStringDeduplicationTools$DeduplicationTest 10 5 3 YoungGC ]
[2021-09-24T19:27:12.540826Z] Gathering output for process 2124
Begin: DeduplicationTest
Creating strings: total=10, unique=5
Creating strings: total=10, unique=10
Begin: Young GC 1/6
End: Young GC 1/6
Creating strings: total=10, unique=10
Begin: Young GC 2/6
End: Young GC 2/6
Verifying strings: total=10, uniqueFound=5, uniqueExpected=5
Deduplication completed (as fast as 0 iterations)
End: DeduplicationTest
[2021-09-24T19:37:43.153991100Z] Waiting for completion for process 2124
[2021-09-24T19:37:47.889926200Z] Waiting for completion finished for process 2124
Command line: [c:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\windows-x64-debug.jdk\\jdk-18\\fastdebug\\bin\\java.exe -cp T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\gc\\stringdedup\\TestStringDeduplicationPrintOptions_G1.d;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jdk-18+16-926\\src.full\\open\\test\\hotspot\\jtreg\\gc\\stringdedup;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3;T:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\classes\\3\\test\\lib;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\javatest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jtreg.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\junit.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\hamcrest.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\testng.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\jcommander.jar;C:\\ade\\mesos\\work_dir\\jib-master\\install\\jtreg\\6\\1\\bundles\\jtreg-6+1.zip\\jtreg\\lib\\guice.jar -XX:MaxRAMPercentage=4.16667 -Djava.io.tmpdir=t:\\testoutput\\test-support\\jtreg_open_test_hotspot_jtreg_hotspot_gc\\tmp -Xcomp -XX:+CreateCoredumpOnCrash -ea -esa -XX:CompileThreshold=100 -XX:+UnlockExperimentalVMOptions -server -XX:+TieredCompilation -XX:-DoEscapeAnalysis -XX:+UseG1GC -Xmn50m -Xms100m -Xmx100m -XX:+UnlockDiagnosticVMOptions --add-opens=java.base/java.lang=ALL-UNNAMED -XX:+VerifyAfterGC -Xlog:stringdedup -XX:+UseStringDeduplication -XX:StringDeduplicationAgeThreshold=3 gc.stringdedup.TestStringDeduplicationTools$DeduplicationTest 10 5 3 YoungGC ]
[2021-09-24
result: Error. Agent error: java.lang.Exception: Agent 46 timed out with a timeout of 1200 seconds; check console log for any additional details
- relates to
-
JDK-8273695 Safepoint deadlock on VMOperation_lock
- Closed
-
JDK-8271834 TestStringDeduplicationAgeThreshold intermittent failures on Shenandoah
- Resolved
-
JDK-8313153 Test gc/stringdedup/TestStringDeduplicationPrintOptions.java#ZGenerational timed out
- Closed