[2025-02-25T21:48:37.109Z] Running test renaissance-log-regression_0 ... [2025-02-25T21:48:37.109Z] =============================================== [2025-02-25T21:48:37.109Z] renaissance-log-regression_0 Start Time: Tue Feb 25 21:48:36 2025 Epoch Time (ms): 1740520116600 [2025-02-25T21:48:37.109Z] variation: NoOptions [2025-02-25T21:48:37.109Z] JVM_OPTIONS: [2025-02-25T21:48:37.109Z] { \ [2025-02-25T21:48:37.109Z] echo ""; echo "TEST SETUP:"; \ [2025-02-25T21:48:37.109Z] echo "Nothing to be done for setup."; \ [2025-02-25T21:48:37.109Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17405193194599/renaissance-log-regression_0"; \ [2025-02-25T21:48:37.109Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17405193194599/renaissance-log-regression_0"; \ [2025-02-25T21:48:37.109Z] echo ""; echo "TESTING:"; \ [2025-02-25T21:48:37.109Z] "/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_17405193194599/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-02-25T21:48:37.109Z] 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_17405193194599/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-25T21:48:37.109Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-25T21:48:37.109Z] echo "Nothing to be done for teardown."; \ [2025-02-25T21:48:37.109Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17405193194599/TestTargetResult"; [2025-02-25T21:48:37.109Z] [2025-02-25T21:48:37.109Z] TEST SETUP: [2025-02-25T21:48:37.109Z] Nothing to be done for setup. [2025-02-25T21:48:37.109Z] [2025-02-25T21:48:37.109Z] TESTING: [2025-02-25T21:48:43.179Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-25T21:48:43.179Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-25T21:48:48.089Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-02-25T21:48:48.089Z] GC before operation: completed in 167.795 ms, heap usage 63.299 MB -> 24.923 MB. [2025-02-25T21:48:58.439Z] ====== log-regression (apache-spark) [default], iteration 0 completed (9836.200 ms) ====== [2025-02-25T21:48:58.439Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-02-25T21:48:58.439Z] GC before operation: completed in 384.855 ms, heap usage 397.277 MB -> 101.596 MB. [2025-02-25T21:49:00.394Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2326.360 ms) ====== [2025-02-25T21:49:00.394Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-02-25T21:49:00.394Z] GC before operation: completed in 229.160 ms, heap usage 268.034 MB -> 100.876 MB. [2025-02-25T21:49:03.621Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2031.253 ms) ====== [2025-02-25T21:49:03.621Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-02-25T21:49:03.621Z] GC before operation: completed in 210.164 ms, heap usage 209.132 MB -> 100.888 MB. [2025-02-25T21:49:07.416Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1888.220 ms) ====== [2025-02-25T21:49:07.416Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-02-25T21:49:07.416Z] GC before operation: completed in 213.251 ms, heap usage 216.298 MB -> 101.265 MB. [2025-02-25T21:49:07.416Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1817.414 ms) ====== [2025-02-25T21:49:07.416Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-02-25T21:49:07.416Z] GC before operation: completed in 194.612 ms, heap usage 190.978 MB -> 101.313 MB. [2025-02-25T21:49:09.374Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1854.301 ms) ====== [2025-02-25T21:49:09.374Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-02-25T21:49:09.374Z] GC before operation: completed in 205.042 ms, heap usage 116.505 MB -> 101.508 MB. [2025-02-25T21:49:11.349Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1635.138 ms) ====== [2025-02-25T21:49:11.349Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-02-25T21:49:11.349Z] GC before operation: completed in 224.480 ms, heap usage 238.114 MB -> 102.358 MB. [2025-02-25T21:49:12.312Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1599.867 ms) ====== [2025-02-25T21:49:12.312Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-02-25T21:49:13.307Z] GC before operation: completed in 208.956 ms, heap usage 194.066 MB -> 102.213 MB. [2025-02-25T21:49:14.261Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1585.697 ms) ====== [2025-02-25T21:49:14.261Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-02-25T21:49:14.261Z] GC before operation: completed in 198.005 ms, heap usage 335.765 MB -> 103.615 MB. [2025-02-25T21:49:16.214Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1582.944 ms) ====== [2025-02-25T21:49:16.214Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-02-25T21:49:16.214Z] GC before operation: completed in 181.058 ms, heap usage 308.624 MB -> 103.763 MB. [2025-02-25T21:49:18.172Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1484.110 ms) ====== [2025-02-25T21:49:18.172Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-02-25T21:49:18.172Z] GC before operation: completed in 246.620 ms, heap usage 359.576 MB -> 104.310 MB. [2025-02-25T21:49:20.122Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1720.218 ms) ====== [2025-02-25T21:49:20.122Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-02-25T21:49:20.122Z] GC before operation: completed in 166.187 ms, heap usage 332.733 MB -> 104.341 MB. [2025-02-25T21:49:22.069Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1580.701 ms) ====== [2025-02-25T21:49:22.069Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-02-25T21:49:22.069Z] GC before operation: completed in 161.051 ms, heap usage 265.784 MB -> 104.016 MB. [2025-02-25T21:49:23.018Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1481.453 ms) ====== [2025-02-25T21:49:23.018Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-02-25T21:49:23.018Z] GC before operation: completed in 154.092 ms, heap usage 247.085 MB -> 104.144 MB. [2025-02-25T21:49:24.969Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1529.723 ms) ====== [2025-02-25T21:49:24.969Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-02-25T21:49:24.969Z] GC before operation: completed in 197.606 ms, heap usage 223.001 MB -> 104.195 MB. [2025-02-25T21:49:27.653Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1472.281 ms) ====== [2025-02-25T21:49:27.653Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-02-25T21:49:27.653Z] GC before operation: completed in 185.135 ms, heap usage 343.670 MB -> 105.425 MB. [2025-02-25T21:49:28.603Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1402.178 ms) ====== [2025-02-25T21:49:28.603Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-02-25T21:49:28.603Z] GC before operation: completed in 176.943 ms, heap usage 274.817 MB -> 105.144 MB. [2025-02-25T21:49:29.552Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1416.828 ms) ====== [2025-02-25T21:49:29.552Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-02-25T21:49:29.552Z] GC before operation: completed in 189.934 ms, heap usage 307.626 MB -> 105.690 MB. [2025-02-25T21:49:31.500Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1418.830 ms) ====== [2025-02-25T21:49:31.500Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-02-25T21:49:31.500Z] GC before operation: completed in 169.472 ms, heap usage 335.137 MB -> 106.123 MB. [2025-02-25T21:49:32.450Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1320.108 ms) ====== [2025-02-25T21:49:33.433Z] ----------------------------------- [2025-02-25T21:49:33.433Z] renaissance-log-regression_0_PASSED [2025-02-25T21:49:33.433Z] ----------------------------------- [2025-02-25T21:49:33.433Z] [2025-02-25T21:49:33.433Z] TEST TEARDOWN: [2025-02-25T21:49:33.433Z] Nothing to be done for teardown. [2025-02-25T21:49:33.433Z] renaissance-log-regression_0 Finish Time: Tue Feb 25 21:49:32 2025 Epoch Time (ms): 1740520172604