renaissance-als_0
[2026-02-11T22:40:48.050Z] Running test renaissance-als_0 ...
[2026-02-11T22:40:48.050Z] ===============================================
[2026-02-11T22:40:48.050Z] renaissance-als_0 Start Time: Wed Feb 11 22:40:47 2026 Epoch Time (ms): 1770849647709
[2026-02-11T22:40:48.050Z] variation: NoOptions
[2026-02-11T22:40:48.050Z] JVM_OPTIONS:
[2026-02-11T22:40:48.050Z] { \
[2026-02-11T22:40:48.050Z] echo ""; echo "TEST SETUP:"; \
[2026-02-11T22:40:48.050Z] echo "Nothing to be done for setup."; \
[2026-02-11T22:40:48.050Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17708494377957/renaissance-als_0"; \
[2026-02-11T22:40:48.050Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17708494377957/renaissance-als_0"; \
[2026-02-11T22:40:48.050Z] echo ""; echo "TESTING:"; \
[2026-02-11T22:40:48.050Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17708494377957/renaissance-als_0"/als.json" als; \
[2026-02-11T22:40:48.050Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17708494377957/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-11T22:40:48.050Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-11T22:40:48.050Z] echo "Nothing to be done for teardown."; \
[2026-02-11T22:40:48.050Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17708494377957/TestTargetResult";
[2026-02-11T22:40:48.050Z]
[2026-02-11T22:40:48.050Z] TEST SETUP:
[2026-02-11T22:40:48.050Z] Nothing to be done for setup.
[2026-02-11T22:40:48.050Z]
[2026-02-11T22:40:48.050Z] TESTING:
[2026-02-11T22:40:53.149Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads.
[2026-02-11T22:40:58.102Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-11T22:40:58.102Z] GC before operation: completed in 96.592 ms, heap usage 51.926 MB -> 34.748 MB.
[2026-02-11T22:41:31.954Z] ====== als (apache-spark) [default], iteration 0 completed (30074.144 ms) ======
[2026-02-11T22:41:31.954Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-11T22:41:31.954Z] GC before operation: completed in 112.522 ms, heap usage 397.664 MB -> 61.800 MB.
[2026-02-11T22:41:43.459Z] ====== als (apache-spark) [default], iteration 1 completed (14099.998 ms) ======
[2026-02-11T22:41:43.459Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-11T22:41:43.459Z] GC before operation: completed in 98.507 ms, heap usage 200.131 MB -> 62.454 MB.
[2026-02-11T22:41:56.951Z] ====== als (apache-spark) [default], iteration 2 completed (12250.404 ms) ======
[2026-02-11T22:41:56.951Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-11T22:41:56.951Z] GC before operation: completed in 96.462 ms, heap usage 106.139 MB -> 62.595 MB.
[2026-02-11T22:42:08.302Z] ====== als (apache-spark) [default], iteration 3 completed (12303.155 ms) ======
[2026-02-11T22:42:08.303Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-11T22:42:08.649Z] GC before operation: completed in 102.088 ms, heap usage 255.926 MB -> 63.726 MB.
[2026-02-11T22:42:22.178Z] ====== als (apache-spark) [default], iteration 4 completed (11613.607 ms) ======
[2026-02-11T22:42:22.178Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-11T22:42:22.178Z] GC before operation: completed in 172.815 ms, heap usage 611.339 MB -> 64.863 MB.
[2026-02-11T22:42:33.304Z] ====== als (apache-spark) [default], iteration 5 completed (11539.852 ms) ======
[2026-02-11T22:42:33.304Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-11T22:42:33.304Z] GC before operation: completed in 101.841 ms, heap usage 207.132 MB -> 64.661 MB.
[2026-02-11T22:42:44.261Z] ====== als (apache-spark) [default], iteration 6 completed (11205.477 ms) ======
[2026-02-11T22:42:44.261Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-11T22:42:44.261Z] GC before operation: completed in 107.109 ms, heap usage 497.089 MB -> 65.687 MB.
[2026-02-11T22:42:57.613Z] ====== als (apache-spark) [default], iteration 7 completed (11503.435 ms) ======
[2026-02-11T22:42:57.613Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-11T22:42:57.613Z] GC before operation: completed in 108.209 ms, heap usage 415.969 MB -> 66.124 MB.
[2026-02-11T22:43:09.136Z] ====== als (apache-spark) [default], iteration 8 completed (11320.258 ms) ======
[2026-02-11T22:43:09.136Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-11T22:43:09.136Z] GC before operation: completed in 130.149 ms, heap usage 445.547 MB -> 66.853 MB.
[2026-02-11T22:43:20.287Z] ====== als (apache-spark) [default], iteration 9 completed (11332.311 ms) ======
[2026-02-11T22:43:20.287Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-11T22:43:20.287Z] GC before operation: completed in 112.948 ms, heap usage 504.949 MB -> 67.047 MB.
[2026-02-11T22:43:31.287Z] ====== als (apache-spark) [default], iteration 10 completed (11771.646 ms) ======
[2026-02-11T22:43:31.287Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-11T22:43:31.287Z] GC before operation: completed in 118.552 ms, heap usage 653.520 MB -> 67.564 MB.
[2026-02-11T22:43:44.619Z] ====== als (apache-spark) [default], iteration 11 completed (11448.496 ms) ======
[2026-02-11T22:43:44.619Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-11T22:43:44.619Z] GC before operation: completed in 110.865 ms, heap usage 232.788 MB -> 67.182 MB.
[2026-02-11T22:43:55.636Z] ====== als (apache-spark) [default], iteration 12 completed (11154.831 ms) ======
[2026-02-11T22:43:55.636Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-11T22:43:55.636Z] GC before operation: completed in 115.007 ms, heap usage 624.674 MB -> 67.887 MB.
[2026-02-11T22:44:06.706Z] ====== als (apache-spark) [default], iteration 13 completed (11246.836 ms) ======
[2026-02-11T22:44:06.706Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-11T22:44:06.706Z] GC before operation: completed in 114.161 ms, heap usage 605.804 MB -> 68.210 MB.
[2026-02-11T22:44:17.692Z] ====== als (apache-spark) [default], iteration 14 completed (11368.959 ms) ======
[2026-02-11T22:44:17.692Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-11T22:44:17.692Z] GC before operation: completed in 115.030 ms, heap usage 691.746 MB -> 68.519 MB.
[2026-02-11T22:44:30.865Z] ====== als (apache-spark) [default], iteration 15 completed (11140.576 ms) ======
[2026-02-11T22:44:30.865Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-11T22:44:30.865Z] GC before operation: completed in 115.842 ms, heap usage 553.003 MB -> 68.763 MB.
[2026-02-11T22:44:41.897Z] ====== als (apache-spark) [default], iteration 16 completed (11207.158 ms) ======
[2026-02-11T22:44:41.897Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-11T22:44:41.897Z] GC before operation: completed in 161.852 ms, heap usage 328.998 MB -> 68.672 MB.
[2026-02-11T22:44:52.797Z] ====== als (apache-spark) [default], iteration 17 completed (10955.108 ms) ======
[2026-02-11T22:44:52.797Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-11T22:44:52.797Z] GC before operation: completed in 114.730 ms, heap usage 422.067 MB -> 69.125 MB.
[2026-02-11T22:45:03.793Z] ====== als (apache-spark) [default], iteration 18 completed (11265.834 ms) ======
[2026-02-11T22:45:03.793Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-11T22:45:03.793Z] GC before operation: completed in 115.600 ms, heap usage 462.485 MB -> 69.423 MB.
[2026-02-11T22:45:16.991Z] ====== als (apache-spark) [default], iteration 19 completed (10990.940 ms) ======
[2026-02-11T22:45:16.991Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-11T22:45:16.991Z] GC before operation: completed in 121.658 ms, heap usage 681.182 MB -> 69.903 MB.
[2026-02-11T22:45:27.836Z] ====== als (apache-spark) [default], iteration 20 completed (11404.280 ms) ======
[2026-02-11T22:45:27.836Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-11T22:45:27.836Z] GC before operation: completed in 123.870 ms, heap usage 508.523 MB -> 69.872 MB.
[2026-02-11T22:45:38.786Z] ====== als (apache-spark) [default], iteration 21 completed (11667.718 ms) ======
[2026-02-11T22:45:38.786Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-11T22:45:38.786Z] GC before operation: completed in 119.623 ms, heap usage 468.021 MB -> 70.204 MB.
[2026-02-11T22:45:52.005Z] ====== als (apache-spark) [default], iteration 22 completed (11211.274 ms) ======
[2026-02-11T22:45:52.005Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-11T22:45:52.005Z] GC before operation: completed in 115.013 ms, heap usage 137.106 MB -> 70.034 MB.
[2026-02-11T22:46:02.973Z] ====== als (apache-spark) [default], iteration 23 completed (10982.013 ms) ======
[2026-02-11T22:46:02.973Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-11T22:46:02.973Z] GC before operation: completed in 121.096 ms, heap usage 452.036 MB -> 70.754 MB.
[2026-02-11T22:46:13.893Z] ====== als (apache-spark) [default], iteration 24 completed (10949.340 ms) ======
[2026-02-11T22:46:13.893Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-11T22:46:13.893Z] GC before operation: completed in 114.179 ms, heap usage 137.667 MB -> 70.650 MB.
[2026-02-11T22:46:24.805Z] ====== als (apache-spark) [default], iteration 25 completed (11014.861 ms) ======
[2026-02-11T22:46:24.805Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-11T22:46:24.805Z] GC before operation: completed in 113.248 ms, heap usage 202.762 MB -> 70.788 MB.
[2026-02-11T22:46:38.069Z] ====== als (apache-spark) [default], iteration 26 completed (11809.657 ms) ======
[2026-02-11T22:46:38.069Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-11T22:46:38.069Z] GC before operation: completed in 124.321 ms, heap usage 604.629 MB -> 71.808 MB.
[2026-02-11T22:46:49.021Z] ====== als (apache-spark) [default], iteration 27 completed (11172.568 ms) ======
[2026-02-11T22:46:49.021Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-11T22:46:49.021Z] GC before operation: completed in 120.681 ms, heap usage 157.083 MB -> 71.477 MB.
[2026-02-11T22:47:00.016Z] ====== als (apache-spark) [default], iteration 28 completed (11135.932 ms) ======
[2026-02-11T22:47:00.016Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-11T22:47:00.016Z] GC before operation: completed in 121.940 ms, heap usage 794.103 MB -> 71.922 MB.
[2026-02-11T22:47:10.887Z] ====== als (apache-spark) [default], iteration 29 completed (10835.554 ms) ======
[2026-02-11T22:47:10.887Z] -----------------------------------
[2026-02-11T22:47:10.887Z] renaissance-als_0_PASSED
[2026-02-11T22:47:10.887Z] -----------------------------------
[2026-02-11T22:47:10.887Z]
[2026-02-11T22:47:10.887Z] TEST TEARDOWN:
[2026-02-11T22:47:10.887Z] Nothing to be done for teardown.
[2026-02-11T22:47:10.887Z] renaissance-als_0 Finish Time: Wed Feb 11 22:47:10 2026 Epoch Time (ms): 1770850030564