[2024-11-28T22:06:27.723Z] Running test renaissance-log-regression_0 ... [2024-11-28T22:06:27.723Z] =============================================== [2024-11-28T22:06:27.723Z] renaissance-log-regression_0 Start Time: Thu Nov 28 22:06:27 2024 Epoch Time (ms): 1732831587515 [2024-11-28T22:06:27.723Z] variation: NoOptions [2024-11-28T22:06:27.724Z] JVM_OPTIONS: [2024-11-28T22:06:27.724Z] { \ [2024-11-28T22:06:27.724Z] echo ""; echo "TEST SETUP:"; \ [2024-11-28T22:06:27.724Z] echo "Nothing to be done for setup."; \ [2024-11-28T22:06:27.724Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17328306537033/renaissance-log-regression_0"; \ [2024-11-28T22:06:27.724Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17328306537033/renaissance-log-regression_0"; \ [2024-11-28T22:06:27.724Z] echo ""; echo "TESTING:"; \ [2024-11-28T22:06:27.724Z] "/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_17328306537033/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-11-28T22:06:27.724Z] 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_17328306537033/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-28T22:06:27.724Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-28T22:06:27.724Z] echo "Nothing to be done for teardown."; \ [2024-11-28T22:06:27.724Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17328306537033/TestTargetResult"; [2024-11-28T22:06:27.724Z] [2024-11-28T22:06:27.724Z] TEST SETUP: [2024-11-28T22:06:27.724Z] Nothing to be done for setup. [2024-11-28T22:06:27.724Z] [2024-11-28T22:06:27.724Z] TESTING: [2024-11-28T22:06:31.883Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-28T22:06:34.403Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-28T22:06:40.797Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-11-28T22:06:40.797Z] GC before operation: completed in 174.526 ms, heap usage 67.247 MB -> 25.658 MB. [2024-11-28T22:06:52.470Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11401.963 ms) ====== [2024-11-28T22:06:52.471Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-11-28T22:06:52.471Z] GC before operation: completed in 443.871 ms, heap usage 446.457 MB -> 101.431 MB. [2024-11-28T22:06:55.031Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2690.956 ms) ====== [2024-11-28T22:06:55.031Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-11-28T22:06:55.031Z] GC before operation: completed in 243.293 ms, heap usage 496.014 MB -> 102.667 MB. [2024-11-28T22:06:57.771Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2569.135 ms) ====== [2024-11-28T22:06:57.771Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-11-28T22:06:57.771Z] GC before operation: completed in 210.848 ms, heap usage 459.516 MB -> 102.950 MB. [2024-11-28T22:07:00.426Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2137.220 ms) ====== [2024-11-28T22:07:00.426Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-11-28T22:07:00.426Z] GC before operation: completed in 229.720 ms, heap usage 337.920 MB -> 102.158 MB. [2024-11-28T22:07:02.390Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2033.650 ms) ====== [2024-11-28T22:07:02.390Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-11-28T22:07:02.390Z] GC before operation: completed in 233.663 ms, heap usage 331.188 MB -> 102.372 MB. [2024-11-28T22:07:04.328Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2071.594 ms) ====== [2024-11-28T22:07:04.328Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-11-28T22:07:04.735Z] GC before operation: completed in 222.015 ms, heap usage 335.487 MB -> 102.668 MB. [2024-11-28T22:07:06.670Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1999.631 ms) ====== [2024-11-28T22:07:06.670Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-11-28T22:07:07.066Z] GC before operation: completed in 223.300 ms, heap usage 319.976 MB -> 102.778 MB. [2024-11-28T22:07:08.984Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1860.565 ms) ====== [2024-11-28T22:07:08.984Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-11-28T22:07:08.984Z] GC before operation: completed in 233.784 ms, heap usage 321.758 MB -> 103.041 MB. [2024-11-28T22:07:10.907Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1834.954 ms) ====== [2024-11-28T22:07:10.907Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-11-28T22:07:10.907Z] GC before operation: completed in 197.660 ms, heap usage 309.008 MB -> 103.309 MB. [2024-11-28T22:07:12.837Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1859.798 ms) ====== [2024-11-28T22:07:12.837Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-11-28T22:07:13.348Z] GC before operation: completed in 223.255 ms, heap usage 300.692 MB -> 103.415 MB. [2024-11-28T22:07:14.889Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1886.170 ms) ====== [2024-11-28T22:07:14.889Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-11-28T22:07:15.280Z] GC before operation: completed in 253.959 ms, heap usage 302.604 MB -> 103.678 MB. [2024-11-28T22:07:17.198Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1851.535 ms) ====== [2024-11-28T22:07:17.198Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-11-28T22:07:17.198Z] GC before operation: completed in 182.657 ms, heap usage 301.671 MB -> 103.886 MB. [2024-11-28T22:07:19.771Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2059.543 ms) ====== [2024-11-28T22:07:19.771Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-11-28T22:07:19.771Z] GC before operation: completed in 203.771 ms, heap usage 316.793 MB -> 104.247 MB. [2024-11-28T22:07:21.684Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1698.767 ms) ====== [2024-11-28T22:07:21.684Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-11-28T22:07:21.684Z] GC before operation: completed in 217.254 ms, heap usage 310.861 MB -> 104.500 MB. [2024-11-28T22:07:23.613Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1790.851 ms) ====== [2024-11-28T22:07:23.613Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-11-28T22:07:23.613Z] GC before operation: completed in 219.115 ms, heap usage 319.926 MB -> 104.743 MB. [2024-11-28T22:07:25.530Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1730.222 ms) ====== [2024-11-28T22:07:25.530Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-11-28T22:07:25.530Z] GC before operation: completed in 233.788 ms, heap usage 309.051 MB -> 104.978 MB. [2024-11-28T22:07:27.441Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1858.926 ms) ====== [2024-11-28T22:07:27.441Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-11-28T22:07:27.821Z] GC before operation: completed in 291.329 ms, heap usage 311.166 MB -> 105.289 MB. [2024-11-28T22:07:29.725Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1719.156 ms) ====== [2024-11-28T22:07:29.725Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-11-28T22:07:29.725Z] GC before operation: completed in 293.812 ms, heap usage 303.505 MB -> 105.355 MB. [2024-11-28T22:07:31.650Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1724.538 ms) ====== [2024-11-28T22:07:31.650Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-11-28T22:07:31.650Z] GC before operation: completed in 210.020 ms, heap usage 302.656 MB -> 105.589 MB. [2024-11-28T22:07:33.593Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1814.817 ms) ====== [2024-11-28T22:07:33.593Z] ----------------------------------- [2024-11-28T22:07:33.593Z] renaissance-log-regression_0_PASSED [2024-11-28T22:07:33.593Z] ----------------------------------- [2024-11-28T22:07:33.593Z] [2024-11-28T22:07:33.593Z] TEST TEARDOWN: [2024-11-28T22:07:33.593Z] Nothing to be done for teardown. [2024-11-28T22:07:33.973Z] renaissance-log-regression_0 Finish Time: Thu Nov 28 22:07:33 2024 Epoch Time (ms): 1732831653585