[2026-02-26T23:02:38.652Z] Running test renaissance-als_0 ... [2026-02-26T23:02:38.652Z] =============================================== [2026-02-26T23:02:38.652Z] renaissance-als_0 Start Time: Thu Feb 26 23:02:38 2026 Epoch Time (ms): 1772146958164 [2026-02-26T23:02:38.652Z] variation: NoOptions [2026-02-26T23:02:38.652Z] JVM_OPTIONS: [2026-02-26T23:02:38.652Z] { \ [2026-02-26T23:02:38.652Z] echo ""; echo "TEST SETUP:"; \ [2026-02-26T23:02:38.652Z] echo "Nothing to be done for setup."; \ [2026-02-26T23:02:38.652Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17721467638749/renaissance-als_0"; \ [2026-02-26T23:02:38.652Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17721467638749/renaissance-als_0"; \ [2026-02-26T23:02:38.652Z] echo ""; echo "TESTING:"; \ [2026-02-26T23:02:38.652Z] "/home/jenkins/workspace/Test_openjdk25_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_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17721467638749/renaissance-als_0"/als.json" als; \ [2026-02-26T23:02:38.652Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17721467638749/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-26T23:02:38.652Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-26T23:02:38.652Z] echo "Nothing to be done for teardown."; \ [2026-02-26T23:02:38.652Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17721467638749/TestTargetResult"; [2026-02-26T23:02:38.652Z] [2026-02-26T23:02:38.652Z] TEST SETUP: [2026-02-26T23:02:38.652Z] Nothing to be done for setup. [2026-02-26T23:02:38.652Z] [2026-02-26T23:02:38.652Z] TESTING: [2026-02-26T23:02:39.296Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-26T23:02:39.296Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17721467638749/renaissance-als_0/launcher-230238-15943560707011964974/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-26T23:02:39.296Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-26T23:02:39.296Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-26T23:02:52.139Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2026-02-26T23:02:55.954Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-26T23:02:55.954Z] GC before operation: completed in 50.209 ms, heap usage 52.000 MB -> 34.918 MB. [2026-02-26T23:03:24.051Z] ====== als (apache-spark) [default], iteration 0 completed (26751.747 ms) ====== [2026-02-26T23:03:24.051Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-26T23:03:24.051Z] GC before operation: completed in 116.620 ms, heap usage 103.024 MB -> 61.361 MB. [2026-02-26T23:03:38.738Z] ====== als (apache-spark) [default], iteration 1 completed (14349.803 ms) ====== [2026-02-26T23:03:38.739Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-26T23:03:38.739Z] GC before operation: completed in 125.649 ms, heap usage 462.062 MB -> 62.639 MB. [2026-02-26T23:03:53.399Z] ====== als (apache-spark) [default], iteration 2 completed (13334.846 ms) ====== [2026-02-26T23:03:53.399Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-26T23:03:53.399Z] GC before operation: completed in 103.777 ms, heap usage 109.966 MB -> 62.722 MB. [2026-02-26T23:04:05.730Z] ====== als (apache-spark) [default], iteration 3 completed (13629.266 ms) ====== [2026-02-26T23:04:05.730Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-26T23:04:06.375Z] GC before operation: completed in 104.127 ms, heap usage 187.585 MB -> 63.348 MB. [2026-02-26T23:04:18.716Z] ====== als (apache-spark) [default], iteration 4 completed (12669.474 ms) ====== [2026-02-26T23:04:18.716Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-26T23:04:19.359Z] GC before operation: completed in 105.419 ms, heap usage 427.913 MB -> 64.319 MB. [2026-02-26T23:04:31.800Z] ====== als (apache-spark) [default], iteration 5 completed (12467.142 ms) ====== [2026-02-26T23:04:31.800Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-26T23:04:31.800Z] GC before operation: completed in 117.919 ms, heap usage 101.384 MB -> 64.431 MB. [2026-02-26T23:04:44.663Z] ====== als (apache-spark) [default], iteration 6 completed (12496.808 ms) ====== [2026-02-26T23:04:44.663Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-26T23:04:44.663Z] GC before operation: completed in 112.776 ms, heap usage 277.838 MB -> 65.069 MB. [2026-02-26T23:04:59.260Z] ====== als (apache-spark) [default], iteration 7 completed (12665.989 ms) ====== [2026-02-26T23:04:59.260Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-26T23:04:59.260Z] GC before operation: completed in 128.910 ms, heap usage 153.299 MB -> 65.566 MB. [2026-02-26T23:05:11.589Z] ====== als (apache-spark) [default], iteration 8 completed (12481.399 ms) ====== [2026-02-26T23:05:11.589Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-26T23:05:11.589Z] GC before operation: completed in 142.857 ms, heap usage 379.461 MB -> 66.328 MB. [2026-02-26T23:05:23.950Z] ====== als (apache-spark) [default], iteration 9 completed (12256.129 ms) ====== [2026-02-26T23:05:23.950Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-26T23:05:23.950Z] GC before operation: completed in 118.963 ms, heap usage 228.822 MB -> 66.367 MB. [2026-02-26T23:05:36.285Z] ====== als (apache-spark) [default], iteration 10 completed (12610.244 ms) ====== [2026-02-26T23:05:36.285Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-26T23:05:36.285Z] GC before operation: completed in 119.798 ms, heap usage 322.175 MB -> 66.721 MB. [2026-02-26T23:05:50.872Z] ====== als (apache-spark) [default], iteration 11 completed (12425.596 ms) ====== [2026-02-26T23:05:50.872Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-26T23:05:50.872Z] GC before operation: completed in 123.701 ms, heap usage 333.708 MB -> 66.959 MB. [2026-02-26T23:06:01.302Z] ====== als (apache-spark) [default], iteration 12 completed (12106.497 ms) ====== [2026-02-26T23:06:01.302Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-26T23:06:01.943Z] GC before operation: completed in 122.070 ms, heap usage 474.475 MB -> 67.439 MB. [2026-02-26T23:06:14.284Z] ====== als (apache-spark) [default], iteration 13 completed (12199.578 ms) ====== [2026-02-26T23:06:14.284Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-26T23:06:14.284Z] GC before operation: completed in 116.713 ms, heap usage 193.330 MB -> 67.275 MB. [2026-02-26T23:06:26.791Z] ====== als (apache-spark) [default], iteration 14 completed (12073.664 ms) ====== [2026-02-26T23:06:26.791Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-26T23:06:26.791Z] GC before operation: completed in 120.260 ms, heap usage 358.796 MB -> 67.775 MB. [2026-02-26T23:06:39.689Z] ====== als (apache-spark) [default], iteration 15 completed (12221.641 ms) ====== [2026-02-26T23:06:39.690Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-26T23:06:39.690Z] GC before operation: completed in 121.313 ms, heap usage 370.026 MB -> 67.962 MB. [2026-02-26T23:06:52.233Z] ====== als (apache-spark) [default], iteration 16 completed (12216.841 ms) ====== [2026-02-26T23:06:52.233Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-26T23:06:52.233Z] GC before operation: completed in 189.024 ms, heap usage 381.472 MB -> 68.232 MB. [2026-02-26T23:07:04.619Z] ====== als (apache-spark) [default], iteration 17 completed (12363.704 ms) ====== [2026-02-26T23:07:04.619Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-26T23:07:04.619Z] GC before operation: completed in 125.223 ms, heap usage 427.031 MB -> 68.719 MB. [2026-02-26T23:07:17.004Z] ====== als (apache-spark) [default], iteration 18 completed (12266.487 ms) ====== [2026-02-26T23:07:17.004Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-26T23:07:17.004Z] GC before operation: completed in 119.819 ms, heap usage 130.644 MB -> 68.557 MB. [2026-02-26T23:07:29.358Z] ====== als (apache-spark) [default], iteration 19 completed (12156.691 ms) ====== [2026-02-26T23:07:29.358Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-26T23:07:29.358Z] GC before operation: completed in 119.638 ms, heap usage 292.024 MB -> 69.040 MB. [2026-02-26T23:07:43.968Z] ====== als (apache-spark) [default], iteration 20 completed (12570.648 ms) ====== [2026-02-26T23:07:43.969Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-26T23:07:43.969Z] GC before operation: completed in 120.301 ms, heap usage 326.523 MB -> 69.292 MB. [2026-02-26T23:07:56.317Z] ====== als (apache-spark) [default], iteration 21 completed (13008.571 ms) ====== [2026-02-26T23:07:56.317Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-26T23:07:56.317Z] GC before operation: completed in 127.749 ms, heap usage 286.894 MB -> 69.402 MB. [2026-02-26T23:08:08.810Z] ====== als (apache-spark) [default], iteration 22 completed (12468.218 ms) ====== [2026-02-26T23:08:08.810Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-26T23:08:08.810Z] GC before operation: completed in 119.889 ms, heap usage 291.291 MB -> 69.690 MB. [2026-02-26T23:08:21.168Z] ====== als (apache-spark) [default], iteration 23 completed (12129.990 ms) ====== [2026-02-26T23:08:21.168Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-26T23:08:21.168Z] GC before operation: completed in 125.478 ms, heap usage 468.723 MB -> 70.330 MB. [2026-02-26T23:08:33.642Z] ====== als (apache-spark) [default], iteration 24 completed (12124.032 ms) ====== [2026-02-26T23:08:33.642Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-26T23:08:33.642Z] GC before operation: completed in 120.678 ms, heap usage 115.686 MB -> 70.147 MB. [2026-02-26T23:08:45.970Z] ====== als (apache-spark) [default], iteration 25 completed (12150.904 ms) ====== [2026-02-26T23:08:45.970Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-26T23:08:45.970Z] GC before operation: completed in 127.743 ms, heap usage 157.754 MB -> 70.411 MB. [2026-02-26T23:08:58.368Z] ====== als (apache-spark) [default], iteration 26 completed (12120.543 ms) ====== [2026-02-26T23:08:58.368Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-26T23:08:58.368Z] GC before operation: completed in 128.935 ms, heap usage 455.463 MB -> 71.195 MB. [2026-02-26T23:09:10.705Z] ====== als (apache-spark) [default], iteration 27 completed (12154.181 ms) ====== [2026-02-26T23:09:10.705Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-26T23:09:10.705Z] GC before operation: completed in 124.013 ms, heap usage 396.061 MB -> 71.292 MB. [2026-02-26T23:09:25.285Z] ====== als (apache-spark) [default], iteration 28 completed (12447.458 ms) ====== [2026-02-26T23:09:25.285Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-26T23:09:25.285Z] GC before operation: completed in 128.253 ms, heap usage 200.119 MB -> 71.299 MB. [2026-02-26T23:09:35.774Z] ====== als (apache-spark) [default], iteration 29 completed (12003.617 ms) ====== [2026-02-26T23:09:36.415Z] ----------------------------------- [2026-02-26T23:09:36.415Z] renaissance-als_0_PASSED [2026-02-26T23:09:36.415Z] ----------------------------------- [2026-02-26T23:09:36.415Z] [2026-02-26T23:09:36.415Z] TEST TEARDOWN: [2026-02-26T23:09:36.415Z] Nothing to be done for teardown. [2026-02-26T23:09:36.415Z] renaissance-als_0 Finish Time: Thu Feb 26 23:09:35 2026 Epoch Time (ms): 1772147375952