[2024-10-30T22:20:42.156Z] Running test renaissance-dec-tree_0 ... [2024-10-30T22:20:42.156Z] =============================================== [2024-10-30T22:20:42.156Z] renaissance-dec-tree_0 Start Time: Wed Oct 30 17:20:41 2024 Epoch Time (ms): 1730326841469 [2024-10-30T22:20:42.156Z] variation: NoOptions [2024-10-30T22:20:42.156Z] JVM_OPTIONS: [2024-10-30T22:20:42.156Z] { \ [2024-10-30T22:20:42.156Z] echo ""; echo "TEST SETUP:"; \ [2024-10-30T22:20:42.156Z] echo "Nothing to be done for setup."; \ [2024-10-30T22:20:42.156Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17303265957862/renaissance-dec-tree_0"; \ [2024-10-30T22:20:42.156Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17303265957862/renaissance-dec-tree_0"; \ [2024-10-30T22:20:42.156Z] echo ""; echo "TESTING:"; \ [2024-10-30T22:20:42.156Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-17.0.14+1/bin/..//bin/java" --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.util=ALL-UNNAMED --add-opens java.base/java.util.concurrent=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.base/java.lang.invoke=ALL-UNNAMED -jar "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17303265957862/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-30T22:20:42.156Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17303265957862/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-30T22:20:42.156Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-30T22:20:42.156Z] echo "Nothing to be done for teardown."; \ [2024-10-30T22:20:42.156Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17303265957862/TestTargetResult"; [2024-10-30T22:20:42.156Z] [2024-10-30T22:20:42.156Z] TEST SETUP: [2024-10-30T22:20:42.156Z] Nothing to be done for setup. [2024-10-30T22:20:42.156Z] [2024-10-30T22:20:42.156Z] TESTING: [2024-10-30T22:20:44.374Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-30T22:20:46.590Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-10-30T22:20:48.877Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-30T22:20:48.877Z] GC before operation: completed in 42.350 ms, heap usage 81.749 MB -> 35.745 MB. [2024-10-30T22:20:56.521Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6898.648 ms) ====== [2024-10-30T22:20:56.521Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-30T22:20:56.521Z] GC before operation: completed in 80.078 ms, heap usage 208.427 MB -> 65.296 MB. [2024-10-30T22:20:57.946Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1862.982 ms) ====== [2024-10-30T22:20:57.946Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-30T22:20:57.946Z] GC before operation: completed in 99.585 ms, heap usage 145.579 MB -> 65.274 MB. [2024-10-30T22:20:59.372Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1693.503 ms) ====== [2024-10-30T22:20:59.372Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-30T22:20:59.372Z] GC before operation: completed in 81.773 ms, heap usage 129.968 MB -> 76.483 MB. [2024-10-30T22:21:00.792Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1398.146 ms) ====== [2024-10-30T22:21:00.792Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-30T22:21:01.482Z] GC before operation: completed in 73.295 ms, heap usage 409.900 MB -> 66.153 MB. [2024-10-30T22:21:02.903Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1515.153 ms) ====== [2024-10-30T22:21:02.903Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-30T22:21:02.903Z] GC before operation: completed in 87.876 ms, heap usage 267.596 MB -> 88.466 MB. [2024-10-30T22:21:04.333Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1420.158 ms) ====== [2024-10-30T22:21:04.333Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-30T22:21:04.333Z] GC before operation: completed in 74.681 ms, heap usage 320.015 MB -> 83.063 MB. [2024-10-30T22:21:05.752Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1428.097 ms) ====== [2024-10-30T22:21:05.752Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-30T22:21:05.752Z] GC before operation: completed in 109.300 ms, heap usage 377.300 MB -> 77.637 MB. [2024-10-30T22:21:07.260Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1652.709 ms) ====== [2024-10-30T22:21:07.260Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-30T22:21:07.260Z] GC before operation: completed in 83.393 ms, heap usage 418.256 MB -> 78.019 MB. [2024-10-30T22:21:08.699Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1396.336 ms) ====== [2024-10-30T22:21:08.699Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-30T22:21:08.699Z] GC before operation: completed in 81.312 ms, heap usage 156.452 MB -> 66.731 MB. [2024-10-30T22:21:10.233Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1395.050 ms) ====== [2024-10-30T22:21:10.233Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-30T22:21:10.233Z] GC before operation: completed in 89.859 ms, heap usage 202.903 MB -> 94.850 MB. [2024-10-30T22:21:11.689Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1299.145 ms) ====== [2024-10-30T22:21:11.689Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-30T22:21:11.689Z] GC before operation: completed in 88.952 ms, heap usage 293.781 MB -> 78.193 MB. [2024-10-30T22:21:13.114Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1308.665 ms) ====== [2024-10-30T22:21:13.114Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-30T22:21:13.114Z] GC before operation: completed in 85.397 ms, heap usage 154.090 MB -> 67.210 MB. [2024-10-30T22:21:15.325Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1604.945 ms) ====== [2024-10-30T22:21:15.325Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-30T22:21:15.325Z] GC before operation: completed in 96.290 ms, heap usage 169.668 MB -> 78.165 MB. [2024-10-30T22:21:16.757Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1452.067 ms) ====== [2024-10-30T22:21:16.757Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-30T22:21:16.757Z] GC before operation: completed in 94.573 ms, heap usage 411.496 MB -> 78.878 MB. [2024-10-30T22:21:18.182Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1621.641 ms) ====== [2024-10-30T22:21:18.182Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-30T22:21:18.182Z] GC before operation: completed in 99.190 ms, heap usage 404.436 MB -> 67.877 MB. [2024-10-30T22:21:19.610Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1515.686 ms) ====== [2024-10-30T22:21:19.610Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-30T22:21:19.610Z] GC before operation: completed in 91.810 ms, heap usage 215.735 MB -> 84.348 MB. [2024-10-30T22:21:21.829Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1613.056 ms) ====== [2024-10-30T22:21:21.829Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-30T22:21:21.829Z] GC before operation: completed in 96.759 ms, heap usage 356.006 MB -> 67.962 MB. [2024-10-30T22:21:23.252Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1351.437 ms) ====== [2024-10-30T22:21:23.252Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-30T22:21:23.252Z] GC before operation: completed in 89.542 ms, heap usage 209.855 MB -> 96.024 MB. [2024-10-30T22:21:24.680Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1455.149 ms) ====== [2024-10-30T22:21:24.680Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-30T22:21:24.680Z] GC before operation: completed in 98.720 ms, heap usage 278.525 MB -> 84.536 MB. [2024-10-30T22:21:26.103Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1415.035 ms) ====== [2024-10-30T22:21:26.104Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-30T22:21:26.104Z] GC before operation: completed in 100.793 ms, heap usage 363.368 MB -> 90.342 MB. [2024-10-30T22:21:27.524Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1287.754 ms) ====== [2024-10-30T22:21:27.524Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-30T22:21:27.524Z] GC before operation: completed in 122.606 ms, heap usage 298.524 MB -> 85.083 MB. [2024-10-30T22:21:28.947Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1463.982 ms) ====== [2024-10-30T22:21:28.947Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-30T22:21:28.947Z] GC before operation: completed in 98.970 ms, heap usage 332.092 MB -> 96.294 MB. [2024-10-30T22:21:30.370Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1275.414 ms) ====== [2024-10-30T22:21:30.370Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-30T22:21:30.370Z] GC before operation: completed in 111.847 ms, heap usage 245.320 MB -> 79.712 MB. [2024-10-30T22:21:31.850Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1253.789 ms) ====== [2024-10-30T22:21:31.850Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-30T22:21:31.850Z] GC before operation: completed in 107.047 ms, heap usage 449.562 MB -> 85.449 MB. [2024-10-30T22:21:33.276Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1434.146 ms) ====== [2024-10-30T22:21:33.276Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-30T22:21:33.276Z] GC before operation: completed in 115.665 ms, heap usage 339.547 MB -> 96.461 MB. [2024-10-30T22:21:34.697Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1509.255 ms) ====== [2024-10-30T22:21:34.697Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-30T22:21:34.697Z] GC before operation: completed in 100.366 ms, heap usage 230.204 MB -> 68.861 MB. [2024-10-30T22:21:36.125Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1228.924 ms) ====== [2024-10-30T22:21:36.125Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-30T22:21:36.125Z] GC before operation: completed in 100.415 ms, heap usage 252.493 MB -> 96.807 MB. [2024-10-30T22:21:37.669Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1532.709 ms) ====== [2024-10-30T22:21:37.669Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-30T22:21:37.669Z] GC before operation: completed in 107.268 ms, heap usage 270.236 MB -> 79.992 MB. [2024-10-30T22:21:39.125Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1393.245 ms) ====== [2024-10-30T22:21:39.125Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-30T22:21:39.840Z] GC before operation: completed in 117.800 ms, heap usage 437.155 MB -> 97.028 MB. [2024-10-30T22:21:40.525Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1216.135 ms) ====== [2024-10-30T22:21:40.525Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-30T22:21:40.525Z] GC before operation: completed in 98.541 ms, heap usage 235.106 MB -> 69.315 MB. [2024-10-30T22:21:41.962Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1389.934 ms) ====== [2024-10-30T22:21:41.962Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-30T22:21:41.962Z] GC before operation: completed in 93.938 ms, heap usage 204.399 MB -> 80.721 MB. [2024-10-30T22:21:43.386Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1316.481 ms) ====== [2024-10-30T22:21:43.386Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-30T22:21:43.386Z] GC before operation: completed in 120.114 ms, heap usage 441.902 MB -> 91.764 MB. [2024-10-30T22:21:44.814Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1188.005 ms) ====== [2024-10-30T22:21:44.814Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-30T22:21:44.814Z] GC before operation: completed in 123.417 ms, heap usage 266.967 MB -> 69.808 MB. [2024-10-30T22:21:46.267Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1270.932 ms) ====== [2024-10-30T22:21:46.267Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-30T22:21:46.267Z] GC before operation: completed in 110.102 ms, heap usage 176.767 MB -> 69.506 MB. [2024-10-30T22:21:47.688Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1297.844 ms) ====== [2024-10-30T22:21:47.688Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-30T22:21:47.688Z] GC before operation: completed in 95.642 ms, heap usage 111.127 MB -> 80.170 MB. [2024-10-30T22:21:49.109Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1427.343 ms) ====== [2024-10-30T22:21:49.109Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-30T22:21:49.109Z] GC before operation: completed in 113.738 ms, heap usage 269.182 MB -> 86.484 MB. [2024-10-30T22:21:50.541Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1465.812 ms) ====== [2024-10-30T22:21:50.541Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-30T22:21:51.232Z] GC before operation: completed in 110.060 ms, heap usage 355.074 MB -> 80.893 MB. [2024-10-30T22:21:51.920Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1280.795 ms) ====== [2024-10-30T22:21:51.920Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-30T22:21:52.606Z] GC before operation: completed in 118.625 ms, heap usage 373.891 MB -> 86.411 MB. [2024-10-30T22:21:54.036Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1525.001 ms) ====== [2024-10-30T22:21:54.036Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-30T22:21:54.036Z] GC before operation: completed in 105.894 ms, heap usage 322.512 MB -> 81.510 MB. [2024-10-30T22:21:55.456Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1221.893 ms) ====== [2024-10-30T22:21:55.456Z] ----------------------------------- [2024-10-30T22:21:55.456Z] renaissance-dec-tree_0_PASSED [2024-10-30T22:21:55.456Z] ----------------------------------- [2024-10-30T22:21:55.456Z] [2024-10-30T22:21:55.456Z] TEST TEARDOWN: [2024-10-30T22:21:55.456Z] Nothing to be done for teardown. [2024-10-30T22:21:55.456Z] renaissance-dec-tree_0 Finish Time: Wed Oct 30 17:21:55 2024 Epoch Time (ms): 1730326915254