[2026-02-14T23:10:40.381Z] Running test renaissance-als_0 ... [2026-02-14T23:10:40.381Z] =============================================== [2026-02-14T23:10:40.381Z] renaissance-als_0 Start Time: Sat Feb 14 23:10:40 2026 Epoch Time (ms): 1771110640139 [2026-02-14T23:10:40.381Z] variation: NoOptions [2026-02-14T23:10:40.381Z] JVM_OPTIONS: [2026-02-14T23:10:40.381Z] { \ [2026-02-14T23:10:40.381Z] echo ""; echo "TEST SETUP:"; \ [2026-02-14T23:10:40.381Z] echo "Nothing to be done for setup."; \ [2026-02-14T23:10:40.381Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1771110638985/renaissance-als_0"; \ [2026-02-14T23:10:40.381Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1771110638985/renaissance-als_0"; \ [2026-02-14T23:10:40.381Z] echo ""; echo "TESTING:"; \ [2026-02-14T23:10:40.381Z] "/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_1771110638985/renaissance-als_0"/als.json" als; \ [2026-02-14T23:10:40.381Z] 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_1771110638985/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-14T23:10:40.381Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-14T23:10:40.381Z] echo "Nothing to be done for teardown."; \ [2026-02-14T23:10:40.381Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_1771110638985/TestTargetResult"; [2026-02-14T23:10:40.381Z] [2026-02-14T23:10:40.381Z] TEST SETUP: [2026-02-14T23:10:40.381Z] Nothing to be done for setup. [2026-02-14T23:10:40.381Z] [2026-02-14T23:10:40.381Z] TESTING: [2026-02-14T23:10:43.294Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-14T23:10:43.294Z] 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_1771110638985/renaissance-als_0/launcher-231040-10230054961692366514/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-14T23:10:43.294Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-14T23:10:43.294Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-14T23:10:59.239Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-14T23:11:10.950Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-14T23:11:11.708Z] GC before operation: completed in 110.221 ms, heap usage 58.871 MB -> 35.132 MB. [2026-02-14T23:12:19.037Z] ====== als (apache-spark) [default], iteration 0 completed (62424.521 ms) ====== [2026-02-14T23:12:19.037Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-14T23:12:19.037Z] GC before operation: completed in 281.287 ms, heap usage 428.867 MB -> 61.624 MB. [2026-02-14T23:12:37.728Z] ====== als (apache-spark) [default], iteration 1 completed (19782.202 ms) ====== [2026-02-14T23:12:37.728Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-14T23:12:37.728Z] GC before operation: completed in 230.601 ms, heap usage 257.095 MB -> 62.540 MB. [2026-02-14T23:13:10.855Z] ====== als (apache-spark) [default], iteration 2 completed (26877.088 ms) ====== [2026-02-14T23:13:10.855Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-14T23:13:10.855Z] GC before operation: completed in 130.304 ms, heap usage 434.114 MB -> 63.391 MB. [2026-02-14T23:13:24.414Z] ====== als (apache-spark) [default], iteration 3 completed (19037.712 ms) ====== [2026-02-14T23:13:24.414Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-14T23:13:24.414Z] GC before operation: completed in 274.450 ms, heap usage 356.865 MB -> 63.704 MB. [2026-02-14T23:13:40.477Z] ====== als (apache-spark) [default], iteration 4 completed (16676.110 ms) ====== [2026-02-14T23:13:40.477Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-14T23:13:40.477Z] GC before operation: completed in 233.288 ms, heap usage 175.478 MB -> 64.026 MB. [2026-02-14T23:13:59.702Z] ====== als (apache-spark) [default], iteration 5 completed (15310.976 ms) ====== [2026-02-14T23:13:59.702Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-14T23:13:59.702Z] GC before operation: completed in 180.640 ms, heap usage 180.473 MB -> 64.610 MB. [2026-02-14T23:14:15.660Z] ====== als (apache-spark) [default], iteration 6 completed (17726.187 ms) ====== [2026-02-14T23:14:15.660Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-14T23:14:15.660Z] GC before operation: completed in 334.198 ms, heap usage 266.536 MB -> 65.307 MB. [2026-02-14T23:14:38.295Z] ====== als (apache-spark) [default], iteration 7 completed (20862.980 ms) ====== [2026-02-14T23:14:38.295Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-14T23:14:38.296Z] GC before operation: completed in 225.438 ms, heap usage 191.372 MB -> 65.707 MB. [2026-02-14T23:14:59.697Z] ====== als (apache-spark) [default], iteration 8 completed (22246.918 ms) ====== [2026-02-14T23:14:59.697Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-14T23:14:59.697Z] GC before operation: completed in 185.196 ms, heap usage 475.821 MB -> 66.726 MB. [2026-02-14T23:15:25.684Z] ====== als (apache-spark) [default], iteration 9 completed (23627.414 ms) ====== [2026-02-14T23:15:25.684Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-14T23:15:25.684Z] GC before operation: completed in 287.159 ms, heap usage 177.527 MB -> 66.452 MB. [2026-02-14T23:15:44.526Z] ====== als (apache-spark) [default], iteration 10 completed (18274.464 ms) ====== [2026-02-14T23:15:44.526Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-14T23:15:44.526Z] GC before operation: completed in 267.347 ms, heap usage 324.232 MB -> 66.881 MB. [2026-02-14T23:16:03.252Z] ====== als (apache-spark) [default], iteration 11 completed (19349.385 ms) ====== [2026-02-14T23:16:03.252Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-14T23:16:03.252Z] GC before operation: completed in 310.242 ms, heap usage 481.814 MB -> 67.376 MB. [2026-02-14T23:16:25.033Z] ====== als (apache-spark) [default], iteration 12 completed (20041.155 ms) ====== [2026-02-14T23:16:25.033Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-14T23:16:25.033Z] GC before operation: completed in 304.337 ms, heap usage 180.419 MB -> 67.209 MB. [2026-02-14T23:16:47.368Z] ====== als (apache-spark) [default], iteration 13 completed (20080.751 ms) ====== [2026-02-14T23:16:47.368Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-14T23:16:47.368Z] GC before operation: completed in 291.793 ms, heap usage 349.503 MB -> 67.774 MB. [2026-02-14T23:17:17.176Z] ====== als (apache-spark) [default], iteration 14 completed (28141.945 ms) ====== [2026-02-14T23:17:17.176Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-14T23:17:17.176Z] GC before operation: completed in 251.336 ms, heap usage 268.016 MB -> 67.858 MB. [2026-02-14T23:17:33.143Z] ====== als (apache-spark) [default], iteration 15 completed (18567.300 ms) ====== [2026-02-14T23:17:33.143Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-14T23:17:33.143Z] GC before operation: completed in 374.907 ms, heap usage 336.806 MB -> 68.190 MB. [2026-02-14T23:17:52.128Z] ====== als (apache-spark) [default], iteration 16 completed (17408.332 ms) ====== [2026-02-14T23:17:52.128Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-14T23:17:52.128Z] GC before operation: completed in 238.210 ms, heap usage 256.938 MB -> 68.422 MB. [2026-02-14T23:18:14.512Z] ====== als (apache-spark) [default], iteration 17 completed (21044.787 ms) ====== [2026-02-14T23:18:14.512Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-14T23:18:14.512Z] GC before operation: completed in 211.476 ms, heap usage 222.481 MB -> 68.606 MB. [2026-02-14T23:18:30.656Z] ====== als (apache-spark) [default], iteration 18 completed (17182.745 ms) ====== [2026-02-14T23:18:30.656Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-14T23:18:31.414Z] GC before operation: completed in 291.099 ms, heap usage 522.711 MB -> 69.281 MB. [2026-02-14T23:18:53.284Z] ====== als (apache-spark) [default], iteration 19 completed (19538.531 ms) ====== [2026-02-14T23:18:53.284Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-14T23:18:53.284Z] GC before operation: completed in 273.344 ms, heap usage 345.444 MB -> 69.368 MB. [2026-02-14T23:19:15.073Z] ====== als (apache-spark) [default], iteration 20 completed (20774.016 ms) ====== [2026-02-14T23:19:15.073Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-14T23:19:15.073Z] GC before operation: completed in 331.404 ms, heap usage 196.160 MB -> 69.302 MB. [2026-02-14T23:19:33.922Z] ====== als (apache-spark) [default], iteration 21 completed (19993.917 ms) ====== [2026-02-14T23:19:33.922Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-14T23:19:33.922Z] GC before operation: completed in 287.028 ms, heap usage 250.898 MB -> 69.645 MB. [2026-02-14T23:19:59.430Z] ====== als (apache-spark) [default], iteration 22 completed (23609.494 ms) ====== [2026-02-14T23:19:59.430Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-14T23:19:59.430Z] GC before operation: completed in 303.500 ms, heap usage 355.441 MB -> 70.196 MB. [2026-02-14T23:20:18.212Z] ====== als (apache-spark) [default], iteration 23 completed (19331.639 ms) ====== [2026-02-14T23:20:18.212Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-14T23:20:18.212Z] GC before operation: completed in 290.415 ms, heap usage 555.464 MB -> 70.646 MB. [2026-02-14T23:20:40.032Z] ====== als (apache-spark) [default], iteration 24 completed (18960.379 ms) ====== [2026-02-14T23:20:40.032Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-14T23:20:40.032Z] GC before operation: completed in 288.541 ms, heap usage 346.582 MB -> 70.584 MB. [2026-02-14T23:20:56.152Z] ====== als (apache-spark) [default], iteration 25 completed (17764.756 ms) ====== [2026-02-14T23:20:56.152Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-14T23:20:56.152Z] GC before operation: completed in 303.761 ms, heap usage 487.379 MB -> 71.081 MB. [2026-02-14T23:21:15.175Z] ====== als (apache-spark) [default], iteration 26 completed (18665.333 ms) ====== [2026-02-14T23:21:15.175Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-14T23:21:15.175Z] GC before operation: completed in 267.742 ms, heap usage 494.504 MB -> 71.328 MB. [2026-02-14T23:21:37.017Z] ====== als (apache-spark) [default], iteration 27 completed (19415.341 ms) ====== [2026-02-14T23:21:37.017Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-14T23:21:37.017Z] GC before operation: completed in 288.144 ms, heap usage 343.555 MB -> 71.401 MB. [2026-02-14T23:21:55.718Z] ====== als (apache-spark) [default], iteration 28 completed (18789.951 ms) ====== [2026-02-14T23:21:55.718Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-14T23:21:55.718Z] GC before operation: completed in 371.017 ms, heap usage 479.991 MB -> 71.903 MB. [2026-02-14T23:22:14.637Z] ====== als (apache-spark) [default], iteration 29 completed (18403.326 ms) ====== [2026-02-14T23:22:15.383Z] ----------------------------------- [2026-02-14T23:22:15.383Z] renaissance-als_0_PASSED [2026-02-14T23:22:15.383Z] ----------------------------------- [2026-02-14T23:22:15.383Z] [2026-02-14T23:22:15.383Z] TEST TEARDOWN: [2026-02-14T23:22:15.383Z] Nothing to be done for teardown. [2026-02-14T23:22:15.383Z] renaissance-als_0 Finish Time: Sat Feb 14 23:22:14 2026 Epoch Time (ms): 1771111334662