[2025-06-30T17:44:25.399Z] Running test renaissance-log-regression_0 ... [2025-06-30T17:44:25.399Z] =============================================== [2025-06-30T17:44:25.399Z] renaissance-log-regression_0 Start Time: Mon Jun 30 17:44:24 2025 Epoch Time (ms): 1751305464831 [2025-06-30T17:44:25.399Z] variation: NoOptions [2025-06-30T17:44:25.399Z] JVM_OPTIONS: [2025-06-30T17:44:25.399Z] { \ [2025-06-30T17:44:25.399Z] echo ""; echo "TEST SETUP:"; \ [2025-06-30T17:44:25.399Z] echo "Nothing to be done for setup."; \ [2025-06-30T17:44:25.399Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17513047269342/renaissance-log-regression_0"; \ [2025-06-30T17:44:25.399Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17513047269342/renaissance-log-regression_0"; \ [2025-06-30T17:44:25.399Z] echo ""; echo "TESTING:"; \ [2025-06-30T17:44:25.399Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/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_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17513047269342/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-06-30T17:44:25.399Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17513047269342/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-30T17:44:25.399Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-30T17:44:25.399Z] echo "Nothing to be done for teardown."; \ [2025-06-30T17:44:25.399Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_aarch64_linux_testList_1/aqa-tests/TKG/../TKG/output_17513047269342/TestTargetResult"; [2025-06-30T17:44:25.399Z] [2025-06-30T17:44:25.399Z] TEST SETUP: [2025-06-30T17:44:25.399Z] Nothing to be done for setup. [2025-06-30T17:44:25.399Z] [2025-06-30T17:44:25.399Z] TESTING: [2025-06-30T17:44:30.642Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2025-06-30T17:44:34.436Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-06-30T17:44:34.436Z] GC before operation: completed in 49.249 ms, heap usage 65.022 MB -> 35.700 MB. [2025-06-30T17:44:43.978Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10457.645 ms) ====== [2025-06-30T17:44:43.978Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-06-30T17:44:43.978Z] GC before operation: completed in 71.321 ms, heap usage 556.495 MB -> 127.099 MB. [2025-06-30T17:44:45.885Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2253.842 ms) ====== [2025-06-30T17:44:45.885Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-06-30T17:44:45.885Z] GC before operation: completed in 79.607 ms, heap usage 697.194 MB -> 128.348 MB. [2025-06-30T17:44:47.790Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1917.289 ms) ====== [2025-06-30T17:44:47.790Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-06-30T17:44:48.720Z] GC before operation: completed in 84.471 ms, heap usage 723.318 MB -> 128.818 MB. [2025-06-30T17:44:50.622Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1880.277 ms) ====== [2025-06-30T17:44:50.622Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-06-30T17:44:50.622Z] GC before operation: completed in 84.522 ms, heap usage 349.464 MB -> 128.101 MB. [2025-06-30T17:44:51.549Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1693.981 ms) ====== [2025-06-30T17:44:51.549Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-06-30T17:44:52.475Z] GC before operation: completed in 89.964 ms, heap usage 395.759 MB -> 128.651 MB. [2025-06-30T17:44:53.401Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1766.304 ms) ====== [2025-06-30T17:44:53.401Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-06-30T17:44:54.327Z] GC before operation: completed in 92.392 ms, heap usage 513.531 MB -> 129.379 MB. [2025-06-30T17:44:55.254Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1607.086 ms) ====== [2025-06-30T17:44:55.254Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-06-30T17:44:55.254Z] GC before operation: completed in 89.746 ms, heap usage 690.426 MB -> 130.332 MB. [2025-06-30T17:44:57.159Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1565.651 ms) ====== [2025-06-30T17:44:57.159Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-06-30T17:44:57.159Z] GC before operation: completed in 102.917 ms, heap usage 506.674 MB -> 130.193 MB. [2025-06-30T17:44:59.077Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1615.978 ms) ====== [2025-06-30T17:44:59.077Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-06-30T17:44:59.077Z] GC before operation: completed in 94.331 ms, heap usage 683.714 MB -> 131.084 MB. [2025-06-30T17:45:00.982Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1517.846 ms) ====== [2025-06-30T17:45:00.982Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-06-30T17:45:00.982Z] GC before operation: completed in 100.028 ms, heap usage 456.929 MB -> 130.804 MB. [2025-06-30T17:45:01.909Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1525.458 ms) ====== [2025-06-30T17:45:01.909Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-06-30T17:45:01.909Z] GC before operation: completed in 101.600 ms, heap usage 626.540 MB -> 131.530 MB. [2025-06-30T17:45:03.811Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1492.587 ms) ====== [2025-06-30T17:45:03.811Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-06-30T17:45:03.811Z] GC before operation: completed in 101.455 ms, heap usage 462.159 MB -> 131.467 MB. [2025-06-30T17:45:05.713Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1451.673 ms) ====== [2025-06-30T17:45:05.713Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-06-30T17:45:05.713Z] GC before operation: completed in 107.089 ms, heap usage 674.125 MB -> 132.441 MB. [2025-06-30T17:45:06.642Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1563.686 ms) ====== [2025-06-30T17:45:06.642Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-06-30T17:45:06.642Z] GC before operation: completed in 105.017 ms, heap usage 370.670 MB -> 131.984 MB. [2025-06-30T17:45:08.544Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1457.011 ms) ====== [2025-06-30T17:45:08.544Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-06-30T17:45:08.544Z] GC before operation: completed in 105.502 ms, heap usage 318.606 MB -> 132.083 MB. [2025-06-30T17:45:10.447Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1403.960 ms) ====== [2025-06-30T17:45:10.447Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-06-30T17:45:10.447Z] GC before operation: completed in 105.916 ms, heap usage 525.074 MB -> 133.142 MB. [2025-06-30T17:45:11.375Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1631.442 ms) ====== [2025-06-30T17:45:11.375Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-06-30T17:45:12.301Z] GC before operation: completed in 108.566 ms, heap usage 508.928 MB -> 133.387 MB. [2025-06-30T17:45:13.227Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1414.447 ms) ====== [2025-06-30T17:45:13.227Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-06-30T17:45:13.227Z] GC before operation: completed in 105.988 ms, heap usage 380.186 MB -> 133.414 MB. [2025-06-30T17:45:15.131Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1427.423 ms) ====== [2025-06-30T17:45:15.131Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-06-30T17:45:15.131Z] GC before operation: completed in 182.531 ms, heap usage 578.055 MB -> 134.314 MB. [2025-06-30T17:45:16.057Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1398.814 ms) ====== [2025-06-30T17:45:16.984Z] ----------------------------------- [2025-06-30T17:45:16.984Z] renaissance-log-regression_0_PASSED [2025-06-30T17:45:16.984Z] ----------------------------------- [2025-06-30T17:45:16.984Z] [2025-06-30T17:45:16.984Z] TEST TEARDOWN: [2025-06-30T17:45:16.984Z] Nothing to be done for teardown. [2025-06-30T17:45:16.984Z] renaissance-log-regression_0 Finish Time: Mon Jun 30 17:45:16 2025 Epoch Time (ms): 1751305516188