[2024-11-07T23:47:35.000Z] Running test renaissance-log-regression_0 ... [2024-11-07T23:47:35.000Z] =============================================== [2024-11-07T23:47:35.000Z] renaissance-log-regression_0 Start Time: Thu Nov 7 23:47:34 2024 Epoch Time (ms): 1731023254496 [2024-11-07T23:47:35.000Z] variation: NoOptions [2024-11-07T23:47:35.000Z] JVM_OPTIONS: [2024-11-07T23:47:35.000Z] { \ [2024-11-07T23:47:35.000Z] echo ""; echo "TEST SETUP:"; \ [2024-11-07T23:47:35.000Z] echo "Nothing to be done for setup."; \ [2024-11-07T23:47:35.000Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17310222975035/renaissance-log-regression_0"; \ [2024-11-07T23:47:35.000Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17310222975035/renaissance-log-regression_0"; \ [2024-11-07T23:47:35.000Z] echo ""; echo "TESTING:"; \ [2024-11-07T23:47:35.000Z] "/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_17310222975035/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-11-07T23:47:35.000Z] 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_17310222975035/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-07T23:47:35.000Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-07T23:47:35.000Z] echo "Nothing to be done for teardown."; \ [2024-11-07T23:47:35.000Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17310222975035/TestTargetResult"; [2024-11-07T23:47:35.000Z] [2024-11-07T23:47:35.000Z] TEST SETUP: [2024-11-07T23:47:35.000Z] Nothing to be done for setup. [2024-11-07T23:47:35.000Z] [2024-11-07T23:47:35.000Z] TESTING: [2024-11-07T23:47:39.029Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-07T23:47:43.122Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2024-11-07T23:47:51.051Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-11-07T23:47:51.051Z] GC before operation: completed in 221.278 ms, heap usage 99.309 MB -> 29.111 MB. [2024-11-07T23:48:04.919Z] ====== log-regression (apache-spark) [default], iteration 0 completed (14714.014 ms) ====== [2024-11-07T23:48:04.919Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-11-07T23:48:05.840Z] GC before operation: completed in 414.547 ms, heap usage 246.328 MB -> 104.292 MB. [2024-11-07T23:48:08.766Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3453.369 ms) ====== [2024-11-07T23:48:08.766Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-11-07T23:48:09.688Z] GC before operation: completed in 330.596 ms, heap usage 203.957 MB -> 105.786 MB. [2024-11-07T23:48:12.679Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2906.448 ms) ====== [2024-11-07T23:48:12.679Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-11-07T23:48:12.679Z] GC before operation: completed in 346.494 ms, heap usage 1.206 GB -> 112.874 MB. [2024-11-07T23:48:15.604Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2658.903 ms) ====== [2024-11-07T23:48:15.604Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-11-07T23:48:15.604Z] GC before operation: completed in 328.738 ms, heap usage 1.151 GB -> 113.088 MB. [2024-11-07T23:48:18.530Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2544.756 ms) ====== [2024-11-07T23:48:18.530Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-11-07T23:48:18.530Z] GC before operation: completed in 321.120 ms, heap usage 1.049 GB -> 113.311 MB. [2024-11-07T23:48:20.425Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2447.354 ms) ====== [2024-11-07T23:48:20.425Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-11-07T23:48:21.346Z] GC before operation: completed in 307.129 ms, heap usage 1.039 GB -> 113.754 MB. [2024-11-07T23:48:23.245Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2400.842 ms) ====== [2024-11-07T23:48:23.245Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-11-07T23:48:24.167Z] GC before operation: completed in 312.371 ms, heap usage 1.030 GB -> 114.201 MB. [2024-11-07T23:48:26.061Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2399.149 ms) ====== [2024-11-07T23:48:26.061Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-11-07T23:48:26.983Z] GC before operation: completed in 311.113 ms, heap usage 1.022 GB -> 114.705 MB. [2024-11-07T23:48:28.874Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2289.537 ms) ====== [2024-11-07T23:48:28.874Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-11-07T23:48:28.874Z] GC before operation: completed in 318.752 ms, heap usage 1.033 GB -> 115.097 MB. [2024-11-07T23:48:31.796Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2180.996 ms) ====== [2024-11-07T23:48:31.796Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-11-07T23:48:31.796Z] GC before operation: completed in 331.993 ms, heap usage 1.029 GB -> 115.539 MB. [2024-11-07T23:48:33.690Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2164.137 ms) ====== [2024-11-07T23:48:33.690Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-11-07T23:48:34.620Z] GC before operation: completed in 325.102 ms, heap usage 1.029 GB -> 116.001 MB. [2024-11-07T23:48:36.513Z] ====== log-regression (apache-spark) [default], iteration 11 completed (2164.201 ms) ====== [2024-11-07T23:48:36.513Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-11-07T23:48:36.513Z] GC before operation: completed in 322.961 ms, heap usage 1.032 GB -> 116.429 MB. [2024-11-07T23:48:38.405Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2110.116 ms) ====== [2024-11-07T23:48:38.405Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-11-07T23:48:39.327Z] GC before operation: completed in 370.523 ms, heap usage 1.032 GB -> 116.815 MB. [2024-11-07T23:48:41.218Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2157.118 ms) ====== [2024-11-07T23:48:41.218Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-11-07T23:48:41.218Z] GC before operation: completed in 343.069 ms, heap usage 1.054 GB -> 117.273 MB. [2024-11-07T23:48:44.139Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2001.367 ms) ====== [2024-11-07T23:48:44.139Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-11-07T23:48:44.139Z] GC before operation: completed in 308.193 ms, heap usage 1.038 GB -> 117.709 MB. [2024-11-07T23:48:46.032Z] ====== log-regression (apache-spark) [default], iteration 15 completed (2145.544 ms) ====== [2024-11-07T23:48:46.032Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-11-07T23:48:46.032Z] GC before operation: completed in 338.519 ms, heap usage 1.035 GB -> 118.175 MB. [2024-11-07T23:48:48.955Z] ====== log-regression (apache-spark) [default], iteration 16 completed (2107.398 ms) ====== [2024-11-07T23:48:48.955Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-11-07T23:48:48.956Z] GC before operation: completed in 311.541 ms, heap usage 1.038 GB -> 118.618 MB. [2024-11-07T23:48:50.846Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1942.629 ms) ====== [2024-11-07T23:48:50.846Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-11-07T23:48:50.846Z] GC before operation: completed in 332.885 ms, heap usage 1.036 GB -> 119.004 MB. [2024-11-07T23:48:52.740Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1929.561 ms) ====== [2024-11-07T23:48:52.740Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-11-07T23:48:53.661Z] GC before operation: completed in 316.295 ms, heap usage 1.034 GB -> 119.434 MB. [2024-11-07T23:48:55.554Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2000.269 ms) ====== [2024-11-07T23:48:55.554Z] ----------------------------------- [2024-11-07T23:48:55.554Z] renaissance-log-regression_0_PASSED [2024-11-07T23:48:55.554Z] ----------------------------------- [2024-11-07T23:48:55.554Z] [2024-11-07T23:48:55.554Z] TEST TEARDOWN: [2024-11-07T23:48:55.554Z] Nothing to be done for teardown. [2024-11-07T23:48:55.554Z] renaissance-log-regression_0 Finish Time: Thu Nov 7 23:48:55 2024 Epoch Time (ms): 1731023335459