[2025-02-13T21:43:54.920Z] Running test renaissance-log-regression_0 ... [2025-02-13T21:43:54.920Z] =============================================== [2025-02-13T21:43:54.920Z] renaissance-log-regression_0 Start Time: Thu Feb 13 21:43:54 2025 Epoch Time (ms): 1739483034386 [2025-02-13T21:43:54.920Z] variation: NoOptions [2025-02-13T21:43:54.920Z] JVM_OPTIONS: [2025-02-13T21:43:54.920Z] { \ [2025-02-13T21:43:54.920Z] echo ""; echo "TEST SETUP:"; \ [2025-02-13T21:43:54.920Z] echo "Nothing to be done for setup."; \ [2025-02-13T21:43:54.920Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17394822075452/renaissance-log-regression_0"; \ [2025-02-13T21:43:54.920Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17394822075452/renaissance-log-regression_0"; \ [2025-02-13T21:43:54.920Z] echo ""; echo "TESTING:"; \ [2025-02-13T21:43:54.920Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17394822075452/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-02-13T21:43:54.920Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17394822075452/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-13T21:43:54.920Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-13T21:43:54.920Z] echo "Nothing to be done for teardown."; \ [2025-02-13T21:43:54.920Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17394822075452/TestTargetResult"; [2025-02-13T21:43:54.920Z] [2025-02-13T21:43:54.920Z] TEST SETUP: [2025-02-13T21:43:54.920Z] Nothing to be done for setup. [2025-02-13T21:43:54.920Z] [2025-02-13T21:43:54.920Z] TESTING: [2025-02-13T21:43:59.068Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-13T21:44:01.028Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-13T21:44:05.177Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-02-13T21:44:06.133Z] GC before operation: completed in 154.054 ms, heap usage 117.773 MB -> 27.345 MB. [2025-02-13T21:44:15.897Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10054.928 ms) ====== [2025-02-13T21:44:15.897Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-02-13T21:44:15.897Z] GC before operation: completed in 346.570 ms, heap usage 298.181 MB -> 100.721 MB. [2025-02-13T21:44:18.913Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2372.631 ms) ====== [2025-02-13T21:44:18.913Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-02-13T21:44:18.913Z] GC before operation: completed in 199.686 ms, heap usage 348.045 MB -> 101.571 MB. [2025-02-13T21:44:20.870Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2239.630 ms) ====== [2025-02-13T21:44:20.870Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-02-13T21:44:20.870Z] GC before operation: completed in 213.189 ms, heap usage 282.887 MB -> 101.474 MB. [2025-02-13T21:44:22.825Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2051.982 ms) ====== [2025-02-13T21:44:22.825Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-02-13T21:44:23.777Z] GC before operation: completed in 226.851 ms, heap usage 218.026 MB -> 101.258 MB. [2025-02-13T21:44:25.740Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1931.906 ms) ====== [2025-02-13T21:44:25.740Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-02-13T21:44:25.740Z] GC before operation: completed in 223.787 ms, heap usage 218.625 MB -> 101.567 MB. [2025-02-13T21:44:27.695Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1897.488 ms) ====== [2025-02-13T21:44:27.695Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-02-13T21:44:27.695Z] GC before operation: completed in 199.168 ms, heap usage 279.642 MB -> 102.387 MB. [2025-02-13T21:44:29.647Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1843.589 ms) ====== [2025-02-13T21:44:29.647Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-02-13T21:44:29.647Z] GC before operation: completed in 202.337 ms, heap usage 228.388 MB -> 102.199 MB. [2025-02-13T21:44:31.308Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1774.016 ms) ====== [2025-02-13T21:44:31.308Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-02-13T21:44:31.308Z] GC before operation: completed in 204.110 ms, heap usage 331.774 MB -> 103.347 MB. [2025-02-13T21:44:33.261Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1733.004 ms) ====== [2025-02-13T21:44:33.261Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-02-13T21:44:33.261Z] GC before operation: completed in 220.506 ms, heap usage 342.567 MB -> 103.762 MB. [2025-02-13T21:44:35.213Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1733.946 ms) ====== [2025-02-13T21:44:35.213Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-02-13T21:44:35.213Z] GC before operation: completed in 194.311 ms, heap usage 301.492 MB -> 103.614 MB. [2025-02-13T21:44:37.167Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1645.258 ms) ====== [2025-02-13T21:44:37.167Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-02-13T21:44:37.167Z] GC before operation: completed in 261.193 ms, heap usage 284.325 MB -> 103.688 MB. [2025-02-13T21:44:39.123Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1703.797 ms) ====== [2025-02-13T21:44:39.123Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-02-13T21:44:39.123Z] GC before operation: completed in 175.390 ms, heap usage 246.037 MB -> 103.545 MB. [2025-02-13T21:44:41.089Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1700.171 ms) ====== [2025-02-13T21:44:41.089Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-02-13T21:44:41.089Z] GC before operation: completed in 169.249 ms, heap usage 296.477 MB -> 104.246 MB. [2025-02-13T21:44:43.051Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1593.622 ms) ====== [2025-02-13T21:44:43.051Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-02-13T21:44:43.051Z] GC before operation: completed in 215.719 ms, heap usage 303.450 MB -> 104.571 MB. [2025-02-13T21:44:45.039Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1577.105 ms) ====== [2025-02-13T21:44:45.039Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-02-13T21:44:45.040Z] GC before operation: completed in 164.777 ms, heap usage 255.144 MB -> 104.434 MB. [2025-02-13T21:44:45.999Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1572.170 ms) ====== [2025-02-13T21:44:45.999Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-02-13T21:44:46.952Z] GC before operation: completed in 197.761 ms, heap usage 363.892 MB -> 105.615 MB. [2025-02-13T21:44:47.906Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1545.384 ms) ====== [2025-02-13T21:44:47.906Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-02-13T21:44:47.906Z] GC before operation: completed in 167.428 ms, heap usage 206.080 MB -> 104.634 MB. [2025-02-13T21:44:49.866Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1540.541 ms) ====== [2025-02-13T21:44:49.866Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-02-13T21:44:49.866Z] GC before operation: completed in 206.011 ms, heap usage 207.964 MB -> 104.731 MB. [2025-02-13T21:44:51.828Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1562.881 ms) ====== [2025-02-13T21:44:51.828Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-02-13T21:44:51.828Z] GC before operation: completed in 217.804 ms, heap usage 265.772 MB -> 105.506 MB. [2025-02-13T21:44:53.789Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1559.751 ms) ====== [2025-02-13T21:44:53.789Z] ----------------------------------- [2025-02-13T21:44:53.789Z] renaissance-log-regression_0_PASSED [2025-02-13T21:44:53.789Z] ----------------------------------- [2025-02-13T21:44:53.789Z] [2025-02-13T21:44:53.789Z] TEST TEARDOWN: [2025-02-13T21:44:53.789Z] Nothing to be done for teardown. [2025-02-13T21:44:53.789Z] renaissance-log-regression_0 Finish Time: Thu Feb 13 21:44:53 2025 Epoch Time (ms): 1739483093080