[2026-02-13T10:39:01.129Z] Running test renaissance-als_0 ... [2026-02-13T10:39:01.129Z] =============================================== [2026-02-13T10:39:01.129Z] renaissance-als_0 Start Time: Fri Feb 13 10:39:00 2026 Epoch Time (ms): 1770979140951 [2026-02-13T10:39:01.129Z] variation: NoOptions [2026-02-13T10:39:01.129Z] JVM_OPTIONS: [2026-02-13T10:39:01.129Z] { \ [2026-02-13T10:39:01.129Z] echo ""; echo "TEST SETUP:"; \ [2026-02-13T10:39:01.129Z] echo "Nothing to be done for setup."; \ [2026-02-13T10:39:01.129Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17709791403260/renaissance-als_0"; \ [2026-02-13T10:39:01.129Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17709791403260/renaissance-als_0"; \ [2026-02-13T10:39:01.129Z] echo ""; echo "TESTING:"; \ [2026-02-13T10:39:01.129Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_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_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17709791403260/renaissance-als_0"/als.json" als; \ [2026-02-13T10:39:01.129Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17709791403260/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-13T10:39:01.129Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-13T10:39:01.129Z] echo "Nothing to be done for teardown."; \ [2026-02-13T10:39:01.129Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17709791403260/TestTargetResult"; [2026-02-13T10:39:01.129Z] [2026-02-13T10:39:01.129Z] TEST SETUP: [2026-02-13T10:39:01.129Z] Nothing to be done for setup. [2026-02-13T10:39:01.129Z] [2026-02-13T10:39:01.129Z] TESTING: [2026-02-13T10:39:02.718Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-13T10:39:02.718Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17709791403260/renaissance-als_0/launcher-103901-5847160539073110036/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-13T10:39:02.718Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-13T10:39:02.718Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-13T10:39:18.844Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-13T10:39:22.271Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-13T10:39:22.271Z] GC before operation: completed in 46.574 ms, heap usage 193.500 MB -> 35.150 MB. [2026-02-13T10:39:44.921Z] ====== als (apache-spark) [default], iteration 0 completed (21386.689 ms) ====== [2026-02-13T10:39:44.921Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-13T10:39:44.921Z] GC before operation: completed in 106.223 ms, heap usage 279.101 MB -> 61.780 MB. [2026-02-13T10:39:53.248Z] ====== als (apache-spark) [default], iteration 1 completed (8332.353 ms) ====== [2026-02-13T10:39:53.248Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-13T10:39:53.248Z] GC before operation: completed in 82.395 ms, heap usage 201.563 MB -> 62.655 MB. [2026-02-13T10:40:01.570Z] ====== als (apache-spark) [default], iteration 2 completed (7691.526 ms) ====== [2026-02-13T10:40:01.570Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-13T10:40:01.570Z] GC before operation: completed in 81.858 ms, heap usage 494.451 MB -> 63.621 MB. [2026-02-13T10:40:10.252Z] ====== als (apache-spark) [default], iteration 3 completed (8340.770 ms) ====== [2026-02-13T10:40:10.252Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-13T10:40:10.252Z] GC before operation: completed in 83.929 ms, heap usage 156.174 MB -> 63.677 MB. [2026-02-13T10:40:17.142Z] ====== als (apache-spark) [default], iteration 4 completed (7106.037 ms) ====== [2026-02-13T10:40:17.142Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-13T10:40:17.142Z] GC before operation: completed in 84.943 ms, heap usage 262.259 MB -> 64.401 MB. [2026-02-13T10:40:24.051Z] ====== als (apache-spark) [default], iteration 5 completed (6969.020 ms) ====== [2026-02-13T10:40:24.051Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-13T10:40:24.829Z] GC before operation: completed in 93.306 ms, heap usage 103.631 MB -> 64.861 MB. [2026-02-13T10:40:33.145Z] ====== als (apache-spark) [default], iteration 6 completed (7976.923 ms) ====== [2026-02-13T10:40:33.145Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-13T10:40:33.145Z] GC before operation: completed in 103.531 ms, heap usage 94.018 MB -> 65.393 MB. [2026-02-13T10:40:40.576Z] ====== als (apache-spark) [default], iteration 7 completed (7132.175 ms) ====== [2026-02-13T10:40:40.576Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-13T10:40:40.576Z] GC before operation: completed in 88.216 ms, heap usage 527.331 MB -> 66.380 MB. [2026-02-13T10:40:47.484Z] ====== als (apache-spark) [default], iteration 8 completed (6800.530 ms) ====== [2026-02-13T10:40:47.484Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-13T10:40:47.484Z] GC before operation: completed in 88.008 ms, heap usage 187.412 MB -> 66.398 MB. [2026-02-13T10:40:54.453Z] ====== als (apache-spark) [default], iteration 9 completed (6557.599 ms) ====== [2026-02-13T10:40:54.453Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-13T10:40:54.453Z] GC before operation: completed in 89.450 ms, heap usage 127.933 MB -> 66.641 MB. [2026-02-13T10:41:01.343Z] ====== als (apache-spark) [default], iteration 10 completed (6712.599 ms) ====== [2026-02-13T10:41:01.343Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-13T10:41:01.343Z] GC before operation: completed in 99.581 ms, heap usage 190.506 MB -> 66.929 MB. [2026-02-13T10:41:08.250Z] ====== als (apache-spark) [default], iteration 11 completed (6736.506 ms) ====== [2026-02-13T10:41:08.250Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-13T10:41:08.250Z] GC before operation: completed in 98.484 ms, heap usage 492.198 MB -> 67.566 MB. [2026-02-13T10:41:15.135Z] ====== als (apache-spark) [default], iteration 12 completed (6688.969 ms) ====== [2026-02-13T10:41:15.135Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-13T10:41:15.135Z] GC before operation: completed in 95.025 ms, heap usage 354.983 MB -> 67.613 MB. [2026-02-13T10:41:22.023Z] ====== als (apache-spark) [default], iteration 13 completed (6617.859 ms) ====== [2026-02-13T10:41:22.023Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-13T10:41:22.023Z] GC before operation: completed in 97.111 ms, heap usage 401.795 MB -> 67.929 MB. [2026-02-13T10:41:28.176Z] ====== als (apache-spark) [default], iteration 14 completed (6584.559 ms) ====== [2026-02-13T10:41:28.176Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-13T10:41:28.949Z] GC before operation: completed in 116.837 ms, heap usage 537.447 MB -> 68.473 MB. [2026-02-13T10:41:35.855Z] ====== als (apache-spark) [default], iteration 15 completed (6676.040 ms) ====== [2026-02-13T10:41:35.856Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-13T10:41:35.856Z] GC before operation: completed in 97.535 ms, heap usage 595.901 MB -> 68.765 MB. [2026-02-13T10:41:42.759Z] ====== als (apache-spark) [default], iteration 16 completed (6549.272 ms) ====== [2026-02-13T10:41:42.759Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-13T10:41:42.760Z] GC before operation: completed in 98.133 ms, heap usage 282.840 MB -> 68.578 MB. [2026-02-13T10:41:54.544Z] ====== als (apache-spark) [default], iteration 17 completed (9771.922 ms) ====== [2026-02-13T10:41:54.544Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-13T10:41:54.544Z] GC before operation: completed in 91.655 ms, heap usage 234.291 MB -> 68.819 MB. [2026-02-13T10:42:10.146Z] ====== als (apache-spark) [default], iteration 18 completed (11628.841 ms) ====== [2026-02-13T10:42:10.146Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-13T10:42:10.146Z] GC before operation: completed in 115.363 ms, heap usage 208.926 MB -> 68.984 MB. [2026-02-13T10:42:23.946Z] ====== als (apache-spark) [default], iteration 19 completed (18252.068 ms) ====== [2026-02-13T10:42:23.946Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-13T10:42:23.946Z] GC before operation: completed in 104.307 ms, heap usage 358.964 MB -> 69.524 MB. [2026-02-13T10:42:31.518Z] ====== als (apache-spark) [default], iteration 20 completed (7065.734 ms) ====== [2026-02-13T10:42:31.518Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-13T10:42:31.518Z] GC before operation: completed in 117.421 ms, heap usage 357.925 MB -> 69.783 MB. [2026-02-13T10:42:38.430Z] ====== als (apache-spark) [default], iteration 21 completed (7526.028 ms) ====== [2026-02-13T10:42:38.430Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-13T10:42:38.430Z] GC before operation: completed in 97.439 ms, heap usage 491.465 MB -> 70.258 MB. [2026-02-13T10:42:46.762Z] ====== als (apache-spark) [default], iteration 22 completed (6919.859 ms) ====== [2026-02-13T10:42:46.762Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-13T10:42:46.762Z] GC before operation: completed in 101.082 ms, heap usage 360.854 MB -> 70.258 MB. [2026-02-13T10:42:52.423Z] ====== als (apache-spark) [default], iteration 23 completed (6579.840 ms) ====== [2026-02-13T10:42:52.423Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-13T10:42:53.200Z] GC before operation: completed in 109.860 ms, heap usage 442.174 MB -> 70.722 MB. [2026-02-13T10:43:00.126Z] ====== als (apache-spark) [default], iteration 24 completed (6673.448 ms) ====== [2026-02-13T10:43:00.126Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-13T10:43:00.126Z] GC before operation: completed in 99.543 ms, heap usage 389.913 MB -> 70.645 MB. [2026-02-13T10:43:07.028Z] ====== als (apache-spark) [default], iteration 25 completed (6799.065 ms) ====== [2026-02-13T10:43:07.028Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-13T10:43:07.028Z] GC before operation: completed in 100.497 ms, heap usage 451.354 MB -> 71.190 MB. [2026-02-13T10:43:13.939Z] ====== als (apache-spark) [default], iteration 26 completed (7013.571 ms) ====== [2026-02-13T10:43:13.939Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-13T10:43:13.939Z] GC before operation: completed in 103.654 ms, heap usage 350.463 MB -> 71.249 MB. [2026-02-13T10:43:21.125Z] ====== als (apache-spark) [default], iteration 27 completed (6517.243 ms) ====== [2026-02-13T10:43:21.125Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-13T10:43:21.125Z] GC before operation: completed in 105.083 ms, heap usage 194.381 MB -> 70.802 MB. [2026-02-13T10:43:28.035Z] ====== als (apache-spark) [default], iteration 28 completed (6424.870 ms) ====== [2026-02-13T10:43:28.035Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-13T10:43:28.035Z] GC before operation: completed in 101.806 ms, heap usage 358.940 MB -> 71.318 MB. [2026-02-13T10:43:34.943Z] ====== als (apache-spark) [default], iteration 29 completed (6719.879 ms) ====== [2026-02-13T10:43:34.943Z] ----------------------------------- [2026-02-13T10:43:34.943Z] renaissance-als_0_PASSED [2026-02-13T10:43:34.943Z] ----------------------------------- [2026-02-13T10:43:34.943Z] [2026-02-13T10:43:34.943Z] TEST TEARDOWN: [2026-02-13T10:43:34.943Z] Nothing to be done for teardown. [2026-02-13T10:43:34.943Z] renaissance-als_0 Finish Time: Fri Feb 13 10:43:34 2026 Epoch Time (ms): 1770979414240