[2024-12-05T02:22:01.794Z] Running test renaissance-dec-tree_0 ... [2024-12-05T02:22:01.794Z] =============================================== [2024-12-05T02:22:02.433Z] renaissance-dec-tree_0 Start Time: Thu Dec 5 02:22:01 2024 Epoch Time (ms): 1733365321764 [2024-12-05T02:22:02.433Z] variation: NoOptions [2024-12-05T02:22:02.433Z] JVM_OPTIONS: [2024-12-05T02:22:02.433Z] { \ [2024-12-05T02:22:02.433Z] echo ""; echo "TEST SETUP:"; \ [2024-12-05T02:22:02.433Z] echo "Nothing to be done for setup."; \ [2024-12-05T02:22:02.433Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17333621009543/renaissance-dec-tree_0"; \ [2024-12-05T02:22:02.433Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17333621009543/renaissance-dec-tree_0"; \ [2024-12-05T02:22:02.433Z] echo ""; echo "TESTING:"; \ [2024-12-05T02:22:02.433Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/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_17333621009543/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-12-05T02:22:02.433Z] 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_17333621009543/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-12-05T02:22:02.433Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-12-05T02:22:02.433Z] echo "Nothing to be done for teardown."; \ [2024-12-05T02:22:02.433Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17333621009543/TestTargetResult"; [2024-12-05T02:22:02.434Z] [2024-12-05T02:22:02.434Z] TEST SETUP: [2024-12-05T02:22:02.434Z] Nothing to be done for setup. [2024-12-05T02:22:02.434Z] [2024-12-05T02:22:02.434Z] TESTING: [2024-12-05T02:22:22.747Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-12-05T02:22:46.670Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-12-05T02:23:20.444Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-12-05T02:23:20.444Z] GC before operation: completed in 466.334 ms, heap usage 57.760 MB -> 35.143 MB. [2024-12-05T02:24:51.374Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (92596.424 ms) ====== [2024-12-05T02:24:51.374Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-12-05T02:24:52.080Z] GC before operation: completed in 980.312 ms, heap usage 238.116 MB -> 64.610 MB. [2024-12-05T02:25:25.600Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (31021.830 ms) ====== [2024-12-05T02:25:25.600Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-12-05T02:25:25.600Z] GC before operation: completed in 775.590 ms, heap usage 263.947 MB -> 65.367 MB. [2024-12-05T02:25:54.300Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (27729.552 ms) ====== [2024-12-05T02:25:54.300Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-12-05T02:25:54.300Z] GC before operation: completed in 781.565 ms, heap usage 234.363 MB -> 65.114 MB. [2024-12-05T02:26:15.189Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (22995.693 ms) ====== [2024-12-05T02:26:15.189Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-12-05T02:26:15.917Z] GC before operation: completed in 682.556 ms, heap usage 144.733 MB -> 65.283 MB. [2024-12-05T02:26:40.227Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (21596.938 ms) ====== [2024-12-05T02:26:40.227Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-12-05T02:26:40.227Z] GC before operation: completed in 732.330 ms, heap usage 337.037 MB -> 76.689 MB. [2024-12-05T02:27:01.179Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (20678.821 ms) ====== [2024-12-05T02:27:01.179Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-12-05T02:27:01.179Z] GC before operation: completed in 901.385 ms, heap usage 357.246 MB -> 65.782 MB. [2024-12-05T02:27:18.797Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (18680.579 ms) ====== [2024-12-05T02:27:18.797Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-12-05T02:27:19.479Z] GC before operation: completed in 952.886 ms, heap usage 193.989 MB -> 66.246 MB. [2024-12-05T02:27:37.317Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (17509.449 ms) ====== [2024-12-05T02:27:37.317Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-12-05T02:27:38.099Z] GC before operation: completed in 786.847 ms, heap usage 210.314 MB -> 66.264 MB. [2024-12-05T02:27:55.681Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (15901.878 ms) ====== [2024-12-05T02:27:55.681Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-12-05T02:27:55.681Z] GC before operation: completed in 759.059 ms, heap usage 224.263 MB -> 66.656 MB. [2024-12-05T02:28:11.635Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (17013.601 ms) ====== [2024-12-05T02:28:11.635Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-12-05T02:28:12.297Z] GC before operation: completed in 842.541 ms, heap usage 329.264 MB -> 66.919 MB. [2024-12-05T02:28:29.695Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (15438.884 ms) ====== [2024-12-05T02:28:29.695Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-12-05T02:28:29.695Z] GC before operation: completed in 858.824 ms, heap usage 342.330 MB -> 66.510 MB. [2024-12-05T02:28:47.184Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (17426.421 ms) ====== [2024-12-05T02:28:47.184Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-12-05T02:28:47.184Z] GC before operation: completed in 873.273 ms, heap usage 339.357 MB -> 66.763 MB. [2024-12-05T02:29:04.822Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (16027.179 ms) ====== [2024-12-05T02:29:04.822Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-12-05T02:29:04.822Z] GC before operation: completed in 731.356 ms, heap usage 300.712 MB -> 77.816 MB. [2024-12-05T02:29:19.506Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (13810.895 ms) ====== [2024-12-05T02:29:19.506Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-12-05T02:29:19.506Z] GC before operation: completed in 913.594 ms, heap usage 177.401 MB -> 66.837 MB. [2024-12-05T02:29:31.995Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (13332.125 ms) ====== [2024-12-05T02:29:31.995Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-12-05T02:29:32.636Z] GC before operation: completed in 768.617 ms, heap usage 328.820 MB -> 83.618 MB. [2024-12-05T02:29:47.336Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (13877.873 ms) ====== [2024-12-05T02:29:47.336Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-12-05T02:29:47.336Z] GC before operation: completed in 1042.140 ms, heap usage 420.856 MB -> 67.291 MB. [2024-12-05T02:30:02.142Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (13972.948 ms) ====== [2024-12-05T02:30:02.142Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-12-05T02:30:02.818Z] GC before operation: completed in 924.538 ms, heap usage 299.968 MB -> 67.200 MB. [2024-12-05T02:30:17.886Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (15023.343 ms) ====== [2024-12-05T02:30:17.886Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-12-05T02:30:18.567Z] GC before operation: completed in 1083.866 ms, heap usage 297.978 MB -> 67.485 MB. [2024-12-05T02:30:33.329Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (14397.858 ms) ====== [2024-12-05T02:30:33.329Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-12-05T02:30:34.032Z] GC before operation: completed in 1230.711 ms, heap usage 297.931 MB -> 67.400 MB. [2024-12-05T02:30:51.455Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (15050.982 ms) ====== [2024-12-05T02:30:51.456Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-12-05T02:30:51.456Z] GC before operation: completed in 989.123 ms, heap usage 297.486 MB -> 67.524 MB. [2024-12-05T02:31:06.283Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (15317.144 ms) ====== [2024-12-05T02:31:06.283Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-12-05T02:31:06.920Z] GC before operation: completed in 1069.682 ms, heap usage 302.497 MB -> 67.764 MB. [2024-12-05T02:31:21.683Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (14072.889 ms) ====== [2024-12-05T02:31:21.683Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-12-05T02:31:21.683Z] GC before operation: completed in 755.896 ms, heap usage 302.218 MB -> 67.713 MB. [2024-12-05T02:31:36.365Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (14830.195 ms) ====== [2024-12-05T02:31:36.365Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-12-05T02:31:37.056Z] GC before operation: completed in 892.510 ms, heap usage 301.944 MB -> 68.035 MB. [2024-12-05T02:31:51.883Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (13108.545 ms) ====== [2024-12-05T02:31:51.883Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-12-05T02:31:51.883Z] GC before operation: completed in 952.437 ms, heap usage 297.882 MB -> 67.877 MB. [2024-12-05T02:32:06.574Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (13988.511 ms) ====== [2024-12-05T02:32:06.574Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-12-05T02:32:06.574Z] GC before operation: completed in 937.710 ms, heap usage 285.258 MB -> 68.144 MB. [2024-12-05T02:32:21.484Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (14795.774 ms) ====== [2024-12-05T02:32:21.484Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-12-05T02:32:22.122Z] GC before operation: completed in 904.649 ms, heap usage 292.844 MB -> 68.253 MB. [2024-12-05T02:32:39.580Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (16068.538 ms) ====== [2024-12-05T02:32:39.580Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-12-05T02:32:39.580Z] GC before operation: completed in 1067.095 ms, heap usage 276.796 MB -> 68.354 MB. [2024-12-05T02:32:52.708Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (13828.383 ms) ====== [2024-12-05T02:32:52.708Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-12-05T02:32:54.052Z] GC before operation: completed in 1017.744 ms, heap usage 307.091 MB -> 68.352 MB. [2024-12-05T02:33:11.778Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (17386.399 ms) ====== [2024-12-05T02:33:11.778Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-12-05T02:33:13.234Z] GC before operation: completed in 1558.802 ms, heap usage 295.275 MB -> 68.385 MB. [2024-12-05T02:33:34.004Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (18668.595 ms) ====== [2024-12-05T02:33:34.004Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-12-05T02:33:34.004Z] GC before operation: completed in 1274.881 ms, heap usage 299.549 MB -> 68.668 MB. [2024-12-05T02:33:51.802Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (17427.901 ms) ====== [2024-12-05T02:33:51.802Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-12-05T02:33:51.802Z] GC before operation: completed in 1229.184 ms, heap usage 288.256 MB -> 68.957 MB. [2024-12-05T02:34:09.493Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (17991.823 ms) ====== [2024-12-05T02:34:09.494Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-12-05T02:34:10.943Z] GC before operation: completed in 1412.696 ms, heap usage 292.180 MB -> 68.825 MB. [2024-12-05T02:34:31.715Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (17892.868 ms) ====== [2024-12-05T02:34:31.715Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-12-05T02:34:31.715Z] GC before operation: completed in 1387.984 ms, heap usage 288.934 MB -> 69.043 MB. [2024-12-05T02:34:49.386Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (17189.043 ms) ====== [2024-12-05T02:34:49.386Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-12-05T02:34:49.386Z] GC before operation: completed in 956.763 ms, heap usage 288.605 MB -> 69.034 MB. [2024-12-05T02:35:07.056Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (18324.803 ms) ====== [2024-12-05T02:35:07.056Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-12-05T02:35:08.404Z] GC before operation: completed in 1232.997 ms, heap usage 292.764 MB -> 69.201 MB. [2024-12-05T02:35:25.963Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (16614.009 ms) ====== [2024-12-05T02:35:25.963Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-12-05T02:35:25.963Z] GC before operation: completed in 996.645 ms, heap usage 275.697 MB -> 69.157 MB. [2024-12-05T02:35:43.677Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (17197.175 ms) ====== [2024-12-05T02:35:43.677Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-12-05T02:35:44.379Z] GC before operation: completed in 1160.317 ms, heap usage 283.537 MB -> 69.300 MB. [2024-12-05T02:36:01.748Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (16999.798 ms) ====== [2024-12-05T02:36:01.748Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-12-05T02:36:02.413Z] GC before operation: completed in 1347.280 ms, heap usage 281.888 MB -> 69.423 MB. [2024-12-05T02:36:19.958Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (16530.219 ms) ====== [2024-12-05T02:36:19.958Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-12-05T02:36:19.958Z] GC before operation: completed in 1242.754 ms, heap usage 258.454 MB -> 70.644 MB. [2024-12-05T02:36:37.414Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (15227.661 ms) ====== [2024-12-05T02:36:38.818Z] ----------------------------------- [2024-12-05T02:36:38.818Z] renaissance-dec-tree_0_PASSED [2024-12-05T02:36:38.818Z] ----------------------------------- [2024-12-05T02:36:38.818Z] [2024-12-05T02:36:38.818Z] TEST TEARDOWN: [2024-12-05T02:36:38.818Z] Nothing to be done for teardown. [2024-12-05T02:36:38.818Z] renaissance-dec-tree_0 Finish Time: Thu Dec 5 02:36:38 2024 Epoch Time (ms): 1733366198385