[2025-01-07T21:56:33.854Z] Running test renaissance-log-regression_0 ... [2025-01-07T21:56:33.854Z] =============================================== [2025-01-07T21:56:33.854Z] renaissance-log-regression_0 Start Time: Tue Jan 7 21:56:33 2025 Epoch Time (ms): 1736286993495 [2025-01-07T21:56:33.854Z] variation: NoOptions [2025-01-07T21:56:33.854Z] JVM_OPTIONS: [2025-01-07T21:56:33.854Z] { \ [2025-01-07T21:56:33.854Z] echo ""; echo "TEST SETUP:"; \ [2025-01-07T21:56:33.854Z] echo "Nothing to be done for setup."; \ [2025-01-07T21:56:33.854Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17362860424424/renaissance-log-regression_0"; \ [2025-01-07T21:56:33.854Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17362860424424/renaissance-log-regression_0"; \ [2025-01-07T21:56:33.854Z] echo ""; echo "TESTING:"; \ [2025-01-07T21:56:33.854Z] "/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_17362860424424/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-01-07T21:56:33.854Z] 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_17362860424424/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-07T21:56:33.854Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-07T21:56:33.854Z] echo "Nothing to be done for teardown."; \ [2025-01-07T21:56:33.854Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_aarch64_linux/aqa-tests/TKG/../TKG/output_17362860424424/TestTargetResult"; [2025-01-07T21:56:33.854Z] [2025-01-07T21:56:33.855Z] TEST SETUP: [2025-01-07T21:56:33.855Z] Nothing to be done for setup. [2025-01-07T21:56:33.855Z] [2025-01-07T21:56:33.855Z] TESTING: [2025-01-07T21:56:37.959Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-07T21:56:40.464Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-01-07T21:56:46.778Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-01-07T21:56:46.778Z] GC before operation: completed in 157.248 ms, heap usage 72.061 MB -> 25.964 MB. [2025-01-07T21:56:58.414Z] ====== log-regression (apache-spark) [default], iteration 0 completed (11545.476 ms) ====== [2025-01-07T21:56:58.414Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-01-07T21:56:58.414Z] GC before operation: completed in 355.413 ms, heap usage 533.769 MB -> 102.089 MB. [2025-01-07T21:57:00.998Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2876.342 ms) ====== [2025-01-07T21:57:00.998Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-01-07T21:57:00.998Z] GC before operation: completed in 261.601 ms, heap usage 463.874 MB -> 102.250 MB. [2025-01-07T21:57:03.562Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2469.088 ms) ====== [2025-01-07T21:57:03.562Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-01-07T21:57:03.961Z] GC before operation: completed in 235.475 ms, heap usage 416.052 MB -> 102.520 MB. [2025-01-07T21:57:06.537Z] ====== log-regression (apache-spark) [default], iteration 3 completed (2240.260 ms) ====== [2025-01-07T21:57:06.537Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-01-07T21:57:06.537Z] GC before operation: completed in 242.347 ms, heap usage 309.752 MB -> 101.867 MB. [2025-01-07T21:57:08.402Z] ====== log-regression (apache-spark) [default], iteration 4 completed (2069.546 ms) ====== [2025-01-07T21:57:08.402Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-01-07T21:57:08.792Z] GC before operation: completed in 231.787 ms, heap usage 315.330 MB -> 102.271 MB. [2025-01-07T21:57:10.691Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2096.133 ms) ====== [2025-01-07T21:57:10.691Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-01-07T21:57:11.082Z] GC before operation: completed in 216.688 ms, heap usage 325.951 MB -> 102.577 MB. [2025-01-07T21:57:12.975Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1967.460 ms) ====== [2025-01-07T21:57:12.975Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-01-07T21:57:12.975Z] GC before operation: completed in 188.776 ms, heap usage 323.888 MB -> 102.866 MB. [2025-01-07T21:57:15.506Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1921.307 ms) ====== [2025-01-07T21:57:15.506Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-01-07T21:57:15.506Z] GC before operation: completed in 212.210 ms, heap usage 327.936 MB -> 103.184 MB. [2025-01-07T21:57:17.392Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1864.585 ms) ====== [2025-01-07T21:57:17.392Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-01-07T21:57:17.392Z] GC before operation: completed in 187.646 ms, heap usage 335.830 MB -> 103.458 MB. [2025-01-07T21:57:19.337Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1840.427 ms) ====== [2025-01-07T21:57:19.337Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-01-07T21:57:19.337Z] GC before operation: completed in 218.528 ms, heap usage 334.734 MB -> 103.710 MB. [2025-01-07T21:57:21.212Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1974.793 ms) ====== [2025-01-07T21:57:21.212Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-01-07T21:57:21.611Z] GC before operation: completed in 258.285 ms, heap usage 329.767 MB -> 103.903 MB. [2025-01-07T21:57:23.532Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1861.561 ms) ====== [2025-01-07T21:57:23.532Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-01-07T21:57:23.532Z] GC before operation: completed in 235.461 ms, heap usage 322.139 MB -> 104.061 MB. [2025-01-07T21:57:26.055Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1988.401 ms) ====== [2025-01-07T21:57:26.055Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-01-07T21:57:26.055Z] GC before operation: completed in 226.972 ms, heap usage 321.085 MB -> 104.288 MB. [2025-01-07T21:57:27.490Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1716.898 ms) ====== [2025-01-07T21:57:27.490Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-01-07T21:57:27.930Z] GC before operation: completed in 236.571 ms, heap usage 308.499 MB -> 104.499 MB. [2025-01-07T21:57:29.928Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1740.963 ms) ====== [2025-01-07T21:57:29.928Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-01-07T21:57:29.928Z] GC before operation: completed in 224.571 ms, heap usage 324.109 MB -> 104.741 MB. [2025-01-07T21:57:31.926Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1796.141 ms) ====== [2025-01-07T21:57:31.926Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-01-07T21:57:31.926Z] GC before operation: completed in 239.826 ms, heap usage 324.254 MB -> 105.053 MB. [2025-01-07T21:57:33.821Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1989.141 ms) ====== [2025-01-07T21:57:33.821Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-01-07T21:57:34.212Z] GC before operation: completed in 275.369 ms, heap usage 314.775 MB -> 105.337 MB. [2025-01-07T21:57:36.120Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1716.684 ms) ====== [2025-01-07T21:57:36.120Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-01-07T21:57:36.120Z] GC before operation: completed in 280.793 ms, heap usage 325.615 MB -> 105.495 MB. [2025-01-07T21:57:38.140Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1718.411 ms) ====== [2025-01-07T21:57:38.140Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-01-07T21:57:38.140Z] GC before operation: completed in 218.988 ms, heap usage 331.584 MB -> 105.888 MB. [2025-01-07T21:57:40.071Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1780.192 ms) ====== [2025-01-07T21:57:40.071Z] ----------------------------------- [2025-01-07T21:57:40.071Z] renaissance-log-regression_0_PASSED [2025-01-07T21:57:40.071Z] ----------------------------------- [2025-01-07T21:57:40.071Z] [2025-01-07T21:57:40.071Z] TEST TEARDOWN: [2025-01-07T21:57:40.071Z] Nothing to be done for teardown. [2025-01-07T21:57:40.071Z] renaissance-log-regression_0 Finish Time: Tue Jan 7 21:57:40 2025 Epoch Time (ms): 1736287060042