[2026-04-25T14:44:17.565Z] Running test renaissance-dec-tree_0 ... [2026-04-25T14:44:17.565Z] =============================================== [2026-04-25T14:44:17.565Z] renaissance-dec-tree_0 Start Time: Sat Apr 25 14:44:16 2026 Epoch Time (ms): 1777128256556 [2026-04-25T14:44:17.565Z] variation: NoOptions [2026-04-25T14:44:17.565Z] JVM_OPTIONS: [2026-04-25T14:44:17.565Z] { \ [2026-04-25T14:44:17.565Z] echo ""; echo "TEST SETUP:"; \ [2026-04-25T14:44:17.565Z] echo "Nothing to be done for setup."; \ [2026-04-25T14:44:17.565Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1777127575267/renaissance-dec-tree_0"; \ [2026-04-25T14:44:17.565Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1777127575267/renaissance-dec-tree_0"; \ [2026-04-25T14:44:17.565Z] echo ""; echo "TESTING:"; \ [2026-04-25T14:44:17.565Z] "/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_1777127575267/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2026-04-25T14:44:17.566Z] 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_1777127575267/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-04-25T14:44:17.566Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-04-25T14:44:17.566Z] echo "Nothing to be done for teardown."; \ [2026-04-25T14:44:17.566Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_1777127575267/TestTargetResult"; [2026-04-25T14:44:17.566Z] [2026-04-25T14:44:17.566Z] TEST SETUP: [2026-04-25T14:44:17.566Z] Nothing to be done for setup. [2026-04-25T14:44:17.566Z] [2026-04-25T14:44:17.566Z] TESTING: [2026-04-25T14:44:22.995Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-04-25T14:44:24.941Z] WARNING: An illegal reflective access operation has occurred [2026-04-25T14:44:24.941Z] 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_1777127575267/renaissance-dec-tree_0/harness-144417-8271411194684200048/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2026-04-25T14:44:24.941Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2026-04-25T14:44:24.941Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2026-04-25T14:44:24.941Z] WARNING: All illegal access operations will be denied in a future release [2026-04-25T14:44:25.890Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2026-04-25T14:44:25.890Z] GC before operation: completed in 56.853 ms, heap usage 101.017 MB -> 34.406 MB. [2026-04-25T14:44:36.287Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9738.474 ms) ====== [2026-04-25T14:44:36.287Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2026-04-25T14:44:36.287Z] GC before operation: completed in 121.695 ms, heap usage 289.052 MB -> 68.299 MB. [2026-04-25T14:44:38.233Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2487.694 ms) ====== [2026-04-25T14:44:38.233Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2026-04-25T14:44:38.233Z] GC before operation: completed in 12.563 ms, heap usage 172.242 MB -> 172.490 MB. [2026-04-25T14:44:40.179Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (2007.736 ms) ====== [2026-04-25T14:44:40.179Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2026-04-25T14:44:41.126Z] GC before operation: completed in 106.546 ms, heap usage 280.257 MB -> 80.537 MB. [2026-04-25T14:44:43.072Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (2053.923 ms) ====== [2026-04-25T14:44:43.072Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2026-04-25T14:44:43.072Z] GC before operation: completed in 103.504 ms, heap usage 118.611 MB -> 68.826 MB. [2026-04-25T14:44:45.017Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1988.713 ms) ====== [2026-04-25T14:44:45.017Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2026-04-25T14:44:45.017Z] GC before operation: completed in 128.264 ms, heap usage 203.949 MB -> 69.375 MB. [2026-04-25T14:44:46.963Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1899.287 ms) ====== [2026-04-25T14:44:46.963Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2026-04-25T14:44:46.963Z] GC before operation: completed in 104.250 ms, heap usage 268.487 MB -> 69.733 MB. [2026-04-25T14:44:48.909Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1814.843 ms) ====== [2026-04-25T14:44:48.909Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2026-04-25T14:44:48.909Z] GC before operation: completed in 109.479 ms, heap usage 241.588 MB -> 75.339 MB. [2026-04-25T14:44:50.861Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1748.533 ms) ====== [2026-04-25T14:44:50.861Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2026-04-25T14:44:50.861Z] GC before operation: completed in 110.096 ms, heap usage 230.908 MB -> 70.080 MB. [2026-04-25T14:44:52.815Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1801.534 ms) ====== [2026-04-25T14:44:52.815Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2026-04-25T14:44:52.815Z] GC before operation: completed in 131.447 ms, heap usage 185.423 MB -> 80.753 MB. [2026-04-25T14:44:52.815Z] 14:44:52.099 WARN [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManager - Asked to remove block rdd_429_1, which does not exist [2026-04-25T14:44:54.761Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1855.389 ms) ====== [2026-04-25T14:44:54.761Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2026-04-25T14:44:54.761Z] GC before operation: completed in 127.688 ms, heap usage 247.149 MB -> 70.300 MB. [2026-04-25T14:44:56.707Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1875.080 ms) ====== [2026-04-25T14:44:56.707Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2026-04-25T14:44:56.707Z] GC before operation: completed in 125.880 ms, heap usage 120.457 MB -> 69.796 MB. [2026-04-25T14:44:58.663Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1800.929 ms) ====== [2026-04-25T14:44:58.663Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2026-04-25T14:44:58.663Z] GC before operation: completed in 134.881 ms, heap usage 348.355 MB -> 81.426 MB. [2026-04-25T14:45:00.609Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1800.719 ms) ====== [2026-04-25T14:45:00.609Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2026-04-25T14:45:00.609Z] GC before operation: completed in 136.745 ms, heap usage 247.717 MB -> 81.544 MB. [2026-04-25T14:45:02.555Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1772.745 ms) ====== [2026-04-25T14:45:02.555Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2026-04-25T14:45:02.555Z] GC before operation: completed in 128.209 ms, heap usage 174.009 MB -> 81.555 MB. [2026-04-25T14:45:04.499Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1742.860 ms) ====== [2026-04-25T14:45:04.499Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2026-04-25T14:45:04.499Z] GC before operation: completed in 132.137 ms, heap usage 220.300 MB -> 70.892 MB. [2026-04-25T14:45:06.449Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1766.811 ms) ====== [2026-04-25T14:45:06.449Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2026-04-25T14:45:06.449Z] GC before operation: completed in 124.845 ms, heap usage 251.466 MB -> 71.065 MB. [2026-04-25T14:45:08.396Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1735.207 ms) ====== [2026-04-25T14:45:08.396Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2026-04-25T14:45:08.396Z] GC before operation: completed in 134.959 ms, heap usage 156.224 MB -> 81.615 MB. [2026-04-25T14:45:10.340Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1759.047 ms) ====== [2026-04-25T14:45:10.340Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2026-04-25T14:45:10.340Z] GC before operation: completed in 129.459 ms, heap usage 214.242 MB -> 82.422 MB. [2026-04-25T14:45:11.287Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1715.774 ms) ====== [2026-04-25T14:45:11.287Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2026-04-25T14:45:12.336Z] GC before operation: completed in 132.361 ms, heap usage 215.088 MB -> 71.383 MB. [2026-04-25T14:45:13.284Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1777.523 ms) ====== [2026-04-25T14:45:13.284Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2026-04-25T14:45:13.284Z] GC before operation: completed in 130.907 ms, heap usage 226.453 MB -> 71.485 MB. [2026-04-25T14:45:15.924Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1719.868 ms) ====== [2026-04-25T14:45:15.924Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2026-04-25T14:45:15.924Z] GC before operation: completed in 119.623 ms, heap usage 248.414 MB -> 71.813 MB. [2026-04-25T14:45:16.872Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1674.387 ms) ====== [2026-04-25T14:45:16.872Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2026-04-25T14:45:17.819Z] GC before operation: completed in 126.209 ms, heap usage 186.859 MB -> 71.242 MB. [2026-04-25T14:45:18.767Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1686.500 ms) ====== [2026-04-25T14:45:18.767Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2026-04-25T14:45:18.767Z] GC before operation: completed in 126.276 ms, heap usage 174.514 MB -> 71.499 MB. [2026-04-25T14:45:20.711Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1700.511 ms) ====== [2026-04-25T14:45:20.711Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2026-04-25T14:45:20.711Z] GC before operation: completed in 123.458 ms, heap usage 184.982 MB -> 71.460 MB. [2026-04-25T14:45:22.688Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1700.069 ms) ====== [2026-04-25T14:45:22.688Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2026-04-25T14:45:22.688Z] GC before operation: completed in 132.595 ms, heap usage 298.013 MB -> 72.012 MB. [2026-04-25T14:45:24.633Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1669.933 ms) ====== [2026-04-25T14:45:24.633Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2026-04-25T14:45:24.633Z] GC before operation: completed in 122.580 ms, heap usage 177.896 MB -> 82.862 MB. [2026-04-25T14:45:24.633Z] 14:45:24.053 WARN [block-manager-storage-async-thread-pool-66] org.apache.spark.storage.BlockManager - Block broadcast_363 could not be removed as it was not found on disk or in memory [2026-04-25T14:45:24.633Z] 14:45:24.241 WARN [block-manager-storage-async-thread-pool-66] org.apache.spark.storage.BlockManager - Block broadcast_363 was not removed normally. [2026-04-25T14:45:24.633Z] 14:45:24.251 ERROR [block-manager-storage-async-thread-pool-66] org.apache.spark.storage.BlockManagerStorageEndpoint - Error in removing broadcast 363 [2026-04-25T14:45:24.633Z] org.apache.spark.SparkException: Block broadcast_363 does not exist [2026-04-25T14:45:24.633Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3$adapted(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerStorageEndpoint$$anonfun$receiveAndReply$1.$anonfun$applyOrElse$4(BlockManagerStorageEndpoint.scala:69) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?] [2026-04-25T14:45:24.633Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?] [2026-04-25T14:45:24.633Z] at java.lang.Thread.run(Thread.java:829) [?:?] [2026-04-25T14:45:24.633Z] 14:45:24.296 ERROR [Spark Context Cleaner] org.apache.spark.ContextCleaner - Error cleaning broadcast 363 [2026-04-25T14:45:24.633Z] org.apache.spark.SparkException: Exception thrown in awaitResult: [2026-04-25T14:45:24.633Z] at org.apache.spark.util.SparkThreadUtils$.awaitResult(SparkThreadUtils.scala:56) ~[spark-common-utils_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.util.ThreadUtils$.awaitResult(ThreadUtils.scala:310) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:75) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerMaster.removeBroadcast(BlockManagerMaster.scala:222) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.broadcast.TorrentBroadcast$.unpersist(TorrentBroadcast.scala:395) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.broadcast.TorrentBroadcastFactory.unbroadcast(TorrentBroadcastFactory.scala:49) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.broadcast.BroadcastManager.unbroadcast(BroadcastManager.scala:82) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.ContextCleaner.doCleanupBroadcast(ContextCleaner.scala:256) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3(ContextCleaner.scala:204) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3$adapted(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.Option.foreach(Option.scala:437) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$1(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.util.Utils$.tryOrStopSparkContext(Utils.scala:1356) [spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.ContextCleaner.org$apache$spark$ContextCleaner$$keepCleaning(ContextCleaner.scala:189) [spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.ContextCleaner$$anon$1.run(ContextCleaner.scala:79) [spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] Caused by: org.apache.spark.SparkException: Block broadcast_363 does not exist [2026-04-25T14:45:24.633Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3$adapted(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerStorageEndpoint$$anonfun$receiveAndReply$1.$anonfun$applyOrElse$4(BlockManagerStorageEndpoint.scala:69) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?] [2026-04-25T14:45:24.633Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?] [2026-04-25T14:45:24.633Z] at java.lang.Thread.run(Thread.java:829) ~[?:?] [2026-04-25T14:45:24.633Z] 14:45:24.287 WARN [block-manager-ask-thread-pool-81] org.apache.spark.storage.BlockManagerMaster - Failed to remove broadcast 363 with removeFromMaster = true - Block broadcast_363 does not exist [2026-04-25T14:45:24.633Z] org.apache.spark.SparkException: Block broadcast_363 does not exist [2026-04-25T14:45:24.633Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3$adapted(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerStorageEndpoint$$anonfun$receiveAndReply$1.$anonfun$applyOrElse$4(BlockManagerStorageEndpoint.scala:69) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2026-04-25T14:45:24.633Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?] [2026-04-25T14:45:24.633Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?] [2026-04-25T14:45:24.633Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?] [2026-04-25T14:45:24.633Z] at java.lang.Thread.run(Thread.java:829) [?:?] [2026-04-25T14:45:26.578Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1702.980 ms) ====== [2026-04-25T14:45:26.578Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2026-04-25T14:45:26.578Z] GC before operation: completed in 148.776 ms, heap usage 232.654 MB -> 84.124 MB. [2026-04-25T14:45:28.524Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1641.897 ms) ====== [2026-04-25T14:45:28.524Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2026-04-25T14:45:28.524Z] GC before operation: completed in 145.365 ms, heap usage 331.369 MB -> 84.396 MB. [2026-04-25T14:45:29.471Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1690.233 ms) ====== [2026-04-25T14:45:29.471Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2026-04-25T14:45:30.420Z] GC before operation: completed in 143.482 ms, heap usage 265.353 MB -> 73.223 MB. [2026-04-25T14:45:31.366Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1668.280 ms) ====== [2026-04-25T14:45:31.367Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2026-04-25T14:45:32.314Z] GC before operation: completed in 137.398 ms, heap usage 146.011 MB -> 72.965 MB. [2026-04-25T14:45:33.262Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1683.095 ms) ====== [2026-04-25T14:45:33.262Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2026-04-25T14:45:33.262Z] GC before operation: completed in 137.572 ms, heap usage 187.735 MB -> 73.413 MB. [2026-04-25T14:45:35.207Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1718.691 ms) ====== [2026-04-25T14:45:35.207Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2026-04-25T14:45:35.207Z] GC before operation: completed in 134.609 ms, heap usage 151.978 MB -> 73.658 MB. [2026-04-25T14:45:37.151Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1683.948 ms) ====== [2026-04-25T14:45:37.151Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2026-04-25T14:45:37.151Z] GC before operation: completed in 143.463 ms, heap usage 276.457 MB -> 89.925 MB. [2026-04-25T14:45:39.096Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1627.238 ms) ====== [2026-04-25T14:45:39.096Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2026-04-25T14:45:39.096Z] GC before operation: completed in 140.707 ms, heap usage 323.629 MB -> 90.458 MB. [2026-04-25T14:45:41.041Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1642.995 ms) ====== [2026-04-25T14:45:41.041Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2026-04-25T14:45:41.041Z] GC before operation: completed in 134.200 ms, heap usage 308.680 MB -> 74.010 MB. [2026-04-25T14:45:42.991Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1677.549 ms) ====== [2026-04-25T14:45:42.991Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2026-04-25T14:45:42.991Z] GC before operation: completed in 128.835 ms, heap usage 231.728 MB -> 85.264 MB. [2026-04-25T14:45:43.939Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1628.425 ms) ====== [2026-04-25T14:45:43.939Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2026-04-25T14:45:44.887Z] GC before operation: completed in 131.529 ms, heap usage 196.371 MB -> 73.919 MB. [2026-04-25T14:45:45.834Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1665.696 ms) ====== [2026-04-25T14:45:45.834Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2026-04-25T14:45:45.834Z] GC before operation: completed in 127.570 ms, heap usage 162.935 MB -> 74.307 MB. [2026-04-25T14:45:47.784Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1612.424 ms) ====== [2026-04-25T14:45:47.784Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2026-04-25T14:45:47.784Z] GC before operation: completed in 136.639 ms, heap usage 320.039 MB -> 85.566 MB. [2026-04-25T14:45:49.731Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1577.790 ms) ====== [2026-04-25T14:45:49.731Z] ----------------------------------- [2026-04-25T14:45:49.731Z] renaissance-dec-tree_0_PASSED [2026-04-25T14:45:49.731Z] ----------------------------------- [2026-04-25T14:45:49.731Z] [2026-04-25T14:45:49.731Z] TEST TEARDOWN: [2026-04-25T14:45:49.731Z] Nothing to be done for teardown. [2026-04-25T14:45:49.731Z] renaissance-dec-tree_0 Finish Time: Sat Apr 25 14:45:49 2026 Epoch Time (ms): 1777128349400