[2024-10-29T22:32:18.254Z] Running test renaissance-log-regression_0 ... [2024-10-29T22:32:18.254Z] =============================================== [2024-10-29T22:32:18.941Z] renaissance-log-regression_0 Start Time: Tue Oct 29 17:32:18 2024 Epoch Time (ms): 1730241138204 [2024-10-29T22:32:18.941Z] variation: NoOptions [2024-10-29T22:32:18.941Z] JVM_OPTIONS: [2024-10-29T22:32:18.941Z] { \ [2024-10-29T22:32:18.941Z] echo ""; echo "TEST SETUP:"; \ [2024-10-29T22:32:18.941Z] echo "Nothing to be done for setup."; \ [2024-10-29T22:32:18.941Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-log-regression_0"; \ [2024-10-29T22:32:18.941Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-log-regression_0"; \ [2024-10-29T22:32:18.941Z] echo ""; echo "TESTING:"; \ [2024-10-29T22:32:18.941Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk8u442-b01/bin/..//bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-10-29T22:32:18.941Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-29T22:32:18.941Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-29T22:32:18.941Z] echo "Nothing to be done for teardown."; \ [2024-10-29T22:32:18.941Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17302404021562/TestTargetResult"; [2024-10-29T22:32:18.941Z] [2024-10-29T22:32:18.941Z] TEST SETUP: [2024-10-29T22:32:18.941Z] Nothing to be done for setup. [2024-10-29T22:32:18.941Z] [2024-10-29T22:32:18.941Z] TESTING: [2024-10-29T22:32:22.033Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-29T22:32:23.493Z] NOTE: 'log-regression' benchmark uses Spark local executor with 8 (out of 8) threads. [2024-10-29T22:32:27.534Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-10-29T22:32:27.534Z] GC before operation: completed in 180.223 ms, heap usage 70.191 MB -> 26.991 MB. [2024-10-29T22:32:36.745Z] ====== log-regression (apache-spark) [default], iteration 0 completed (8925.167 ms) ====== [2024-10-29T22:32:36.745Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-10-29T22:32:36.745Z] GC before operation: completed in 367.783 ms, heap usage 561.973 MB -> 107.531 MB. [2024-10-29T22:32:38.989Z] ====== log-regression (apache-spark) [default], iteration 1 completed (2197.705 ms) ====== [2024-10-29T22:32:38.989Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-10-29T22:32:38.989Z] GC before operation: completed in 320.351 ms, heap usage 322.049 MB -> 105.923 MB. [2024-10-29T22:32:41.215Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1857.037 ms) ====== [2024-10-29T22:32:41.215Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-10-29T22:32:41.215Z] GC before operation: completed in 236.099 ms, heap usage 278.290 MB -> 106.045 MB. [2024-10-29T22:32:43.463Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1744.597 ms) ====== [2024-10-29T22:32:43.463Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-10-29T22:32:43.463Z] GC before operation: completed in 239.362 ms, heap usage 299.863 MB -> 106.732 MB. [2024-10-29T22:32:44.889Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1784.842 ms) ====== [2024-10-29T22:32:44.889Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-10-29T22:32:45.580Z] GC before operation: completed in 244.395 ms, heap usage 257.059 MB -> 106.725 MB. [2024-10-29T22:32:47.029Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1672.481 ms) ====== [2024-10-29T22:32:47.029Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-10-29T22:32:47.029Z] GC before operation: completed in 221.164 ms, heap usage 383.621 MB -> 108.487 MB. [2024-10-29T22:32:49.263Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1809.812 ms) ====== [2024-10-29T22:32:49.263Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-10-29T22:32:49.263Z] GC before operation: completed in 227.892 ms, heap usage 428.770 MB -> 109.380 MB. [2024-10-29T22:32:50.690Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1746.138 ms) ====== [2024-10-29T22:32:50.690Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-10-29T22:32:51.387Z] GC before operation: completed in 208.330 ms, heap usage 467.054 MB -> 110.303 MB. [2024-10-29T22:32:52.812Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1730.382 ms) ====== [2024-10-29T22:32:52.812Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-10-29T22:32:52.812Z] GC before operation: completed in 229.482 ms, heap usage 410.835 MB -> 110.085 MB. [2024-10-29T22:32:55.052Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1692.501 ms) ====== [2024-10-29T22:32:55.052Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-10-29T22:32:55.052Z] GC before operation: completed in 221.857 ms, heap usage 316.932 MB -> 109.505 MB. [2024-10-29T22:32:56.476Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1664.328 ms) ====== [2024-10-29T22:32:56.476Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-10-29T22:32:57.169Z] GC before operation: completed in 185.102 ms, heap usage 235.360 MB -> 109.270 MB. [2024-10-29T22:32:58.611Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1629.599 ms) ====== [2024-10-29T22:32:58.611Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-10-29T22:32:58.611Z] GC before operation: completed in 243.459 ms, heap usage 218.423 MB -> 109.286 MB. [2024-10-29T22:33:00.040Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1575.684 ms) ====== [2024-10-29T22:33:00.040Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-10-29T22:33:00.728Z] GC before operation: completed in 166.284 ms, heap usage 335.236 MB -> 111.066 MB. [2024-10-29T22:33:02.174Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1625.771 ms) ====== [2024-10-29T22:33:02.174Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-10-29T22:33:02.174Z] GC before operation: completed in 232.497 ms, heap usage 428.829 MB -> 112.441 MB. [2024-10-29T22:33:04.411Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1632.710 ms) ====== [2024-10-29T22:33:04.411Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-10-29T22:33:04.411Z] GC before operation: completed in 239.679 ms, heap usage 455.277 MB -> 113.148 MB. [2024-10-29T22:33:05.842Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1685.804 ms) ====== [2024-10-29T22:33:05.842Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-10-29T22:33:06.544Z] GC before operation: completed in 284.595 ms, heap usage 471.811 MB -> 113.869 MB. [2024-10-29T22:33:07.968Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1760.358 ms) ====== [2024-10-29T22:33:07.968Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-10-29T22:33:07.968Z] GC before operation: completed in 204.844 ms, heap usage 356.593 MB -> 112.944 MB. [2024-10-29T22:33:10.194Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1614.468 ms) ====== [2024-10-29T22:33:10.194Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-10-29T22:33:10.194Z] GC before operation: completed in 184.505 ms, heap usage 277.892 MB -> 112.645 MB. [2024-10-29T22:33:11.636Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1591.227 ms) ====== [2024-10-29T22:33:11.636Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-10-29T22:33:11.636Z] GC before operation: completed in 211.620 ms, heap usage 211.881 MB -> 112.341 MB. [2024-10-29T22:33:13.857Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1679.880 ms) ====== [2024-10-29T22:33:13.857Z] ----------------------------------- [2024-10-29T22:33:13.857Z] renaissance-log-regression_0_PASSED [2024-10-29T22:33:13.857Z] ----------------------------------- [2024-10-29T22:33:13.857Z] [2024-10-29T22:33:13.857Z] TEST TEARDOWN: [2024-10-29T22:33:13.857Z] Nothing to be done for teardown. [2024-10-29T22:33:13.857Z] renaissance-log-regression_0 Finish Time: Tue Oct 29 17:33:13 2024 Epoch Time (ms): 1730241193545