[2024-11-22T07:13:48.472Z] Running test renaissance-dec-tree_0 ... [2024-11-22T07:13:48.472Z] =============================================== [2024-11-22T07:13:48.472Z] renaissance-dec-tree_0 Start Time: Fri Nov 22 07:13:47 2024 Epoch Time (ms): 1732259627669 [2024-11-22T07:13:48.472Z] variation: NoOptions [2024-11-22T07:13:48.472Z] JVM_OPTIONS: [2024-11-22T07:13:48.472Z] { \ [2024-11-22T07:13:48.472Z] echo ""; echo "TEST SETUP:"; \ [2024-11-22T07:13:48.472Z] echo "Nothing to be done for setup."; \ [2024-11-22T07:13:48.472Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17322585752769/renaissance-dec-tree_0"; \ [2024-11-22T07:13:48.472Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17322585752769/renaissance-dec-tree_0"; \ [2024-11-22T07:13:48.472Z] echo ""; echo "TESTING:"; \ [2024-11-22T07:13:48.472Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-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_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17322585752769/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-22T07:13:48.473Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17322585752769/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-22T07:13:48.473Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-22T07:13:48.473Z] echo "Nothing to be done for teardown."; \ [2024-11-22T07:13:48.473Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17322585752769/TestTargetResult"; [2024-11-22T07:13:48.473Z] [2024-11-22T07:13:48.473Z] TEST SETUP: [2024-11-22T07:13:48.473Z] Nothing to be done for setup. [2024-11-22T07:13:48.473Z] [2024-11-22T07:13:48.473Z] TESTING: [2024-11-22T07:13:55.683Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-22T07:14:02.873Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-22T07:14:06.461Z] WARNING: An illegal reflective access operation has occurred [2024-11-22T07:14:06.461Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17322585752769/renaissance-dec-tree_0/harness-071349-3154116571782301867/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-11-22T07:14:06.461Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-11-22T07:14:06.461Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-11-22T07:14:06.461Z] WARNING: All illegal access operations will be denied in a future release [2024-11-22T07:14:15.623Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-22T07:14:15.623Z] GC before operation: completed in 161.281 ms, heap usage 95.162 MB -> 33.805 MB. [2024-11-22T07:14:51.618Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (33962.546 ms) ====== [2024-11-22T07:14:51.618Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-22T07:14:51.618Z] GC before operation: completed in 363.406 ms, heap usage 291.019 MB -> 63.667 MB. [2024-11-22T07:15:00.227Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (11284.995 ms) ====== [2024-11-22T07:15:00.227Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-22T07:15:01.053Z] GC before operation: completed in 503.587 ms, heap usage 197.653 MB -> 64.090 MB. [2024-11-22T07:15:13.131Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (11240.795 ms) ====== [2024-11-22T07:15:13.131Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-22T07:15:13.131Z] GC before operation: completed in 381.730 ms, heap usage 210.200 MB -> 64.388 MB. [2024-11-22T07:15:21.783Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (8964.075 ms) ====== [2024-11-22T07:15:21.783Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-22T07:15:21.783Z] GC before operation: completed in 515.136 ms, heap usage 231.139 MB -> 64.594 MB. [2024-11-22T07:15:30.500Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8698.779 ms) ====== [2024-11-22T07:15:30.501Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-22T07:15:31.323Z] GC before operation: completed in 493.006 ms, heap usage 229.826 MB -> 64.850 MB. [2024-11-22T07:15:38.699Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (7694.371 ms) ====== [2024-11-22T07:15:38.699Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-22T07:15:39.510Z] GC before operation: completed in 377.522 ms, heap usage 157.870 MB -> 65.019 MB. [2024-11-22T07:15:46.713Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6789.981 ms) ====== [2024-11-22T07:15:46.713Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-22T07:15:46.713Z] GC before operation: completed in 514.326 ms, heap usage 119.166 MB -> 64.793 MB. [2024-11-22T07:15:52.588Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5940.706 ms) ====== [2024-11-22T07:15:52.588Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-22T07:15:53.402Z] GC before operation: completed in 312.043 ms, heap usage 194.108 MB -> 76.467 MB. [2024-11-22T07:15:59.285Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (6003.779 ms) ====== [2024-11-22T07:15:59.285Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-22T07:15:59.285Z] GC before operation: completed in 434.110 ms, heap usage 242.400 MB -> 92.848 MB. [2024-11-22T07:16:05.175Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (5670.708 ms) ====== [2024-11-22T07:16:05.175Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-22T07:16:05.175Z] GC before operation: completed in 394.011 ms, heap usage 124.790 MB -> 65.256 MB. [2024-11-22T07:16:11.043Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (5220.879 ms) ====== [2024-11-22T07:16:11.043Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-22T07:16:11.043Z] GC before operation: completed in 391.366 ms, heap usage 134.015 MB -> 65.641 MB. [2024-11-22T07:16:18.102Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (5301.034 ms) ====== [2024-11-22T07:16:18.102Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-22T07:16:18.102Z] GC before operation: completed in 436.929 ms, heap usage 316.075 MB -> 65.740 MB. [2024-11-22T07:16:22.927Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (6277.617 ms) ====== [2024-11-22T07:16:22.927Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-22T07:16:23.747Z] GC before operation: completed in 453.631 ms, heap usage 234.050 MB -> 76.779 MB. [2024-11-22T07:16:29.613Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (5460.083 ms) ====== [2024-11-22T07:16:29.613Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-22T07:16:29.613Z] GC before operation: completed in 456.436 ms, heap usage 280.990 MB -> 77.130 MB. [2024-11-22T07:16:34.626Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (5326.864 ms) ====== [2024-11-22T07:16:34.626Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-22T07:16:35.437Z] GC before operation: completed in 369.744 ms, heap usage 204.907 MB -> 66.096 MB. [2024-11-22T07:16:40.121Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5302.127 ms) ====== [2024-11-22T07:16:40.121Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-22T07:16:40.952Z] GC before operation: completed in 468.058 ms, heap usage 264.154 MB -> 66.282 MB. [2024-11-22T07:16:45.637Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4754.694 ms) ====== [2024-11-22T07:16:45.637Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-22T07:16:46.449Z] GC before operation: completed in 465.243 ms, heap usage 106.934 MB -> 65.920 MB. [2024-11-22T07:16:52.318Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (5332.502 ms) ====== [2024-11-22T07:16:52.318Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-22T07:16:52.318Z] GC before operation: completed in 450.774 ms, heap usage 114.329 MB -> 66.418 MB. [2024-11-22T07:16:56.979Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5271.282 ms) ====== [2024-11-22T07:16:56.979Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-22T07:16:57.785Z] GC before operation: completed in 435.241 ms, heap usage 112.177 MB -> 66.013 MB. [2024-11-22T07:17:02.553Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4565.153 ms) ====== [2024-11-22T07:17:02.553Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-22T07:17:02.553Z] GC before operation: completed in 519.372 ms, heap usage 259.795 MB -> 66.680 MB. [2024-11-22T07:17:07.553Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4778.105 ms) ====== [2024-11-22T07:17:07.553Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-22T07:17:08.428Z] GC before operation: completed in 394.376 ms, heap usage 243.556 MB -> 83.107 MB. [2024-11-22T07:17:12.249Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (4514.444 ms) ====== [2024-11-22T07:17:12.249Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-22T07:17:13.121Z] GC before operation: completed in 420.396 ms, heap usage 160.646 MB -> 66.859 MB. [2024-11-22T07:17:16.938Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4157.889 ms) ====== [2024-11-22T07:17:16.938Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-22T07:17:17.807Z] GC before operation: completed in 437.035 ms, heap usage 203.016 MB -> 78.149 MB. [2024-11-22T07:17:21.633Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (4008.160 ms) ====== [2024-11-22T07:17:21.634Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-22T07:17:21.634Z] GC before operation: completed in 443.661 ms, heap usage 113.777 MB -> 66.668 MB. [2024-11-22T07:17:26.573Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (3971.106 ms) ====== [2024-11-22T07:17:26.573Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-22T07:17:26.573Z] GC before operation: completed in 358.928 ms, heap usage 216.562 MB -> 67.191 MB. [2024-11-22T07:17:30.965Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (4592.326 ms) ====== [2024-11-22T07:17:30.965Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-22T07:17:30.965Z] GC before operation: completed in 433.639 ms, heap usage 223.869 MB -> 67.290 MB. [2024-11-22T07:17:35.946Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4514.134 ms) ====== [2024-11-22T07:17:35.946Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-22T07:17:35.946Z] GC before operation: completed in 417.121 ms, heap usage 153.339 MB -> 67.371 MB. [2024-11-22T07:17:40.919Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4597.715 ms) ====== [2024-11-22T07:17:40.919Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-22T07:17:40.919Z] GC before operation: completed in 411.535 ms, heap usage 291.094 MB -> 67.489 MB. [2024-11-22T07:17:47.144Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (5046.865 ms) ====== [2024-11-22T07:17:47.144Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-22T07:17:47.144Z] GC before operation: completed in 471.883 ms, heap usage 285.330 MB -> 67.598 MB. [2024-11-22T07:17:52.107Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (4769.607 ms) ====== [2024-11-22T07:17:52.107Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-22T07:17:52.107Z] GC before operation: completed in 469.013 ms, heap usage 164.930 MB -> 67.706 MB. [2024-11-22T07:17:55.932Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4220.391 ms) ====== [2024-11-22T07:17:55.932Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-22T07:17:56.796Z] GC before operation: completed in 543.751 ms, heap usage 219.995 MB -> 67.786 MB. [2024-11-22T07:18:01.779Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (4237.256 ms) ====== [2024-11-22T07:18:01.779Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-22T07:18:01.779Z] GC before operation: completed in 428.413 ms, heap usage 285.219 MB -> 67.962 MB. [2024-11-22T07:18:06.730Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (4674.344 ms) ====== [2024-11-22T07:18:06.730Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-22T07:18:06.730Z] GC before operation: completed in 465.161 ms, heap usage 217.334 MB -> 67.984 MB. [2024-11-22T07:18:11.684Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (4621.575 ms) ====== [2024-11-22T07:18:11.684Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-22T07:18:11.684Z] GC before operation: completed in 488.364 ms, heap usage 165.308 MB -> 67.897 MB. [2024-11-22T07:18:16.667Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (4316.677 ms) ====== [2024-11-22T07:18:16.667Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-22T07:18:16.667Z] GC before operation: completed in 535.116 ms, heap usage 209.091 MB -> 68.032 MB. [2024-11-22T07:18:22.827Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (5453.051 ms) ====== [2024-11-22T07:18:22.827Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-22T07:18:22.827Z] GC before operation: completed in 480.723 ms, heap usage 101.051 MB -> 67.712 MB. [2024-11-22T07:18:26.639Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4139.453 ms) ====== [2024-11-22T07:18:26.639Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-22T07:18:27.499Z] GC before operation: completed in 373.009 ms, heap usage 232.065 MB -> 68.214 MB. [2024-11-22T07:18:30.913Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (4096.653 ms) ====== [2024-11-22T07:18:30.913Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-22T07:18:31.777Z] GC before operation: completed in 504.169 ms, heap usage 171.120 MB -> 68.193 MB. [2024-11-22T07:18:36.701Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (5149.768 ms) ====== [2024-11-22T07:18:36.701Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-22T07:18:37.562Z] GC before operation: completed in 599.558 ms, heap usage 299.812 MB -> 68.553 MB. [2024-11-22T07:18:42.469Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (5049.415 ms) ====== [2024-11-22T07:18:43.337Z] ----------------------------------- [2024-11-22T07:18:43.337Z] renaissance-dec-tree_0_PASSED [2024-11-22T07:18:43.337Z] ----------------------------------- [2024-11-22T07:18:43.337Z] [2024-11-22T07:18:43.337Z] TEST TEARDOWN: [2024-11-22T07:18:43.337Z] Nothing to be done for teardown. [2024-11-22T07:18:43.337Z] renaissance-dec-tree_0 Finish Time: Fri Nov 22 07:18:42 2024 Epoch Time (ms): 1732259922817