[2024-11-20T23:51:53.285Z] Running test renaissance-dec-tree_0 ... [2024-11-20T23:51:53.285Z] =============================================== [2024-11-20T23:51:53.285Z] renaissance-dec-tree_0 Start Time: Wed Nov 20 23:51:52 2024 Epoch Time (ms): 1732146712323 [2024-11-20T23:51:53.285Z] variation: NoOptions [2024-11-20T23:51:53.285Z] JVM_OPTIONS: [2024-11-20T23:51:53.285Z] { \ [2024-11-20T23:51:53.285Z] echo ""; echo "TEST SETUP:"; \ [2024-11-20T23:51:53.285Z] echo "Nothing to be done for setup."; \ [2024-11-20T23:51:53.285Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_173214619237/renaissance-dec-tree_0"; \ [2024-11-20T23:51:53.285Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_173214619237/renaissance-dec-tree_0"; \ [2024-11-20T23:51:53.285Z] echo ""; echo "TESTING:"; \ [2024-11-20T23:51:53.285Z] "/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_173214619237/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-20T23:51:53.285Z] 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_173214619237/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-20T23:51:53.285Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-20T23:51:53.285Z] echo "Nothing to be done for teardown."; \ [2024-11-20T23:51:53.285Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_173214619237/TestTargetResult"; [2024-11-20T23:51:53.285Z] [2024-11-20T23:51:53.285Z] TEST SETUP: [2024-11-20T23:51:53.285Z] Nothing to be done for setup. [2024-11-20T23:51:53.285Z] [2024-11-20T23:51:53.285Z] TESTING: [2024-11-20T23:51:56.351Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-20T23:51:58.335Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-20T23:52:00.550Z] WARNING: An illegal reflective access operation has occurred [2024-11-20T23:52:00.550Z] 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_173214619237/renaissance-dec-tree_0/harness-235153-13575956625607598106/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-11-20T23:52:00.550Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-11-20T23:52:00.550Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-11-20T23:52:00.550Z] WARNING: All illegal access operations will be denied in a future release [2024-11-20T23:52:01.517Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-20T23:52:01.517Z] GC before operation: completed in 61.566 ms, heap usage 60.779 MB -> 33.758 MB. [2024-11-20T23:52:09.758Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8023.852 ms) ====== [2024-11-20T23:52:09.758Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-20T23:52:09.758Z] GC before operation: completed in 86.559 ms, heap usage 148.739 MB -> 63.362 MB. [2024-11-20T23:52:11.740Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2259.906 ms) ====== [2024-11-20T23:52:11.740Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-20T23:52:11.740Z] GC before operation: completed in 90.241 ms, heap usage 144.908 MB -> 63.953 MB. [2024-11-20T23:52:13.725Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1994.741 ms) ====== [2024-11-20T23:52:13.725Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-20T23:52:14.690Z] GC before operation: completed in 86.117 ms, heap usage 187.690 MB -> 64.391 MB. [2024-11-20T23:52:15.656Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1828.356 ms) ====== [2024-11-20T23:52:15.656Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-20T23:52:16.626Z] GC before operation: completed in 93.191 ms, heap usage 172.988 MB -> 64.350 MB. [2024-11-20T23:52:17.593Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1784.345 ms) ====== [2024-11-20T23:52:17.593Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-20T23:52:17.593Z] GC before operation: completed in 101.458 ms, heap usage 131.615 MB -> 64.395 MB. [2024-11-20T23:52:19.584Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1748.119 ms) ====== [2024-11-20T23:52:19.584Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-20T23:52:19.584Z] GC before operation: completed in 103.641 ms, heap usage 142.954 MB -> 64.871 MB. [2024-11-20T23:52:21.568Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1760.774 ms) ====== [2024-11-20T23:52:21.569Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-20T23:52:21.569Z] GC before operation: completed in 115.730 ms, heap usage 159.957 MB -> 64.833 MB. [2024-11-20T23:52:23.552Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1841.419 ms) ====== [2024-11-20T23:52:23.552Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-20T23:52:23.552Z] GC before operation: completed in 99.170 ms, heap usage 129.758 MB -> 65.199 MB. [2024-11-20T23:52:25.537Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1732.210 ms) ====== [2024-11-20T23:52:25.537Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-20T23:52:25.537Z] GC before operation: completed in 110.945 ms, heap usage 182.764 MB -> 65.325 MB. [2024-11-20T23:52:27.529Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1801.655 ms) ====== [2024-11-20T23:52:27.529Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-20T23:52:27.529Z] GC before operation: completed in 117.157 ms, heap usage 217.261 MB -> 65.611 MB. [2024-11-20T23:52:29.511Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1691.534 ms) ====== [2024-11-20T23:52:29.511Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-20T23:52:29.511Z] GC before operation: completed in 101.817 ms, heap usage 132.220 MB -> 65.716 MB. [2024-11-20T23:52:31.495Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1708.926 ms) ====== [2024-11-20T23:52:31.495Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-20T23:52:31.495Z] GC before operation: completed in 110.468 ms, heap usage 106.877 MB -> 65.283 MB. [2024-11-20T23:52:32.460Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1681.717 ms) ====== [2024-11-20T23:52:32.460Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-20T23:52:32.460Z] GC before operation: completed in 120.872 ms, heap usage 115.784 MB -> 65.652 MB. [2024-11-20T23:52:34.442Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1651.576 ms) ====== [2024-11-20T23:52:34.442Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-20T23:52:34.442Z] GC before operation: completed in 111.967 ms, heap usage 267.494 MB -> 87.876 MB. [2024-11-20T23:52:36.421Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1668.698 ms) ====== [2024-11-20T23:52:36.421Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-20T23:52:36.421Z] GC before operation: completed in 117.446 ms, heap usage 204.926 MB -> 71.425 MB. [2024-11-20T23:52:38.401Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1620.059 ms) ====== [2024-11-20T23:52:38.401Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-20T23:52:38.401Z] GC before operation: completed in 116.047 ms, heap usage 187.461 MB -> 66.325 MB. [2024-11-20T23:52:40.379Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1695.098 ms) ====== [2024-11-20T23:52:40.379Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-20T23:52:40.379Z] GC before operation: completed in 116.081 ms, heap usage 159.585 MB -> 66.284 MB. [2024-11-20T23:52:41.353Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1688.812 ms) ====== [2024-11-20T23:52:41.353Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-20T23:52:41.353Z] GC before operation: completed in 109.116 ms, heap usage 113.195 MB -> 65.976 MB. [2024-11-20T23:52:43.398Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1632.129 ms) ====== [2024-11-20T23:52:43.398Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-20T23:52:43.398Z] GC before operation: completed in 109.683 ms, heap usage 240.852 MB -> 66.474 MB. [2024-11-20T23:52:45.378Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1670.403 ms) ====== [2024-11-20T23:52:45.378Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-20T23:52:45.378Z] GC before operation: completed in 126.654 ms, heap usage 208.939 MB -> 66.726 MB. [2024-11-20T23:52:47.364Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1673.099 ms) ====== [2024-11-20T23:52:47.364Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-20T23:52:47.364Z] GC before operation: completed in 128.023 ms, heap usage 191.252 MB -> 66.676 MB. [2024-11-20T23:52:49.346Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1700.951 ms) ====== [2024-11-20T23:52:49.346Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-20T23:52:49.346Z] GC before operation: completed in 128.456 ms, heap usage 144.597 MB -> 66.904 MB. [2024-11-20T23:52:50.311Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1672.608 ms) ====== [2024-11-20T23:52:50.311Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-20T23:52:50.311Z] GC before operation: completed in 130.201 ms, heap usage 224.209 MB -> 66.876 MB. [2024-11-20T23:52:52.293Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1645.358 ms) ====== [2024-11-20T23:52:52.293Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-20T23:52:52.293Z] GC before operation: completed in 119.875 ms, heap usage 217.252 MB -> 66.975 MB. [2024-11-20T23:52:54.274Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1642.038 ms) ====== [2024-11-20T23:52:54.274Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-20T23:52:54.274Z] GC before operation: completed in 113.251 ms, heap usage 199.012 MB -> 78.364 MB. [2024-11-20T23:52:56.258Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1607.778 ms) ====== [2024-11-20T23:52:56.258Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-20T23:52:56.258Z] GC before operation: completed in 122.112 ms, heap usage 239.677 MB -> 78.060 MB. [2024-11-20T23:52:57.225Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1647.074 ms) ====== [2024-11-20T23:52:57.225Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-20T23:52:58.190Z] GC before operation: completed in 124.848 ms, heap usage 226.285 MB -> 67.418 MB. [2024-11-20T23:52:59.157Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1640.492 ms) ====== [2024-11-20T23:52:59.157Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-20T23:52:59.157Z] GC before operation: completed in 131.785 ms, heap usage 190.879 MB -> 67.512 MB. [2024-11-20T23:53:01.138Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1670.531 ms) ====== [2024-11-20T23:53:01.138Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-20T23:53:01.138Z] GC before operation: completed in 137.541 ms, heap usage 215.999 MB -> 78.366 MB. [2024-11-20T23:53:03.148Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1653.621 ms) ====== [2024-11-20T23:53:03.148Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-20T23:53:03.148Z] GC before operation: completed in 124.512 ms, heap usage 228.938 MB -> 78.627 MB. [2024-11-20T23:53:06.028Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1672.643 ms) ====== [2024-11-20T23:53:06.028Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-20T23:53:06.028Z] GC before operation: completed in 141.115 ms, heap usage 327.725 MB -> 89.841 MB. [2024-11-20T23:53:06.996Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1665.949 ms) ====== [2024-11-20T23:53:06.996Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-20T23:53:06.996Z] GC before operation: completed in 129.323 ms, heap usage 213.540 MB -> 67.901 MB. [2024-11-20T23:53:07.961Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1608.529 ms) ====== [2024-11-20T23:53:07.961Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-20T23:53:08.927Z] GC before operation: completed in 130.890 ms, heap usage 219.012 MB -> 67.851 MB. [2024-11-20T23:53:09.976Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1572.910 ms) ====== [2024-11-20T23:53:09.976Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-20T23:53:09.976Z] GC before operation: completed in 121.818 ms, heap usage 107.648 MB -> 84.177 MB. [2024-11-20T23:53:11.961Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1582.380 ms) ====== [2024-11-20T23:53:11.961Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-20T23:53:11.961Z] GC before operation: completed in 119.877 ms, heap usage 159.795 MB -> 84.450 MB. [2024-11-20T23:53:13.942Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1548.700 ms) ====== [2024-11-20T23:53:13.942Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-20T23:53:13.942Z] GC before operation: completed in 120.281 ms, heap usage 240.251 MB -> 79.443 MB. [2024-11-20T23:53:15.089Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1587.959 ms) ====== [2024-11-20T23:53:15.089Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-20T23:53:15.089Z] GC before operation: completed in 115.161 ms, heap usage 219.278 MB -> 68.397 MB. [2024-11-20T23:53:17.071Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1588.677 ms) ====== [2024-11-20T23:53:17.071Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-20T23:53:17.071Z] GC before operation: completed in 116.523 ms, heap usage 207.288 MB -> 68.366 MB. [2024-11-20T23:53:19.147Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1596.004 ms) ====== [2024-11-20T23:53:19.147Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-20T23:53:19.147Z] GC before operation: completed in 116.853 ms, heap usage 194.197 MB -> 68.590 MB. [2024-11-20T23:53:20.115Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1577.400 ms) ====== [2024-11-20T23:53:20.115Z] ----------------------------------- [2024-11-20T23:53:20.115Z] renaissance-dec-tree_0_PASSED [2024-11-20T23:53:20.115Z] ----------------------------------- [2024-11-20T23:53:20.115Z] [2024-11-20T23:53:20.115Z] TEST TEARDOWN: [2024-11-20T23:53:20.115Z] Nothing to be done for teardown. [2024-11-20T23:53:20.115Z] renaissance-dec-tree_0 Finish Time: Wed Nov 20 23:53:19 2024 Epoch Time (ms): 1732146799962