[2026-02-04T23:31:33.540Z] Running test renaissance-log-regression_0 ... [2026-02-04T23:31:33.540Z] =============================================== [2026-02-04T23:31:33.540Z] renaissance-log-regression_0 Start Time: Wed Feb 4 23:31:32 2026 Epoch Time (ms): 1770247892814 [2026-02-04T23:31:33.540Z] variation: NoOptions [2026-02-04T23:31:33.540Z] JVM_OPTIONS: [2026-02-04T23:31:33.540Z] { \ [2026-02-04T23:31:33.540Z] echo ""; echo "TEST SETUP:"; \ [2026-02-04T23:31:33.540Z] echo "Nothing to be done for setup."; \ [2026-02-04T23:31:33.540Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702471989882/renaissance-log-regression_0"; \ [2026-02-04T23:31:33.540Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702471989882/renaissance-log-regression_0"; \ [2026-02-04T23:31:33.540Z] echo ""; echo "TESTING:"; \ [2026-02-04T23:31:33.540Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_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_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702471989882/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2026-02-04T23:31:33.540Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702471989882/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-04T23:31:33.540Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-04T23:31:33.540Z] echo "Nothing to be done for teardown."; \ [2026-02-04T23:31:33.540Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17702471989882/TestTargetResult"; [2026-02-04T23:31:33.540Z] [2026-02-04T23:31:33.540Z] TEST SETUP: [2026-02-04T23:31:33.540Z] Nothing to be done for setup. [2026-02-04T23:31:33.540Z] [2026-02-04T23:31:33.540Z] TESTING: [2026-02-04T23:31:38.993Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-04T23:31:40.983Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2026-02-04T23:31:40.983Z] GC before operation: completed in 60.744 ms, heap usage 73.259 MB -> 35.243 MB. [2026-02-04T23:31:50.878Z] ====== log-regression (apache-spark) [default], iteration 0 completed (9633.860 ms) ====== [2026-02-04T23:31:50.878Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2026-02-04T23:31:50.878Z] GC before operation: completed in 89.662 ms, heap usage 180.168 MB -> 119.583 MB. [2026-02-04T23:31:52.932Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2016.749 ms) ====== [2026-02-04T23:31:52.932Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2026-02-04T23:31:52.932Z] GC before operation: completed in 74.210 ms, heap usage 664.253 MB -> 121.313 MB. [2026-02-04T23:31:54.919Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1826.074 ms) ====== [2026-02-04T23:31:54.919Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2026-02-04T23:31:54.919Z] GC before operation: completed in 81.754 ms, heap usage 410.141 MB -> 120.931 MB. [2026-02-04T23:31:56.906Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1599.372 ms) ====== [2026-02-04T23:31:56.906Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2026-02-04T23:31:56.906Z] GC before operation: completed in 80.964 ms, heap usage 591.256 MB -> 121.802 MB. [2026-02-04T23:31:57.874Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1524.991 ms) ====== [2026-02-04T23:31:57.874Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2026-02-04T23:31:57.874Z] GC before operation: completed in 80.032 ms, heap usage 475.547 MB -> 121.752 MB. [2026-02-04T23:31:59.861Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1468.811 ms) ====== [2026-02-04T23:31:59.861Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2026-02-04T23:31:59.861Z] GC before operation: completed in 92.595 ms, heap usage 376.915 MB -> 121.663 MB. [2026-02-04T23:32:00.832Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1505.338 ms) ====== [2026-02-04T23:32:00.832Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2026-02-04T23:32:00.832Z] GC before operation: completed in 109.888 ms, heap usage 477.118 MB -> 122.202 MB. [2026-02-04T23:32:02.821Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1527.743 ms) ====== [2026-02-04T23:32:02.821Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2026-02-04T23:32:02.821Z] GC before operation: completed in 108.172 ms, heap usage 607.535 MB -> 122.831 MB. [2026-02-04T23:32:04.826Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1452.898 ms) ====== [2026-02-04T23:32:04.826Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2026-02-04T23:32:04.826Z] GC before operation: completed in 89.500 ms, heap usage 673.669 MB -> 123.695 MB. [2026-02-04T23:32:06.903Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1418.158 ms) ====== [2026-02-04T23:32:06.903Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2026-02-04T23:32:06.903Z] GC before operation: completed in 87.550 ms, heap usage 691.430 MB -> 123.434 MB. [2026-02-04T23:32:08.042Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1386.330 ms) ====== [2026-02-04T23:32:08.042Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2026-02-04T23:32:08.042Z] GC before operation: completed in 85.138 ms, heap usage 387.306 MB -> 122.744 MB. [2026-02-04T23:32:09.018Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1454.097 ms) ====== [2026-02-04T23:32:09.018Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2026-02-04T23:32:09.018Z] GC before operation: completed in 86.838 ms, heap usage 311.662 MB -> 122.693 MB. [2026-02-04T23:32:09.995Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1450.382 ms) ====== [2026-02-04T23:32:09.996Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2026-02-04T23:32:10.966Z] GC before operation: completed in 87.973 ms, heap usage 510.896 MB -> 123.594 MB. [2026-02-04T23:32:11.942Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1440.690 ms) ====== [2026-02-04T23:32:11.942Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2026-02-04T23:32:11.942Z] GC before operation: completed in 84.241 ms, heap usage 452.177 MB -> 123.656 MB. [2026-02-04T23:32:13.969Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1427.925 ms) ====== [2026-02-04T23:32:13.969Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2026-02-04T23:32:13.969Z] GC before operation: completed in 87.279 ms, heap usage 515.890 MB -> 124.015 MB. [2026-02-04T23:32:14.944Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1430.677 ms) ====== [2026-02-04T23:32:14.944Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2026-02-04T23:32:14.944Z] GC before operation: completed in 91.069 ms, heap usage 294.188 MB -> 123.492 MB. [2026-02-04T23:32:16.930Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1417.982 ms) ====== [2026-02-04T23:32:16.930Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2026-02-04T23:32:16.930Z] GC before operation: completed in 86.663 ms, heap usage 308.646 MB -> 123.724 MB. [2026-02-04T23:32:17.898Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1344.766 ms) ====== [2026-02-04T23:32:17.898Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2026-02-04T23:32:17.898Z] GC before operation: completed in 88.754 ms, heap usage 956.976 MB -> 125.480 MB. [2026-02-04T23:32:18.875Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1332.110 ms) ====== [2026-02-04T23:32:18.875Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2026-02-04T23:32:19.846Z] GC before operation: completed in 103.021 ms, heap usage 673.821 MB -> 125.287 MB. [2026-02-04T23:32:20.814Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1417.464 ms) ====== [2026-02-04T23:32:20.814Z] ----------------------------------- [2026-02-04T23:32:20.814Z] renaissance-log-regression_0_PASSED [2026-02-04T23:32:20.814Z] ----------------------------------- [2026-02-04T23:32:20.814Z] [2026-02-04T23:32:20.814Z] TEST TEARDOWN: [2026-02-04T23:32:20.814Z] Nothing to be done for teardown. [2026-02-04T23:32:20.814Z] renaissance-log-regression_0 Finish Time: Wed Feb 4 23:32:20 2026 Epoch Time (ms): 1770247940550