[2024-09-05T20:51:24.312Z] Running test renaissance-log-regression_0 ... [2024-09-05T20:51:24.312Z] =============================================== [2024-09-05T20:51:24.312Z] renaissance-log-regression_0 Start Time: Thu Sep 5 20:51:23 2024 Epoch Time (ms): 1725569483747 [2024-09-05T20:51:24.312Z] variation: NoOptions [2024-09-05T20:51:24.312Z] JVM_OPTIONS: [2024-09-05T20:51:24.312Z] { \ [2024-09-05T20:51:24.312Z] echo ""; echo "TEST SETUP:"; \ [2024-09-05T20:51:24.312Z] echo "Nothing to be done for setup."; \ [2024-09-05T20:51:24.312Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17255689523030/renaissance-log-regression_0"; \ [2024-09-05T20:51:24.312Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17255689523030/renaissance-log-regression_0"; \ [2024-09-05T20:51:24.312Z] echo ""; echo "TESTING:"; \ [2024-09-05T20:51:24.312Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17255689523030/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-09-05T20:51:24.312Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17255689523030/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-05T20:51:24.312Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-05T20:51:24.312Z] echo "Nothing to be done for teardown."; \ [2024-09-05T20:51:24.312Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17255689523030/TestTargetResult"; [2024-09-05T20:51:24.312Z] [2024-09-05T20:51:24.312Z] TEST SETUP: [2024-09-05T20:51:24.312Z] Nothing to be done for setup. [2024-09-05T20:51:24.312Z] [2024-09-05T20:51:24.312Z] TESTING: [2024-09-05T20:51:26.994Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-05T20:51:28.922Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2024-09-05T20:51:31.891Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-09-05T20:51:32.827Z] GC before operation: completed in 130.591 ms, heap usage 96.511 MB -> 29.161 MB. [2024-09-05T20:51:39.457Z] ====== log-regression (apache-spark) [default], iteration 0 completed (7208.172 ms) ====== [2024-09-05T20:51:39.457Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-09-05T20:51:40.394Z] GC before operation: completed in 299.764 ms, heap usage 877.609 MB -> 109.585 MB. [2024-09-05T20:51:41.331Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1713.153 ms) ====== [2024-09-05T20:51:41.331Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-09-05T20:51:42.270Z] GC before operation: completed in 198.609 ms, heap usage 172.471 MB -> 105.050 MB. [2024-09-05T20:51:43.208Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1528.509 ms) ====== [2024-09-05T20:51:43.208Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-09-05T20:51:43.208Z] GC before operation: completed in 209.593 ms, heap usage 1.173 GB -> 112.459 MB. [2024-09-05T20:51:45.130Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1376.526 ms) ====== [2024-09-05T20:51:45.130Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-09-05T20:51:45.130Z] GC before operation: completed in 183.333 ms, heap usage 1.171 GB -> 112.933 MB. [2024-09-05T20:51:46.067Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1295.431 ms) ====== [2024-09-05T20:51:46.067Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-09-05T20:51:47.009Z] GC before operation: completed in 173.469 ms, heap usage 1.137 GB -> 113.408 MB. [2024-09-05T20:51:47.946Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1273.483 ms) ====== [2024-09-05T20:51:47.946Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-09-05T20:51:47.946Z] GC before operation: completed in 190.500 ms, heap usage 1.135 GB -> 113.816 MB. [2024-09-05T20:51:49.869Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1287.824 ms) ====== [2024-09-05T20:51:49.869Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-09-05T20:51:49.869Z] GC before operation: completed in 184.843 ms, heap usage 1.128 GB -> 114.247 MB. [2024-09-05T20:51:50.812Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1365.178 ms) ====== [2024-09-05T20:51:50.812Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-09-05T20:51:50.812Z] GC before operation: completed in 189.336 ms, heap usage 1.133 GB -> 114.749 MB. [2024-09-05T20:51:52.736Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1300.058 ms) ====== [2024-09-05T20:51:52.736Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-09-05T20:51:52.736Z] GC before operation: completed in 180.022 ms, heap usage 1.131 GB -> 115.195 MB. [2024-09-05T20:51:53.676Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1161.326 ms) ====== [2024-09-05T20:51:53.676Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-09-05T20:51:53.676Z] GC before operation: completed in 183.135 ms, heap usage 1.124 GB -> 115.639 MB. [2024-09-05T20:51:55.597Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1148.548 ms) ====== [2024-09-05T20:51:55.597Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-09-05T20:51:55.597Z] GC before operation: completed in 197.846 ms, heap usage 1.132 GB -> 116.029 MB. [2024-09-05T20:51:56.533Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1083.984 ms) ====== [2024-09-05T20:51:56.533Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-09-05T20:51:56.533Z] GC before operation: completed in 183.044 ms, heap usage 1.129 GB -> 116.462 MB. [2024-09-05T20:51:57.472Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1090.202 ms) ====== [2024-09-05T20:51:57.472Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-09-05T20:51:57.472Z] GC before operation: completed in 174.463 ms, heap usage 1.129 GB -> 116.902 MB. [2024-09-05T20:51:59.396Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1056.971 ms) ====== [2024-09-05T20:51:59.396Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-09-05T20:51:59.396Z] GC before operation: completed in 177.453 ms, heap usage 1.136 GB -> 117.355 MB. [2024-09-05T20:52:00.332Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1033.983 ms) ====== [2024-09-05T20:52:00.332Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-09-05T20:52:00.332Z] GC before operation: completed in 176.758 ms, heap usage 1.132 GB -> 117.792 MB. [2024-09-05T20:52:01.267Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1102.531 ms) ====== [2024-09-05T20:52:01.267Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-09-05T20:52:01.267Z] GC before operation: completed in 221.609 ms, heap usage 1.133 GB -> 118.268 MB. [2024-09-05T20:52:03.188Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1135.629 ms) ====== [2024-09-05T20:52:03.188Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-09-05T20:52:03.188Z] GC before operation: completed in 206.028 ms, heap usage 1.133 GB -> 118.774 MB. [2024-09-05T20:52:04.124Z] ====== log-regression (apache-spark) [default], iteration 17 completed (977.796 ms) ====== [2024-09-05T20:52:04.124Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-09-05T20:52:04.124Z] GC before operation: completed in 225.451 ms, heap usage 1.129 GB -> 119.143 MB. [2024-09-05T20:52:05.060Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1035.598 ms) ====== [2024-09-05T20:52:05.060Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-09-05T20:52:05.060Z] GC before operation: completed in 185.794 ms, heap usage 1.131 GB -> 119.470 MB. [2024-09-05T20:52:05.999Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1022.233 ms) ====== [2024-09-05T20:52:06.934Z] ----------------------------------- [2024-09-05T20:52:06.934Z] renaissance-log-regression_0_PASSED [2024-09-05T20:52:06.934Z] ----------------------------------- [2024-09-05T20:52:06.934Z] [2024-09-05T20:52:06.934Z] TEST TEARDOWN: [2024-09-05T20:52:06.934Z] Nothing to be done for teardown. [2024-09-05T20:52:06.934Z] renaissance-log-regression_0 Finish Time: Thu Sep 5 20:52:06 2024 Epoch Time (ms): 1725569526189