renaissance-dec-tree_0
[2025-06-26T17:22:57.387Z] Running test renaissance-dec-tree_0 ...
[2025-06-26T17:22:57.387Z] ===============================================
[2025-06-26T17:22:57.387Z] renaissance-dec-tree_0 Start Time: Thu Jun 26 17:22:57 2025 Epoch Time (ms): 1750958577250
[2025-06-26T17:22:57.387Z] variation: NoOptions
[2025-06-26T17:22:57.387Z] JVM_OPTIONS:
[2025-06-26T17:22:57.387Z] { \
[2025-06-26T17:22:57.387Z] echo ""; echo "TEST SETUP:"; \
[2025-06-26T17:22:57.387Z] echo "Nothing to be done for setup."; \
[2025-06-26T17:22:57.387Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17509580495448/renaissance-dec-tree_0"; \
[2025-06-26T17:22:57.387Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17509580495448/renaissance-dec-tree_0"; \
[2025-06-26T17:22:57.387Z] echo ""; echo "TESTING:"; \
[2025-06-26T17:22:57.387Z] "/home/jenkins/workspace/Test_openjdk21_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_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17509580495448/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \
[2025-06-26T17:22:57.387Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17509580495448/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \
[2025-06-26T17:22:57.387Z] echo ""; echo "TEST TEARDOWN:"; \
[2025-06-26T17:22:57.387Z] echo "Nothing to be done for teardown."; \
[2025-06-26T17:22:57.387Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17509580495448/TestTargetResult";
[2025-06-26T17:22:57.387Z]
[2025-06-26T17:22:57.387Z] TEST SETUP:
[2025-06-26T17:22:57.387Z] Nothing to be done for setup.
[2025-06-26T17:22:57.387Z]
[2025-06-26T17:22:57.387Z] TESTING:
[2025-06-26T17:23:02.755Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads.
[2025-06-26T17:23:05.768Z] ====== dec-tree (apache-spark) [default], iteration 0 started ======
[2025-06-26T17:23:05.768Z] GC before operation: completed in 59.258 ms, heap usage 50.404 MB -> 35.034 MB.
[2025-06-26T17:23:15.510Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (9041.650 ms) ======
[2025-06-26T17:23:15.510Z] ====== dec-tree (apache-spark) [default], iteration 1 started ======
[2025-06-26T17:23:15.510Z] GC before operation: completed in 104.294 ms, heap usage 249.459 MB -> 69.342 MB.
[2025-06-26T17:23:16.462Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2066.525 ms) ======
[2025-06-26T17:23:16.462Z] ====== dec-tree (apache-spark) [default], iteration 2 started ======
[2025-06-26T17:23:16.462Z] GC before operation: completed in 105.743 ms, heap usage 218.650 MB -> 69.569 MB.
[2025-06-26T17:23:18.414Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1850.477 ms) ======
[2025-06-26T17:23:18.414Z] ====== dec-tree (apache-spark) [default], iteration 3 started ======
[2025-06-26T17:23:18.414Z] GC before operation: completed in 96.449 ms, heap usage 216.336 MB -> 69.807 MB.
[2025-06-26T17:23:20.473Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1724.853 ms) ======
[2025-06-26T17:23:20.473Z] ====== dec-tree (apache-spark) [default], iteration 4 started ======
[2025-06-26T17:23:20.473Z] GC before operation: completed in 91.868 ms, heap usage 164.635 MB -> 69.714 MB.
[2025-06-26T17:23:22.427Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1689.929 ms) ======
[2025-06-26T17:23:22.428Z] ====== dec-tree (apache-spark) [default], iteration 5 started ======
[2025-06-26T17:23:22.428Z] GC before operation: completed in 111.130 ms, heap usage 153.714 MB -> 70.066 MB.
[2025-06-26T17:23:24.380Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1714.360 ms) ======
[2025-06-26T17:23:24.380Z] ====== dec-tree (apache-spark) [default], iteration 6 started ======
[2025-06-26T17:23:24.380Z] GC before operation: completed in 93.099 ms, heap usage 390.423 MB -> 70.604 MB.
[2025-06-26T17:23:26.332Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1567.957 ms) ======
[2025-06-26T17:23:26.332Z] ====== dec-tree (apache-spark) [default], iteration 7 started ======
[2025-06-26T17:23:26.332Z] GC before operation: completed in 116.280 ms, heap usage 251.226 MB -> 81.702 MB.
[2025-06-26T17:23:27.283Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1640.174 ms) ======
[2025-06-26T17:23:27.283Z] ====== dec-tree (apache-spark) [default], iteration 8 started ======
[2025-06-26T17:23:27.283Z] GC before operation: completed in 102.458 ms, heap usage 277.521 MB -> 70.923 MB.
[2025-06-26T17:23:29.235Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1609.845 ms) ======
[2025-06-26T17:23:29.235Z] ====== dec-tree (apache-spark) [default], iteration 9 started ======
[2025-06-26T17:23:29.235Z] GC before operation: completed in 107.297 ms, heap usage 393.335 MB -> 87.637 MB.
[2025-06-26T17:23:31.122Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1608.629 ms) ======
[2025-06-26T17:23:31.122Z] ====== dec-tree (apache-spark) [default], iteration 10 started ======
[2025-06-26T17:23:31.122Z] GC before operation: completed in 114.681 ms, heap usage 124.637 MB -> 70.429 MB.
[2025-06-26T17:23:33.239Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1631.158 ms) ======
[2025-06-26T17:23:33.239Z] ====== dec-tree (apache-spark) [default], iteration 11 started ======
[2025-06-26T17:23:33.239Z] GC before operation: completed in 110.826 ms, heap usage 234.778 MB -> 76.616 MB.
[2025-06-26T17:23:34.193Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1591.692 ms) ======
[2025-06-26T17:23:34.193Z] ====== dec-tree (apache-spark) [default], iteration 12 started ======
[2025-06-26T17:23:34.193Z] GC before operation: completed in 131.302 ms, heap usage 349.506 MB -> 71.467 MB.
[2025-06-26T17:23:36.147Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1606.472 ms) ======
[2025-06-26T17:23:36.147Z] ====== dec-tree (apache-spark) [default], iteration 13 started ======
[2025-06-26T17:23:36.147Z] GC before operation: completed in 107.776 ms, heap usage 107.312 MB -> 70.959 MB.
[2025-06-26T17:23:38.108Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1614.497 ms) ======
[2025-06-26T17:23:38.108Z] ====== dec-tree (apache-spark) [default], iteration 14 started ======
[2025-06-26T17:23:38.108Z] GC before operation: completed in 113.085 ms, heap usage 174.400 MB -> 71.364 MB.
[2025-06-26T17:23:40.062Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1583.647 ms) ======
[2025-06-26T17:23:40.062Z] ====== dec-tree (apache-spark) [default], iteration 15 started ======
[2025-06-26T17:23:40.062Z] GC before operation: completed in 137.514 ms, heap usage 368.513 MB -> 82.580 MB.
[2025-06-26T17:23:41.013Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1547.315 ms) ======
[2025-06-26T17:23:41.013Z] ====== dec-tree (apache-spark) [default], iteration 16 started ======
[2025-06-26T17:23:41.013Z] GC before operation: completed in 146.034 ms, heap usage 222.090 MB -> 83.221 MB.
[2025-06-26T17:23:42.981Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1567.332 ms) ======
[2025-06-26T17:23:42.981Z] ====== dec-tree (apache-spark) [default], iteration 17 started ======
[2025-06-26T17:23:42.981Z] GC before operation: completed in 138.507 ms, heap usage 221.330 MB -> 83.232 MB.
[2025-06-26T17:23:44.935Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1538.043 ms) ======
[2025-06-26T17:23:44.936Z] ====== dec-tree (apache-spark) [default], iteration 18 started ======
[2025-06-26T17:23:44.936Z] GC before operation: completed in 117.084 ms, heap usage 223.225 MB -> 83.154 MB.
[2025-06-26T17:23:45.896Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1529.107 ms) ======
[2025-06-26T17:23:45.896Z] ====== dec-tree (apache-spark) [default], iteration 19 started ======
[2025-06-26T17:23:46.847Z] GC before operation: completed in 116.544 ms, heap usage 222.293 MB -> 83.206 MB.
[2025-06-26T17:23:47.799Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1550.950 ms) ======
[2025-06-26T17:23:47.799Z] ====== dec-tree (apache-spark) [default], iteration 20 started ======
[2025-06-26T17:23:47.799Z] GC before operation: completed in 118.467 ms, heap usage 191.347 MB -> 83.280 MB.
[2025-06-26T17:23:49.759Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1540.311 ms) ======
[2025-06-26T17:23:49.759Z] ====== dec-tree (apache-spark) [default], iteration 21 started ======
[2025-06-26T17:23:49.759Z] GC before operation: completed in 115.484 ms, heap usage 161.891 MB -> 77.617 MB.
[2025-06-26T17:23:51.710Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1520.975 ms) ======
[2025-06-26T17:23:51.710Z] ====== dec-tree (apache-spark) [default], iteration 22 started ======
[2025-06-26T17:23:51.710Z] GC before operation: completed in 129.539 ms, heap usage 439.033 MB -> 89.231 MB.
[2025-06-26T17:23:52.661Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1549.550 ms) ======
[2025-06-26T17:23:52.661Z] ====== dec-tree (apache-spark) [default], iteration 23 started ======
[2025-06-26T17:23:52.661Z] GC before operation: completed in 139.617 ms, heap usage 139.830 MB -> 83.071 MB.
[2025-06-26T17:23:54.616Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1518.590 ms) ======
[2025-06-26T17:23:54.616Z] ====== dec-tree (apache-spark) [default], iteration 24 started ======
[2025-06-26T17:23:54.616Z] GC before operation: completed in 140.820 ms, heap usage 443.470 MB -> 89.447 MB.
[2025-06-26T17:23:56.577Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1556.039 ms) ======
[2025-06-26T17:23:56.577Z] ====== dec-tree (apache-spark) [default], iteration 25 started ======
[2025-06-26T17:23:56.577Z] GC before operation: completed in 138.660 ms, heap usage 124.527 MB -> 77.741 MB.
[2025-06-26T17:23:58.528Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1537.183 ms) ======
[2025-06-26T17:23:58.528Z] ====== dec-tree (apache-spark) [default], iteration 26 started ======
[2025-06-26T17:23:58.528Z] GC before operation: completed in 136.625 ms, heap usage 510.485 MB -> 84.010 MB.
[2025-06-26T17:23:59.480Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1533.344 ms) ======
[2025-06-26T17:23:59.480Z] ====== dec-tree (apache-spark) [default], iteration 27 started ======
[2025-06-26T17:23:59.480Z] GC before operation: completed in 129.463 ms, heap usage 386.375 MB -> 73.161 MB.
[2025-06-26T17:24:01.434Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1510.571 ms) ======
[2025-06-26T17:24:01.434Z] ====== dec-tree (apache-spark) [default], iteration 28 started ======
[2025-06-26T17:24:01.434Z] GC before operation: completed in 129.850 ms, heap usage 381.766 MB -> 84.478 MB.
[2025-06-26T17:24:03.395Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1482.440 ms) ======
[2025-06-26T17:24:03.395Z] ====== dec-tree (apache-spark) [default], iteration 29 started ======
[2025-06-26T17:24:03.395Z] GC before operation: completed in 122.123 ms, heap usage 178.042 MB -> 73.103 MB.
[2025-06-26T17:24:04.347Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1532.622 ms) ======
[2025-06-26T17:24:04.348Z] ====== dec-tree (apache-spark) [default], iteration 30 started ======
[2025-06-26T17:24:04.348Z] GC before operation: completed in 131.553 ms, heap usage 330.590 MB -> 84.314 MB.
[2025-06-26T17:24:06.303Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1538.766 ms) ======
[2025-06-26T17:24:06.303Z] ====== dec-tree (apache-spark) [default], iteration 31 started ======
[2025-06-26T17:24:06.303Z] GC before operation: completed in 125.649 ms, heap usage 174.948 MB -> 73.328 MB.
[2025-06-26T17:24:08.258Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1528.986 ms) ======
[2025-06-26T17:24:08.258Z] ====== dec-tree (apache-spark) [default], iteration 32 started ======
[2025-06-26T17:24:08.258Z] GC before operation: completed in 140.591 ms, heap usage 330.946 MB -> 73.656 MB.
[2025-06-26T17:24:09.209Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1503.410 ms) ======
[2025-06-26T17:24:09.209Z] ====== dec-tree (apache-spark) [default], iteration 33 started ======
[2025-06-26T17:24:10.170Z] GC before operation: completed in 139.221 ms, heap usage 382.483 MB -> 90.472 MB.
[2025-06-26T17:24:11.122Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1486.146 ms) ======
[2025-06-26T17:24:11.122Z] ====== dec-tree (apache-spark) [default], iteration 34 started ======
[2025-06-26T17:24:11.122Z] GC before operation: completed in 126.529 ms, heap usage 449.983 MB -> 73.848 MB.
[2025-06-26T17:24:13.254Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1518.065 ms) ======
[2025-06-26T17:24:13.254Z] ====== dec-tree (apache-spark) [default], iteration 35 started ======
[2025-06-26T17:24:13.254Z] GC before operation: completed in 128.642 ms, heap usage 236.449 MB -> 90.618 MB.
[2025-06-26T17:24:14.207Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1541.457 ms) ======
[2025-06-26T17:24:14.207Z] ====== dec-tree (apache-spark) [default], iteration 36 started ======
[2025-06-26T17:24:14.207Z] GC before operation: completed in 134.177 ms, heap usage 451.018 MB -> 74.117 MB.
[2025-06-26T17:24:16.163Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1501.000 ms) ======
[2025-06-26T17:24:16.163Z] ====== dec-tree (apache-spark) [default], iteration 37 started ======
[2025-06-26T17:24:16.164Z] GC before operation: completed in 134.014 ms, heap usage 359.157 MB -> 85.395 MB.
[2025-06-26T17:24:18.118Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1513.592 ms) ======
[2025-06-26T17:24:18.118Z] ====== dec-tree (apache-spark) [default], iteration 38 started ======
[2025-06-26T17:24:18.118Z] GC before operation: completed in 134.003 ms, heap usage 173.994 MB -> 85.222 MB.
[2025-06-26T17:24:18.118Z] 17:24:17.531 WARN [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManager - Block broadcast_527_piece0 was not removed normally.
[2025-06-26T17:24:18.118Z] 17:24:17.536 ERROR [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManagerStorageEndpoint - Error in removing broadcast 527
[2025-06-26T17:24:18.118Z] org.apache.spark.SparkException: Block broadcast_527_piece0 does not exist
[2025-06-26T17:24:18.118Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3$adapted(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] 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]
[2025-06-26T17:24:18.118Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) ~[?:?]
[2025-06-26T17:24:18.118Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ~[?:?]
[2025-06-26T17:24:18.118Z] at java.lang.Thread.run(Thread.java:1583) [?:?]
[2025-06-26T17:24:18.118Z] 17:24:17.546 ERROR [Spark Context Cleaner] org.apache.spark.ContextCleaner - Error cleaning broadcast 527
[2025-06-26T17:24:18.118Z] org.apache.spark.SparkException: Exception thrown in awaitResult:
[2025-06-26T17:24:18.118Z] at org.apache.spark.util.SparkThreadUtils$.awaitResult(SparkThreadUtils.scala:56) ~[spark-common-utils_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.util.ThreadUtils$.awaitResult(ThreadUtils.scala:310) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:75) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManagerMaster.removeBroadcast(BlockManagerMaster.scala:222) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.broadcast.TorrentBroadcast$.unpersist(TorrentBroadcast.scala:395) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.broadcast.TorrentBroadcastFactory.unbroadcast(TorrentBroadcastFactory.scala:49) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.broadcast.BroadcastManager.unbroadcast(BroadcastManager.scala:82) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.ContextCleaner.doCleanupBroadcast(ContextCleaner.scala:256) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3(ContextCleaner.scala:204) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3$adapted(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.Option.foreach(Option.scala:437) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$1(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.util.Utils$.tryOrStopSparkContext(Utils.scala:1356) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.ContextCleaner.org$apache$spark$ContextCleaner$$keepCleaning(ContextCleaner.scala:189) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.ContextCleaner$$anon$1.run(ContextCleaner.scala:79) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] Caused by: org.apache.spark.SparkException: Block broadcast_527_piece0 does not exist
[2025-06-26T17:24:18.118Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3$adapted(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] 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]
[2025-06-26T17:24:18.118Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) ~[?:?]
[2025-06-26T17:24:18.118Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ~[?:?]
[2025-06-26T17:24:18.118Z] at java.lang.Thread.run(Thread.java:1583) ~[?:?]
[2025-06-26T17:24:18.118Z] 17:24:17.546 WARN [block-manager-ask-thread-pool-37] org.apache.spark.storage.BlockManagerMaster - Failed to remove broadcast 527 with removeFromMaster = true - Block broadcast_527_piece0 does not exist
[2025-06-26T17:24:18.118Z] org.apache.spark.SparkException: Block broadcast_527_piece0 does not exist
[2025-06-26T17:24:18.118Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3$adapted(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] 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]
[2025-06-26T17:24:18.118Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.118Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-26T17:24:18.118Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.119Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?]
[2025-06-26T17:24:18.119Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) ~[?:?]
[2025-06-26T17:24:18.119Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) ~[?:?]
[2025-06-26T17:24:18.119Z] at java.lang.Thread.run(Thread.java:1583) [?:?]
[2025-06-26T17:24:19.071Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1590.305 ms) ======
[2025-06-26T17:24:19.071Z] ====== dec-tree (apache-spark) [default], iteration 39 started ======
[2025-06-26T17:24:20.718Z] GC before operation: completed in 144.605 ms, heap usage 459.222 MB -> 86.684 MB.
[2025-06-26T17:24:21.780Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1518.996 ms) ======
[2025-06-26T17:24:21.780Z] -----------------------------------
[2025-06-26T17:24:21.780Z] renaissance-dec-tree_0_PASSED
[2025-06-26T17:24:21.780Z] -----------------------------------
[2025-06-26T17:24:21.780Z]
[2025-06-26T17:24:21.780Z] TEST TEARDOWN:
[2025-06-26T17:24:21.780Z] Nothing to be done for teardown.
[2025-06-26T17:24:21.780Z] renaissance-dec-tree_0 Finish Time: Thu Jun 26 17:24:20 2025 Epoch Time (ms): 1750958660880