[2023-04-19T09:26:04.981Z] Running test renaissance-log-regression_0 ... [2023-04-19T09:26:04.981Z] =============================================== [2023-04-19T09:26:04.981Z] renaissance-log-regression_0 Start Time: Wed Apr 19 09:26:04 2023 Epoch Time (ms): 1681896364826 [2023-04-19T09:26:04.981Z] variation: NoOptions [2023-04-19T09:26:04.981Z] JVM_OPTIONS: [2023-04-19T09:26:04.981Z] { \ [2023-04-19T09:26:04.981Z] echo ""; echo "TEST SETUP:"; \ [2023-04-19T09:26:04.981Z] echo "Nothing to be done for setup."; \ [2023-04-19T09:26:04.981Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_16818954038537/renaissance-log-regression_0"; \ [2023-04-19T09:26:04.981Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_16818954038537/renaissance-log-regression_0"; \ [2023-04-19T09:26:04.981Z] echo ""; echo "TESTING:"; \ [2023-04-19T09:26:04.981Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/openjdkbinary/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_16818954038537/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2023-04-19T09:26:04.981Z] 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_16818954038537/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2023-04-19T09:26:04.981Z] echo ""; echo "TEST TEARDOWN:"; \ [2023-04-19T09:26:04.981Z] echo "Nothing to be done for teardown."; \ [2023-04-19T09:26:04.981Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_16818954038537/TestTargetResult"; [2023-04-19T09:26:04.981Z] [2023-04-19T09:26:04.981Z] TEST SETUP: [2023-04-19T09:26:04.981Z] Nothing to be done for setup. [2023-04-19T09:26:04.981Z] [2023-04-19T09:26:04.981Z] TESTING: [2023-04-19T09:26:08.989Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2023-04-19T09:26:12.173Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2023-04-19T09:26:17.223Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2023-04-19T09:26:17.584Z] GC before operation: completed in 170.815 ms, heap usage 59.051 MB -> 24.492 MB. [2023-04-19T09:26:28.965Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11278.801 ms) ====== [2023-04-19T09:26:28.965Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2023-04-19T09:26:28.965Z] GC before operation: completed in 371.090 ms, heap usage 555.219 MB -> 102.227 MB. [2023-04-19T09:26:32.247Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3024.731 ms) ====== [2023-04-19T09:26:32.247Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2023-04-19T09:26:32.247Z] GC before operation: completed in 252.349 ms, heap usage 532.926 MB -> 102.891 MB. [2023-04-19T09:26:34.767Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2391.355 ms) ====== [2023-04-19T09:26:34.767Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2023-04-19T09:26:35.136Z] GC before operation: completed in 186.722 ms, heap usage 480.894 MB -> 103.048 MB. [2023-04-19T09:26:37.634Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2207.688 ms) ====== [2023-04-19T09:26:37.634Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2023-04-19T09:26:37.634Z] GC before operation: completed in 204.651 ms, heap usage 341.775 MB -> 102.139 MB. [2023-04-19T09:26:39.513Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2181.332 ms) ====== [2023-04-19T09:26:39.513Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2023-04-19T09:26:39.897Z] GC before operation: completed in 221.213 ms, heap usage 336.348 MB -> 102.371 MB. [2023-04-19T09:26:41.821Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2136.347 ms) ====== [2023-04-19T09:26:41.821Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2023-04-19T09:26:42.236Z] GC before operation: completed in 186.687 ms, heap usage 329.225 MB -> 102.587 MB. [2023-04-19T09:26:44.221Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2060.116 ms) ====== [2023-04-19T09:26:44.221Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2023-04-19T09:26:44.221Z] GC before operation: completed in 207.077 ms, heap usage 325.280 MB -> 102.782 MB. [2023-04-19T09:26:46.706Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1931.862 ms) ====== [2023-04-19T09:26:46.707Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2023-04-19T09:26:46.707Z] GC before operation: completed in 208.069 ms, heap usage 318.985 MB -> 103.040 MB. [2023-04-19T09:26:48.618Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1915.792 ms) ====== [2023-04-19T09:26:48.619Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2023-04-19T09:26:48.619Z] GC before operation: completed in 205.052 ms, heap usage 318.179 MB -> 103.261 MB. [2023-04-19T09:26:50.578Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1907.578 ms) ====== [2023-04-19T09:26:50.578Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2023-04-19T09:26:50.578Z] GC before operation: completed in 189.142 ms, heap usage 321.290 MB -> 103.512 MB. [2023-04-19T09:26:53.229Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1960.864 ms) ====== [2023-04-19T09:26:53.229Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2023-04-19T09:26:53.229Z] GC before operation: completed in 274.146 ms, heap usage 320.365 MB -> 103.746 MB. [2023-04-19T09:26:55.139Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1878.222 ms) ====== [2023-04-19T09:26:55.139Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2023-04-19T09:26:55.139Z] GC before operation: completed in 179.082 ms, heap usage 308.544 MB -> 104.002 MB. [2023-04-19T09:26:57.039Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2080.060 ms) ====== [2023-04-19T09:26:57.039Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2023-04-19T09:26:57.448Z] GC before operation: completed in 193.385 ms, heap usage 308.621 MB -> 104.199 MB. [2023-04-19T09:26:59.349Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1780.079 ms) ====== [2023-04-19T09:26:59.349Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2023-04-19T09:26:59.349Z] GC before operation: completed in 214.080 ms, heap usage 314.262 MB -> 104.440 MB. [2023-04-19T09:27:01.259Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1776.276 ms) ====== [2023-04-19T09:27:01.259Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2023-04-19T09:27:01.260Z] GC before operation: completed in 212.274 ms, heap usage 304.203 MB -> 104.616 MB. [2023-04-19T09:27:03.230Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1802.032 ms) ====== [2023-04-19T09:27:03.230Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2023-04-19T09:27:03.230Z] GC before operation: completed in 195.700 ms, heap usage 302.969 MB -> 104.852 MB. [2023-04-19T09:27:05.150Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1887.060 ms) ====== [2023-04-19T09:27:05.150Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2023-04-19T09:27:05.521Z] GC before operation: completed in 183.846 ms, heap usage 302.430 MB -> 105.171 MB. [2023-04-19T09:27:07.409Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1781.462 ms) ====== [2023-04-19T09:27:07.409Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2023-04-19T09:27:07.409Z] GC before operation: completed in 174.887 ms, heap usage 309.868 MB -> 105.468 MB. [2023-04-19T09:27:09.329Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1776.471 ms) ====== [2023-04-19T09:27:09.329Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2023-04-19T09:27:09.329Z] GC before operation: completed in 169.685 ms, heap usage 319.405 MB -> 105.721 MB. [2023-04-19T09:27:11.221Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1829.213 ms) ====== [2023-04-19T09:27:11.592Z] ----------------------------------- [2023-04-19T09:27:11.592Z] renaissance-log-regression_0_PASSED [2023-04-19T09:27:11.592Z] ----------------------------------- [2023-04-19T09:27:11.592Z] [2023-04-19T09:27:11.592Z] TEST TEARDOWN: [2023-04-19T09:27:11.592Z] Nothing to be done for teardown. [2023-04-19T09:27:11.592Z] renaissance-log-regression_0 Finish Time: Wed Apr 19 09:27:11 2023 Epoch Time (ms): 1681896431276