renaissance-als_0
[2026-02-04T22:35:17.749Z] Running test renaissance-als_0 ...
[2026-02-04T22:35:17.749Z] ===============================================
[2026-02-04T22:35:17.749Z] renaissance-als_0 Start Time: Wed Feb 4 22:35:17 2026 Epoch Time (ms): 1770244517370
[2026-02-04T22:35:17.749Z] variation: NoOptions
[2026-02-04T22:35:17.749Z] JVM_OPTIONS:
[2026-02-04T22:35:17.749Z] { \
[2026-02-04T22:35:17.749Z] echo ""; echo "TEST SETUP:"; \
[2026-02-04T22:35:17.749Z] echo "Nothing to be done for setup."; \
[2026-02-04T22:35:17.749Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702443368552/renaissance-als_0"; \
[2026-02-04T22:35:17.749Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702443368552/renaissance-als_0"; \
[2026-02-04T22:35:17.749Z] echo ""; echo "TESTING:"; \
[2026-02-04T22:35:17.749Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702443368552/renaissance-als_0"/als.json" als; \
[2026-02-04T22:35:17.750Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702443368552/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-04T22:35:17.750Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-04T22:35:17.750Z] echo "Nothing to be done for teardown."; \
[2026-02-04T22:35:17.750Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17702443368552/TestTargetResult";
[2026-02-04T22:35:17.750Z]
[2026-02-04T22:35:17.750Z] TEST SETUP:
[2026-02-04T22:35:17.750Z] Nothing to be done for setup.
[2026-02-04T22:35:17.750Z]
[2026-02-04T22:35:17.750Z] TESTING:
[2026-02-04T22:35:26.209Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads.
[2026-02-04T22:35:30.181Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-04T22:35:30.181Z] GC before operation: completed in 52.873 ms, heap usage 207.468 MB -> 34.867 MB.
[2026-02-04T22:35:56.720Z] ====== als (apache-spark) [default], iteration 0 completed (24604.483 ms) ======
[2026-02-04T22:35:56.720Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-04T22:35:56.720Z] GC before operation: completed in 108.600 ms, heap usage 265.264 MB -> 61.602 MB.
[2026-02-04T22:36:07.598Z] ====== als (apache-spark) [default], iteration 1 completed (12278.386 ms) ======
[2026-02-04T22:36:07.598Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-04T22:36:08.459Z] GC before operation: completed in 106.476 ms, heap usage 130.506 MB -> 62.315 MB.
[2026-02-04T22:36:19.449Z] ====== als (apache-spark) [default], iteration 2 completed (10510.898 ms) ======
[2026-02-04T22:36:19.449Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-04T22:36:19.449Z] GC before operation: completed in 99.846 ms, heap usage 209.849 MB -> 62.979 MB.
[2026-02-04T22:36:30.870Z] ====== als (apache-spark) [default], iteration 3 completed (10876.335 ms) ======
[2026-02-04T22:36:30.870Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-04T22:36:30.870Z] GC before operation: completed in 112.997 ms, heap usage 266.818 MB -> 63.654 MB.
[2026-02-04T22:36:41.533Z] ====== als (apache-spark) [default], iteration 4 completed (10239.317 ms) ======
[2026-02-04T22:36:41.533Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-04T22:36:41.533Z] GC before operation: completed in 105.988 ms, heap usage 185.149 MB -> 64.075 MB.
[2026-02-04T22:36:50.302Z] ====== als (apache-spark) [default], iteration 5 completed (9574.952 ms) ======
[2026-02-04T22:36:50.302Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-04T22:36:50.302Z] GC before operation: completed in 109.754 ms, heap usage 251.492 MB -> 64.717 MB.
[2026-02-04T22:36:59.904Z] ====== als (apache-spark) [default], iteration 6 completed (9424.680 ms) ======
[2026-02-04T22:36:59.904Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-04T22:37:00.561Z] GC before operation: completed in 106.645 ms, heap usage 113.374 MB -> 65.234 MB.
[2026-02-04T22:37:10.856Z] ====== als (apache-spark) [default], iteration 7 completed (10261.524 ms) ======
[2026-02-04T22:37:10.856Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-04T22:37:10.856Z] GC before operation: completed in 94.619 ms, heap usage 79.079 MB -> 65.246 MB.
[2026-02-04T22:37:22.761Z] ====== als (apache-spark) [default], iteration 8 completed (9852.851 ms) ======
[2026-02-04T22:37:22.761Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-04T22:37:22.761Z] GC before operation: completed in 109.467 ms, heap usage 344.346 MB -> 66.450 MB.
[2026-02-04T22:37:32.070Z] ====== als (apache-spark) [default], iteration 9 completed (9727.768 ms) ======
[2026-02-04T22:37:32.070Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-04T22:37:32.070Z] GC before operation: completed in 117.523 ms, heap usage 474.424 MB -> 66.923 MB.
[2026-02-04T22:37:41.405Z] ====== als (apache-spark) [default], iteration 10 completed (10025.044 ms) ======
[2026-02-04T22:37:41.405Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-04T22:37:41.405Z] GC before operation: completed in 108.474 ms, heap usage 358.859 MB -> 66.907 MB.
[2026-02-04T22:37:52.491Z] ====== als (apache-spark) [default], iteration 11 completed (9742.944 ms) ======
[2026-02-04T22:37:52.491Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-04T22:37:52.491Z] GC before operation: completed in 102.963 ms, heap usage 333.754 MB -> 67.278 MB.
[2026-02-04T22:38:01.686Z] ====== als (apache-spark) [default], iteration 12 completed (9641.898 ms) ======
[2026-02-04T22:38:01.687Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-04T22:38:01.687Z] GC before operation: completed in 104.369 ms, heap usage 182.990 MB -> 67.229 MB.
[2026-02-04T22:38:11.679Z] ====== als (apache-spark) [default], iteration 13 completed (9814.870 ms) ======
[2026-02-04T22:38:11.679Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-04T22:38:11.679Z] GC before operation: completed in 111.580 ms, heap usage 389.742 MB -> 67.726 MB.
[2026-02-04T22:38:22.993Z] ====== als (apache-spark) [default], iteration 14 completed (9693.509 ms) ======
[2026-02-04T22:38:22.993Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-04T22:38:22.993Z] GC before operation: completed in 99.484 ms, heap usage 434.324 MB -> 68.250 MB.
[2026-02-04T22:38:31.240Z] ====== als (apache-spark) [default], iteration 15 completed (9344.178 ms) ======
[2026-02-04T22:38:31.240Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-04T22:38:31.240Z] GC before operation: completed in 108.703 ms, heap usage 297.625 MB -> 68.269 MB.
[2026-02-04T22:38:40.815Z] ====== als (apache-spark) [default], iteration 16 completed (9299.395 ms) ======
[2026-02-04T22:38:40.815Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-04T22:38:40.815Z] GC before operation: completed in 163.921 ms, heap usage 533.844 MB -> 68.840 MB.
[2026-02-04T22:38:50.467Z] ====== als (apache-spark) [default], iteration 17 completed (9560.300 ms) ======
[2026-02-04T22:38:50.467Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-04T22:38:50.823Z] GC before operation: completed in 128.191 ms, heap usage 330.873 MB -> 68.723 MB.
[2026-02-04T22:39:02.052Z] ====== als (apache-spark) [default], iteration 18 completed (9487.084 ms) ======
[2026-02-04T22:39:02.052Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-04T22:39:02.052Z] GC before operation: completed in 98.264 ms, heap usage 440.296 MB -> 69.231 MB.
[2026-02-04T22:39:11.638Z] ====== als (apache-spark) [default], iteration 19 completed (9554.478 ms) ======
[2026-02-04T22:39:11.638Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-04T22:39:11.638Z] GC before operation: completed in 98.745 ms, heap usage 209.966 MB -> 69.047 MB.
[2026-02-04T22:39:21.407Z] ====== als (apache-spark) [default], iteration 20 completed (9855.450 ms) ======
[2026-02-04T22:39:21.407Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-04T22:39:21.407Z] GC before operation: completed in 107.440 ms, heap usage 186.123 MB -> 69.270 MB.
[2026-02-04T22:39:30.604Z] ====== als (apache-spark) [default], iteration 21 completed (9991.073 ms) ======
[2026-02-04T22:39:30.604Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-04T22:39:30.604Z] GC before operation: completed in 102.682 ms, heap usage 109.474 MB -> 69.530 MB.
[2026-02-04T22:39:41.762Z] ====== als (apache-spark) [default], iteration 22 completed (9478.490 ms) ======
[2026-02-04T22:39:41.762Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-04T22:39:41.762Z] GC before operation: completed in 105.412 ms, heap usage 318.203 MB -> 70.030 MB.
[2026-02-04T22:39:51.371Z] ====== als (apache-spark) [default], iteration 23 completed (9416.846 ms) ======
[2026-02-04T22:39:51.371Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-04T22:39:51.371Z] GC before operation: completed in 151.719 ms, heap usage 222.751 MB -> 70.259 MB.
[2026-02-04T22:40:01.355Z] ====== als (apache-spark) [default], iteration 24 completed (9256.658 ms) ======
[2026-02-04T22:40:01.355Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-04T22:40:01.355Z] GC before operation: completed in 109.217 ms, heap usage 264.846 MB -> 70.610 MB.
[2026-02-04T22:40:09.274Z] ====== als (apache-spark) [default], iteration 25 completed (9108.594 ms) ======
[2026-02-04T22:40:09.274Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-04T22:40:09.274Z] GC before operation: completed in 104.349 ms, heap usage 146.817 MB -> 70.632 MB.
[2026-02-04T22:40:19.197Z] ====== als (apache-spark) [default], iteration 26 completed (9434.986 ms) ======
[2026-02-04T22:40:19.197Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-04T22:40:19.197Z] GC before operation: completed in 100.356 ms, heap usage 344.109 MB -> 71.110 MB.
[2026-02-04T22:40:30.296Z] ====== als (apache-spark) [default], iteration 27 completed (9444.470 ms) ======
[2026-02-04T22:40:30.296Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-04T22:40:30.296Z] GC before operation: completed in 93.648 ms, heap usage 136.282 MB -> 71.049 MB.
[2026-02-04T22:40:39.701Z] ====== als (apache-spark) [default], iteration 28 completed (9763.794 ms) ======
[2026-02-04T22:40:39.702Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-04T22:40:39.702Z] GC before operation: completed in 93.022 ms, heap usage 376.545 MB -> 71.520 MB.
[2026-02-04T22:40:49.347Z] ====== als (apache-spark) [default], iteration 29 completed (9334.545 ms) ======
[2026-02-04T22:40:49.347Z] -----------------------------------
[2026-02-04T22:40:49.347Z] renaissance-als_0_PASSED
[2026-02-04T22:40:49.347Z] -----------------------------------
[2026-02-04T22:40:49.347Z]
[2026-02-04T22:40:49.347Z] TEST TEARDOWN:
[2026-02-04T22:40:49.347Z] Nothing to be done for teardown.
[2026-02-04T22:40:49.347Z] renaissance-als_0 Finish Time: Wed Feb 4 22:40:48 2026 Epoch Time (ms): 1770244848645