[2025-02-20T01:43:27.253Z] Running test renaissance-dec-tree_0 ... [2025-02-20T01:43:27.253Z] =============================================== [2025-02-20T01:43:27.253Z] renaissance-dec-tree_0 Start Time: Thu Feb 20 01:43:27 2025 Epoch Time (ms): 1740015807057 [2025-02-20T01:43:27.253Z] variation: NoOptions [2025-02-20T01:43:27.253Z] JVM_OPTIONS: [2025-02-20T01:43:27.253Z] { \ [2025-02-20T01:43:27.253Z] echo ""; echo "TEST SETUP:"; \ [2025-02-20T01:43:27.253Z] echo "Nothing to be done for setup."; \ [2025-02-20T01:43:27.253Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17400148699441/renaissance-dec-tree_0"; \ [2025-02-20T01:43:27.253Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17400148699441/renaissance-dec-tree_0"; \ [2025-02-20T01:43:27.253Z] echo ""; echo "TESTING:"; \ [2025-02-20T01:43:27.254Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17400148699441/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-20T01:43:27.254Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17400148699441/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-20T01:43:27.254Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-20T01:43:27.254Z] echo "Nothing to be done for teardown."; \ [2025-02-20T01:43:27.254Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/../TKG/output_17400148699441/TestTargetResult"; [2025-02-20T01:43:27.254Z] [2025-02-20T01:43:27.254Z] TEST SETUP: [2025-02-20T01:43:27.254Z] Nothing to be done for setup. [2025-02-20T01:43:27.254Z] [2025-02-20T01:43:27.254Z] TESTING: [2025-02-20T01:43:46.113Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-20T01:43:48.613Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 16) threads. [2025-02-20T01:43:54.217Z] WARNING: An illegal reflective access operation has occurred [2025-02-20T01:43:54.217Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix/aqa-tests/TKG/output_17400148699441/renaissance-dec-tree_0/harness-014328-11342346813891257244/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-20T01:43:54.217Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-20T01:43:54.217Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-20T01:43:54.217Z] WARNING: All illegal access operations will be denied in a future release [2025-02-20T01:43:57.638Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-20T01:43:57.638Z] GC before operation: completed in 137.096 ms, heap usage 53.834 MB -> 34.352 MB. [2025-02-20T01:44:07.541Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9718.008 ms) ====== [2025-02-20T01:44:07.541Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-20T01:44:07.541Z] GC before operation: completed in 98.565 ms, heap usage 202.517 MB -> 64.449 MB. [2025-02-20T01:44:09.134Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2194.239 ms) ====== [2025-02-20T01:44:09.134Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-20T01:44:09.134Z] GC before operation: completed in 97.576 ms, heap usage 161.340 MB -> 64.351 MB. [2025-02-20T01:44:11.605Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1880.842 ms) ====== [2025-02-20T01:44:11.606Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-20T01:44:11.606Z] GC before operation: completed in 106.740 ms, heap usage 255.512 MB -> 65.031 MB. [2025-02-20T01:44:13.194Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1835.122 ms) ====== [2025-02-20T01:44:13.194Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-20T01:44:13.194Z] GC before operation: completed in 122.185 ms, heap usage 170.063 MB -> 65.211 MB. [2025-02-20T01:44:15.132Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1795.004 ms) ====== [2025-02-20T01:44:15.132Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-20T01:44:15.132Z] GC before operation: completed in 122.202 ms, heap usage 290.969 MB -> 65.481 MB. [2025-02-20T01:44:17.602Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1829.876 ms) ====== [2025-02-20T01:44:17.602Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-20T01:44:17.602Z] GC before operation: completed in 126.076 ms, heap usage 346.687 MB -> 65.917 MB. [2025-02-20T01:44:19.194Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1717.829 ms) ====== [2025-02-20T01:44:19.194Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-20T01:44:19.194Z] GC before operation: completed in 116.352 ms, heap usage 205.669 MB -> 65.757 MB. [2025-02-20T01:44:20.790Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1661.125 ms) ====== [2025-02-20T01:44:20.790Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-20T01:44:20.790Z] GC before operation: completed in 121.292 ms, heap usage 236.194 MB -> 66.015 MB. [2025-02-20T01:44:22.386Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1708.076 ms) ====== [2025-02-20T01:44:22.386Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-20T01:44:22.386Z] GC before operation: completed in 133.878 ms, heap usage 197.916 MB -> 66.337 MB. [2025-02-20T01:44:24.856Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1837.296 ms) ====== [2025-02-20T01:44:24.856Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-20T01:44:24.856Z] GC before operation: completed in 159.241 ms, heap usage 203.450 MB -> 66.226 MB. [2025-02-20T01:44:26.475Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1840.685 ms) ====== [2025-02-20T01:44:26.475Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-20T01:44:26.475Z] GC before operation: completed in 171.377 ms, heap usage 297.682 MB -> 66.186 MB. [2025-02-20T01:44:28.950Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1727.781 ms) ====== [2025-02-20T01:44:28.950Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-20T01:44:28.950Z] GC before operation: completed in 158.416 ms, heap usage 217.597 MB -> 66.465 MB. [2025-02-20T01:44:30.540Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1666.657 ms) ====== [2025-02-20T01:44:30.540Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-20T01:44:30.540Z] GC before operation: completed in 139.486 ms, heap usage 204.520 MB -> 66.591 MB. [2025-02-20T01:44:32.130Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1680.531 ms) ====== [2025-02-20T01:44:32.130Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-20T01:44:32.130Z] GC before operation: completed in 172.166 ms, heap usage 127.904 MB -> 77.158 MB. [2025-02-20T01:44:33.721Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1695.365 ms) ====== [2025-02-20T01:44:33.721Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-20T01:44:34.503Z] GC before operation: completed in 155.112 ms, heap usage 261.087 MB -> 66.798 MB. [2025-02-20T01:44:36.100Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1643.867 ms) ====== [2025-02-20T01:44:36.100Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-20T01:44:36.100Z] GC before operation: completed in 169.939 ms, heap usage 242.764 MB -> 66.959 MB. [2025-02-20T01:44:37.689Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1703.365 ms) ====== [2025-02-20T01:44:37.689Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-20T01:44:37.689Z] GC before operation: completed in 161.986 ms, heap usage 163.759 MB -> 66.643 MB. [2025-02-20T01:44:39.283Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1639.524 ms) ====== [2025-02-20T01:44:39.283Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-20T01:44:39.283Z] GC before operation: completed in 169.736 ms, heap usage 242.447 MB -> 67.015 MB. [2025-02-20T01:44:41.788Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1898.293 ms) ====== [2025-02-20T01:44:41.788Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-20T01:44:41.788Z] GC before operation: completed in 202.934 ms, heap usage 198.456 MB -> 72.726 MB. [2025-02-20T01:44:43.382Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1856.803 ms) ====== [2025-02-20T01:44:43.382Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-20T01:44:44.156Z] GC before operation: completed in 204.133 ms, heap usage 238.143 MB -> 78.486 MB. [2025-02-20T01:44:45.753Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1820.022 ms) ====== [2025-02-20T01:44:45.753Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-20T01:44:45.753Z] GC before operation: completed in 197.417 ms, heap usage 124.034 MB -> 66.744 MB. [2025-02-20T01:44:47.349Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1818.264 ms) ====== [2025-02-20T01:44:47.349Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-20T01:44:48.124Z] GC before operation: completed in 221.334 ms, heap usage 144.751 MB -> 67.121 MB. [2025-02-20T01:44:49.721Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1755.140 ms) ====== [2025-02-20T01:44:49.721Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-20T01:44:49.721Z] GC before operation: completed in 189.028 ms, heap usage 228.772 MB -> 67.650 MB. [2025-02-20T01:44:51.314Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1708.386 ms) ====== [2025-02-20T01:44:51.315Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-20T01:44:51.315Z] GC before operation: completed in 159.112 ms, heap usage 109.745 MB -> 67.191 MB. [2025-02-20T01:44:53.813Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1750.188 ms) ====== [2025-02-20T01:44:53.813Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-20T01:44:53.813Z] GC before operation: completed in 213.101 ms, heap usage 111.865 MB -> 78.424 MB. [2025-02-20T01:44:55.409Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1753.746 ms) ====== [2025-02-20T01:44:55.409Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-20T01:44:55.409Z] GC before operation: completed in 234.601 ms, heap usage 365.726 MB -> 95.381 MB. [2025-02-20T01:44:57.898Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1853.844 ms) ====== [2025-02-20T01:44:57.898Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-20T01:44:57.898Z] GC before operation: completed in 197.676 ms, heap usage 367.482 MB -> 79.151 MB. [2025-02-20T01:44:59.505Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1716.484 ms) ====== [2025-02-20T01:44:59.505Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-20T01:44:59.505Z] GC before operation: completed in 181.715 ms, heap usage 183.936 MB -> 67.863 MB. [2025-02-20T01:45:01.108Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1621.051 ms) ====== [2025-02-20T01:45:01.108Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-20T01:45:01.108Z] GC before operation: completed in 188.215 ms, heap usage 164.961 MB -> 67.963 MB. [2025-02-20T01:45:02.704Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1624.086 ms) ====== [2025-02-20T01:45:02.704Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-20T01:45:03.483Z] GC before operation: completed in 195.418 ms, heap usage 250.884 MB -> 79.460 MB. [2025-02-20T01:45:05.079Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1785.309 ms) ====== [2025-02-20T01:45:05.079Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-20T01:45:05.079Z] GC before operation: completed in 242.314 ms, heap usage 346.605 MB -> 79.558 MB. [2025-02-20T01:45:06.676Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1790.940 ms) ====== [2025-02-20T01:45:06.676Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-20T01:45:07.452Z] GC before operation: completed in 267.101 ms, heap usage 443.767 MB -> 68.726 MB. [2025-02-20T01:45:09.052Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1800.534 ms) ====== [2025-02-20T01:45:09.052Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-20T01:45:09.052Z] GC before operation: completed in 215.204 ms, heap usage 310.624 MB -> 79.750 MB. [2025-02-20T01:45:10.655Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1679.185 ms) ====== [2025-02-20T01:45:10.655Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-20T01:45:11.434Z] GC before operation: completed in 219.555 ms, heap usage 314.343 MB -> 68.712 MB. [2025-02-20T01:45:13.026Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1724.745 ms) ====== [2025-02-20T01:45:13.026Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-20T01:45:13.026Z] GC before operation: completed in 222.129 ms, heap usage 353.031 MB -> 68.838 MB. [2025-02-20T01:45:14.629Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1604.785 ms) ====== [2025-02-20T01:45:14.629Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-20T01:45:14.629Z] GC before operation: completed in 212.715 ms, heap usage 164.060 MB -> 74.121 MB. [2025-02-20T01:45:17.118Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1723.228 ms) ====== [2025-02-20T01:45:17.118Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-20T01:45:17.118Z] GC before operation: completed in 212.961 ms, heap usage 285.983 MB -> 85.570 MB. [2025-02-20T01:45:18.713Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1681.199 ms) ====== [2025-02-20T01:45:18.713Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-20T01:45:18.713Z] GC before operation: completed in 236.091 ms, heap usage 254.489 MB -> 85.448 MB. [2025-02-20T01:45:20.302Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1681.078 ms) ====== [2025-02-20T01:45:20.302Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-20T01:45:21.075Z] GC before operation: completed in 192.988 ms, heap usage 282.088 MB -> 69.428 MB. [2025-02-20T01:45:22.668Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1810.160 ms) ====== [2025-02-20T01:45:22.668Z] ----------------------------------- [2025-02-20T01:45:22.668Z] renaissance-dec-tree_0_PASSED [2025-02-20T01:45:22.668Z] ----------------------------------- [2025-02-20T01:45:22.668Z] [2025-02-20T01:45:22.668Z] TEST TEARDOWN: [2025-02-20T01:45:22.668Z] Nothing to be done for teardown. [2025-02-20T01:45:22.668Z] renaissance-dec-tree_0 Finish Time: Thu Feb 20 01:45:22 2025 Epoch Time (ms): 1740015922510