[2025-03-05T22:34:11.414Z] Running test renaissance-dec-tree_0 ... [2025-03-05T22:34:11.414Z] =============================================== [2025-03-05T22:34:11.414Z] renaissance-dec-tree_0 Start Time: Wed Mar 5 22:34:10 2025 Epoch Time (ms): 1741214050946 [2025-03-05T22:34:11.414Z] variation: NoOptions [2025-03-05T22:34:11.414Z] JVM_OPTIONS: [2025-03-05T22:34:11.414Z] { \ [2025-03-05T22:34:11.414Z] echo ""; echo "TEST SETUP:"; \ [2025-03-05T22:34:11.414Z] echo "Nothing to be done for setup."; \ [2025-03-05T22:34:11.414Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17412135471852/renaissance-dec-tree_0"; \ [2025-03-05T22:34:11.414Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17412135471852/renaissance-dec-tree_0"; \ [2025-03-05T22:34:11.414Z] echo ""; echo "TESTING:"; \ [2025-03-05T22:34:11.414Z] "/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_17412135471852/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-03-05T22:34:11.414Z] 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_17412135471852/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-05T22:34:11.414Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-05T22:34:11.414Z] echo "Nothing to be done for teardown."; \ [2025-03-05T22:34:11.414Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17412135471852/TestTargetResult"; [2025-03-05T22:34:11.414Z] [2025-03-05T22:34:11.414Z] TEST SETUP: [2025-03-05T22:34:11.414Z] Nothing to be done for setup. [2025-03-05T22:34:11.414Z] [2025-03-05T22:34:11.414Z] TESTING: [2025-03-05T22:34:14.450Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-05T22:34:16.399Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-03-05T22:34:17.348Z] WARNING: An illegal reflective access operation has occurred [2025-03-05T22:34:17.348Z] 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_17412135471852/renaissance-dec-tree_0/harness-223411-1810269259746153701/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-05T22:34:17.348Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-05T22:34:17.348Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-05T22:34:17.348Z] WARNING: All illegal access operations will be denied in a future release [2025-03-05T22:34:20.358Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-03-05T22:34:20.358Z] GC before operation: completed in 50.865 ms, heap usage 55.878 MB -> 33.749 MB. [2025-03-05T22:34:28.481Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7600.053 ms) ====== [2025-03-05T22:34:28.481Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-03-05T22:34:28.481Z] GC before operation: completed in 103.833 ms, heap usage 103.438 MB -> 63.369 MB. [2025-03-05T22:34:30.448Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2185.099 ms) ====== [2025-03-05T22:34:30.448Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-03-05T22:34:30.448Z] GC before operation: completed in 109.653 ms, heap usage 186.527 MB -> 63.951 MB. [2025-03-05T22:34:32.396Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1897.426 ms) ====== [2025-03-05T22:34:32.396Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-03-05T22:34:32.396Z] GC before operation: completed in 89.205 ms, heap usage 127.536 MB -> 64.087 MB. [2025-03-05T22:34:34.348Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1777.408 ms) ====== [2025-03-05T22:34:34.348Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-03-05T22:34:34.348Z] GC before operation: completed in 89.191 ms, heap usage 260.518 MB -> 64.619 MB. [2025-03-05T22:34:36.300Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1751.427 ms) ====== [2025-03-05T22:34:36.300Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-03-05T22:34:36.301Z] GC before operation: completed in 102.540 ms, heap usage 181.441 MB -> 64.679 MB. [2025-03-05T22:34:37.250Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1639.624 ms) ====== [2025-03-05T22:34:37.250Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-03-05T22:34:37.250Z] GC before operation: completed in 94.333 ms, heap usage 275.933 MB -> 65.032 MB. [2025-03-05T22:34:39.239Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1651.940 ms) ====== [2025-03-05T22:34:39.239Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-03-05T22:34:39.239Z] GC before operation: completed in 94.814 ms, heap usage 229.318 MB -> 65.099 MB. [2025-03-05T22:34:41.205Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1644.242 ms) ====== [2025-03-05T22:34:41.205Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-03-05T22:34:41.205Z] GC before operation: completed in 95.813 ms, heap usage 132.092 MB -> 65.070 MB. [2025-03-05T22:34:43.151Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1608.083 ms) ====== [2025-03-05T22:34:43.151Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-03-05T22:34:43.151Z] GC before operation: completed in 95.945 ms, heap usage 162.893 MB -> 65.055 MB. [2025-03-05T22:34:44.118Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1623.892 ms) ====== [2025-03-05T22:34:44.118Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-03-05T22:34:44.118Z] GC before operation: completed in 98.041 ms, heap usage 262.915 MB -> 65.568 MB. [2025-03-05T22:34:46.080Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1591.167 ms) ====== [2025-03-05T22:34:46.080Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-03-05T22:34:46.080Z] GC before operation: completed in 98.350 ms, heap usage 230.348 MB -> 65.672 MB. [2025-03-05T22:34:48.030Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1582.571 ms) ====== [2025-03-05T22:34:48.030Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-03-05T22:34:48.030Z] GC before operation: completed in 102.303 ms, heap usage 217.621 MB -> 76.671 MB. [2025-03-05T22:34:49.981Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1568.303 ms) ====== [2025-03-05T22:34:49.981Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-03-05T22:34:49.981Z] GC before operation: completed in 98.461 ms, heap usage 139.167 MB -> 65.450 MB. [2025-03-05T22:34:50.931Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1525.083 ms) ====== [2025-03-05T22:34:50.931Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-03-05T22:34:50.931Z] GC before operation: completed in 101.091 ms, heap usage 283.446 MB -> 77.030 MB. [2025-03-05T22:34:52.880Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1595.134 ms) ====== [2025-03-05T22:34:52.880Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-03-05T22:34:52.880Z] GC before operation: completed in 113.411 ms, heap usage 149.548 MB -> 65.709 MB. [2025-03-05T22:34:54.852Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1560.414 ms) ====== [2025-03-05T22:34:54.852Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-03-05T22:34:54.852Z] GC before operation: completed in 106.713 ms, heap usage 164.773 MB -> 66.035 MB. [2025-03-05T22:34:55.802Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1556.100 ms) ====== [2025-03-05T22:34:55.802Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-03-05T22:34:55.802Z] GC before operation: completed in 108.523 ms, heap usage 201.839 MB -> 66.256 MB. [2025-03-05T22:34:57.752Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1582.449 ms) ====== [2025-03-05T22:34:57.752Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-03-05T22:34:57.752Z] GC before operation: completed in 108.994 ms, heap usage 251.685 MB -> 66.360 MB. [2025-03-05T22:34:59.719Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1547.321 ms) ====== [2025-03-05T22:34:59.719Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-03-05T22:34:59.719Z] GC before operation: completed in 103.460 ms, heap usage 183.216 MB -> 66.462 MB. [2025-03-05T22:35:00.668Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1531.742 ms) ====== [2025-03-05T22:35:00.668Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-03-05T22:35:01.619Z] GC before operation: completed in 106.073 ms, heap usage 264.730 MB -> 66.558 MB. [2025-03-05T22:35:02.577Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1520.281 ms) ====== [2025-03-05T22:35:02.577Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-03-05T22:35:02.577Z] GC before operation: completed in 114.963 ms, heap usage 165.337 MB -> 66.394 MB. [2025-03-05T22:35:04.525Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1528.540 ms) ====== [2025-03-05T22:35:04.525Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-03-05T22:35:04.525Z] GC before operation: completed in 106.170 ms, heap usage 275.078 MB -> 83.457 MB. [2025-03-05T22:35:06.473Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1500.420 ms) ====== [2025-03-05T22:35:06.473Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-03-05T22:35:06.473Z] GC before operation: completed in 110.976 ms, heap usage 206.631 MB -> 67.021 MB. [2025-03-05T22:35:07.427Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1520.521 ms) ====== [2025-03-05T22:35:07.427Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-03-05T22:35:07.427Z] GC before operation: completed in 108.249 ms, heap usage 147.203 MB -> 66.686 MB. [2025-03-05T22:35:09.378Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1520.523 ms) ====== [2025-03-05T22:35:09.378Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-03-05T22:35:09.378Z] GC before operation: completed in 109.120 ms, heap usage 190.947 MB -> 67.479 MB. [2025-03-05T22:35:12.781Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1530.120 ms) ====== [2025-03-05T22:35:12.781Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-03-05T22:35:12.781Z] GC before operation: completed in 117.615 ms, heap usage 222.723 MB -> 67.176 MB. [2025-03-05T22:35:12.781Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1518.294 ms) ====== [2025-03-05T22:35:12.781Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-03-05T22:35:12.781Z] GC before operation: completed in 110.424 ms, heap usage 286.748 MB -> 67.278 MB. [2025-03-05T22:35:13.730Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1494.316 ms) ====== [2025-03-05T22:35:13.730Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-03-05T22:35:14.679Z] GC before operation: completed in 108.695 ms, heap usage 266.528 MB -> 72.774 MB. [2025-03-05T22:35:15.629Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1493.738 ms) ====== [2025-03-05T22:35:15.629Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-03-05T22:35:15.629Z] GC before operation: completed in 115.722 ms, heap usage 197.249 MB -> 67.607 MB. [2025-03-05T22:35:17.582Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1508.145 ms) ====== [2025-03-05T22:35:17.582Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-03-05T22:35:17.582Z] GC before operation: completed in 110.707 ms, heap usage 276.029 MB -> 78.638 MB. [2025-03-05T22:35:19.530Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1514.312 ms) ====== [2025-03-05T22:35:19.530Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-03-05T22:35:19.530Z] GC before operation: completed in 115.136 ms, heap usage 279.588 MB -> 67.799 MB. [2025-03-05T22:35:20.478Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1544.093 ms) ====== [2025-03-05T22:35:20.478Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-03-05T22:35:20.478Z] GC before operation: completed in 117.055 ms, heap usage 161.742 MB -> 67.645 MB. [2025-03-05T22:35:22.436Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1500.777 ms) ====== [2025-03-05T22:35:22.436Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-03-05T22:35:22.436Z] GC before operation: completed in 115.410 ms, heap usage 229.572 MB -> 67.865 MB. [2025-03-05T22:35:24.387Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1466.507 ms) ====== [2025-03-05T22:35:24.387Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-03-05T22:35:24.387Z] GC before operation: completed in 110.520 ms, heap usage 247.490 MB -> 84.438 MB. [2025-03-05T22:35:25.336Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1472.224 ms) ====== [2025-03-05T22:35:25.336Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-03-05T22:35:25.336Z] GC before operation: completed in 113.800 ms, heap usage 261.593 MB -> 68.051 MB. [2025-03-05T22:35:27.287Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1496.547 ms) ====== [2025-03-05T22:35:27.287Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-03-05T22:35:27.287Z] GC before operation: completed in 136.151 ms, heap usage 270.928 MB -> 68.166 MB. [2025-03-05T22:35:29.238Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1578.880 ms) ====== [2025-03-05T22:35:29.239Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-03-05T22:35:29.239Z] GC before operation: completed in 138.804 ms, heap usage 256.205 MB -> 68.412 MB. [2025-03-05T22:35:30.187Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1572.792 ms) ====== [2025-03-05T22:35:30.187Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-03-05T22:35:30.187Z] GC before operation: completed in 130.671 ms, heap usage 134.113 MB -> 68.072 MB. [2025-03-05T22:35:32.138Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1549.945 ms) ====== [2025-03-05T22:35:32.138Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-03-05T22:35:32.138Z] GC before operation: completed in 141.873 ms, heap usage 289.815 MB -> 90.615 MB. [2025-03-05T22:35:34.091Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1563.774 ms) ====== [2025-03-05T22:35:34.091Z] ----------------------------------- [2025-03-05T22:35:34.091Z] renaissance-dec-tree_0_PASSED [2025-03-05T22:35:34.091Z] ----------------------------------- [2025-03-05T22:35:34.091Z] [2025-03-05T22:35:34.091Z] TEST TEARDOWN: [2025-03-05T22:35:34.091Z] Nothing to be done for teardown. [2025-03-05T22:35:34.091Z] renaissance-dec-tree_0 Finish Time: Wed Mar 5 22:35:33 2025 Epoch Time (ms): 1741214133605