[2026-02-20T00:27:13.448Z] Running test renaissance-als_0 ... [2026-02-20T00:27:13.448Z] =============================================== [2026-02-20T00:27:13.448Z] renaissance-als_0 Start Time: Fri Feb 20 00:27:12 2026 Epoch Time (ms): 1771547232967 [2026-02-20T00:27:13.448Z] variation: NoOptions [2026-02-20T00:27:13.448Z] JVM_OPTIONS: [2026-02-20T00:27:13.448Z] { \ [2026-02-20T00:27:13.448Z] echo ""; echo "TEST SETUP:"; \ [2026-02-20T00:27:13.448Z] echo "Nothing to be done for setup."; \ [2026-02-20T00:27:13.448Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17715470756521/renaissance-als_0"; \ [2026-02-20T00:27:13.448Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17715470756521/renaissance-als_0"; \ [2026-02-20T00:27:13.448Z] echo ""; echo "TESTING:"; \ [2026-02-20T00:27:13.448Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_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_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17715470756521/renaissance-als_0"/als.json" als; \ [2026-02-20T00:27:13.449Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17715470756521/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-20T00:27:13.449Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-20T00:27:13.449Z] echo "Nothing to be done for teardown."; \ [2026-02-20T00:27:13.449Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17715470756521/TestTargetResult"; [2026-02-20T00:27:13.449Z] [2026-02-20T00:27:13.449Z] TEST SETUP: [2026-02-20T00:27:13.449Z] Nothing to be done for setup. [2026-02-20T00:27:13.449Z] [2026-02-20T00:27:13.449Z] TESTING: [2026-02-20T00:27:14.407Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-20T00:27:14.407Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17715470756521/renaissance-als_0/launcher-002713-18110808587170361536/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-20T00:27:14.407Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-20T00:27:14.407Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-20T00:27:18.590Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-20T00:27:24.006Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-20T00:27:24.006Z] GC before operation: completed in 52.620 ms, heap usage 431.882 MB -> 35.069 MB. [2026-02-20T00:27:42.408Z] ====== als (apache-spark) [default], iteration 0 completed (17056.362 ms) ====== [2026-02-20T00:27:42.408Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-20T00:27:42.408Z] GC before operation: completed in 91.899 ms, heap usage 190.724 MB -> 61.724 MB. [2026-02-20T00:27:49.167Z] ====== als (apache-spark) [default], iteration 1 completed (7598.214 ms) ====== [2026-02-20T00:27:49.167Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-20T00:27:49.167Z] GC before operation: completed in 79.521 ms, heap usage 504.044 MB -> 63.030 MB. [2026-02-20T00:27:55.921Z] ====== als (apache-spark) [default], iteration 2 completed (7258.270 ms) ====== [2026-02-20T00:27:55.921Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-20T00:27:55.921Z] GC before operation: completed in 85.305 ms, heap usage 332.914 MB -> 63.343 MB. [2026-02-20T00:28:04.160Z] ====== als (apache-spark) [default], iteration 3 completed (6991.433 ms) ====== [2026-02-20T00:28:04.160Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-20T00:28:04.160Z] GC before operation: completed in 96.454 ms, heap usage 281.165 MB -> 63.883 MB. [2026-02-20T00:28:10.899Z] ====== als (apache-spark) [default], iteration 4 completed (6792.191 ms) ====== [2026-02-20T00:28:10.899Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-20T00:28:10.899Z] GC before operation: completed in 96.909 ms, heap usage 529.096 MB -> 64.841 MB. [2026-02-20T00:28:17.660Z] ====== als (apache-spark) [default], iteration 5 completed (6711.500 ms) ====== [2026-02-20T00:28:17.660Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-20T00:28:17.660Z] GC before operation: completed in 91.303 ms, heap usage 159.333 MB -> 64.950 MB. [2026-02-20T00:28:24.279Z] ====== als (apache-spark) [default], iteration 6 completed (6617.248 ms) ====== [2026-02-20T00:28:24.279Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-20T00:28:25.237Z] GC before operation: completed in 106.912 ms, heap usage 540.309 MB -> 65.953 MB. [2026-02-20T00:28:31.980Z] ====== als (apache-spark) [default], iteration 7 completed (6631.190 ms) ====== [2026-02-20T00:28:31.980Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-20T00:28:31.980Z] GC before operation: completed in 87.370 ms, heap usage 253.727 MB -> 66.127 MB. [2026-02-20T00:28:38.725Z] ====== als (apache-spark) [default], iteration 8 completed (6663.855 ms) ====== [2026-02-20T00:28:38.725Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-20T00:28:38.725Z] GC before operation: completed in 117.487 ms, heap usage 134.443 MB -> 66.522 MB. [2026-02-20T00:28:45.486Z] ====== als (apache-spark) [default], iteration 9 completed (6564.985 ms) ====== [2026-02-20T00:28:45.486Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-20T00:28:45.486Z] GC before operation: completed in 96.017 ms, heap usage 187.007 MB -> 66.830 MB. [2026-02-20T00:28:52.236Z] ====== als (apache-spark) [default], iteration 10 completed (6647.169 ms) ====== [2026-02-20T00:28:52.236Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-20T00:28:52.236Z] GC before operation: completed in 95.370 ms, heap usage 319.027 MB -> 67.235 MB. [2026-02-20T00:29:00.431Z] ====== als (apache-spark) [default], iteration 11 completed (6614.532 ms) ====== [2026-02-20T00:29:00.431Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-20T00:29:00.431Z] GC before operation: completed in 91.179 ms, heap usage 187.554 MB -> 67.230 MB. [2026-02-20T00:29:07.203Z] ====== als (apache-spark) [default], iteration 12 completed (6592.004 ms) ====== [2026-02-20T00:29:07.203Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-20T00:29:07.203Z] GC before operation: completed in 109.019 ms, heap usage 155.044 MB -> 67.572 MB. [2026-02-20T00:29:13.950Z] ====== als (apache-spark) [default], iteration 13 completed (6691.135 ms) ====== [2026-02-20T00:29:13.950Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-20T00:29:13.950Z] GC before operation: completed in 90.072 ms, heap usage 429.865 MB -> 68.269 MB. [2026-02-20T00:29:20.586Z] ====== als (apache-spark) [default], iteration 14 completed (6564.081 ms) ====== [2026-02-20T00:29:20.586Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-20T00:29:20.586Z] GC before operation: completed in 102.511 ms, heap usage 285.960 MB -> 68.270 MB. [2026-02-20T00:29:27.465Z] ====== als (apache-spark) [default], iteration 15 completed (6544.788 ms) ====== [2026-02-20T00:29:27.465Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-20T00:29:27.465Z] GC before operation: completed in 103.296 ms, heap usage 195.874 MB -> 68.378 MB. [2026-02-20T00:29:34.203Z] ====== als (apache-spark) [default], iteration 16 completed (6539.501 ms) ====== [2026-02-20T00:29:34.203Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-20T00:29:34.203Z] GC before operation: completed in 109.615 ms, heap usage 107.525 MB -> 68.642 MB. [2026-02-20T00:29:41.147Z] ====== als (apache-spark) [default], iteration 17 completed (6510.544 ms) ====== [2026-02-20T00:29:41.147Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-20T00:29:41.147Z] GC before operation: completed in 109.805 ms, heap usage 452.497 MB -> 69.383 MB. [2026-02-20T00:29:47.919Z] ====== als (apache-spark) [default], iteration 18 completed (6562.288 ms) ====== [2026-02-20T00:29:47.919Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-20T00:29:47.919Z] GC before operation: completed in 113.424 ms, heap usage 360.374 MB -> 69.410 MB. [2026-02-20T00:29:54.659Z] ====== als (apache-spark) [default], iteration 19 completed (6490.508 ms) ====== [2026-02-20T00:29:54.659Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-20T00:29:54.659Z] GC before operation: completed in 110.632 ms, heap usage 445.229 MB -> 69.923 MB. [2026-02-20T00:30:01.407Z] ====== als (apache-spark) [default], iteration 20 completed (6758.257 ms) ====== [2026-02-20T00:30:01.407Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-20T00:30:01.407Z] GC before operation: completed in 100.302 ms, heap usage 295.545 MB -> 69.928 MB. [2026-02-20T00:30:08.590Z] ====== als (apache-spark) [default], iteration 21 completed (6564.561 ms) ====== [2026-02-20T00:30:08.590Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-20T00:30:08.590Z] GC before operation: completed in 100.385 ms, heap usage 497.456 MB -> 70.435 MB. [2026-02-20T00:30:15.815Z] ====== als (apache-spark) [default], iteration 22 completed (6547.062 ms) ====== [2026-02-20T00:30:15.815Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-20T00:30:15.815Z] GC before operation: completed in 98.656 ms, heap usage 444.771 MB -> 70.712 MB. [2026-02-20T00:30:22.697Z] ====== als (apache-spark) [default], iteration 23 completed (6539.594 ms) ====== [2026-02-20T00:30:22.697Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-20T00:30:22.697Z] GC before operation: completed in 100.733 ms, heap usage 323.147 MB -> 70.720 MB. [2026-02-20T00:30:29.435Z] ====== als (apache-spark) [default], iteration 24 completed (6593.493 ms) ====== [2026-02-20T00:30:29.435Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-20T00:30:29.435Z] GC before operation: completed in 103.833 ms, heap usage 276.470 MB -> 70.883 MB. [2026-02-20T00:30:36.194Z] ====== als (apache-spark) [default], iteration 25 completed (6433.856 ms) ====== [2026-02-20T00:30:36.194Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-20T00:30:36.194Z] GC before operation: completed in 99.232 ms, heap usage 152.682 MB -> 71.025 MB. [2026-02-20T00:30:42.964Z] ====== als (apache-spark) [default], iteration 26 completed (6407.240 ms) ====== [2026-02-20T00:30:42.964Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-20T00:30:42.964Z] GC before operation: completed in 97.455 ms, heap usage 596.477 MB -> 71.896 MB. [2026-02-20T00:30:49.743Z] ====== als (apache-spark) [default], iteration 27 completed (6510.627 ms) ====== [2026-02-20T00:30:49.743Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-20T00:30:49.743Z] GC before operation: completed in 103.511 ms, heap usage 431.310 MB -> 72.015 MB. [2026-02-20T00:30:56.485Z] ====== als (apache-spark) [default], iteration 28 completed (6468.195 ms) ====== [2026-02-20T00:30:56.485Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-20T00:30:56.485Z] GC before operation: completed in 105.379 ms, heap usage 449.391 MB -> 72.206 MB. [2026-02-20T00:31:02.575Z] ====== als (apache-spark) [default], iteration 29 completed (6457.085 ms) ====== [2026-02-20T00:31:02.575Z] ----------------------------------- [2026-02-20T00:31:02.575Z] renaissance-als_0_PASSED [2026-02-20T00:31:02.575Z] ----------------------------------- [2026-02-20T00:31:02.575Z] [2026-02-20T00:31:02.575Z] TEST TEARDOWN: [2026-02-20T00:31:02.575Z] Nothing to be done for teardown. [2026-02-20T00:31:02.575Z] renaissance-als_0 Finish Time: Fri Feb 20 00:31:02 2026 Epoch Time (ms): 1771547462473