[2024-08-02T02:17:45.959Z] Running test renaissance-log-regression_0 ... [2024-08-02T02:17:45.959Z] =============================================== [2024-08-02T02:17:45.959Z] renaissance-log-regression_0 Start Time: Fri Aug 2 02:17:45 2024 Epoch Time (ms): 1722565065071 [2024-08-02T02:17:45.959Z] variation: NoOptions [2024-08-02T02:17:45.959Z] JVM_OPTIONS: [2024-08-02T02:17:45.959Z] { \ [2024-08-02T02:17:45.959Z] echo ""; echo "TEST SETUP:"; \ [2024-08-02T02:17:45.959Z] echo "Nothing to be done for setup."; \ [2024-08-02T02:17:45.959Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225640756604/renaissance-log-regression_0"; \ [2024-08-02T02:17:45.959Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225640756604/renaissance-log-regression_0"; \ [2024-08-02T02:17:45.959Z] echo ""; echo "TESTING:"; \ [2024-08-02T02:17:45.959Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225640756604/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-08-02T02:17:45.959Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225640756604/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-02T02:17:45.959Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-02T02:17:45.959Z] echo "Nothing to be done for teardown."; \ [2024-08-02T02:17:45.959Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225640756604/TestTargetResult"; [2024-08-02T02:17:45.959Z] [2024-08-02T02:17:45.959Z] TEST SETUP: [2024-08-02T02:17:45.959Z] Nothing to be done for setup. [2024-08-02T02:17:45.959Z] [2024-08-02T02:17:45.959Z] TESTING: [2024-08-02T02:17:50.067Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-02T02:17:54.180Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2024-08-02T02:18:03.833Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-08-02T02:18:03.833Z] GC before operation: completed in 244.579 ms, heap usage 97.806 MB -> 29.154 MB. [2024-08-02T02:18:19.555Z] ====== log-regression (apache-spark) [default], iteration 0 completed (15664.246 ms) ====== [2024-08-02T02:18:19.555Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-08-02T02:18:19.555Z] GC before operation: completed in 431.140 ms, heap usage 921.083 MB -> 111.647 MB. [2024-08-02T02:18:22.545Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3570.146 ms) ====== [2024-08-02T02:18:22.545Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-08-02T02:18:23.488Z] GC before operation: completed in 325.760 ms, heap usage 1.269 GB -> 112.714 MB. [2024-08-02T02:18:26.473Z] ====== log-regression (apache-spark) [default], iteration 2 completed (3194.130 ms) ====== [2024-08-02T02:18:26.474Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-08-02T02:18:26.474Z] GC before operation: completed in 296.908 ms, heap usage 1.187 GB -> 112.488 MB. [2024-08-02T02:18:29.458Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2866.540 ms) ====== [2024-08-02T02:18:29.458Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-08-02T02:18:29.458Z] GC before operation: completed in 318.705 ms, heap usage 1.141 GB -> 112.954 MB. [2024-08-02T02:18:32.452Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2672.778 ms) ====== [2024-08-02T02:18:32.452Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-08-02T02:18:32.452Z] GC before operation: completed in 310.915 ms, heap usage 1.133 GB -> 113.438 MB. [2024-08-02T02:18:35.442Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2600.367 ms) ====== [2024-08-02T02:18:35.442Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-08-02T02:18:35.442Z] GC before operation: completed in 290.402 ms, heap usage 1.130 GB -> 113.854 MB. [2024-08-02T02:18:38.429Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2518.004 ms) ====== [2024-08-02T02:18:38.429Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-08-02T02:18:38.430Z] GC before operation: completed in 300.067 ms, heap usage 1.126 GB -> 114.290 MB. [2024-08-02T02:18:41.417Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2653.929 ms) ====== [2024-08-02T02:18:41.417Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-08-02T02:18:41.417Z] GC before operation: completed in 306.500 ms, heap usage 1.137 GB -> 114.726 MB. [2024-08-02T02:18:43.353Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2367.703 ms) ====== [2024-08-02T02:18:43.353Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-08-02T02:18:44.296Z] GC before operation: completed in 300.422 ms, heap usage 1.132 GB -> 115.164 MB. [2024-08-02T02:18:46.230Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2291.870 ms) ====== [2024-08-02T02:18:46.230Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-08-02T02:18:46.230Z] GC before operation: completed in 300.110 ms, heap usage 1.130 GB -> 115.612 MB. [2024-08-02T02:18:49.214Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2369.915 ms) ====== [2024-08-02T02:18:49.214Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-08-02T02:18:49.214Z] GC before operation: completed in 292.084 ms, heap usage 1.133 GB -> 116.075 MB. [2024-08-02T02:18:51.148Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2290.748 ms) ====== [2024-08-02T02:18:51.148Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-08-02T02:18:52.090Z] GC before operation: completed in 292.481 ms, heap usage 1.144 GB -> 116.458 MB. [2024-08-02T02:18:54.022Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2260.056 ms) ====== [2024-08-02T02:18:54.022Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-08-02T02:18:54.964Z] GC before operation: completed in 340.474 ms, heap usage 1.157 GB -> 116.900 MB. [2024-08-02T02:18:56.896Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2227.122 ms) ====== [2024-08-02T02:18:56.896Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-08-02T02:18:56.896Z] GC before operation: completed in 312.161 ms, heap usage 1.135 GB -> 117.359 MB. [2024-08-02T02:18:58.830Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2189.883 ms) ====== [2024-08-02T02:18:58.830Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-08-02T02:18:59.776Z] GC before operation: completed in 329.332 ms, heap usage 1.136 GB -> 117.795 MB. [2024-08-02T02:19:01.411Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2216.592 ms) ====== [2024-08-02T02:19:01.411Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-08-02T02:19:02.351Z] GC before operation: completed in 317.773 ms, heap usage 1.133 GB -> 118.215 MB. [2024-08-02T02:19:04.286Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2120.524 ms) ====== [2024-08-02T02:19:04.286Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-08-02T02:19:04.286Z] GC before operation: completed in 283.932 ms, heap usage 1.136 GB -> 118.712 MB. [2024-08-02T02:19:06.216Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2031.866 ms) ====== [2024-08-02T02:19:06.216Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-08-02T02:19:07.157Z] GC before operation: completed in 323.427 ms, heap usage 1.136 GB -> 119.093 MB. [2024-08-02T02:19:09.135Z] ====== log-regression (apache-spark) [default], iteration 18 completed (2166.406 ms) ====== [2024-08-02T02:19:09.135Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-08-02T02:19:09.135Z] GC before operation: completed in 294.469 ms, heap usage 1.139 GB -> 119.522 MB. [2024-08-02T02:19:11.070Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2074.636 ms) ====== [2024-08-02T02:19:12.011Z] ----------------------------------- [2024-08-02T02:19:12.012Z] renaissance-log-regression_0_PASSED [2024-08-02T02:19:12.012Z] ----------------------------------- [2024-08-02T02:19:12.012Z] [2024-08-02T02:19:12.012Z] TEST TEARDOWN: [2024-08-02T02:19:12.012Z] Nothing to be done for teardown. [2024-08-02T02:19:12.012Z] renaissance-log-regression_0 Finish Time: Fri Aug 2 02:19:11 2024 Epoch Time (ms): 1722565151510