[2025-02-05T22:05:21.649Z] Running test renaissance-dec-tree_0 ... [2025-02-05T22:05:21.649Z] =============================================== [2025-02-05T22:05:21.649Z] renaissance-dec-tree_0 Start Time: Wed Feb 5 22:05:21 2025 Epoch Time (ms): 1738793121209 [2025-02-05T22:05:21.649Z] variation: NoOptions [2025-02-05T22:05:21.649Z] JVM_OPTIONS: [2025-02-05T22:05:21.649Z] { \ [2025-02-05T22:05:21.649Z] echo ""; echo "TEST SETUP:"; \ [2025-02-05T22:05:21.649Z] echo "Nothing to be done for setup."; \ [2025-02-05T22:05:21.649Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17387927367138/renaissance-dec-tree_0"; \ [2025-02-05T22:05:21.649Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17387927367138/renaissance-dec-tree_0"; \ [2025-02-05T22:05:21.649Z] echo ""; echo "TESTING:"; \ [2025-02-05T22:05:21.649Z] "/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_17387927367138/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-05T22:05:21.649Z] 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_17387927367138/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-05T22:05:21.649Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-05T22:05:21.649Z] echo "Nothing to be done for teardown."; \ [2025-02-05T22:05:21.649Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17387927367138/TestTargetResult"; [2025-02-05T22:05:21.649Z] [2025-02-05T22:05:21.649Z] TEST SETUP: [2025-02-05T22:05:21.649Z] Nothing to be done for setup. [2025-02-05T22:05:21.649Z] [2025-02-05T22:05:21.649Z] TESTING: [2025-02-05T22:05:26.154Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-05T22:05:27.768Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 24) threads. [2025-02-05T22:05:32.259Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-05T22:05:32.259Z] GC before operation: completed in 86.580 ms, heap usage 39.140 MB -> 35.425 MB. [2025-02-05T22:05:40.621Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7578.291 ms) ====== [2025-02-05T22:05:40.621Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-05T22:05:40.621Z] GC before operation: completed in 94.972 ms, heap usage 269.948 MB -> 66.747 MB. [2025-02-05T22:05:41.394Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1901.512 ms) ====== [2025-02-05T22:05:41.395Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-05T22:05:42.172Z] GC before operation: completed in 83.137 ms, heap usage 139.297 MB -> 66.697 MB. [2025-02-05T22:05:43.773Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1677.630 ms) ====== [2025-02-05T22:05:43.774Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-05T22:05:43.774Z] GC before operation: completed in 87.634 ms, heap usage 145.589 MB -> 67.102 MB. [2025-02-05T22:05:45.382Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1589.663 ms) ====== [2025-02-05T22:05:45.382Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-05T22:05:45.382Z] GC before operation: completed in 87.979 ms, heap usage 314.973 MB -> 67.639 MB. [2025-02-05T22:05:46.981Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1558.142 ms) ====== [2025-02-05T22:05:46.981Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-05T22:05:46.981Z] GC before operation: completed in 96.759 ms, heap usage 251.594 MB -> 67.880 MB. [2025-02-05T22:05:48.586Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1523.346 ms) ====== [2025-02-05T22:05:48.586Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-05T22:05:48.586Z] GC before operation: completed in 94.203 ms, heap usage 404.741 MB -> 67.960 MB. [2025-02-05T22:05:50.187Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1480.755 ms) ====== [2025-02-05T22:05:50.187Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-05T22:05:50.187Z] GC before operation: completed in 100.649 ms, heap usage 204.959 MB -> 68.203 MB. [2025-02-05T22:05:51.787Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1507.835 ms) ====== [2025-02-05T22:05:51.787Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-05T22:05:51.787Z] GC before operation: completed in 95.834 ms, heap usage 118.251 MB -> 67.912 MB. [2025-02-05T22:05:53.386Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1497.432 ms) ====== [2025-02-05T22:05:53.386Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-05T22:05:53.386Z] GC before operation: completed in 104.499 ms, heap usage 422.142 MB -> 79.575 MB. [2025-02-05T22:05:55.017Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1470.014 ms) ====== [2025-02-05T22:05:55.017Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-05T22:05:55.017Z] GC before operation: completed in 109.795 ms, heap usage 447.755 MB -> 79.504 MB. [2025-02-05T22:05:56.628Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1441.996 ms) ====== [2025-02-05T22:05:56.628Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-05T22:05:56.628Z] GC before operation: completed in 102.761 ms, heap usage 334.580 MB -> 68.811 MB. [2025-02-05T22:05:58.236Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1452.037 ms) ====== [2025-02-05T22:05:58.236Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-05T22:05:58.236Z] GC before operation: completed in 107.634 ms, heap usage 374.492 MB -> 69.192 MB. [2025-02-05T22:05:59.836Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1435.756 ms) ====== [2025-02-05T22:05:59.836Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-05T22:05:59.836Z] GC before operation: completed in 106.033 ms, heap usage 299.630 MB -> 96.549 MB. [2025-02-05T22:06:01.435Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1469.196 ms) ====== [2025-02-05T22:06:01.435Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-05T22:06:01.435Z] GC before operation: completed in 111.069 ms, heap usage 375.991 MB -> 69.220 MB. [2025-02-05T22:06:03.047Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1450.295 ms) ====== [2025-02-05T22:06:03.047Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-05T22:06:03.047Z] GC before operation: completed in 103.607 ms, heap usage 301.721 MB -> 69.324 MB. [2025-02-05T22:06:03.826Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1420.841 ms) ====== [2025-02-05T22:06:03.826Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-05T22:06:04.612Z] GC before operation: completed in 117.336 ms, heap usage 380.060 MB -> 69.508 MB. [2025-02-05T22:06:05.387Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1434.626 ms) ====== [2025-02-05T22:06:05.387Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-05T22:06:06.168Z] GC before operation: completed in 108.221 ms, heap usage 276.574 MB -> 69.465 MB. [2025-02-05T22:06:06.948Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1414.433 ms) ====== [2025-02-05T22:06:06.948Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-05T22:06:07.721Z] GC before operation: completed in 119.138 ms, heap usage 352.310 MB -> 80.444 MB. [2025-02-05T22:06:08.501Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1463.259 ms) ====== [2025-02-05T22:06:08.501Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-05T22:06:09.281Z] GC before operation: completed in 113.248 ms, heap usage 284.372 MB -> 80.552 MB. [2025-02-05T22:06:10.074Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1407.272 ms) ====== [2025-02-05T22:06:10.074Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-05T22:06:10.074Z] GC before operation: completed in 114.448 ms, heap usage 267.303 MB -> 70.152 MB. [2025-02-05T22:06:11.673Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1439.331 ms) ====== [2025-02-05T22:06:11.673Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-05T22:06:11.673Z] GC before operation: completed in 116.959 ms, heap usage 354.357 MB -> 69.865 MB. [2025-02-05T22:06:13.280Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1436.688 ms) ====== [2025-02-05T22:06:13.281Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-05T22:06:13.281Z] GC before operation: completed in 117.106 ms, heap usage 105.742 MB -> 75.220 MB. [2025-02-05T22:06:14.904Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1436.677 ms) ====== [2025-02-05T22:06:14.904Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-05T22:06:14.904Z] GC before operation: completed in 124.384 ms, heap usage 284.163 MB -> 81.367 MB. [2025-02-05T22:06:16.503Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1432.048 ms) ====== [2025-02-05T22:06:16.503Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-05T22:06:16.503Z] GC before operation: completed in 120.879 ms, heap usage 520.544 MB -> 86.857 MB. [2025-02-05T22:06:18.103Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1398.743 ms) ====== [2025-02-05T22:06:18.103Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-05T22:06:18.103Z] GC before operation: completed in 127.200 ms, heap usage 230.241 MB -> 81.160 MB. [2025-02-05T22:06:19.712Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1432.524 ms) ====== [2025-02-05T22:06:19.712Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-05T22:06:19.712Z] GC before operation: completed in 125.733 ms, heap usage 358.700 MB -> 97.956 MB. [2025-02-05T22:06:21.309Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1451.171 ms) ====== [2025-02-05T22:06:21.309Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-05T22:06:21.309Z] GC before operation: completed in 118.582 ms, heap usage 226.094 MB -> 81.361 MB. [2025-02-05T22:06:22.911Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1461.322 ms) ====== [2025-02-05T22:06:22.911Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-05T22:06:22.911Z] GC before operation: completed in 130.734 ms, heap usage 342.673 MB -> 81.618 MB. [2025-02-05T22:06:24.510Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1435.845 ms) ====== [2025-02-05T22:06:24.510Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-05T22:06:24.510Z] GC before operation: completed in 121.650 ms, heap usage 374.971 MB -> 81.711 MB. [2025-02-05T22:06:26.113Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1402.386 ms) ====== [2025-02-05T22:06:26.113Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-05T22:06:26.113Z] GC before operation: completed in 139.103 ms, heap usage 246.169 MB -> 82.189 MB. [2025-02-05T22:06:27.740Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1388.014 ms) ====== [2025-02-05T22:06:27.740Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-05T22:06:27.740Z] GC before operation: completed in 136.084 ms, heap usage 410.322 MB -> 81.919 MB. [2025-02-05T22:06:29.387Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1419.586 ms) ====== [2025-02-05T22:06:29.387Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-05T22:06:29.387Z] GC before operation: completed in 121.636 ms, heap usage 281.750 MB -> 93.100 MB. [2025-02-05T22:06:30.161Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1440.428 ms) ====== [2025-02-05T22:06:30.161Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-05T22:06:30.935Z] GC before operation: completed in 128.514 ms, heap usage 284.959 MB -> 82.120 MB. [2025-02-05T22:06:31.718Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1395.252 ms) ====== [2025-02-05T22:06:31.718Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-05T22:06:32.493Z] GC before operation: completed in 135.925 ms, heap usage 408.332 MB -> 87.656 MB. [2025-02-05T22:06:33.268Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1415.853 ms) ====== [2025-02-05T22:06:33.268Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-05T22:06:34.042Z] GC before operation: completed in 130.979 ms, heap usage 340.629 MB -> 82.312 MB. [2025-02-05T22:06:34.817Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1394.995 ms) ====== [2025-02-05T22:06:34.817Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-05T22:06:35.592Z] GC before operation: completed in 125.892 ms, heap usage 303.888 MB -> 76.788 MB. [2025-02-05T22:06:36.374Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1406.025 ms) ====== [2025-02-05T22:06:36.374Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-05T22:06:37.150Z] GC before operation: completed in 135.973 ms, heap usage 384.303 MB -> 87.946 MB. [2025-02-05T22:06:37.967Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1405.548 ms) ====== [2025-02-05T22:06:37.967Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-05T22:06:37.967Z] GC before operation: completed in 133.973 ms, heap usage 261.405 MB -> 77.110 MB. [2025-02-05T22:06:39.565Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1367.180 ms) ====== [2025-02-05T22:06:39.565Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-05T22:06:39.565Z] GC before operation: completed in 134.062 ms, heap usage 407.411 MB -> 72.021 MB. [2025-02-05T22:06:41.172Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1403.152 ms) ====== [2025-02-05T22:06:41.172Z] ----------------------------------- [2025-02-05T22:06:41.172Z] renaissance-dec-tree_0_PASSED [2025-02-05T22:06:41.172Z] ----------------------------------- [2025-02-05T22:06:41.172Z] [2025-02-05T22:06:41.172Z] TEST TEARDOWN: [2025-02-05T22:06:41.172Z] Nothing to be done for teardown. [2025-02-05T22:06:41.958Z] renaissance-dec-tree_0 Finish Time: Wed Feb 5 22:06:41 2025 Epoch Time (ms): 1738793201098