[2024-08-02T07:45:15.201Z] Running test renaissance-log-regression_0 ... [2024-08-02T07:45:15.201Z] =============================================== [2024-08-02T07:45:15.201Z] renaissance-log-regression_0 Start Time: Fri Aug 2 00:45:13 2024 Epoch Time (ms): 1722584713639 [2024-08-02T07:45:15.201Z] variation: NoOptions [2024-08-02T07:45:15.201Z] JVM_OPTIONS: [2024-08-02T07:45:15.201Z] { \ [2024-08-02T07:45:15.201Z] echo ""; echo "TEST SETUP:"; \ [2024-08-02T07:45:15.201Z] echo "Nothing to be done for setup."; \ [2024-08-02T07:45:15.201Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-log-regression_0"; \ [2024-08-02T07:45:15.201Z] cd "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-log-regression_0"; \ [2024-08-02T07:45:15.201Z] echo ""; echo "TESTING:"; \ [2024-08-02T07:45:15.201Z] "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/jdkbinary/j2sdk-image/Contents/Home/bin/..//bin/java" -jar "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-08-02T07:45:15.201Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-02T07:45:15.201Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-02T07:45:15.201Z] echo "Nothing to be done for teardown."; \ [2024-08-02T07:45:15.201Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk8_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17225828174357/TestTargetResult"; [2024-08-02T07:45:15.201Z] [2024-08-02T07:45:15.201Z] TEST SETUP: [2024-08-02T07:45:15.201Z] Nothing to be done for setup. [2024-08-02T07:45:15.201Z] [2024-08-02T07:45:15.201Z] TESTING: [2024-08-02T07:45:19.425Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-02T07:45:20.249Z] NOTE: 'log-regression' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-08-02T07:45:25.478Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-08-02T07:45:25.479Z] GC before operation: completed in 107.300 ms, heap usage 101.608 MB -> 26.157 MB. [2024-08-02T07:45:37.343Z] ====== log-regression (apache-spark) [default], iteration 0 completed (10443.870 ms) ====== [2024-08-02T07:45:37.343Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-08-02T07:45:37.343Z] GC before operation: completed in 210.367 ms, heap usage 408.436 MB -> 102.256 MB. [2024-08-02T07:45:38.815Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3003.302 ms) ====== [2024-08-02T07:45:38.815Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-08-02T07:45:39.760Z] GC before operation: completed in 704.127 ms, heap usage 447.227 MB -> 101.805 MB. [2024-08-02T07:45:41.168Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1395.633 ms) ====== [2024-08-02T07:45:41.168Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-08-02T07:45:41.168Z] GC before operation: completed in 92.187 ms, heap usage 1.193 GB -> 103.565 MB. [2024-08-02T07:45:43.263Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2219.198 ms) ====== [2024-08-02T07:45:43.263Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-08-02T07:45:43.677Z] GC before operation: completed in 207.040 ms, heap usage 1.148 GB -> 104.047 MB. [2024-08-02T07:45:44.503Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1073.057 ms) ====== [2024-08-02T07:45:44.503Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-08-02T07:45:44.921Z] GC before operation: completed in 105.265 ms, heap usage 1.148 GB -> 104.212 MB. [2024-08-02T07:45:46.427Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1501.278 ms) ====== [2024-08-02T07:45:46.427Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-08-02T07:45:46.427Z] GC before operation: completed in 188.167 ms, heap usage 1.071 GB -> 104.401 MB. [2024-08-02T07:45:48.487Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1649.314 ms) ====== [2024-08-02T07:45:48.487Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-08-02T07:45:48.487Z] GC before operation: completed in 594.192 ms, heap usage 1.056 GB -> 104.655 MB. [2024-08-02T07:45:52.337Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3347.897 ms) ====== [2024-08-02T07:45:52.337Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-08-02T07:45:52.337Z] GC before operation: completed in 349.626 ms, heap usage 1.048 GB -> 104.868 MB. [2024-08-02T07:45:53.739Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1327.466 ms) ====== [2024-08-02T07:45:53.739Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-08-02T07:45:53.739Z] GC before operation: completed in 179.332 ms, heap usage 1.039 GB -> 105.122 MB. [2024-08-02T07:45:55.889Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2049.705 ms) ====== [2024-08-02T07:45:55.889Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-08-02T07:45:55.889Z] GC before operation: completed in 141.379 ms, heap usage 1.041 GB -> 105.376 MB. [2024-08-02T07:45:58.049Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2171.916 ms) ====== [2024-08-02T07:45:58.049Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-08-02T07:45:58.454Z] GC before operation: completed in 129.751 ms, heap usage 1.037 GB -> 105.568 MB. [2024-08-02T07:45:59.293Z] ====== log-regression (apache-spark) [default], iteration 11 completed (804.517 ms) ====== [2024-08-02T07:45:59.294Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-08-02T07:45:59.294Z] GC before operation: completed in 92.909 ms, heap usage 1.043 GB -> 105.823 MB. [2024-08-02T07:46:00.163Z] ====== log-regression (apache-spark) [default], iteration 12 completed (838.416 ms) ====== [2024-08-02T07:46:00.163Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-08-02T07:46:00.163Z] GC before operation: completed in 108.999 ms, heap usage 1.044 GB -> 106.074 MB. [2024-08-02T07:46:01.628Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1387.263 ms) ====== [2024-08-02T07:46:01.628Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-08-02T07:46:01.628Z] GC before operation: completed in 124.329 ms, heap usage 1.032 GB -> 106.330 MB. [2024-08-02T07:46:02.509Z] ====== log-regression (apache-spark) [default], iteration 14 completed (926.591 ms) ====== [2024-08-02T07:46:02.509Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-08-02T07:46:02.953Z] GC before operation: completed in 100.811 ms, heap usage 1.041 GB -> 106.568 MB. [2024-08-02T07:46:04.537Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1844.012 ms) ====== [2024-08-02T07:46:04.537Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-08-02T07:46:05.096Z] GC before operation: completed in 196.346 ms, heap usage 1.039 GB -> 106.835 MB. [2024-08-02T07:46:06.521Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1610.784 ms) ====== [2024-08-02T07:46:06.521Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-08-02T07:46:06.521Z] GC before operation: completed in 223.218 ms, heap usage 1.043 GB -> 107.133 MB. [2024-08-02T07:46:09.322Z] ====== log-regression (apache-spark) [default], iteration 17 completed (2516.969 ms) ====== [2024-08-02T07:46:09.322Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-08-02T07:46:09.322Z] GC before operation: completed in 179.833 ms, heap usage 1.047 GB -> 107.265 MB. [2024-08-02T07:46:11.491Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1892.162 ms) ====== [2024-08-02T07:46:11.491Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-08-02T07:46:11.491Z] GC before operation: completed in 179.376 ms, heap usage 1.034 GB -> 107.496 MB. [2024-08-02T07:46:13.621Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1888.165 ms) ====== [2024-08-02T07:46:14.582Z] ----------------------------------- [2024-08-02T07:46:14.582Z] renaissance-log-regression_0_PASSED [2024-08-02T07:46:14.582Z] ----------------------------------- [2024-08-02T07:46:15.057Z] [2024-08-02T07:46:15.057Z] TEST TEARDOWN: [2024-08-02T07:46:15.057Z] Nothing to be done for teardown. [2024-08-02T07:46:15.057Z] renaissance-log-regression_0 Finish Time: Fri Aug 2 00:46:13 2024 Epoch Time (ms): 1722584773224