[2024-09-05T07:34:08.947Z] Running test renaissance-dec-tree_0 ... [2024-09-05T07:34:08.947Z] =============================================== [2024-09-05T07:34:08.947Z] renaissance-dec-tree_0 Start Time: Thu Sep 5 07:34:08 2024 Epoch Time (ms): 1725521648258 [2024-09-05T07:34:08.947Z] variation: NoOptions [2024-09-05T07:34:08.947Z] JVM_OPTIONS: [2024-09-05T07:34:08.947Z] { \ [2024-09-05T07:34:08.947Z] echo ""; echo "TEST SETUP:"; \ [2024-09-05T07:34:08.947Z] echo "Nothing to be done for setup."; \ [2024-09-05T07:34:08.947Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17255212989108/renaissance-dec-tree_0"; \ [2024-09-05T07:34:08.947Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17255212989108/renaissance-dec-tree_0"; \ [2024-09-05T07:34:08.947Z] echo ""; echo "TESTING:"; \ [2024-09-05T07:34:08.947Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17255212989108/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-09-05T07:34:08.947Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17255212989108/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-05T07:34:08.947Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-05T07:34:08.947Z] echo "Nothing to be done for teardown."; \ [2024-09-05T07:34:08.947Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17255212989108/TestTargetResult"; [2024-09-05T07:34:08.947Z] [2024-09-05T07:34:08.947Z] TEST SETUP: [2024-09-05T07:34:08.947Z] Nothing to be done for setup. [2024-09-05T07:34:08.947Z] [2024-09-05T07:34:08.947Z] TESTING: [2024-09-05T07:34:10.608Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-05T07:34:12.267Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-09-05T07:34:15.823Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-09-05T07:34:15.823Z] GC before operation: completed in 45.851 ms, heap usage 59.571 MB -> 35.113 MB. [2024-09-05T07:34:22.975Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7733.295 ms) ====== [2024-09-05T07:34:22.975Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-09-05T07:34:22.975Z] GC before operation: completed in 79.573 ms, heap usage 188.838 MB -> 64.421 MB. [2024-09-05T07:34:25.562Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2173.165 ms) ====== [2024-09-05T07:34:25.562Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-09-05T07:34:25.562Z] GC before operation: completed in 73.253 ms, heap usage 375.027 MB -> 64.970 MB. [2024-09-05T07:34:27.233Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1594.773 ms) ====== [2024-09-05T07:34:27.233Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-09-05T07:34:27.233Z] GC before operation: completed in 72.063 ms, heap usage 169.271 MB -> 64.982 MB. [2024-09-05T07:34:28.897Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1594.043 ms) ====== [2024-09-05T07:34:28.897Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-09-05T07:34:28.897Z] GC before operation: completed in 76.221 ms, heap usage 349.333 MB -> 65.632 MB. [2024-09-05T07:34:30.565Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1604.285 ms) ====== [2024-09-05T07:34:30.565Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-09-05T07:34:30.565Z] GC before operation: completed in 80.393 ms, heap usage 223.104 MB -> 65.856 MB. [2024-09-05T07:34:32.230Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1365.018 ms) ====== [2024-09-05T07:34:32.230Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-09-05T07:34:32.230Z] GC before operation: completed in 67.146 ms, heap usage 342.839 MB -> 65.924 MB. [2024-09-05T07:34:33.043Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1311.663 ms) ====== [2024-09-05T07:34:33.043Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-09-05T07:34:33.850Z] GC before operation: completed in 71.291 ms, heap usage 329.139 MB -> 77.022 MB. [2024-09-05T07:34:34.660Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1232.223 ms) ====== [2024-09-05T07:34:34.660Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-09-05T07:34:34.660Z] GC before operation: completed in 79.272 ms, heap usage 337.863 MB -> 66.354 MB. [2024-09-05T07:34:36.329Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1250.327 ms) ====== [2024-09-05T07:34:36.329Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-09-05T07:34:36.329Z] GC before operation: completed in 71.991 ms, heap usage 323.968 MB -> 66.553 MB. [2024-09-05T07:34:37.142Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1204.401 ms) ====== [2024-09-05T07:34:37.142Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-09-05T07:34:37.142Z] GC before operation: completed in 70.665 ms, heap usage 312.815 MB -> 66.530 MB. [2024-09-05T07:34:38.803Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1249.963 ms) ====== [2024-09-05T07:34:38.803Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-09-05T07:34:38.803Z] GC before operation: completed in 72.062 ms, heap usage 326.231 MB -> 66.651 MB. [2024-09-05T07:34:39.610Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1143.275 ms) ====== [2024-09-05T07:34:39.610Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-09-05T07:34:39.610Z] GC before operation: completed in 72.041 ms, heap usage 308.760 MB -> 66.910 MB. [2024-09-05T07:34:41.282Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1170.018 ms) ====== [2024-09-05T07:34:41.282Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-09-05T07:34:41.282Z] GC before operation: completed in 78.754 ms, heap usage 313.473 MB -> 77.784 MB. [2024-09-05T07:34:42.092Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1168.459 ms) ====== [2024-09-05T07:34:42.092Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-09-05T07:34:42.092Z] GC before operation: completed in 74.989 ms, heap usage 208.781 MB -> 78.107 MB. [2024-09-05T07:34:43.755Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1112.873 ms) ====== [2024-09-05T07:34:43.755Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-09-05T07:34:43.756Z] GC before operation: completed in 76.125 ms, heap usage 333.583 MB -> 72.531 MB. [2024-09-05T07:34:44.563Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1144.248 ms) ====== [2024-09-05T07:34:44.563Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-09-05T07:34:44.563Z] GC before operation: completed in 81.738 ms, heap usage 217.984 MB -> 67.445 MB. [2024-09-05T07:34:46.234Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1050.239 ms) ====== [2024-09-05T07:34:46.234Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-09-05T07:34:46.234Z] GC before operation: completed in 75.843 ms, heap usage 317.276 MB -> 67.615 MB. [2024-09-05T07:34:47.041Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1086.721 ms) ====== [2024-09-05T07:34:47.041Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-09-05T07:34:47.041Z] GC before operation: completed in 0.543 ms, heap usage 298.046 MB -> 70.516 MB. [2024-09-05T07:34:47.849Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (977.701 ms) ====== [2024-09-05T07:34:47.849Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-09-05T07:34:47.849Z] GC before operation: completed in 78.703 ms, heap usage 253.087 MB -> 73.040 MB. [2024-09-05T07:34:49.518Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1045.129 ms) ====== [2024-09-05T07:34:49.518Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-09-05T07:34:49.518Z] GC before operation: completed in 77.693 ms, heap usage 208.270 MB -> 67.690 MB. [2024-09-05T07:34:50.328Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1088.358 ms) ====== [2024-09-05T07:34:50.328Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-09-05T07:34:50.328Z] GC before operation: completed in 80.577 ms, heap usage 305.788 MB -> 73.427 MB. [2024-09-05T07:34:51.134Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1113.310 ms) ====== [2024-09-05T07:34:51.134Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-09-05T07:34:51.941Z] GC before operation: completed in 77.619 ms, heap usage 224.105 MB -> 73.592 MB. [2024-09-05T07:34:52.746Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1089.751 ms) ====== [2024-09-05T07:34:52.746Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-09-05T07:34:52.746Z] GC before operation: completed in 81.485 ms, heap usage 236.575 MB -> 79.120 MB. [2024-09-05T07:34:54.104Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1057.883 ms) ====== [2024-09-05T07:34:54.104Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-09-05T07:34:54.104Z] GC before operation: completed in 100.633 ms, heap usage 201.787 MB -> 73.912 MB. [2024-09-05T07:34:54.914Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1102.650 ms) ====== [2024-09-05T07:34:54.914Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-09-05T07:34:54.914Z] GC before operation: completed in 80.422 ms, heap usage 181.677 MB -> 78.853 MB. [2024-09-05T07:34:56.581Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1127.345 ms) ====== [2024-09-05T07:34:56.581Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-09-05T07:34:56.581Z] GC before operation: completed in 83.979 ms, heap usage 315.446 MB -> 79.419 MB. [2024-09-05T07:34:57.386Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1070.776 ms) ====== [2024-09-05T07:34:57.386Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-09-05T07:34:57.386Z] GC before operation: completed in 79.921 ms, heap usage 158.519 MB -> 68.175 MB. [2024-09-05T07:34:58.193Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1022.275 ms) ====== [2024-09-05T07:34:58.193Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-09-05T07:34:58.193Z] GC before operation: completed in 83.638 ms, heap usage 228.941 MB -> 74.004 MB. [2024-09-05T07:34:59.857Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1010.193 ms) ====== [2024-09-05T07:34:59.857Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-09-05T07:34:59.858Z] GC before operation: completed in 84.936 ms, heap usage 234.347 MB -> 79.836 MB. [2024-09-05T07:35:00.664Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1026.632 ms) ====== [2024-09-05T07:35:00.665Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-09-05T07:35:00.665Z] GC before operation: completed in 86.883 ms, heap usage 325.999 MB -> 79.693 MB. [2024-09-05T07:35:01.473Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1038.584 ms) ====== [2024-09-05T07:35:01.473Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-09-05T07:35:02.281Z] GC before operation: completed in 87.468 ms, heap usage 153.916 MB -> 79.649 MB. [2024-09-05T07:35:03.086Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1206.951 ms) ====== [2024-09-05T07:35:03.087Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-09-05T07:35:03.087Z] GC before operation: completed in 89.380 ms, heap usage 267.252 MB -> 85.236 MB. [2024-09-05T07:35:03.896Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1044.616 ms) ====== [2024-09-05T07:35:03.896Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-09-05T07:35:04.703Z] GC before operation: completed in 90.723 ms, heap usage 427.940 MB -> 80.020 MB. [2024-09-05T07:35:05.512Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (986.879 ms) ====== [2024-09-05T07:35:05.512Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-09-05T07:35:05.512Z] GC before operation: completed in 84.581 ms, heap usage 168.110 MB -> 74.451 MB. [2024-09-05T07:35:06.318Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1092.030 ms) ====== [2024-09-05T07:35:06.318Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-09-05T07:35:06.318Z] GC before operation: completed in 85.385 ms, heap usage 124.953 MB -> 79.839 MB. [2024-09-05T07:35:07.985Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1083.126 ms) ====== [2024-09-05T07:35:07.985Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-09-05T07:35:07.985Z] GC before operation: completed in 86.666 ms, heap usage 362.815 MB -> 74.774 MB. [2024-09-05T07:35:08.790Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1064.531 ms) ====== [2024-09-05T07:35:08.790Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-09-05T07:35:08.790Z] GC before operation: completed in 86.585 ms, heap usage 198.233 MB -> 69.624 MB. [2024-09-05T07:35:09.596Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1060.000 ms) ====== [2024-09-05T07:35:09.596Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-09-05T07:35:10.406Z] GC before operation: completed in 90.667 ms, heap usage 256.108 MB -> 75.151 MB. [2024-09-05T07:35:11.216Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1048.576 ms) ====== [2024-09-05T07:35:11.216Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-09-05T07:35:11.216Z] GC before operation: completed in 108.747 ms, heap usage 221.240 MB -> 69.971 MB. [2024-09-05T07:35:12.022Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1063.771 ms) ====== [2024-09-05T07:35:12.828Z] ----------------------------------- [2024-09-05T07:35:12.828Z] renaissance-dec-tree_0_PASSED [2024-09-05T07:35:12.828Z] ----------------------------------- [2024-09-05T07:35:12.828Z] [2024-09-05T07:35:12.828Z] TEST TEARDOWN: [2024-09-05T07:35:12.828Z] Nothing to be done for teardown. [2024-09-05T07:35:12.828Z] renaissance-dec-tree_0 Finish Time: Thu Sep 5 07:35:12 2024 Epoch Time (ms): 1725521712020