[2026-02-14T18:57:20.747Z] Running test renaissance-als_0 ... [2026-02-14T18:57:20.747Z] =============================================== [2026-02-14T18:57:20.747Z] renaissance-als_0 Start Time: Sat Feb 14 18:57:20 2026 Epoch Time (ms): 1771095440379 [2026-02-14T18:57:20.747Z] variation: NoOptions [2026-02-14T18:57:20.747Z] JVM_OPTIONS: [2026-02-14T18:57:20.747Z] { \ [2026-02-14T18:57:20.747Z] echo ""; echo "TEST SETUP:"; \ [2026-02-14T18:57:20.747Z] echo "Nothing to be done for setup."; \ [2026-02-14T18:57:20.747Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17710953335118/renaissance-als_0"; \ [2026-02-14T18:57:20.747Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17710953335118/renaissance-als_0"; \ [2026-02-14T18:57:20.747Z] echo ""; echo "TESTING:"; \ [2026-02-14T18:57:20.747Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/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_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17710953335118/renaissance-als_0"/als.json" als; \ [2026-02-14T18:57:20.747Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17710953335118/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-14T18:57:20.747Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-14T18:57:20.747Z] echo "Nothing to be done for teardown."; \ [2026-02-14T18:57:20.747Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17710953335118/TestTargetResult"; [2026-02-14T18:57:20.747Z] [2026-02-14T18:57:20.747Z] TEST SETUP: [2026-02-14T18:57:20.747Z] Nothing to be done for setup. [2026-02-14T18:57:20.747Z] [2026-02-14T18:57:20.747Z] TESTING: [2026-02-14T18:57:22.385Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2026-02-14T18:57:22.385Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_ppc64_aix/aqa-tests/TKG/output_17710953335118/renaissance-als_0/launcher-185720-16756079485498159462/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2026-02-14T18:57:22.385Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2026-02-14T18:57:22.385Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2026-02-14T18:57:48.441Z] NOTE: 'als' benchmark uses Spark local executor with 12 (out of 16) threads. [2026-02-14T18:57:53.028Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-14T18:57:53.029Z] GC before operation: completed in 136.812 ms, heap usage 297.103 MB -> 34.677 MB. [2026-02-14T18:58:17.113Z] ====== als (apache-spark) [default], iteration 0 completed (20662.260 ms) ====== [2026-02-14T18:58:17.113Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-14T18:58:17.113Z] GC before operation: completed in 125.711 ms, heap usage 653.863 MB -> 61.705 MB. [2026-02-14T18:58:29.028Z] ====== als (apache-spark) [default], iteration 1 completed (12780.798 ms) ====== [2026-02-14T18:58:29.028Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-14T18:58:29.028Z] GC before operation: completed in 121.171 ms, heap usage 187.731 MB -> 62.430 MB. [2026-02-14T18:58:40.997Z] ====== als (apache-spark) [default], iteration 2 completed (12748.726 ms) ====== [2026-02-14T18:58:40.997Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-14T18:58:40.997Z] GC before operation: completed in 121.721 ms, heap usage 377.758 MB -> 62.996 MB. [2026-02-14T18:58:55.104Z] ====== als (apache-spark) [default], iteration 3 completed (13835.068 ms) ====== [2026-02-14T18:58:55.104Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-14T18:58:55.104Z] GC before operation: completed in 116.372 ms, heap usage 910.603 MB -> 64.377 MB. [2026-02-14T18:59:11.541Z] ====== als (apache-spark) [default], iteration 4 completed (14606.705 ms) ====== [2026-02-14T18:59:11.541Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-14T18:59:11.541Z] GC before operation: completed in 113.188 ms, heap usage 312.949 MB -> 63.989 MB. [2026-02-14T18:59:25.628Z] ====== als (apache-spark) [default], iteration 5 completed (13816.104 ms) ====== [2026-02-14T18:59:25.628Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-14T18:59:25.628Z] GC before operation: completed in 108.242 ms, heap usage 395.619 MB -> 65.025 MB. [2026-02-14T18:59:37.566Z] ====== als (apache-spark) [default], iteration 6 completed (13166.684 ms) ====== [2026-02-14T18:59:37.566Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-14T18:59:37.566Z] GC before operation: completed in 124.308 ms, heap usage 396.665 MB -> 65.370 MB. [2026-02-14T18:59:51.588Z] ====== als (apache-spark) [default], iteration 7 completed (13733.493 ms) ====== [2026-02-14T18:59:51.588Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-14T18:59:51.588Z] GC before operation: completed in 111.714 ms, heap usage 853.507 MB -> 66.535 MB. [2026-02-14T19:00:05.695Z] ====== als (apache-spark) [default], iteration 8 completed (13996.778 ms) ====== [2026-02-14T19:00:05.695Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-14T19:00:06.490Z] GC before operation: completed in 132.442 ms, heap usage 612.185 MB -> 66.800 MB. [2026-02-14T19:00:20.508Z] ====== als (apache-spark) [default], iteration 9 completed (13584.322 ms) ====== [2026-02-14T19:00:20.508Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-14T19:00:20.508Z] GC before operation: completed in 137.715 ms, heap usage 136.506 MB -> 66.291 MB. [2026-02-14T19:00:34.706Z] ====== als (apache-spark) [default], iteration 10 completed (13438.974 ms) ====== [2026-02-14T19:00:34.706Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-14T19:00:34.706Z] GC before operation: completed in 131.778 ms, heap usage 868.206 MB -> 67.499 MB. [2026-02-14T19:00:48.901Z] ====== als (apache-spark) [default], iteration 11 completed (13615.615 ms) ====== [2026-02-14T19:00:48.902Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-14T19:00:48.902Z] GC before operation: completed in 125.969 ms, heap usage 708.762 MB -> 67.584 MB. [2026-02-14T19:01:02.944Z] ====== als (apache-spark) [default], iteration 12 completed (13652.063 ms) ====== [2026-02-14T19:01:02.944Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-14T19:01:02.944Z] GC before operation: completed in 123.403 ms, heap usage 1.637 GB -> 69.099 MB. [2026-02-14T19:01:19.329Z] ====== als (apache-spark) [default], iteration 13 completed (15645.859 ms) ====== [2026-02-14T19:01:19.329Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-14T19:01:19.329Z] GC before operation: completed in 109.733 ms, heap usage 452.641 MB -> 67.997 MB. [2026-02-14T19:01:33.311Z] ====== als (apache-spark) [default], iteration 14 completed (14716.263 ms) ====== [2026-02-14T19:01:33.311Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-14T19:01:33.311Z] GC before operation: completed in 95.817 ms, heap usage 397.447 MB -> 68.125 MB. [2026-02-14T19:01:47.435Z] ====== als (apache-spark) [default], iteration 15 completed (13628.548 ms) ====== [2026-02-14T19:01:47.435Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-14T19:01:47.435Z] GC before operation: completed in 101.924 ms, heap usage 840.036 MB -> 69.007 MB. [2026-02-14T19:01:59.356Z] ====== als (apache-spark) [default], iteration 16 completed (12882.746 ms) ====== [2026-02-14T19:01:59.356Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-14T19:02:00.169Z] GC before operation: completed in 104.361 ms, heap usage 507.943 MB -> 68.540 MB. [2026-02-14T19:02:14.224Z] ====== als (apache-spark) [default], iteration 17 completed (13544.286 ms) ====== [2026-02-14T19:02:14.224Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-14T19:02:14.224Z] GC before operation: completed in 98.416 ms, heap usage 211.504 MB -> 68.370 MB. [2026-02-14T19:02:28.219Z] ====== als (apache-spark) [default], iteration 18 completed (13965.647 ms) ====== [2026-02-14T19:02:28.219Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-14T19:02:28.219Z] GC before operation: completed in 106.765 ms, heap usage 556.213 MB -> 69.110 MB. [2026-02-14T19:02:42.203Z] ====== als (apache-spark) [default], iteration 19 completed (13573.503 ms) ====== [2026-02-14T19:02:42.203Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-14T19:02:42.203Z] GC before operation: completed in 104.482 ms, heap usage 170.270 MB -> 69.038 MB. [2026-02-14T19:02:56.237Z] ====== als (apache-spark) [default], iteration 20 completed (12603.611 ms) ====== [2026-02-14T19:02:56.237Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-14T19:02:56.238Z] GC before operation: completed in 131.154 ms, heap usage 526.356 MB -> 69.536 MB. [2026-02-14T19:03:09.238Z] ====== als (apache-spark) [default], iteration 21 completed (13192.801 ms) ====== [2026-02-14T19:03:09.238Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-14T19:03:09.238Z] GC before operation: completed in 106.291 ms, heap usage 218.991 MB -> 69.507 MB. [2026-02-14T19:03:23.380Z] ====== als (apache-spark) [default], iteration 22 completed (13452.877 ms) ====== [2026-02-14T19:03:23.380Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-14T19:03:23.381Z] GC before operation: completed in 101.683 ms, heap usage 828.544 MB -> 70.619 MB. [2026-02-14T19:03:37.396Z] ====== als (apache-spark) [default], iteration 23 completed (13900.073 ms) ====== [2026-02-14T19:03:37.396Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-14T19:03:37.396Z] GC before operation: completed in 104.446 ms, heap usage 269.135 MB -> 70.131 MB. [2026-02-14T19:03:51.445Z] ====== als (apache-spark) [default], iteration 24 completed (14354.230 ms) ====== [2026-02-14T19:03:51.445Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-14T19:03:51.445Z] GC before operation: completed in 115.739 ms, heap usage 213.330 MB -> 70.299 MB. [2026-02-14T19:04:05.506Z] ====== als (apache-spark) [default], iteration 25 completed (13420.899 ms) ====== [2026-02-14T19:04:05.506Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-14T19:04:05.506Z] GC before operation: completed in 133.270 ms, heap usage 1.144 GB -> 71.861 MB. [2026-02-14T19:04:19.524Z] ====== als (apache-spark) [default], iteration 26 completed (13934.656 ms) ====== [2026-02-14T19:04:19.524Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-14T19:04:19.524Z] GC before operation: completed in 125.601 ms, heap usage 157.420 MB -> 70.363 MB. [2026-02-14T19:04:33.536Z] ====== als (apache-spark) [default], iteration 27 completed (13343.483 ms) ====== [2026-02-14T19:04:33.536Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-14T19:04:33.536Z] GC before operation: completed in 137.091 ms, heap usage 919.880 MB -> 71.436 MB. [2026-02-14T19:04:47.597Z] ====== als (apache-spark) [default], iteration 28 completed (13845.343 ms) ====== [2026-02-14T19:04:47.597Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-14T19:04:47.597Z] GC before operation: completed in 128.051 ms, heap usage 625.938 MB -> 71.612 MB. [2026-02-14T19:05:01.595Z] ====== als (apache-spark) [default], iteration 29 completed (13440.111 ms) ====== [2026-02-14T19:05:01.595Z] ----------------------------------- [2026-02-14T19:05:01.595Z] renaissance-als_0_PASSED [2026-02-14T19:05:01.595Z] ----------------------------------- [2026-02-14T19:05:01.595Z] [2026-02-14T19:05:01.595Z] TEST TEARDOWN: [2026-02-14T19:05:01.595Z] Nothing to be done for teardown. [2026-02-14T19:05:01.595Z] renaissance-als_0 Finish Time: Sat Feb 14 19:05:00 2026 Epoch Time (ms): 1771095900150