[2025-05-07T11:35:34.943Z] Running test renaissance-dec-tree_0 ... [2025-05-07T11:35:34.943Z] =============================================== [2025-05-07T11:35:34.943Z] renaissance-dec-tree_0 Start Time: Wed May 7 11:35:34 2025 Epoch Time (ms): 1746617734603 [2025-05-07T11:35:34.943Z] variation: NoOptions [2025-05-07T11:35:34.943Z] JVM_OPTIONS: [2025-05-07T11:35:34.943Z] { \ [2025-05-07T11:35:34.943Z] echo ""; echo "TEST SETUP:"; \ [2025-05-07T11:35:34.943Z] echo "Nothing to be done for setup."; \ [2025-05-07T11:35:34.943Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17466172034810/renaissance-dec-tree_0"; \ [2025-05-07T11:35:34.943Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17466172034810/renaissance-dec-tree_0"; \ [2025-05-07T11:35:34.943Z] echo ""; echo "TESTING:"; \ [2025-05-07T11:35:34.944Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_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_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17466172034810/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-05-07T11:35:34.944Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17466172034810/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-05-07T11:35:34.944Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-05-07T11:35:34.944Z] echo "Nothing to be done for teardown."; \ [2025-05-07T11:35:34.944Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17466172034810/TestTargetResult"; [2025-05-07T11:35:34.944Z] [2025-05-07T11:35:34.944Z] TEST SETUP: [2025-05-07T11:35:34.944Z] Nothing to be done for setup. [2025-05-07T11:35:34.944Z] [2025-05-07T11:35:34.944Z] TESTING: [2025-05-07T11:35:41.626Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-05-07T11:35:42.575Z] WARNING: An illegal reflective access operation has occurred [2025-05-07T11:35:42.575Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17466172034810/renaissance-dec-tree_0/harness-113535-7039385000905186071/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-05-07T11:35:42.575Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-05-07T11:35:42.575Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-05-07T11:35:42.575Z] WARNING: All illegal access operations will be denied in a future release [2025-05-07T11:35:44.525Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-05-07T11:35:44.525Z] GC before operation: completed in 64.088 ms, heap usage 60.272 MB -> 34.400 MB. [2025-05-07T11:35:54.486Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (10326.613 ms) ====== [2025-05-07T11:35:54.486Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-05-07T11:35:54.486Z] GC before operation: completed in 129.154 ms, heap usage 337.552 MB -> 68.299 MB. [2025-05-07T11:35:57.499Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2432.483 ms) ====== [2025-05-07T11:35:57.500Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-05-07T11:35:57.500Z] GC before operation: completed in 128.570 ms, heap usage 226.345 MB -> 68.799 MB. [2025-05-07T11:35:59.449Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1978.153 ms) ====== [2025-05-07T11:35:59.449Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-05-07T11:35:59.449Z] GC before operation: completed in 108.820 ms, heap usage 211.252 MB -> 85.586 MB. [2025-05-07T11:36:01.399Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1925.499 ms) ====== [2025-05-07T11:36:01.399Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-05-07T11:36:01.399Z] GC before operation: completed in 102.796 ms, heap usage 164.291 MB -> 68.781 MB. [2025-05-07T11:36:03.348Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1904.938 ms) ====== [2025-05-07T11:36:03.348Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-05-07T11:36:03.348Z] GC before operation: completed in 105.788 ms, heap usage 108.198 MB -> 68.991 MB. [2025-05-07T11:36:05.300Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1885.791 ms) ====== [2025-05-07T11:36:05.300Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-05-07T11:36:05.300Z] GC before operation: completed in 108.955 ms, heap usage 122.102 MB -> 69.365 MB. [2025-05-07T11:36:07.260Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1827.918 ms) ====== [2025-05-07T11:36:07.260Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-05-07T11:36:07.260Z] GC before operation: completed in 112.307 ms, heap usage 161.872 MB -> 69.871 MB. [2025-05-07T11:36:09.209Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1792.952 ms) ====== [2025-05-07T11:36:09.209Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-05-07T11:36:09.209Z] GC before operation: completed in 126.755 ms, heap usage 148.664 MB -> 91.721 MB. [2025-05-07T11:36:11.282Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1680.074 ms) ====== [2025-05-07T11:36:11.282Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-05-07T11:36:11.282Z] GC before operation: completed in 108.553 ms, heap usage 263.587 MB -> 70.129 MB. [2025-05-07T11:36:13.274Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1738.445 ms) ====== [2025-05-07T11:36:13.274Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-05-07T11:36:13.274Z] GC before operation: completed in 116.856 ms, heap usage 200.776 MB -> 70.235 MB. [2025-05-07T11:36:15.223Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1771.410 ms) ====== [2025-05-07T11:36:15.223Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-05-07T11:36:15.223Z] GC before operation: completed in 113.155 ms, heap usage 291.756 MB -> 75.619 MB. [2025-05-07T11:36:16.172Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1724.191 ms) ====== [2025-05-07T11:36:16.172Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-05-07T11:36:17.125Z] GC before operation: completed in 116.916 ms, heap usage 160.773 MB -> 70.449 MB. [2025-05-07T11:36:18.075Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1758.704 ms) ====== [2025-05-07T11:36:18.075Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-05-07T11:36:19.034Z] GC before operation: completed in 136.906 ms, heap usage 148.725 MB -> 81.163 MB. [2025-05-07T11:36:19.992Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1788.034 ms) ====== [2025-05-07T11:36:19.992Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-05-07T11:36:20.947Z] GC before operation: completed in 134.359 ms, heap usage 261.790 MB -> 70.710 MB. [2025-05-07T11:36:21.897Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1691.127 ms) ====== [2025-05-07T11:36:21.897Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-05-07T11:36:21.897Z] GC before operation: completed in 127.467 ms, heap usage 214.440 MB -> 81.960 MB. [2025-05-07T11:36:23.851Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1656.426 ms) ====== [2025-05-07T11:36:23.851Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-05-07T11:36:23.851Z] GC before operation: completed in 125.626 ms, heap usage 241.833 MB -> 70.988 MB. [2025-05-07T11:36:25.802Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1694.140 ms) ====== [2025-05-07T11:36:25.802Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-05-07T11:36:25.802Z] GC before operation: completed in 134.042 ms, heap usage 275.139 MB -> 70.948 MB. [2025-05-07T11:36:27.754Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1682.526 ms) ====== [2025-05-07T11:36:27.754Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-05-07T11:36:27.754Z] GC before operation: completed in 127.714 ms, heap usage 249.928 MB -> 71.218 MB. [2025-05-07T11:36:29.703Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1718.626 ms) ====== [2025-05-07T11:36:29.703Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-05-07T11:36:29.703Z] GC before operation: completed in 125.229 ms, heap usage 230.581 MB -> 71.323 MB. [2025-05-07T11:36:31.654Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1744.372 ms) ====== [2025-05-07T11:36:31.654Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-05-07T11:36:31.654Z] GC before operation: completed in 133.985 ms, heap usage 258.346 MB -> 71.428 MB. [2025-05-07T11:36:33.605Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1720.625 ms) ====== [2025-05-07T11:36:33.605Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-05-07T11:36:33.605Z] GC before operation: completed in 134.073 ms, heap usage 242.071 MB -> 82.410 MB. [2025-05-07T11:36:35.553Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1706.528 ms) ====== [2025-05-07T11:36:35.553Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-05-07T11:36:35.553Z] GC before operation: completed in 130.906 ms, heap usage 155.852 MB -> 71.622 MB. [2025-05-07T11:36:36.503Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1780.392 ms) ====== [2025-05-07T11:36:36.503Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-05-07T11:36:37.461Z] GC before operation: completed in 136.785 ms, heap usage 150.911 MB -> 82.571 MB. [2025-05-07T11:36:38.561Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1621.589 ms) ====== [2025-05-07T11:36:38.561Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-05-07T11:36:38.561Z] GC before operation: completed in 137.305 ms, heap usage 304.047 MB -> 83.002 MB. [2025-05-07T11:36:40.513Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1652.952 ms) ====== [2025-05-07T11:36:40.513Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-05-07T11:36:40.513Z] GC before operation: completed in 135.881 ms, heap usage 305.237 MB -> 88.525 MB. [2025-05-07T11:36:42.462Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1652.977 ms) ====== [2025-05-07T11:36:42.462Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-05-07T11:36:42.462Z] GC before operation: completed in 134.307 ms, heap usage 139.122 MB -> 71.587 MB. [2025-05-07T11:36:44.410Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1709.272 ms) ====== [2025-05-07T11:36:44.410Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-05-07T11:36:44.410Z] GC before operation: completed in 133.699 ms, heap usage 177.958 MB -> 82.825 MB. [2025-05-07T11:36:46.533Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1698.596 ms) ====== [2025-05-07T11:36:46.533Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-05-07T11:36:46.533Z] GC before operation: completed in 144.442 ms, heap usage 269.571 MB -> 88.615 MB. [2025-05-07T11:36:47.481Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1591.305 ms) ====== [2025-05-07T11:36:47.481Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-05-07T11:36:47.481Z] GC before operation: completed in 147.150 ms, heap usage 333.846 MB -> 83.530 MB. [2025-05-07T11:36:49.433Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1599.296 ms) ====== [2025-05-07T11:36:49.433Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-05-07T11:36:49.433Z] GC before operation: completed in 143.212 ms, heap usage 193.038 MB -> 83.121 MB. [2025-05-07T11:36:51.382Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1668.406 ms) ====== [2025-05-07T11:36:51.382Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-05-07T11:36:51.382Z] GC before operation: completed in 139.663 ms, heap usage 285.999 MB -> 72.565 MB. [2025-05-07T11:36:53.332Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1689.003 ms) ====== [2025-05-07T11:36:53.332Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-05-07T11:36:53.332Z] GC before operation: completed in 140.406 ms, heap usage 240.551 MB -> 72.510 MB. [2025-05-07T11:36:55.284Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1633.215 ms) ====== [2025-05-07T11:36:55.284Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-05-07T11:36:55.284Z] GC before operation: completed in 144.999 ms, heap usage 109.454 MB -> 72.291 MB. [2025-05-07T11:36:57.242Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1716.492 ms) ====== [2025-05-07T11:36:57.242Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-05-07T11:36:57.242Z] GC before operation: completed in 154.813 ms, heap usage 337.979 MB -> 83.836 MB. [2025-05-07T11:36:58.192Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1587.055 ms) ====== [2025-05-07T11:36:58.192Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-05-07T11:36:58.192Z] GC before operation: completed in 146.204 ms, heap usage 241.526 MB -> 72.982 MB. [2025-05-07T11:37:00.140Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1657.974 ms) ====== [2025-05-07T11:37:00.140Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-05-07T11:37:00.140Z] GC before operation: completed in 158.385 ms, heap usage 187.923 MB -> 72.789 MB. [2025-05-07T11:37:02.103Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1635.165 ms) ====== [2025-05-07T11:37:02.103Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-05-07T11:37:02.103Z] GC before operation: completed in 139.331 ms, heap usage 183.846 MB -> 72.876 MB. [2025-05-07T11:37:04.051Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1636.164 ms) ====== [2025-05-07T11:37:04.051Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-05-07T11:37:04.051Z] GC before operation: completed in 140.723 ms, heap usage 295.861 MB -> 73.282 MB. [2025-05-07T11:37:05.998Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1600.567 ms) ====== [2025-05-07T11:37:05.998Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-05-07T11:37:05.998Z] GC before operation: completed in 145.323 ms, heap usage 296.478 MB -> 73.249 MB. [2025-05-07T11:37:06.947Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1628.409 ms) ====== [2025-05-07T11:37:07.898Z] ----------------------------------- [2025-05-07T11:37:07.898Z] renaissance-dec-tree_0_PASSED [2025-05-07T11:37:07.898Z] ----------------------------------- [2025-05-07T11:37:07.898Z] [2025-05-07T11:37:07.898Z] TEST TEARDOWN: [2025-05-07T11:37:07.898Z] Nothing to be done for teardown. [2025-05-07T11:37:07.898Z] renaissance-dec-tree_0 Finish Time: Wed May 7 11:37:07 2025 Epoch Time (ms): 1746617827141