[2025-05-16T21:24:03.938Z] Running test renaissance-dec-tree_0 ... [2025-05-16T21:24:03.938Z] =============================================== [2025-05-16T21:24:03.938Z] renaissance-dec-tree_0 Start Time: Fri May 16 21:24:03 2025 Epoch Time (ms): 1747430643491 [2025-05-16T21:24:03.938Z] variation: NoOptions [2025-05-16T21:24:03.938Z] JVM_OPTIONS: [2025-05-16T21:24:03.938Z] { \ [2025-05-16T21:24:03.938Z] echo ""; echo "TEST SETUP:"; \ [2025-05-16T21:24:03.938Z] echo "Nothing to be done for setup."; \ [2025-05-16T21:24:03.938Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1747429417991/renaissance-dec-tree_0"; \ [2025-05-16T21:24:03.938Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1747429417991/renaissance-dec-tree_0"; \ [2025-05-16T21:24:03.938Z] echo ""; echo "TESTING:"; \ [2025-05-16T21:24:03.939Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1747429417991/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-05-16T21:24:03.939Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1747429417991/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-16T21:24:03.939Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-16T21:24:03.939Z] echo "Nothing to be done for teardown."; \ [2025-05-16T21:24:03.939Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1747429417991/TestTargetResult"; [2025-05-16T21:24:03.939Z] [2025-05-16T21:24:03.939Z] TEST SETUP: [2025-05-16T21:24:03.939Z] Nothing to be done for setup. [2025-05-16T21:24:03.939Z] [2025-05-16T21:24:03.939Z] TESTING: [2025-05-16T21:24:22.109Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-05-16T21:24:23.495Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-05-16T21:24:23.495Z] GC before operation: completed in 46.535 ms, heap usage 61.548 MB -> 34.874 MB. [2025-05-16T21:24:44.928Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (21814.913 ms) ====== [2025-05-16T21:24:44.928Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-05-16T21:24:44.928Z] GC before operation: completed in 161.199 ms, heap usage 294.727 MB -> 67.977 MB. [2025-05-16T21:24:51.301Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (5129.564 ms) ====== [2025-05-16T21:24:51.301Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-05-16T21:24:51.301Z] GC before operation: completed in 238.897 ms, heap usage 213.982 MB -> 68.204 MB. [2025-05-16T21:24:55.318Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (4412.542 ms) ====== [2025-05-16T21:24:55.318Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-05-16T21:24:55.319Z] GC before operation: completed in 188.562 ms, heap usage 278.109 MB -> 88.034 MB. [2025-05-16T21:24:59.565Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4467.447 ms) ====== [2025-05-16T21:24:59.565Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-05-16T21:24:59.565Z] GC before operation: completed in 171.552 ms, heap usage 360.658 MB -> 68.829 MB. [2025-05-16T21:25:02.586Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2959.470 ms) ====== [2025-05-16T21:25:02.586Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-05-16T21:25:03.277Z] GC before operation: completed in 260.847 ms, heap usage 209.867 MB -> 69.022 MB. [2025-05-16T21:25:06.047Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (3286.758 ms) ====== [2025-05-16T21:25:06.047Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-05-16T21:25:06.701Z] GC before operation: completed in 135.102 ms, heap usage 219.889 MB -> 69.214 MB. [2025-05-16T21:25:10.936Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3943.954 ms) ====== [2025-05-16T21:25:10.936Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-05-16T21:25:10.936Z] GC before operation: completed in 267.501 ms, heap usage 220.768 MB -> 69.524 MB. [2025-05-16T21:25:13.959Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3339.492 ms) ====== [2025-05-16T21:25:13.959Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-05-16T21:25:13.959Z] GC before operation: completed in 203.965 ms, heap usage 263.067 MB -> 69.607 MB. [2025-05-16T21:25:16.924Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2882.888 ms) ====== [2025-05-16T21:25:16.925Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-05-16T21:25:17.591Z] GC before operation: completed in 155.281 ms, heap usage 196.906 MB -> 70.037 MB. [2025-05-16T21:25:20.629Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2868.865 ms) ====== [2025-05-16T21:25:20.629Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-05-16T21:25:20.629Z] GC before operation: completed in 450.025 ms, heap usage 309.509 MB -> 69.695 MB. [2025-05-16T21:25:27.505Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (6595.140 ms) ====== [2025-05-16T21:25:27.505Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-05-16T21:25:27.505Z] GC before operation: completed in 229.872 ms, heap usage 129.419 MB -> 69.654 MB. [2025-05-16T21:25:32.072Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4528.191 ms) ====== [2025-05-16T21:25:32.072Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-05-16T21:25:32.072Z] GC before operation: completed in 217.328 ms, heap usage 396.942 MB -> 70.146 MB. [2025-05-16T21:25:36.235Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3625.761 ms) ====== [2025-05-16T21:25:36.236Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-05-16T21:25:36.236Z] GC before operation: completed in 215.539 ms, heap usage 164.835 MB -> 69.791 MB. [2025-05-16T21:25:39.330Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2828.287 ms) ====== [2025-05-16T21:25:39.330Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-05-16T21:25:39.330Z] GC before operation: completed in 209.004 ms, heap usage 278.990 MB -> 97.847 MB. [2025-05-16T21:25:44.471Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4686.339 ms) ====== [2025-05-16T21:25:44.471Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-05-16T21:25:44.471Z] GC before operation: completed in 139.313 ms, heap usage 195.412 MB -> 97.781 MB. [2025-05-16T21:25:52.355Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (8050.076 ms) ====== [2025-05-16T21:25:52.355Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-05-16T21:25:52.355Z] GC before operation: completed in 547.645 ms, heap usage 268.752 MB -> 98.170 MB. [2025-05-16T21:25:59.322Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (6264.410 ms) ====== [2025-05-16T21:25:59.322Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-05-16T21:25:59.322Z] GC before operation: completed in 235.917 ms, heap usage 324.111 MB -> 98.351 MB. [2025-05-16T21:26:03.494Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3921.062 ms) ====== [2025-05-16T21:26:03.494Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-05-16T21:26:03.494Z] GC before operation: completed in 136.117 ms, heap usage 333.600 MB -> 70.843 MB. [2025-05-16T21:26:05.688Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2452.492 ms) ====== [2025-05-16T21:26:05.688Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-05-16T21:26:05.688Z] GC before operation: completed in 165.791 ms, heap usage 196.677 MB -> 70.982 MB. [2025-05-16T21:26:10.107Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4146.756 ms) ====== [2025-05-16T21:26:10.107Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-05-16T21:26:10.107Z] GC before operation: completed in 437.501 ms, heap usage 197.181 MB -> 71.118 MB. [2025-05-16T21:26:22.237Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (11798.465 ms) ====== [2025-05-16T21:26:22.237Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-05-16T21:26:22.895Z] GC before operation: completed in 1098.332 ms, heap usage 241.774 MB -> 71.214 MB. [2025-05-16T21:26:25.948Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3121.847 ms) ====== [2025-05-16T21:26:25.948Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-05-16T21:26:26.603Z] GC before operation: completed in 263.764 ms, heap usage 201.243 MB -> 71.220 MB. [2025-05-16T21:26:28.804Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2581.438 ms) ====== [2025-05-16T21:26:28.804Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-05-16T21:26:29.866Z] GC before operation: completed in 811.394 ms, heap usage 172.989 MB -> 71.091 MB. [2025-05-16T21:26:37.324Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (6603.481 ms) ====== [2025-05-16T21:26:37.324Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-05-16T21:26:37.324Z] GC before operation: completed in 717.669 ms, heap usage 347.057 MB -> 99.050 MB. [2025-05-16T21:26:40.410Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (3349.572 ms) ====== [2025-05-16T21:26:40.410Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-05-16T21:26:41.107Z] GC before operation: completed in 264.327 ms, heap usage 242.808 MB -> 71.468 MB. [2025-05-16T21:26:48.029Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (6706.596 ms) ====== [2025-05-16T21:26:48.029Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-05-16T21:26:48.029Z] GC before operation: completed in 756.761 ms, heap usage 291.501 MB -> 71.561 MB. [2025-05-16T21:26:51.237Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2706.177 ms) ====== [2025-05-16T21:26:51.237Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-05-16T21:26:51.237Z] GC before operation: completed in 199.446 ms, heap usage 293.633 MB -> 80.257 MB. [2025-05-16T21:26:58.907Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (7021.504 ms) ====== [2025-05-16T21:26:58.907Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-05-16T21:26:58.907Z] GC before operation: completed in 599.271 ms, heap usage 279.689 MB -> 80.415 MB. [2025-05-16T21:27:02.096Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3322.870 ms) ====== [2025-05-16T21:27:02.097Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-05-16T21:27:02.779Z] GC before operation: completed in 285.629 ms, heap usage 207.586 MB -> 72.354 MB. [2025-05-16T21:27:06.259Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3702.979 ms) ====== [2025-05-16T21:27:06.259Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-05-16T21:27:08.208Z] GC before operation: completed in 1610.204 ms, heap usage 260.472 MB -> 72.143 MB. [2025-05-16T21:27:11.274Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (3285.638 ms) ====== [2025-05-16T21:27:11.274Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-05-16T21:27:11.274Z] GC before operation: completed in 189.798 ms, heap usage 215.986 MB -> 72.230 MB. [2025-05-16T21:27:14.307Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2903.289 ms) ====== [2025-05-16T21:27:14.307Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-05-16T21:27:14.307Z] GC before operation: completed in 238.054 ms, heap usage 275.123 MB -> 72.172 MB. [2025-05-16T21:27:17.460Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2681.790 ms) ====== [2025-05-16T21:27:17.460Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-05-16T21:27:17.460Z] GC before operation: completed in 435.702 ms, heap usage 285.928 MB -> 72.678 MB. [2025-05-16T21:27:22.253Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (4684.932 ms) ====== [2025-05-16T21:27:22.253Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-05-16T21:27:22.253Z] GC before operation: completed in 236.233 ms, heap usage 331.364 MB -> 72.534 MB. [2025-05-16T21:27:26.452Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3364.462 ms) ====== [2025-05-16T21:27:26.452Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-05-16T21:27:26.452Z] GC before operation: completed in 386.012 ms, heap usage 313.226 MB -> 72.681 MB. [2025-05-16T21:27:29.400Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2855.253 ms) ====== [2025-05-16T21:27:29.400Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-05-16T21:27:29.400Z] GC before operation: completed in 377.530 ms, heap usage 113.704 MB -> 100.262 MB. [2025-05-16T21:27:32.578Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3045.416 ms) ====== [2025-05-16T21:27:32.578Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-05-16T21:27:32.578Z] GC before operation: completed in 202.224 ms, heap usage 432.893 MB -> 72.889 MB. [2025-05-16T21:27:35.888Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2897.377 ms) ====== [2025-05-16T21:27:35.888Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-05-16T21:27:35.888Z] GC before operation: completed in 282.463 ms, heap usage 139.358 MB -> 72.568 MB. [2025-05-16T21:27:39.929Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4114.597 ms) ====== [2025-05-16T21:27:39.929Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-05-16T21:27:40.671Z] GC before operation: completed in 823.077 ms, heap usage 119.703 MB -> 72.355 MB. [2025-05-16T21:27:44.977Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (4377.236 ms) ====== [2025-05-16T21:27:45.656Z] ----------------------------------- [2025-05-16T21:27:45.656Z] renaissance-dec-tree_0_PASSED [2025-05-16T21:27:45.656Z] ----------------------------------- [2025-05-16T21:27:45.656Z] [2025-05-16T21:27:45.656Z] TEST TEARDOWN: [2025-05-16T21:27:45.656Z] Nothing to be done for teardown. [2025-05-16T21:27:45.656Z] renaissance-dec-tree_0 Finish Time: Fri May 16 21:27:45 2025 Epoch Time (ms): 1747430865565