[2026-02-20T00:24:36.566Z] Running test renaissance-als_0 ... [2026-02-20T00:24:36.566Z] =============================================== [2026-02-20T00:24:36.566Z] renaissance-als_0 Start Time: Fri Feb 20 00:24:35 2026 Epoch Time (ms): 1771547075799 [2026-02-20T00:24:36.566Z] variation: NoOptions [2026-02-20T00:24:36.566Z] JVM_OPTIONS: [2026-02-20T00:24:36.566Z] { \ [2026-02-20T00:24:36.566Z] echo ""; echo "TEST SETUP:"; \ [2026-02-20T00:24:36.566Z] echo "Nothing to be done for setup."; \ [2026-02-20T00:24:36.566Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17715470757808/renaissance-als_0"; \ [2026-02-20T00:24:36.566Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17715470757808/renaissance-als_0"; \ [2026-02-20T00:24:36.566Z] echo ""; echo "TESTING:"; \ [2026-02-20T00:24:36.566Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_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_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17715470757808/renaissance-als_0"/als.json" als; \ [2026-02-20T00:24:36.566Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17715470757808/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-20T00:24:36.566Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-20T00:24:36.566Z] echo "Nothing to be done for teardown."; \ [2026-02-20T00:24:36.567Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17715470757808/TestTargetResult"; [2026-02-20T00:24:36.567Z] [2026-02-20T00:24:36.567Z] TEST SETUP: [2026-02-20T00:24:36.567Z] Nothing to be done for setup. [2026-02-20T00:24:36.567Z] [2026-02-20T00:24:36.567Z] TESTING: [2026-02-20T00:24:38.539Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-20T00:24:38.539Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_linux/aqa-tests/TKG/output_17715470757808/renaissance-als_0/launcher-002436-7519320658297259185/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-20T00:24:38.539Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-20T00:24:38.539Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-20T00:24:54.411Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-20T00:25:01.558Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-20T00:25:02.893Z] GC before operation: completed in 87.611 ms, heap usage 161.000 MB -> 35.317 MB. [2026-02-20T00:25:31.682Z] ====== als (apache-spark) [default], iteration 0 completed (28708.965 ms) ====== [2026-02-20T00:25:31.682Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-20T00:25:31.682Z] GC before operation: completed in 158.971 ms, heap usage 261.714 MB -> 62.015 MB. [2026-02-20T00:25:41.540Z] ====== als (apache-spark) [default], iteration 1 completed (8775.842 ms) ====== [2026-02-20T00:25:41.540Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-20T00:25:41.540Z] GC before operation: completed in 151.733 ms, heap usage 219.127 MB -> 62.870 MB. [2026-02-20T00:25:49.820Z] ====== als (apache-spark) [default], iteration 2 completed (8419.332 ms) ====== [2026-02-20T00:25:49.820Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-20T00:25:49.820Z] GC before operation: completed in 154.086 ms, heap usage 468.402 MB -> 63.774 MB. [2026-02-20T00:25:59.685Z] ====== als (apache-spark) [default], iteration 3 completed (8072.753 ms) ====== [2026-02-20T00:25:59.685Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-20T00:25:59.685Z] GC before operation: completed in 157.665 ms, heap usage 271.253 MB -> 63.965 MB. [2026-02-20T00:26:07.962Z] ====== als (apache-spark) [default], iteration 4 completed (7972.229 ms) ====== [2026-02-20T00:26:07.962Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-20T00:26:07.962Z] GC before operation: completed in 165.278 ms, heap usage 212.482 MB -> 64.676 MB. [2026-02-20T00:26:16.288Z] ====== als (apache-spark) [default], iteration 5 completed (7657.852 ms) ====== [2026-02-20T00:26:16.288Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-20T00:26:16.288Z] GC before operation: completed in 168.034 ms, heap usage 285.982 MB -> 65.155 MB. [2026-02-20T00:26:24.556Z] ====== als (apache-spark) [default], iteration 6 completed (7688.134 ms) ====== [2026-02-20T00:26:24.556Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-20T00:26:24.556Z] GC before operation: completed in 167.726 ms, heap usage 286.938 MB -> 65.642 MB. [2026-02-20T00:26:31.328Z] ====== als (apache-spark) [default], iteration 7 completed (7461.200 ms) ====== [2026-02-20T00:26:31.328Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-20T00:26:31.328Z] GC before operation: completed in 152.558 ms, heap usage 489.561 MB -> 66.606 MB. [2026-02-20T00:26:39.582Z] ====== als (apache-spark) [default], iteration 8 completed (7251.654 ms) ====== [2026-02-20T00:26:39.582Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-20T00:26:39.582Z] GC before operation: completed in 180.061 ms, heap usage 190.172 MB -> 66.630 MB. [2026-02-20T00:26:47.827Z] ====== als (apache-spark) [default], iteration 9 completed (7270.274 ms) ====== [2026-02-20T00:26:47.827Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-20T00:26:47.827Z] GC before operation: completed in 172.769 ms, heap usage 458.591 MB -> 67.376 MB. [2026-02-20T00:26:55.387Z] ====== als (apache-spark) [default], iteration 10 completed (7202.194 ms) ====== [2026-02-20T00:26:55.387Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-20T00:26:55.387Z] GC before operation: completed in 156.314 ms, heap usage 299.444 MB -> 67.496 MB. [2026-02-20T00:27:02.154Z] ====== als (apache-spark) [default], iteration 11 completed (7109.899 ms) ====== [2026-02-20T00:27:02.154Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-20T00:27:02.154Z] GC before operation: completed in 165.119 ms, heap usage 373.242 MB -> 67.744 MB. [2026-02-20T00:27:10.402Z] ====== als (apache-spark) [default], iteration 12 completed (7158.556 ms) ====== [2026-02-20T00:27:10.402Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-20T00:27:10.402Z] GC before operation: completed in 164.293 ms, heap usage 551.118 MB -> 68.320 MB. [2026-02-20T00:27:17.187Z] ====== als (apache-spark) [default], iteration 13 completed (7094.578 ms) ====== [2026-02-20T00:27:17.187Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-20T00:27:17.187Z] GC before operation: completed in 169.931 ms, heap usage 324.820 MB -> 68.176 MB. [2026-02-20T00:27:25.491Z] ====== als (apache-spark) [default], iteration 14 completed (7030.887 ms) ====== [2026-02-20T00:27:25.491Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-20T00:27:25.491Z] GC before operation: completed in 178.125 ms, heap usage 322.789 MB -> 68.517 MB. [2026-02-20T00:27:32.272Z] ====== als (apache-spark) [default], iteration 15 completed (6967.122 ms) ====== [2026-02-20T00:27:32.272Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-20T00:27:32.272Z] GC before operation: completed in 205.943 ms, heap usage 350.927 MB -> 68.634 MB. [2026-02-20T00:27:40.558Z] ====== als (apache-spark) [default], iteration 16 completed (7131.219 ms) ====== [2026-02-20T00:27:40.558Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-20T00:27:40.558Z] GC before operation: completed in 193.784 ms, heap usage 350.898 MB -> 68.939 MB. [2026-02-20T00:27:47.359Z] ====== als (apache-spark) [default], iteration 17 completed (7097.741 ms) ====== [2026-02-20T00:27:47.359Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-20T00:27:47.359Z] GC before operation: completed in 174.766 ms, heap usage 384.375 MB -> 69.170 MB. [2026-02-20T00:27:55.603Z] ====== als (apache-spark) [default], iteration 18 completed (6790.086 ms) ====== [2026-02-20T00:27:55.603Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-20T00:27:55.603Z] GC before operation: completed in 198.361 ms, heap usage 594.221 MB -> 69.794 MB. [2026-02-20T00:28:02.397Z] ====== als (apache-spark) [default], iteration 19 completed (7004.985 ms) ====== [2026-02-20T00:28:02.397Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-20T00:28:02.397Z] GC before operation: completed in 173.087 ms, heap usage 553.942 MB -> 70.110 MB. [2026-02-20T00:28:09.189Z] ====== als (apache-spark) [default], iteration 20 completed (7068.152 ms) ====== [2026-02-20T00:28:09.189Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-20T00:28:10.154Z] GC before operation: completed in 206.060 ms, heap usage 449.650 MB -> 70.192 MB. [2026-02-20T00:28:16.991Z] ====== als (apache-spark) [default], iteration 21 completed (7038.593 ms) ====== [2026-02-20T00:28:16.991Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-20T00:28:16.991Z] GC before operation: completed in 194.148 ms, heap usage 539.830 MB -> 70.537 MB. [2026-02-20T00:28:24.391Z] ====== als (apache-spark) [default], iteration 22 completed (6850.696 ms) ====== [2026-02-20T00:28:24.391Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-20T00:28:24.391Z] GC before operation: completed in 190.227 ms, heap usage 257.070 MB -> 70.404 MB. [2026-02-20T00:28:32.652Z] ====== als (apache-spark) [default], iteration 23 completed (6749.205 ms) ====== [2026-02-20T00:28:32.652Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-20T00:28:32.652Z] GC before operation: completed in 206.285 ms, heap usage 218.898 MB -> 70.680 MB. [2026-02-20T00:28:39.435Z] ====== als (apache-spark) [default], iteration 24 completed (7335.933 ms) ====== [2026-02-20T00:28:39.435Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-20T00:28:39.435Z] GC before operation: completed in 175.368 ms, heap usage 312.601 MB -> 71.114 MB. [2026-02-20T00:28:47.702Z] ====== als (apache-spark) [default], iteration 25 completed (6802.761 ms) ====== [2026-02-20T00:28:47.702Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-20T00:28:47.702Z] GC before operation: completed in 197.517 ms, heap usage 114.082 MB -> 71.088 MB. [2026-02-20T00:28:54.582Z] ====== als (apache-spark) [default], iteration 26 completed (6863.719 ms) ====== [2026-02-20T00:28:54.583Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-20T00:28:54.583Z] GC before operation: completed in 203.258 ms, heap usage 223.750 MB -> 71.430 MB. [2026-02-20T00:29:01.370Z] ====== als (apache-spark) [default], iteration 27 completed (6719.245 ms) ====== [2026-02-20T00:29:01.370Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-20T00:29:01.370Z] GC before operation: completed in 228.562 ms, heap usage 234.245 MB -> 71.699 MB. [2026-02-20T00:29:08.214Z] ====== als (apache-spark) [default], iteration 28 completed (6701.228 ms) ====== [2026-02-20T00:29:08.214Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-20T00:29:08.214Z] GC before operation: completed in 204.438 ms, heap usage 446.975 MB -> 71.873 MB. [2026-02-20T00:29:14.996Z] ====== als (apache-spark) [default], iteration 29 completed (6458.034 ms) ====== [2026-02-20T00:29:16.969Z] ----------------------------------- [2026-02-20T00:29:16.969Z] renaissance-als_0_PASSED [2026-02-20T00:29:16.969Z] ----------------------------------- [2026-02-20T00:29:16.969Z] [2026-02-20T00:29:16.969Z] TEST TEARDOWN: [2026-02-20T00:29:16.969Z] Nothing to be done for teardown. [2026-02-20T00:29:16.969Z] renaissance-als_0 Finish Time: Fri Feb 20 00:29:15 2026 Epoch Time (ms): 1771547355881