[2026-02-15T09:34:19.587Z] Running test renaissance-als_0 ... [2026-02-15T09:34:19.587Z] =============================================== [2026-02-15T09:34:19.587Z] renaissance-als_0 Start Time: Sun Feb 15 09:34:13 2026 Epoch Time (ms): 1771148053588 [2026-02-15T09:34:19.587Z] variation: NoOptions [2026-02-15T09:34:19.587Z] JVM_OPTIONS: [2026-02-15T09:34:19.587Z] { \ [2026-02-15T09:34:19.587Z] echo ""; echo "TEST SETUP:"; \ [2026-02-15T09:34:19.587Z] echo "Nothing to be done for setup."; \ [2026-02-15T09:34:19.587Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17711480531411/renaissance-als_0"; \ [2026-02-15T09:34:19.587Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17711480531411/renaissance-als_0"; \ [2026-02-15T09:34:19.587Z] echo ""; echo "TESTING:"; \ [2026-02-15T09:34:19.587Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-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_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17711480531411/renaissance-als_0"/als.json" als; \ [2026-02-15T09:34:19.587Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17711480531411/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-15T09:34:19.587Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-15T09:34:19.587Z] echo "Nothing to be done for teardown."; \ [2026-02-15T09:34:19.587Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17711480531411/TestTargetResult"; [2026-02-15T09:34:19.587Z] [2026-02-15T09:34:19.587Z] TEST SETUP: [2026-02-15T09:34:19.587Z] Nothing to be done for setup. [2026-02-15T09:34:19.587Z] [2026-02-15T09:34:19.587Z] TESTING: [2026-02-15T09:34:19.587Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-15T09:34:19.587Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/output_17711480531411/renaissance-als_0/launcher-093413-11656964275035094314/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-15T09:34:19.587Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-15T09:34:19.587Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-15T09:34:20.770Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-15T09:34:25.002Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-15T09:34:25.002Z] GC before operation: completed in 41.229 ms, heap usage 53.500 MB -> 35.085 MB. [2026-02-15T09:34:41.058Z] ====== als (apache-spark) [default], iteration 0 completed (15678.462 ms) ====== [2026-02-15T09:34:41.058Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-15T09:34:41.058Z] GC before operation: completed in 87.876 ms, heap usage 268.655 MB -> 61.761 MB. [2026-02-15T09:34:47.903Z] ====== als (apache-spark) [default], iteration 1 completed (5919.208 ms) ====== [2026-02-15T09:34:47.903Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-15T09:34:47.903Z] GC before operation: completed in 85.207 ms, heap usage 433.282 MB -> 63.030 MB. [2026-02-15T09:34:53.394Z] ====== als (apache-spark) [default], iteration 2 completed (5368.720 ms) ====== [2026-02-15T09:34:53.394Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-15T09:34:53.394Z] GC before operation: completed in 97.196 ms, heap usage 352.543 MB -> 63.349 MB. [2026-02-15T09:34:58.886Z] ====== als (apache-spark) [default], iteration 3 completed (5135.834 ms) ====== [2026-02-15T09:34:58.886Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-15T09:34:58.886Z] GC before operation: completed in 97.785 ms, heap usage 432.672 MB -> 64.112 MB. [2026-02-15T09:35:04.366Z] ====== als (apache-spark) [default], iteration 4 completed (5449.360 ms) ====== [2026-02-15T09:35:04.366Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-15T09:35:04.366Z] GC before operation: completed in 92.748 ms, heap usage 331.926 MB -> 64.465 MB. [2026-02-15T09:35:08.630Z] ====== als (apache-spark) [default], iteration 5 completed (4872.848 ms) ====== [2026-02-15T09:35:08.630Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-15T09:35:09.607Z] GC before operation: completed in 96.675 ms, heap usage 324.302 MB -> 65.045 MB. [2026-02-15T09:35:15.098Z] ====== als (apache-spark) [default], iteration 6 completed (5136.838 ms) ====== [2026-02-15T09:35:15.098Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-15T09:35:15.098Z] GC before operation: completed in 96.362 ms, heap usage 116.558 MB -> 65.337 MB. [2026-02-15T09:35:19.338Z] ====== als (apache-spark) [default], iteration 7 completed (4924.604 ms) ====== [2026-02-15T09:35:19.338Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-15T09:35:19.338Z] GC before operation: completed in 102.697 ms, heap usage 572.086 MB -> 66.417 MB. [2026-02-15T09:35:24.831Z] ====== als (apache-spark) [default], iteration 8 completed (4934.565 ms) ====== [2026-02-15T09:35:24.831Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-15T09:35:24.831Z] GC before operation: completed in 94.279 ms, heap usage 245.910 MB -> 66.538 MB. [2026-02-15T09:35:30.321Z] ====== als (apache-spark) [default], iteration 9 completed (4764.361 ms) ====== [2026-02-15T09:35:30.321Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-15T09:35:30.321Z] GC before operation: completed in 110.131 ms, heap usage 250.144 MB -> 66.912 MB. [2026-02-15T09:35:34.566Z] ====== als (apache-spark) [default], iteration 10 completed (4686.516 ms) ====== [2026-02-15T09:35:34.566Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-15T09:35:34.566Z] GC before operation: completed in 96.111 ms, heap usage 351.227 MB -> 67.208 MB. [2026-02-15T09:35:40.053Z] ====== als (apache-spark) [default], iteration 11 completed (4663.336 ms) ====== [2026-02-15T09:35:40.053Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-15T09:35:40.053Z] GC before operation: completed in 104.953 ms, heap usage 573.399 MB -> 67.808 MB. [2026-02-15T09:35:44.293Z] ====== als (apache-spark) [default], iteration 12 completed (4641.415 ms) ====== [2026-02-15T09:35:44.293Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-15T09:35:44.293Z] GC before operation: completed in 104.226 ms, heap usage 248.339 MB -> 67.635 MB. [2026-02-15T09:35:49.777Z] ====== als (apache-spark) [default], iteration 13 completed (4819.164 ms) ====== [2026-02-15T09:35:49.777Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-15T09:35:49.777Z] GC before operation: completed in 107.595 ms, heap usage 490.688 MB -> 68.282 MB. [2026-02-15T09:35:55.264Z] ====== als (apache-spark) [default], iteration 14 completed (4710.715 ms) ====== [2026-02-15T09:35:55.264Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-15T09:35:55.264Z] GC before operation: completed in 104.761 ms, heap usage 536.464 MB -> 68.523 MB. [2026-02-15T09:35:59.729Z] ====== als (apache-spark) [default], iteration 15 completed (4799.475 ms) ====== [2026-02-15T09:35:59.729Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-15T09:35:59.729Z] GC before operation: completed in 120.477 ms, heap usage 381.877 MB -> 68.621 MB. [2026-02-15T09:36:05.206Z] ====== als (apache-spark) [default], iteration 16 completed (4731.985 ms) ====== [2026-02-15T09:36:05.206Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-15T09:36:05.206Z] GC before operation: completed in 106.664 ms, heap usage 236.997 MB -> 68.652 MB. [2026-02-15T09:36:09.450Z] ====== als (apache-spark) [default], iteration 17 completed (4670.789 ms) ====== [2026-02-15T09:36:09.450Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-15T09:36:09.450Z] GC before operation: completed in 121.252 ms, heap usage 483.293 MB -> 69.259 MB. [2026-02-15T09:36:14.974Z] ====== als (apache-spark) [default], iteration 18 completed (4581.698 ms) ====== [2026-02-15T09:36:14.974Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-15T09:36:14.974Z] GC before operation: completed in 114.720 ms, heap usage 552.640 MB -> 69.640 MB. [2026-02-15T09:36:19.220Z] ====== als (apache-spark) [default], iteration 19 completed (4619.956 ms) ====== [2026-02-15T09:36:19.220Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-15T09:36:19.220Z] GC before operation: completed in 116.060 ms, heap usage 526.867 MB -> 69.933 MB. [2026-02-15T09:36:29.652Z] ====== als (apache-spark) [default], iteration 20 completed (4753.919 ms) ====== [2026-02-15T09:36:29.652Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-15T09:36:29.652Z] GC before operation: completed in 113.387 ms, heap usage 590.484 MB -> 70.158 MB. [2026-02-15T09:36:29.652Z] ====== als (apache-spark) [default], iteration 21 completed (4729.481 ms) ====== [2026-02-15T09:36:29.652Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-15T09:36:29.652Z] GC before operation: completed in 120.404 ms, heap usage 144.054 MB -> 69.941 MB. [2026-02-15T09:36:33.900Z] ====== als (apache-spark) [default], iteration 22 completed (4663.912 ms) ====== [2026-02-15T09:36:33.900Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-15T09:36:33.900Z] GC before operation: completed in 117.691 ms, heap usage 291.158 MB -> 70.202 MB. [2026-02-15T09:36:39.397Z] ====== als (apache-spark) [default], iteration 23 completed (4626.667 ms) ====== [2026-02-15T09:36:39.397Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-15T09:36:39.397Z] GC before operation: completed in 115.569 ms, heap usage 223.277 MB -> 70.478 MB. [2026-02-15T09:36:44.880Z] ====== als (apache-spark) [default], iteration 24 completed (4906.701 ms) ====== [2026-02-15T09:36:44.880Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-15T09:36:44.880Z] GC before operation: completed in 110.788 ms, heap usage 159.783 MB -> 70.611 MB. [2026-02-15T09:36:49.129Z] ====== als (apache-spark) [default], iteration 25 completed (4739.522 ms) ====== [2026-02-15T09:36:49.129Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-15T09:36:49.129Z] GC before operation: completed in 111.800 ms, heap usage 273.383 MB -> 70.989 MB. [2026-02-15T09:36:54.622Z] ====== als (apache-spark) [default], iteration 26 completed (4675.427 ms) ====== [2026-02-15T09:36:54.622Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-15T09:36:54.622Z] GC before operation: completed in 121.701 ms, heap usage 578.888 MB -> 71.696 MB. [2026-02-15T09:36:58.868Z] ====== als (apache-spark) [default], iteration 27 completed (4752.605 ms) ====== [2026-02-15T09:36:58.868Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-15T09:36:58.869Z] GC before operation: completed in 112.329 ms, heap usage 488.978 MB -> 71.424 MB. [2026-02-15T09:37:04.359Z] ====== als (apache-spark) [default], iteration 28 completed (4733.533 ms) ====== [2026-02-15T09:37:04.359Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-15T09:37:04.359Z] GC before operation: completed in 116.867 ms, heap usage 253.954 MB -> 71.384 MB. [2026-02-15T09:37:08.600Z] ====== als (apache-spark) [default], iteration 29 completed (4637.063 ms) ====== [2026-02-15T09:37:09.574Z] ----------------------------------- [2026-02-15T09:37:09.574Z] renaissance-als_0_PASSED [2026-02-15T09:37:09.574Z] ----------------------------------- [2026-02-15T09:37:09.574Z] [2026-02-15T09:37:09.574Z] TEST TEARDOWN: [2026-02-15T09:37:09.574Z] Nothing to be done for teardown. [2026-02-15T09:37:09.574Z] renaissance-als_0 Finish Time: Sun Feb 15 09:37:08 2026 Epoch Time (ms): 1771148228789