[2024-11-15T22:01:05.150Z] Running test renaissance-dec-tree_0 ... [2024-11-15T22:01:05.150Z] =============================================== [2024-11-15T22:01:05.150Z] renaissance-dec-tree_0 Start Time: Fri Nov 15 22:01:04 2024 Epoch Time (ms): 1731708064337 [2024-11-15T22:01:05.150Z] variation: NoOptions [2024-11-15T22:01:05.150Z] JVM_OPTIONS: [2024-11-15T22:01:05.150Z] { \ [2024-11-15T22:01:05.150Z] echo ""; echo "TEST SETUP:"; \ [2024-11-15T22:01:05.150Z] echo "Nothing to be done for setup."; \ [2024-11-15T22:01:05.150Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17317076864849/renaissance-dec-tree_0"; \ [2024-11-15T22:01:05.150Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17317076864849/renaissance-dec-tree_0"; \ [2024-11-15T22:01:05.150Z] echo ""; echo "TESTING:"; \ [2024-11-15T22:01:05.150Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/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_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17317076864849/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-15T22:01:05.150Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17317076864849/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-15T22:01:05.150Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-15T22:01:05.150Z] echo "Nothing to be done for teardown."; \ [2024-11-15T22:01:05.150Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17317076864849/TestTargetResult"; [2024-11-15T22:01:05.150Z] [2024-11-15T22:01:05.150Z] TEST SETUP: [2024-11-15T22:01:05.150Z] Nothing to be done for setup. [2024-11-15T22:01:05.150Z] [2024-11-15T22:01:05.150Z] TESTING: [2024-11-15T22:01:09.603Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-15T22:01:11.210Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2024-11-15T22:01:15.654Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-15T22:01:15.654Z] GC before operation: completed in 47.895 ms, heap usage 85.116 MB -> 35.180 MB. [2024-11-15T22:01:22.501Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7474.999 ms) ====== [2024-11-15T22:01:22.501Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-15T22:01:22.501Z] GC before operation: completed in 89.267 ms, heap usage 206.921 MB -> 66.318 MB. [2024-11-15T22:01:24.960Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1946.182 ms) ====== [2024-11-15T22:01:24.960Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-15T22:01:24.960Z] GC before operation: completed in 80.463 ms, heap usage 370.388 MB -> 66.919 MB. [2024-11-15T22:01:26.544Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1618.728 ms) ====== [2024-11-15T22:01:26.544Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-15T22:01:26.544Z] GC before operation: completed in 84.526 ms, heap usage 171.266 MB -> 67.086 MB. [2024-11-15T22:01:28.132Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1600.221 ms) ====== [2024-11-15T22:01:28.132Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-15T22:01:28.132Z] GC before operation: completed in 94.120 ms, heap usage 172.792 MB -> 67.239 MB. [2024-11-15T22:01:29.729Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1567.955 ms) ====== [2024-11-15T22:01:29.729Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-15T22:01:29.729Z] GC before operation: completed in 93.192 ms, heap usage 122.028 MB -> 67.134 MB. [2024-11-15T22:01:31.490Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1588.819 ms) ====== [2024-11-15T22:01:31.490Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-15T22:01:31.490Z] GC before operation: completed in 95.886 ms, heap usage 466.776 MB -> 84.819 MB. [2024-11-15T22:01:33.071Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1543.662 ms) ====== [2024-11-15T22:01:33.072Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-15T22:01:33.072Z] GC before operation: completed in 101.863 ms, heap usage 398.208 MB -> 79.189 MB. [2024-11-15T22:01:34.653Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1535.586 ms) ====== [2024-11-15T22:01:34.653Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-15T22:01:34.653Z] GC before operation: completed in 105.688 ms, heap usage 163.855 MB -> 68.126 MB. [2024-11-15T22:01:36.231Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1520.988 ms) ====== [2024-11-15T22:01:36.231Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-15T22:01:36.231Z] GC before operation: completed in 99.087 ms, heap usage 300.529 MB -> 68.505 MB. [2024-11-15T22:01:37.813Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1567.162 ms) ====== [2024-11-15T22:01:37.814Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-15T22:01:37.814Z] GC before operation: completed in 115.776 ms, heap usage 376.557 MB -> 79.360 MB. [2024-11-15T22:01:39.397Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1473.702 ms) ====== [2024-11-15T22:01:39.397Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-15T22:01:39.397Z] GC before operation: completed in 99.485 ms, heap usage 258.654 MB -> 68.728 MB. [2024-11-15T22:01:40.991Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1450.397 ms) ====== [2024-11-15T22:01:40.991Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-15T22:01:40.991Z] GC before operation: completed in 111.622 ms, heap usage 349.943 MB -> 79.633 MB. [2024-11-15T22:01:42.577Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1466.333 ms) ====== [2024-11-15T22:01:42.577Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-15T22:01:42.577Z] GC before operation: completed in 103.704 ms, heap usage 341.549 MB -> 85.576 MB. [2024-11-15T22:01:44.165Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1464.059 ms) ====== [2024-11-15T22:01:44.165Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-15T22:01:44.165Z] GC before operation: completed in 114.786 ms, heap usage 238.050 MB -> 80.084 MB. [2024-11-15T22:01:45.746Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1444.008 ms) ====== [2024-11-15T22:01:45.746Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-15T22:01:45.746Z] GC before operation: completed in 107.863 ms, heap usage 218.809 MB -> 69.494 MB. [2024-11-15T22:01:47.328Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1449.038 ms) ====== [2024-11-15T22:01:47.328Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-15T22:01:47.328Z] GC before operation: completed in 112.087 ms, heap usage 184.215 MB -> 69.176 MB. [2024-11-15T22:01:48.918Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1445.496 ms) ====== [2024-11-15T22:01:48.918Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-15T22:01:48.918Z] GC before operation: completed in 116.769 ms, heap usage 205.055 MB -> 69.561 MB. [2024-11-15T22:01:50.506Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1465.368 ms) ====== [2024-11-15T22:01:50.506Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-15T22:01:50.506Z] GC before operation: completed in 114.414 ms, heap usage 302.030 MB -> 69.680 MB. [2024-11-15T22:01:52.092Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1449.559 ms) ====== [2024-11-15T22:01:52.092Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-15T22:01:52.092Z] GC before operation: completed in 122.103 ms, heap usage 373.537 MB -> 80.694 MB. [2024-11-15T22:01:53.884Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1439.955 ms) ====== [2024-11-15T22:01:53.884Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-15T22:01:53.884Z] GC before operation: completed in 110.294 ms, heap usage 271.275 MB -> 75.564 MB. [2024-11-15T22:01:55.513Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1404.935 ms) ====== [2024-11-15T22:01:55.513Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-15T22:01:55.513Z] GC before operation: completed in 115.123 ms, heap usage 260.394 MB -> 70.227 MB. [2024-11-15T22:01:57.097Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1430.628 ms) ====== [2024-11-15T22:01:57.097Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-15T22:01:57.097Z] GC before operation: completed in 119.757 ms, heap usage 351.015 MB -> 86.470 MB. [2024-11-15T22:01:58.687Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1440.212 ms) ====== [2024-11-15T22:01:58.687Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-15T22:01:58.687Z] GC before operation: completed in 127.832 ms, heap usage 224.656 MB -> 70.065 MB. [2024-11-15T22:02:00.296Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1437.162 ms) ====== [2024-11-15T22:02:00.296Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-15T22:02:00.296Z] GC before operation: completed in 128.465 ms, heap usage 347.701 MB -> 86.660 MB. [2024-11-15T22:02:01.887Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1426.098 ms) ====== [2024-11-15T22:02:01.887Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-15T22:02:01.887Z] GC before operation: completed in 119.263 ms, heap usage 169.790 MB -> 81.249 MB. [2024-11-15T22:02:02.653Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1437.733 ms) ====== [2024-11-15T22:02:02.653Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-15T22:02:03.418Z] GC before operation: completed in 126.828 ms, heap usage 480.365 MB -> 87.305 MB. [2024-11-15T22:02:05.007Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1430.337 ms) ====== [2024-11-15T22:02:05.007Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-15T22:02:05.007Z] GC before operation: completed in 120.730 ms, heap usage 354.155 MB -> 81.380 MB. [2024-11-15T22:02:05.771Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1416.103 ms) ====== [2024-11-15T22:02:05.771Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-15T22:02:06.536Z] GC before operation: completed in 123.468 ms, heap usage 228.443 MB -> 82.053 MB. [2024-11-15T22:02:07.299Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1416.176 ms) ====== [2024-11-15T22:02:07.299Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-15T22:02:08.066Z] GC before operation: completed in 127.070 ms, heap usage 387.545 MB -> 81.719 MB. [2024-11-15T22:02:08.845Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1392.160 ms) ====== [2024-11-15T22:02:08.845Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-15T22:02:09.611Z] GC before operation: completed in 117.754 ms, heap usage 164.958 MB -> 81.560 MB. [2024-11-15T22:02:10.379Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1408.114 ms) ====== [2024-11-15T22:02:10.379Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-15T22:02:11.148Z] GC before operation: completed in 120.181 ms, heap usage 301.785 MB -> 81.953 MB. [2024-11-15T22:02:11.928Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1434.442 ms) ====== [2024-11-15T22:02:11.928Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-15T22:02:13.019Z] GC before operation: completed in 121.058 ms, heap usage 195.269 MB -> 70.859 MB. [2024-11-15T22:02:13.797Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1373.311 ms) ====== [2024-11-15T22:02:13.797Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-15T22:02:13.797Z] GC before operation: completed in 125.364 ms, heap usage 286.651 MB -> 81.981 MB. [2024-11-15T22:02:15.629Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1396.596 ms) ====== [2024-11-15T22:02:15.629Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-15T22:02:15.629Z] GC before operation: completed in 127.632 ms, heap usage 378.654 MB -> 76.769 MB. [2024-11-15T22:02:17.209Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1408.706 ms) ====== [2024-11-15T22:02:17.209Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-15T22:02:17.209Z] GC before operation: completed in 132.133 ms, heap usage 433.251 MB -> 82.426 MB. [2024-11-15T22:02:17.986Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1394.001 ms) ====== [2024-11-15T22:02:17.986Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-15T22:02:18.750Z] GC before operation: completed in 135.276 ms, heap usage 359.830 MB -> 87.918 MB. [2024-11-15T22:02:19.525Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1376.384 ms) ====== [2024-11-15T22:02:19.525Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-15T22:02:20.293Z] GC before operation: completed in 132.425 ms, heap usage 288.695 MB -> 82.393 MB. [2024-11-15T22:02:21.059Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1388.270 ms) ====== [2024-11-15T22:02:21.059Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-15T22:02:21.823Z] GC before operation: completed in 123.087 ms, heap usage 196.474 MB -> 71.334 MB. [2024-11-15T22:02:22.588Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1401.639 ms) ====== [2024-11-15T22:02:22.588Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-15T22:02:23.352Z] GC before operation: completed in 126.819 ms, heap usage 436.308 MB -> 82.772 MB. [2024-11-15T22:02:24.120Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1402.775 ms) ====== [2024-11-15T22:02:24.888Z] ----------------------------------- [2024-11-15T22:02:24.888Z] renaissance-dec-tree_0_PASSED [2024-11-15T22:02:24.888Z] ----------------------------------- [2024-11-15T22:02:24.888Z] [2024-11-15T22:02:24.888Z] TEST TEARDOWN: [2024-11-15T22:02:24.888Z] Nothing to be done for teardown. [2024-11-15T22:02:24.888Z] renaissance-dec-tree_0 Finish Time: Fri Nov 15 22:02:24 2024 Epoch Time (ms): 1731708144277