[2025-06-12T22:33:58.160Z] Running test renaissance-dec-tree_0 ... [2025-06-12T22:33:58.160Z] =============================================== [2025-06-12T22:33:58.160Z] renaissance-dec-tree_0 Start Time: Thu Jun 12 22:33:58 2025 Epoch Time (ms): 1749767638048 [2025-06-12T22:33:58.160Z] variation: NoOptions [2025-06-12T22:33:58.160Z] JVM_OPTIONS: [2025-06-12T22:33:58.160Z] { \ [2025-06-12T22:33:58.160Z] echo ""; echo "TEST SETUP:"; \ [2025-06-12T22:33:58.160Z] echo "Nothing to be done for setup."; \ [2025-06-12T22:33:58.160Z] mkdir -p "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17497671083486/renaissance-dec-tree_0"; \ [2025-06-12T22:33:58.160Z] cd "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17497671083486/renaissance-dec-tree_0"; \ [2025-06-12T22:33:58.160Z] echo ""; echo "TESTING:"; \ [2025-06-12T22:33:58.160Z] "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_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_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17497671083486/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-06-12T22:33:58.160Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17497671083486/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-12T22:33:58.160Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-12T22:33:58.160Z] echo "Nothing to be done for teardown."; \ [2025-06-12T22:33:58.160Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_17497671083486/TestTargetResult"; [2025-06-12T22:33:58.160Z] [2025-06-12T22:33:58.160Z] TEST SETUP: [2025-06-12T22:33:58.160Z] Nothing to be done for setup. [2025-06-12T22:33:58.160Z] [2025-06-12T22:33:58.160Z] TESTING: [2025-06-12T22:33:58.932Z] WARNING: A terminally deprecated method in sun.misc.Unsafe has been called [2025-06-12T22:33:58.932Z] WARNING: sun.misc.Unsafe::objectFieldOffset has been called by scala.runtime.LazyVals$ (file:/home/jenkins/workspace/Test_openjdk25_hs_extended.perf_aarch64_alpine-linux/aqa-tests/TKG/output_17497671083486/renaissance-dec-tree_0/launcher-223358-12817422149091145597/renaissance-harness_3/lib/scala3-library_3-3.3.4.jar) [2025-06-12T22:33:58.932Z] WARNING: Please consider reporting this to the maintainers of class scala.runtime.LazyVals$ [2025-06-12T22:33:58.932Z] WARNING: sun.misc.Unsafe::objectFieldOffset will be removed in a future release [2025-06-12T22:34:05.779Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-06-12T22:34:09.187Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-06-12T22:34:09.187Z] GC before operation: completed in 92.392 ms, heap usage 69.583 MB -> 34.804 MB. [2025-06-12T22:34:31.303Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (19149.117 ms) ====== [2025-06-12T22:34:31.303Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-06-12T22:34:31.303Z] GC before operation: completed in 256.565 ms, heap usage 378.056 MB -> 67.963 MB. [2025-06-12T22:34:32.918Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (3744.734 ms) ====== [2025-06-12T22:34:32.918Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-06-12T22:34:32.918Z] GC before operation: completed in 199.469 ms, heap usage 385.593 MB -> 87.551 MB. [2025-06-12T22:34:36.343Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (3019.357 ms) ====== [2025-06-12T22:34:36.343Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-06-12T22:34:36.343Z] GC before operation: completed in 178.167 ms, heap usage 289.525 MB -> 68.204 MB. [2025-06-12T22:34:38.824Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2779.857 ms) ====== [2025-06-12T22:34:38.824Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-06-12T22:34:38.824Z] GC before operation: completed in 181.647 ms, heap usage 236.675 MB -> 68.402 MB. [2025-06-12T22:34:41.308Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (2610.807 ms) ====== [2025-06-12T22:34:41.308Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-06-12T22:34:42.091Z] GC before operation: completed in 204.957 ms, heap usage 220.243 MB -> 68.598 MB. [2025-06-12T22:34:44.588Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (2694.084 ms) ====== [2025-06-12T22:34:44.588Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-06-12T22:34:44.588Z] GC before operation: completed in 226.487 ms, heap usage 207.642 MB -> 68.799 MB. [2025-06-12T22:34:47.052Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (2454.331 ms) ====== [2025-06-12T22:34:47.052Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-06-12T22:34:47.052Z] GC before operation: completed in 216.152 ms, heap usage 324.226 MB -> 69.062 MB. [2025-06-12T22:34:49.520Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2381.794 ms) ====== [2025-06-12T22:34:49.520Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-06-12T22:34:50.289Z] GC before operation: completed in 171.924 ms, heap usage 340.315 MB -> 69.239 MB. [2025-06-12T22:34:52.765Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (2370.945 ms) ====== [2025-06-12T22:34:52.765Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-06-12T22:34:52.765Z] GC before operation: completed in 200.001 ms, heap usage 320.941 MB -> 69.462 MB. [2025-06-12T22:34:54.689Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2241.662 ms) ====== [2025-06-12T22:34:54.689Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-06-12T22:34:54.689Z] GC before operation: completed in 183.761 ms, heap usage 341.027 MB -> 69.616 MB. [2025-06-12T22:34:57.188Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2327.570 ms) ====== [2025-06-12T22:34:57.188Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-06-12T22:34:57.188Z] GC before operation: completed in 191.669 ms, heap usage 320.680 MB -> 69.589 MB. [2025-06-12T22:34:59.646Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2262.587 ms) ====== [2025-06-12T22:34:59.646Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-06-12T22:34:59.646Z] GC before operation: completed in 216.118 ms, heap usage 320.070 MB -> 89.002 MB. [2025-06-12T22:35:02.117Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2121.764 ms) ====== [2025-06-12T22:35:02.117Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-06-12T22:35:02.117Z] GC before operation: completed in 188.434 ms, heap usage 437.872 MB -> 70.063 MB. [2025-06-12T22:35:04.580Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2210.739 ms) ====== [2025-06-12T22:35:04.580Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-06-12T22:35:04.580Z] GC before operation: completed in 193.150 ms, heap usage 217.201 MB -> 69.998 MB. [2025-06-12T22:35:07.053Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (2473.281 ms) ====== [2025-06-12T22:35:07.053Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-06-12T22:35:07.053Z] GC before operation: completed in 206.313 ms, heap usage 320.705 MB -> 89.488 MB. [2025-06-12T22:35:09.524Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2368.851 ms) ====== [2025-06-12T22:35:09.524Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-06-12T22:35:10.421Z] GC before operation: completed in 217.739 ms, heap usage 258.654 MB -> 70.215 MB. [2025-06-12T22:35:12.014Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2143.647 ms) ====== [2025-06-12T22:35:12.014Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-06-12T22:35:12.014Z] GC before operation: completed in 218.309 ms, heap usage 378.830 MB -> 70.601 MB. [2025-06-12T22:35:14.489Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2087.526 ms) ====== [2025-06-12T22:35:14.489Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-06-12T22:35:14.489Z] GC before operation: completed in 190.398 ms, heap usage 189.707 MB -> 70.384 MB. [2025-06-12T22:35:16.958Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2105.216 ms) ====== [2025-06-12T22:35:16.958Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-06-12T22:35:16.958Z] GC before operation: completed in 189.757 ms, heap usage 152.007 MB -> 70.200 MB. [2025-06-12T22:35:19.449Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2230.717 ms) ====== [2025-06-12T22:35:19.449Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-06-12T22:35:19.449Z] GC before operation: completed in 209.735 ms, heap usage 484.231 MB -> 79.274 MB. [2025-06-12T22:35:21.921Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2173.759 ms) ====== [2025-06-12T22:35:21.921Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-06-12T22:35:21.921Z] GC before operation: completed in 211.766 ms, heap usage 333.464 MB -> 78.963 MB. [2025-06-12T22:35:24.377Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (2261.387 ms) ====== [2025-06-12T22:35:24.377Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-06-12T22:35:24.377Z] GC before operation: completed in 193.607 ms, heap usage 335.251 MB -> 71.243 MB. [2025-06-12T22:35:25.959Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2094.455 ms) ====== [2025-06-12T22:35:25.959Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-06-12T22:35:26.726Z] GC before operation: completed in 215.218 ms, heap usage 320.535 MB -> 71.077 MB. [2025-06-12T22:35:28.307Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2075.910 ms) ====== [2025-06-12T22:35:28.307Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-06-12T22:35:29.074Z] GC before operation: completed in 204.827 ms, heap usage 307.077 MB -> 79.573 MB. [2025-06-12T22:35:30.656Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (2140.217 ms) ====== [2025-06-12T22:35:30.656Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-06-12T22:35:31.426Z] GC before operation: completed in 196.073 ms, heap usage 204.679 MB -> 71.229 MB. [2025-06-12T22:35:33.011Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (2147.206 ms) ====== [2025-06-12T22:35:33.011Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-06-12T22:35:33.780Z] GC before operation: completed in 206.827 ms, heap usage 131.771 MB -> 71.194 MB. [2025-06-12T22:35:35.363Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2023.225 ms) ====== [2025-06-12T22:35:35.363Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-06-12T22:35:35.363Z] GC before operation: completed in 209.199 ms, heap usage 476.485 MB -> 80.136 MB. [2025-06-12T22:35:37.823Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2062.807 ms) ====== [2025-06-12T22:35:37.823Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-06-12T22:35:37.823Z] GC before operation: completed in 192.822 ms, heap usage 320.537 MB -> 71.648 MB. [2025-06-12T22:35:40.332Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2038.841 ms) ====== [2025-06-12T22:35:40.332Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-06-12T22:35:40.332Z] GC before operation: completed in 223.722 ms, heap usage 168.752 MB -> 71.292 MB. [2025-06-12T22:35:42.426Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2112.336 ms) ====== [2025-06-12T22:35:42.426Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-06-12T22:35:42.426Z] GC before operation: completed in 235.964 ms, heap usage 477.225 MB -> 91.393 MB. [2025-06-12T22:35:44.897Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1882.509 ms) ====== [2025-06-12T22:35:44.897Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-06-12T22:35:44.898Z] GC before operation: completed in 229.683 ms, heap usage 231.967 MB -> 90.873 MB. [2025-06-12T22:35:46.536Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1656.897 ms) ====== [2025-06-12T22:35:46.536Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-06-12T22:35:46.536Z] GC before operation: completed in 205.432 ms, heap usage 211.011 MB -> 71.875 MB. [2025-06-12T22:35:48.997Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2035.212 ms) ====== [2025-06-12T22:35:48.997Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-06-12T22:35:48.997Z] GC before operation: completed in 207.727 ms, heap usage 118.895 MB -> 90.729 MB. [2025-06-12T22:35:48.997Z] 22:35:48.320 WARN [block-manager-storage-async-thread-pool-63] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_457, which does not exist [2025-06-12T22:35:50.580Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1839.153 ms) ====== [2025-06-12T22:35:50.580Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-06-12T22:35:50.580Z] GC before operation: completed in 241.381 ms, heap usage 239.344 MB -> 72.157 MB. [2025-06-12T22:35:53.050Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1714.139 ms) ====== [2025-06-12T22:35:53.050Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-06-12T22:35:53.050Z] GC before operation: completed in 236.981 ms, heap usage 153.157 MB -> 72.094 MB. [2025-06-12T22:35:54.726Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2105.690 ms) ====== [2025-06-12T22:35:54.726Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-06-12T22:35:55.491Z] GC before operation: completed in 259.202 ms, heap usage 466.120 MB -> 91.878 MB. [2025-06-12T22:35:57.076Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1958.853 ms) ====== [2025-06-12T22:35:57.076Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-06-12T22:35:57.076Z] GC before operation: completed in 209.653 ms, heap usage 232.397 MB -> 72.497 MB. [2025-06-12T22:35:59.537Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1760.695 ms) ====== [2025-06-12T22:35:59.537Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-06-12T22:35:59.537Z] GC before operation: completed in 221.766 ms, heap usage 325.221 MB -> 72.521 MB. [2025-06-12T22:36:01.149Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2146.898 ms) ====== [2025-06-12T22:36:01.149Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-06-12T22:36:01.918Z] GC before operation: completed in 214.711 ms, heap usage 152.021 MB -> 72.493 MB. [2025-06-12T22:36:03.505Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2020.552 ms) ====== [2025-06-12T22:36:04.278Z] ----------------------------------- [2025-06-12T22:36:04.278Z] renaissance-dec-tree_0_PASSED [2025-06-12T22:36:04.278Z] ----------------------------------- [2025-06-12T22:36:04.278Z] [2025-06-12T22:36:04.278Z] TEST TEARDOWN: [2025-06-12T22:36:04.278Z] Nothing to be done for teardown. [2025-06-12T22:36:05.048Z] renaissance-dec-tree_0 Finish Time: Thu Jun 12 22:36:04 2025 Epoch Time (ms): 1749767764228