renaissance-als_0
[2026-02-14T00:00:50.311Z] Running test renaissance-als_0 ...
[2026-02-14T00:00:50.311Z] ===============================================
[2026-02-14T00:00:50.311Z] renaissance-als_0 Start Time: Sat Feb 14 00:00:50 2026 Epoch Time (ms): 1771027250028
[2026-02-14T00:00:50.311Z] variation: NoOptions
[2026-02-14T00:00:50.311Z] JVM_OPTIONS:
[2026-02-14T00:00:50.311Z] { \
[2026-02-14T00:00:50.311Z] echo ""; echo "TEST SETUP:"; \
[2026-02-14T00:00:50.311Z] echo "Nothing to be done for setup."; \
[2026-02-14T00:00:50.311Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17710271102396/renaissance-als_0"; \
[2026-02-14T00:00:50.311Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17710271102396/renaissance-als_0"; \
[2026-02-14T00:00:50.311Z] echo ""; echo "TESTING:"; \
[2026-02-14T00:00:50.311Z] "/home/jenkins/workspace/Test_openjdk17_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_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17710271102396/renaissance-als_0"/als.json" als; \
[2026-02-14T00:00:50.311Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17710271102396/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \
[2026-02-14T00:00:50.311Z] echo ""; echo "TEST TEARDOWN:"; \
[2026-02-14T00:00:50.311Z] echo "Nothing to be done for teardown."; \
[2026-02-14T00:00:50.311Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17710271102396/TestTargetResult";
[2026-02-14T00:00:50.311Z]
[2026-02-14T00:00:50.311Z] TEST SETUP:
[2026-02-14T00:00:50.311Z] Nothing to be done for setup.
[2026-02-14T00:00:50.311Z]
[2026-02-14T00:00:50.311Z] TESTING:
[2026-02-14T00:00:55.106Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads.
[2026-02-14T00:00:58.080Z] ====== als (apache-spark) [default], iteration 0 started ======
[2026-02-14T00:00:58.080Z] GC before operation: completed in 40.021 ms, heap usage 75.690 MB -> 36.046 MB.
[2026-02-14T00:01:17.286Z] ====== als (apache-spark) [default], iteration 0 completed (16425.681 ms) ======
[2026-02-14T00:01:17.286Z] ====== als (apache-spark) [default], iteration 1 started ======
[2026-02-14T00:01:17.286Z] GC before operation: completed in 106.215 ms, heap usage 731.389 MB -> 63.608 MB.
[2026-02-14T00:01:22.119Z] ====== als (apache-spark) [default], iteration 1 completed (6948.913 ms) ======
[2026-02-14T00:01:22.119Z] ====== als (apache-spark) [default], iteration 2 started ======
[2026-02-14T00:01:22.119Z] GC before operation: completed in 89.121 ms, heap usage 225.993 MB -> 63.713 MB.
[2026-02-14T00:01:29.585Z] ====== als (apache-spark) [default], iteration 2 completed (6122.629 ms) ======
[2026-02-14T00:01:29.585Z] ====== als (apache-spark) [default], iteration 3 started ======
[2026-02-14T00:01:29.585Z] GC before operation: completed in 95.555 ms, heap usage 409.790 MB -> 64.537 MB.
[2026-02-14T00:01:35.498Z] ====== als (apache-spark) [default], iteration 3 completed (6374.487 ms) ======
[2026-02-14T00:01:35.498Z] ====== als (apache-spark) [default], iteration 4 started ======
[2026-02-14T00:01:35.499Z] GC before operation: completed in 104.022 ms, heap usage 416.265 MB -> 65.153 MB.
[2026-02-14T00:01:41.405Z] ====== als (apache-spark) [default], iteration 4 completed (5894.724 ms) ======
[2026-02-14T00:01:41.405Z] ====== als (apache-spark) [default], iteration 5 started ======
[2026-02-14T00:01:41.405Z] GC before operation: completed in 119.804 ms, heap usage 832.380 MB -> 66.336 MB.
[2026-02-14T00:01:47.403Z] ====== als (apache-spark) [default], iteration 5 completed (5827.568 ms) ======
[2026-02-14T00:01:47.403Z] ====== als (apache-spark) [default], iteration 6 started ======
[2026-02-14T00:01:47.403Z] GC before operation: completed in 99.797 ms, heap usage 842.847 MB -> 66.918 MB.
[2026-02-14T00:01:53.318Z] ====== als (apache-spark) [default], iteration 6 completed (5781.769 ms) ======
[2026-02-14T00:01:53.318Z] ====== als (apache-spark) [default], iteration 7 started ======
[2026-02-14T00:01:53.649Z] GC before operation: completed in 113.124 ms, heap usage 359.384 MB -> 66.898 MB.
[2026-02-14T00:01:59.556Z] ====== als (apache-spark) [default], iteration 7 completed (5714.328 ms) ======
[2026-02-14T00:01:59.556Z] ====== als (apache-spark) [default], iteration 8 started ======
[2026-02-14T00:01:59.556Z] GC before operation: completed in 118.063 ms, heap usage 953.347 MB -> 67.957 MB.
[2026-02-14T00:02:05.472Z] ====== als (apache-spark) [default], iteration 8 completed (5849.301 ms) ======
[2026-02-14T00:02:05.472Z] ====== als (apache-spark) [default], iteration 9 started ======
[2026-02-14T00:02:05.800Z] GC before operation: completed in 112.162 ms, heap usage 755.022 MB -> 68.399 MB.
[2026-02-14T00:02:11.713Z] ====== als (apache-spark) [default], iteration 9 completed (5798.942 ms) ======
[2026-02-14T00:02:11.713Z] ====== als (apache-spark) [default], iteration 10 started ======
[2026-02-14T00:02:11.713Z] GC before operation: completed in 102.295 ms, heap usage 720.043 MB -> 68.860 MB.
[2026-02-14T00:02:17.710Z] ====== als (apache-spark) [default], iteration 10 completed (5631.782 ms) ======
[2026-02-14T00:02:17.710Z] ====== als (apache-spark) [default], iteration 11 started ======
[2026-02-14T00:02:17.710Z] GC before operation: completed in 101.927 ms, heap usage 655.036 MB -> 68.855 MB.
[2026-02-14T00:02:23.616Z] ====== als (apache-spark) [default], iteration 11 completed (5742.075 ms) ======
[2026-02-14T00:02:23.616Z] ====== als (apache-spark) [default], iteration 12 started ======
[2026-02-14T00:02:23.616Z] GC before operation: completed in 100.601 ms, heap usage 825.201 MB -> 69.404 MB.
[2026-02-14T00:02:29.549Z] ====== als (apache-spark) [default], iteration 12 completed (5536.284 ms) ======
[2026-02-14T00:02:29.549Z] ====== als (apache-spark) [default], iteration 13 started ======
[2026-02-14T00:02:29.549Z] GC before operation: completed in 102.628 ms, heap usage 687.735 MB -> 69.381 MB.
[2026-02-14T00:02:35.529Z] ====== als (apache-spark) [default], iteration 13 completed (5748.287 ms) ======
[2026-02-14T00:02:35.529Z] ====== als (apache-spark) [default], iteration 14 started ======
[2026-02-14T00:02:35.529Z] GC before operation: completed in 100.956 ms, heap usage 698.270 MB -> 69.669 MB.
[2026-02-14T00:02:41.423Z] ====== als (apache-spark) [default], iteration 14 completed (5552.628 ms) ======
[2026-02-14T00:02:41.423Z] ====== als (apache-spark) [default], iteration 15 started ======
[2026-02-14T00:02:41.423Z] GC before operation: completed in 100.657 ms, heap usage 577.073 MB -> 69.743 MB.
[2026-02-14T00:02:47.331Z] ====== als (apache-spark) [default], iteration 15 completed (5573.976 ms) ======
[2026-02-14T00:02:47.331Z] ====== als (apache-spark) [default], iteration 16 started ======
[2026-02-14T00:02:47.331Z] GC before operation: completed in 104.242 ms, heap usage 675.803 MB -> 70.078 MB.
[2026-02-14T00:02:53.235Z] ====== als (apache-spark) [default], iteration 16 completed (5487.219 ms) ======
[2026-02-14T00:02:53.235Z] ====== als (apache-spark) [default], iteration 17 started ======
[2026-02-14T00:02:53.235Z] GC before operation: completed in 97.685 ms, heap usage 586.715 MB -> 70.308 MB.
[2026-02-14T00:02:59.132Z] ====== als (apache-spark) [default], iteration 17 completed (5546.038 ms) ======
[2026-02-14T00:02:59.132Z] ====== als (apache-spark) [default], iteration 18 started ======
[2026-02-14T00:02:59.132Z] GC before operation: completed in 97.013 ms, heap usage 682.592 MB -> 70.665 MB.
[2026-02-14T00:03:05.038Z] ====== als (apache-spark) [default], iteration 18 completed (5542.361 ms) ======
[2026-02-14T00:03:05.038Z] ====== als (apache-spark) [default], iteration 19 started ======
[2026-02-14T00:03:05.038Z] GC before operation: completed in 111.624 ms, heap usage 532.826 MB -> 70.765 MB.
[2026-02-14T00:03:09.806Z] ====== als (apache-spark) [default], iteration 19 completed (5470.747 ms) ======
[2026-02-14T00:03:09.806Z] ====== als (apache-spark) [default], iteration 20 started ======
[2026-02-14T00:03:09.806Z] GC before operation: completed in 102.868 ms, heap usage 505.286 MB -> 71.100 MB.
[2026-02-14T00:03:15.706Z] ====== als (apache-spark) [default], iteration 20 completed (5711.283 ms) ======
[2026-02-14T00:03:15.706Z] ====== als (apache-spark) [default], iteration 21 started ======
[2026-02-14T00:03:16.035Z] GC before operation: completed in 126.264 ms, heap usage 417.184 MB -> 71.041 MB.
[2026-02-14T00:03:21.942Z] ====== als (apache-spark) [default], iteration 21 completed (5662.822 ms) ======
[2026-02-14T00:03:21.942Z] ====== als (apache-spark) [default], iteration 22 started ======
[2026-02-14T00:03:21.942Z] GC before operation: completed in 107.767 ms, heap usage 645.248 MB -> 71.835 MB.
[2026-02-14T00:03:27.894Z] ====== als (apache-spark) [default], iteration 22 completed (5423.295 ms) ======
[2026-02-14T00:03:27.894Z] ====== als (apache-spark) [default], iteration 23 started ======
[2026-02-14T00:03:27.894Z] GC before operation: completed in 117.518 ms, heap usage 546.119 MB -> 72.001 MB.
[2026-02-14T00:03:33.821Z] ====== als (apache-spark) [default], iteration 23 completed (5673.964 ms) ======
[2026-02-14T00:03:33.821Z] ====== als (apache-spark) [default], iteration 24 started ======
[2026-02-14T00:03:33.821Z] GC before operation: completed in 108.912 ms, heap usage 730.914 MB -> 72.571 MB.
[2026-02-14T00:03:39.734Z] ====== als (apache-spark) [default], iteration 24 completed (5560.954 ms) ======
[2026-02-14T00:03:39.734Z] ====== als (apache-spark) [default], iteration 25 started ======
[2026-02-14T00:03:39.734Z] GC before operation: completed in 118.105 ms, heap usage 763.192 MB -> 72.801 MB.
[2026-02-14T00:03:45.648Z] ====== als (apache-spark) [default], iteration 25 completed (5455.895 ms) ======
[2026-02-14T00:03:45.648Z] ====== als (apache-spark) [default], iteration 26 started ======
[2026-02-14T00:03:45.648Z] GC before operation: completed in 112.075 ms, heap usage 373.207 MB -> 72.303 MB.
[2026-02-14T00:03:50.414Z] ====== als (apache-spark) [default], iteration 26 completed (5493.837 ms) ======
[2026-02-14T00:03:50.414Z] ====== als (apache-spark) [default], iteration 27 started ======
[2026-02-14T00:03:50.746Z] GC before operation: completed in 103.704 ms, heap usage 352.304 MB -> 72.589 MB.
[2026-02-14T00:03:56.660Z] ====== als (apache-spark) [default], iteration 27 completed (5645.016 ms) ======
[2026-02-14T00:03:56.660Z] ====== als (apache-spark) [default], iteration 28 started ======
[2026-02-14T00:03:56.660Z] GC before operation: completed in 112.767 ms, heap usage 1.058 GB -> 73.854 MB.
[2026-02-14T00:04:02.576Z] ====== als (apache-spark) [default], iteration 28 completed (5551.095 ms) ======
[2026-02-14T00:04:02.576Z] ====== als (apache-spark) [default], iteration 29 started ======
[2026-02-14T00:04:02.576Z] GC before operation: completed in 103.247 ms, heap usage 164.921 MB -> 73.082 MB.
[2026-02-14T00:04:08.488Z] ====== als (apache-spark) [default], iteration 29 completed (5523.992 ms) ======
[2026-02-14T00:04:08.488Z] -----------------------------------
[2026-02-14T00:04:08.488Z] renaissance-als_0_PASSED
[2026-02-14T00:04:08.488Z] -----------------------------------
[2026-02-14T00:04:08.488Z]
[2026-02-14T00:04:08.488Z] TEST TEARDOWN:
[2026-02-14T00:04:08.488Z] Nothing to be done for teardown.
[2026-02-14T00:04:08.488Z] renaissance-als_0 Finish Time: Sat Feb 14 00:04:08 2026 Epoch Time (ms): 1771027448334