[2025-06-19T04:29:48.604Z] Running test renaissance-log-regression_0 ... [2025-06-19T04:29:48.604Z] =============================================== [2025-06-19T04:29:48.604Z] renaissance-log-regression_0 Start Time: Thu Jun 19 04:29:48 2025 Epoch Time (ms): 1750307388145 [2025-06-19T04:29:48.604Z] variation: NoOptions [2025-06-19T04:29:48.604Z] JVM_OPTIONS: [2025-06-19T04:29:48.604Z] { \ [2025-06-19T04:29:48.604Z] echo ""; echo "TEST SETUP:"; \ [2025-06-19T04:29:48.604Z] echo "Nothing to be done for setup."; \ [2025-06-19T04:29:48.604Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/../TKG/output_17503062885178/renaissance-log-regression_0"; \ [2025-06-19T04:29:48.604Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/../TKG/output_17503062885178/renaissance-log-regression_0"; \ [2025-06-19T04:29:48.604Z] echo ""; echo "TESTING:"; \ [2025-06-19T04:29:48.604Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_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_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/../TKG/output_17503062885178/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-06-19T04:29:48.605Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/../TKG/output_17503062885178/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-19T04:29:48.605Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-19T04:29:48.605Z] echo "Nothing to be done for teardown."; \ [2025-06-19T04:29:48.605Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix_testList_1/aqa-tests/TKG/../TKG/output_17503062885178/TestTargetResult"; [2025-06-19T04:29:48.605Z] [2025-06-19T04:29:48.605Z] TEST SETUP: [2025-06-19T04:29:48.605Z] Nothing to be done for setup. [2025-06-19T04:29:48.605Z] [2025-06-19T04:29:48.605Z] TESTING: [2025-06-19T04:30:45.621Z] NOTE: 'log-regression' benchmark uses Spark local executor with 12 (out of 16) threads. [2025-06-19T04:30:48.055Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-06-19T04:30:48.055Z] GC before operation: completed in 112.370 ms, heap usage 43.370 MB -> 34.202 MB. [2025-06-19T04:31:04.060Z] ====== log-regression (apache-spark) [default], iteration 0 completed (14978.833 ms) ====== [2025-06-19T04:31:04.060Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-06-19T04:31:04.060Z] GC before operation: completed in 156.261 ms, heap usage 821.432 MB -> 133.015 MB. [2025-06-19T04:31:05.658Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2815.848 ms) ====== [2025-06-19T04:31:05.658Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-06-19T04:31:05.658Z] GC before operation: completed in 148.282 ms, heap usage 363.022 MB -> 132.354 MB. [2025-06-19T04:31:09.056Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2556.325 ms) ====== [2025-06-19T04:31:09.056Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-06-19T04:31:09.056Z] GC before operation: completed in 154.246 ms, heap usage 702.656 MB -> 133.639 MB. [2025-06-19T04:31:11.495Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2364.196 ms) ====== [2025-06-19T04:31:11.495Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-06-19T04:31:11.495Z] GC before operation: completed in 156.465 ms, heap usage 832.620 MB -> 134.532 MB. [2025-06-19T04:31:13.943Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2338.197 ms) ====== [2025-06-19T04:31:13.943Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-06-19T04:31:13.943Z] GC before operation: completed in 153.549 ms, heap usage 868.543 MB -> 134.932 MB. [2025-06-19T04:31:16.391Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2328.047 ms) ====== [2025-06-19T04:31:16.391Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-06-19T04:31:16.391Z] GC before operation: completed in 152.182 ms, heap usage 295.078 MB -> 133.764 MB. [2025-06-19T04:31:18.838Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2282.692 ms) ====== [2025-06-19T04:31:18.838Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-06-19T04:31:18.838Z] GC before operation: completed in 162.128 ms, heap usage 357.870 MB -> 134.315 MB. [2025-06-19T04:31:21.289Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2169.852 ms) ====== [2025-06-19T04:31:21.289Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-06-19T04:31:21.289Z] GC before operation: completed in 156.990 ms, heap usage 594.597 MB -> 135.347 MB. [2025-06-19T04:31:22.888Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2171.366 ms) ====== [2025-06-19T04:31:22.888Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-06-19T04:31:23.647Z] GC before operation: completed in 166.908 ms, heap usage 834.327 MB -> 136.452 MB. [2025-06-19T04:31:25.214Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2192.519 ms) ====== [2025-06-19T04:31:25.214Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-06-19T04:31:25.989Z] GC before operation: completed in 142.179 ms, heap usage 505.377 MB -> 135.787 MB. [2025-06-19T04:31:27.557Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2164.380 ms) ====== [2025-06-19T04:31:27.557Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-06-19T04:31:28.339Z] GC before operation: completed in 155.222 ms, heap usage 835.776 MB -> 137.262 MB. [2025-06-19T04:31:29.960Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2190.350 ms) ====== [2025-06-19T04:31:29.960Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-06-19T04:31:30.720Z] GC before operation: completed in 164.454 ms, heap usage 446.137 MB -> 136.440 MB. [2025-06-19T04:31:32.465Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2397.041 ms) ====== [2025-06-19T04:31:32.465Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-06-19T04:31:33.227Z] GC before operation: completed in 160.308 ms, heap usage 761.632 MB -> 137.735 MB. [2025-06-19T04:31:34.796Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2045.526 ms) ====== [2025-06-19T04:31:34.796Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-06-19T04:31:34.796Z] GC before operation: completed in 168.007 ms, heap usage 865.971 MB -> 138.507 MB. [2025-06-19T04:31:37.237Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2080.008 ms) ====== [2025-06-19T04:31:37.237Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-06-19T04:31:37.237Z] GC before operation: completed in 171.486 ms, heap usage 345.828 MB -> 137.129 MB. [2025-06-19T04:31:39.681Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2021.985 ms) ====== [2025-06-19T04:31:39.681Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-06-19T04:31:39.681Z] GC before operation: completed in 159.839 ms, heap usage 523.434 MB -> 138.077 MB. [2025-06-19T04:31:42.122Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2082.283 ms) ====== [2025-06-19T04:31:42.122Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-06-19T04:31:42.122Z] GC before operation: completed in 187.232 ms, heap usage 718.536 MB -> 139.123 MB. [2025-06-19T04:31:43.706Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2050.413 ms) ====== [2025-06-19T04:31:43.706Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-06-19T04:31:43.706Z] GC before operation: completed in 162.338 ms, heap usage 509.770 MB -> 138.806 MB. [2025-06-19T04:31:46.146Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2152.193 ms) ====== [2025-06-19T04:31:46.146Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-06-19T04:31:46.146Z] GC before operation: completed in 175.532 ms, heap usage 449.479 MB -> 139.010 MB. [2025-06-19T04:31:48.584Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2109.759 ms) ====== [2025-06-19T04:31:49.343Z] ----------------------------------- [2025-06-19T04:31:49.343Z] renaissance-log-regression_0_PASSED [2025-06-19T04:31:49.343Z] ----------------------------------- [2025-06-19T04:31:49.343Z] [2025-06-19T04:31:49.343Z] TEST TEARDOWN: [2025-06-19T04:31:49.343Z] Nothing to be done for teardown. [2025-06-19T04:31:49.343Z] renaissance-log-regression_0 Finish Time: Thu Jun 19 04:31:48 2025 Epoch Time (ms): 1750307508664