renaissance-dec-tree_0
[2025-06-12T05:03:55.351Z] Running test renaissance-dec-tree_0 ...
[2025-06-12T05:03:55.351Z] ===============================================
[2025-06-12T05:03:55.351Z] renaissance-dec-tree_0 Start Time: Thu Jun 12 01:03:54 2025 Epoch Time (ms): 1749704634890
[2025-06-12T05:03:55.351Z] variation: NoOptions
[2025-06-12T05:03:55.351Z] JVM_OPTIONS:
[2025-06-12T05:03:55.351Z] { \
[2025-06-12T05:03:55.351Z] echo ""; echo "TEST SETUP:"; \
[2025-06-12T05:03:55.351Z] echo "Nothing to be done for setup."; \
[2025-06-12T05:03:55.351Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17497035125400/renaissance-dec-tree_0"; \
[2025-06-12T05:03:55.351Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17497035125400/renaissance-dec-tree_0"; \
[2025-06-12T05:03:55.351Z] echo ""; echo "TESTING:"; \
[2025-06-12T05:03:55.351Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17497035125400/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \
[2025-06-12T05:03:55.352Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17497035125400/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \
[2025-06-12T05:03:55.352Z] echo ""; echo "TEST TEARDOWN:"; \
[2025-06-12T05:03:55.352Z] echo "Nothing to be done for teardown."; \
[2025-06-12T05:03:55.352Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17497035125400/TestTargetResult";
[2025-06-12T05:03:55.352Z]
[2025-06-12T05:03:55.352Z] TEST SETUP:
[2025-06-12T05:03:55.352Z] Nothing to be done for setup.
[2025-06-12T05:03:55.352Z]
[2025-06-12T05:03:55.352Z] TESTING:
[2025-06-12T05:04:06.853Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads.
[2025-06-12T05:04:08.511Z] WARNING: An illegal reflective access operation has occurred
[2025-06-12T05:04:08.511Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17497035125400/renaissance-dec-tree_0/harness-010356-6295325160904573550/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme
[2025-06-12T05:04:08.511Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$
[2025-06-12T05:04:08.511Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
[2025-06-12T05:04:08.511Z] WARNING: All illegal access operations will be denied in a future release
[2025-06-12T05:04:10.998Z] ====== dec-tree (apache-spark) [default], iteration 0 started ======
[2025-06-12T05:04:10.998Z] GC before operation: completed in 208.781 ms, heap usage 77.992 MB -> 34.396 MB.
[2025-06-12T05:04:37.035Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (26188.534 ms) ======
[2025-06-12T05:04:37.035Z] ====== dec-tree (apache-spark) [default], iteration 1 started ======
[2025-06-12T05:04:37.843Z] GC before operation: completed in 365.168 ms, heap usage 157.241 MB -> 66.853 MB.
[2025-06-12T05:04:45.974Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7357.421 ms) ======
[2025-06-12T05:04:45.974Z] ====== dec-tree (apache-spark) [default], iteration 2 started ======
[2025-06-12T05:04:45.974Z] GC before operation: completed in 498.674 ms, heap usage 210.282 MB -> 67.654 MB.
[2025-06-12T05:04:51.429Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5736.523 ms) ======
[2025-06-12T05:04:51.430Z] ====== dec-tree (apache-spark) [default], iteration 3 started ======
[2025-06-12T05:04:51.430Z] GC before operation: completed in 396.604 ms, heap usage 103.312 MB -> 67.425 MB.
[2025-06-12T05:04:56.646Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (4729.547 ms) ======
[2025-06-12T05:04:56.646Z] ====== dec-tree (apache-spark) [default], iteration 4 started ======
[2025-06-12T05:04:56.646Z] GC before operation: completed in 388.542 ms, heap usage 237.403 MB -> 67.971 MB.
[2025-06-12T05:05:00.786Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (4299.931 ms) ======
[2025-06-12T05:05:00.786Z] ====== dec-tree (apache-spark) [default], iteration 5 started ======
[2025-06-12T05:05:02.027Z] GC before operation: completed in 334.942 ms, heap usage 197.929 MB -> 68.316 MB.
[2025-06-12T05:05:06.288Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4474.259 ms) ======
[2025-06-12T05:05:06.288Z] ====== dec-tree (apache-spark) [default], iteration 6 started ======
[2025-06-12T05:05:06.288Z] GC before operation: completed in 379.158 ms, heap usage 192.039 MB -> 68.360 MB.
[2025-06-12T05:05:10.591Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3798.280 ms) ======
[2025-06-12T05:05:10.591Z] ====== dec-tree (apache-spark) [default], iteration 7 started ======
[2025-06-12T05:05:10.591Z] GC before operation: completed in 263.319 ms, heap usage 150.085 MB -> 68.540 MB.
[2025-06-12T05:05:14.945Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (4378.331 ms) ======
[2025-06-12T05:05:14.945Z] ====== dec-tree (apache-spark) [default], iteration 8 started ======
[2025-06-12T05:05:14.945Z] GC before operation: completed in 349.933 ms, heap usage 254.225 MB -> 68.867 MB.
[2025-06-12T05:05:19.159Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4202.737 ms) ======
[2025-06-12T05:05:19.160Z] ====== dec-tree (apache-spark) [default], iteration 9 started ======
[2025-06-12T05:05:19.910Z] GC before operation: completed in 429.778 ms, heap usage 282.809 MB -> 68.835 MB.
[2025-06-12T05:05:26.962Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (7093.877 ms) ======
[2025-06-12T05:05:26.962Z] ====== dec-tree (apache-spark) [default], iteration 10 started ======
[2025-06-12T05:05:26.962Z] GC before operation: completed in 380.051 ms, heap usage 130.918 MB -> 69.081 MB.
[2025-06-12T05:05:32.184Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4705.673 ms) ======
[2025-06-12T05:05:32.184Z] ====== dec-tree (apache-spark) [default], iteration 11 started ======
[2025-06-12T05:05:32.184Z] GC before operation: completed in 402.675 ms, heap usage 119.157 MB -> 69.430 MB.
[2025-06-12T05:05:35.310Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3198.225 ms) ======
[2025-06-12T05:05:35.310Z] ====== dec-tree (apache-spark) [default], iteration 12 started ======
[2025-06-12T05:05:35.994Z] GC before operation: completed in 255.393 ms, heap usage 241.637 MB -> 69.310 MB.
[2025-06-12T05:05:39.057Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3441.441 ms) ======
[2025-06-12T05:05:39.057Z] ====== dec-tree (apache-spark) [default], iteration 13 started ======
[2025-06-12T05:05:39.861Z] GC before operation: completed in 333.277 ms, heap usage 149.118 MB -> 69.658 MB.
[2025-06-12T05:05:43.015Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3889.362 ms) ======
[2025-06-12T05:05:43.015Z] ====== dec-tree (apache-spark) [default], iteration 14 started ======
[2025-06-12T05:05:43.857Z] GC before operation: completed in 191.129 ms, heap usage 230.709 MB -> 88.690 MB.
[2025-06-12T05:05:43.857Z] 01:05:43.166 WARN [block-manager-storage-async-thread-pool-29] org.apache.spark.storage.BlockManager - Asked to remove block broadcast_191_piece0, which does not exist
[2025-06-12T05:05:47.994Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (3893.470 ms) ======
[2025-06-12T05:05:47.994Z] ====== dec-tree (apache-spark) [default], iteration 15 started ======
[2025-06-12T05:05:47.994Z] GC before operation: completed in 386.962 ms, heap usage 143.382 MB -> 69.652 MB.
[2025-06-12T05:05:51.657Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3555.240 ms) ======
[2025-06-12T05:05:51.657Z] ====== dec-tree (apache-spark) [default], iteration 16 started ======
[2025-06-12T05:05:52.356Z] GC before operation: completed in 366.485 ms, heap usage 209.096 MB -> 70.065 MB.
[2025-06-12T05:05:54.550Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2971.251 ms) ======
[2025-06-12T05:05:54.550Z] ====== dec-tree (apache-spark) [default], iteration 17 started ======
[2025-06-12T05:05:55.213Z] GC before operation: completed in 246.638 ms, heap usage 116.358 MB -> 69.623 MB.
[2025-06-12T05:05:57.738Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2768.419 ms) ======
[2025-06-12T05:05:57.738Z] ====== dec-tree (apache-spark) [default], iteration 18 started ======
[2025-06-12T05:05:57.738Z] GC before operation: completed in 332.936 ms, heap usage 146.799 MB -> 89.344 MB.
[2025-06-12T05:06:01.935Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (3764.568 ms) ======
[2025-06-12T05:06:01.935Z] ====== dec-tree (apache-spark) [default], iteration 19 started ======
[2025-06-12T05:06:01.935Z] GC before operation: completed in 259.296 ms, heap usage 318.054 MB -> 97.620 MB.
[2025-06-12T05:06:05.012Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2878.428 ms) ======
[2025-06-12T05:06:05.013Z] ====== dec-tree (apache-spark) [default], iteration 20 started ======
[2025-06-12T05:06:05.013Z] GC before operation: completed in 336.806 ms, heap usage 370.838 MB -> 70.125 MB.
[2025-06-12T05:06:08.168Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (2912.080 ms) ======
[2025-06-12T05:06:08.168Z] ====== dec-tree (apache-spark) [default], iteration 21 started ======
[2025-06-12T05:06:08.824Z] GC before operation: completed in 366.051 ms, heap usage 135.133 MB -> 70.218 MB.
[2025-06-12T05:06:11.911Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3615.758 ms) ======
[2025-06-12T05:06:11.912Z] ====== dec-tree (apache-spark) [default], iteration 22 started ======
[2025-06-12T05:06:12.635Z] GC before operation: completed in 305.740 ms, heap usage 180.306 MB -> 70.326 MB.
[2025-06-12T05:06:15.710Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (3073.631 ms) ======
[2025-06-12T05:06:15.710Z] ====== dec-tree (apache-spark) [default], iteration 23 started ======
[2025-06-12T05:06:15.710Z] GC before operation: completed in 233.829 ms, heap usage 153.327 MB -> 70.103 MB.
[2025-06-12T05:06:19.957Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (3540.503 ms) ======
[2025-06-12T05:06:19.957Z] ====== dec-tree (apache-spark) [default], iteration 24 started ======
[2025-06-12T05:06:19.957Z] GC before operation: completed in 289.717 ms, heap usage 255.182 MB -> 70.929 MB.
[2025-06-12T05:06:25.523Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5787.411 ms) ======
[2025-06-12T05:06:25.523Z] ====== dec-tree (apache-spark) [default], iteration 25 started ======
[2025-06-12T05:06:26.292Z] GC before operation: completed in 1145.088 ms, heap usage 263.183 MB -> 98.222 MB.
[2025-06-12T05:06:27.015Z] 01:06:26.396 WARN [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManager - Block broadcast_345 could not be removed as it was not found on disk or in memory
[2025-06-12T05:06:27.015Z] 01:06:26.759 WARN [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManager - Block broadcast_345 was not removed normally.
[2025-06-12T05:06:27.015Z] 01:06:26.765 ERROR [block-manager-storage-async-thread-pool-96] org.apache.spark.storage.BlockManagerStorageEndpoint - Error in removing broadcast 345
[2025-06-12T05:06:27.015Z] org.apache.spark.SparkException: Block broadcast_345 does not exist
[2025-06-12T05:06:27.015Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.015Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.015Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
[2025-06-12T05:06:27.016Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
[2025-06-12T05:06:27.016Z] at java.lang.Thread.run(Thread.java:829) [?:?]
[2025-06-12T05:06:27.016Z] 01:06:26.781 WARN [block-manager-ask-thread-pool-118] org.apache.spark.storage.BlockManagerMaster - Failed to remove broadcast 345 with removeFromMaster = true - Block broadcast_345 does not exist
[2025-06-12T05:06:27.016Z] org.apache.spark.SparkException: Block broadcast_345 does not exist
[2025-06-12T05:06:27.016Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
[2025-06-12T05:06:27.016Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
[2025-06-12T05:06:27.016Z] at java.lang.Thread.run(Thread.java:829) [?:?]
[2025-06-12T05:06:27.016Z] 01:06:26.782 ERROR [Spark Context Cleaner] org.apache.spark.ContextCleaner - Error cleaning broadcast 345
[2025-06-12T05:06:27.016Z] org.apache.spark.SparkException: Exception thrown in awaitResult:
[2025-06-12T05:06:27.016Z] at org.apache.spark.util.SparkThreadUtils$.awaitResult(SparkThreadUtils.scala:56) ~[spark-common-utils_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.util.ThreadUtils$.awaitResult(ThreadUtils.scala:310) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:75) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManagerMaster.removeBroadcast(BlockManagerMaster.scala:222) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.broadcast.TorrentBroadcast$.unpersist(TorrentBroadcast.scala:395) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.broadcast.TorrentBroadcastFactory.unbroadcast(TorrentBroadcastFactory.scala:49) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.broadcast.BroadcastManager.unbroadcast(BroadcastManager.scala:82) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.ContextCleaner.doCleanupBroadcast(ContextCleaner.scala:256) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3(ContextCleaner.scala:204) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.Option.foreach(Option.scala:437) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$1(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.util.Utils$.tryOrStopSparkContext(Utils.scala:1356) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at org.apache.spark.ContextCleaner$$anon$1.run(ContextCleaner.scala:79) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] Caused by: org.apache.spark.SparkException: Block broadcast_345 does not exist
[2025-06-12T05:06:27.016Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] 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-12T05:06:27.016Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:27.016Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
[2025-06-12T05:06:27.016Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
[2025-06-12T05:06:27.016Z] at java.lang.Thread.run(Thread.java:829) ~[?:?]
[2025-06-12T05:06:31.272Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3774.623 ms) ======
[2025-06-12T05:06:31.272Z] ====== dec-tree (apache-spark) [default], iteration 26 started ======
[2025-06-12T05:06:31.272Z] GC before operation: completed in 407.530 ms, heap usage 133.221 MB -> 71.644 MB.
[2025-06-12T05:06:33.603Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3058.127 ms) ======
[2025-06-12T05:06:33.603Z] ====== dec-tree (apache-spark) [default], iteration 27 started ======
[2025-06-12T05:06:34.273Z] GC before operation: completed in 246.327 ms, heap usage 123.053 MB -> 71.438 MB.
[2025-06-12T05:06:36.975Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2552.655 ms) ======
[2025-06-12T05:06:36.975Z] ====== dec-tree (apache-spark) [default], iteration 28 started ======
[2025-06-12T05:06:36.975Z] GC before operation: completed in 211.412 ms, heap usage 108.103 MB -> 99.164 MB.
[2025-06-12T05:06:40.153Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (2914.436 ms) ======
[2025-06-12T05:06:40.153Z] ====== dec-tree (apache-spark) [default], iteration 29 started ======
[2025-06-12T05:06:40.153Z] GC before operation: completed in 320.352 ms, heap usage 287.800 MB -> 80.530 MB.
[2025-06-12T05:06:43.281Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2830.109 ms) ======
[2025-06-12T05:06:43.281Z] ====== dec-tree (apache-spark) [default], iteration 30 started ======
[2025-06-12T05:06:43.281Z] GC before operation: completed in 328.715 ms, heap usage 118.905 MB -> 71.967 MB.
[2025-06-12T05:06:43.281Z] 01:06:42.832 WARN [block-manager-storage-async-thread-pool-46] org.apache.spark.storage.BlockManager - Block broadcast_415 could not be removed as it was not found on disk or in memory
[2025-06-12T05:06:43.281Z] 01:06:42.833 WARN [block-manager-storage-async-thread-pool-46] org.apache.spark.storage.BlockManager - Block broadcast_415 was not removed normally.
[2025-06-12T05:06:43.281Z] 01:06:42.833 ERROR [block-manager-storage-async-thread-pool-46] org.apache.spark.storage.BlockManagerStorageEndpoint - Error in removing broadcast 415
[2025-06-12T05:06:43.281Z] org.apache.spark.SparkException: Block broadcast_415 does not exist
[2025-06-12T05:06:43.281Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.281Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.281Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.281Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.281Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.281Z] 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-12T05:06:43.281Z] 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-12T05:06:43.281Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.281Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.281Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.281Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.281Z] 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-12T05:06:43.281Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.281Z] 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-12T05:06:43.281Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.281Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.281Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
[2025-06-12T05:06:43.281Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
[2025-06-12T05:06:43.281Z] at java.lang.Thread.run(Thread.java:829) [?:?]
[2025-06-12T05:06:43.282Z] 01:06:42.836 WARN [block-manager-ask-thread-pool-102] org.apache.spark.storage.BlockManagerMaster - Failed to remove broadcast 415 with removeFromMaster = true - Block broadcast_415 does not exist
[2025-06-12T05:06:43.282Z] org.apache.spark.SparkException: Block broadcast_415 does not exist
[2025-06-12T05:06:43.282Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [?:?]
[2025-06-12T05:06:43.282Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [?:?]
[2025-06-12T05:06:43.282Z] at java.lang.Thread.run(Thread.java:829) [?:?]
[2025-06-12T05:06:43.282Z] 01:06:42.836 ERROR [Spark Context Cleaner] org.apache.spark.ContextCleaner - Error cleaning broadcast 415
[2025-06-12T05:06:43.282Z] org.apache.spark.SparkException: Exception thrown in awaitResult:
[2025-06-12T05:06:43.282Z] at org.apache.spark.util.SparkThreadUtils$.awaitResult(SparkThreadUtils.scala:56) ~[spark-common-utils_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.util.ThreadUtils$.awaitResult(ThreadUtils.scala:310) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:75) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManagerMaster.removeBroadcast(BlockManagerMaster.scala:222) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.broadcast.TorrentBroadcast$.unpersist(TorrentBroadcast.scala:395) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.broadcast.TorrentBroadcastFactory.unbroadcast(TorrentBroadcastFactory.scala:49) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.broadcast.BroadcastManager.unbroadcast(BroadcastManager.scala:82) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.ContextCleaner.doCleanupBroadcast(ContextCleaner.scala:256) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3(ContextCleaner.scala:204) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.Option.foreach(Option.scala:437) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$1(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.util.Utils$.tryOrStopSparkContext(Utils.scala:1356) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] at org.apache.spark.ContextCleaner$$anon$1.run(ContextCleaner.scala:79) [spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] Caused by: org.apache.spark.SparkException: Block broadcast_415 does not exist
[2025-06-12T05:06:43.282Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] 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-12T05:06:43.282Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?]
[2025-06-12T05:06:43.282Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
[2025-06-12T05:06:43.282Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
[2025-06-12T05:06:43.282Z] at java.lang.Thread.run(Thread.java:829) ~[?:?]
[2025-06-12T05:06:46.271Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2725.878 ms) ======
[2025-06-12T05:06:46.271Z] ====== dec-tree (apache-spark) [default], iteration 31 started ======
[2025-06-12T05:06:46.271Z] GC before operation: completed in 399.471 ms, heap usage 262.702 MB -> 91.650 MB.
[2025-06-12T05:06:49.390Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3141.745 ms) ======
[2025-06-12T05:06:49.390Z] ====== dec-tree (apache-spark) [default], iteration 32 started ======
[2025-06-12T05:06:50.046Z] GC before operation: completed in 464.052 ms, heap usage 240.120 MB -> 72.459 MB.
[2025-06-12T05:06:54.046Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3650.320 ms) ======
[2025-06-12T05:06:54.046Z] ====== dec-tree (apache-spark) [default], iteration 33 started ======
[2025-06-12T05:06:54.046Z] GC before operation: completed in 272.642 ms, heap usage 122.277 MB -> 99.685 MB.
[2025-06-12T05:06:57.257Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3233.377 ms) ======
[2025-06-12T05:06:57.257Z] ====== dec-tree (apache-spark) [default], iteration 34 started ======
[2025-06-12T05:06:57.955Z] GC before operation: completed in 840.117 ms, heap usage 207.805 MB -> 72.505 MB.
[2025-06-12T05:07:01.065Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3365.523 ms) ======
[2025-06-12T05:07:01.065Z] ====== dec-tree (apache-spark) [default], iteration 35 started ======
[2025-06-12T05:07:01.762Z] GC before operation: completed in 428.718 ms, heap usage 151.353 MB -> 72.596 MB.
[2025-06-12T05:07:06.126Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4184.279 ms) ======
[2025-06-12T05:07:06.126Z] ====== dec-tree (apache-spark) [default], iteration 36 started ======
[2025-06-12T05:07:06.126Z] GC before operation: completed in 382.962 ms, heap usage 205.953 MB -> 72.852 MB.
[2025-06-12T05:07:09.175Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2994.791 ms) ======
[2025-06-12T05:07:09.175Z] ====== dec-tree (apache-spark) [default], iteration 37 started ======
[2025-06-12T05:07:09.865Z] GC before operation: completed in 311.826 ms, heap usage 151.259 MB -> 100.390 MB.
[2025-06-12T05:07:12.235Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2556.799 ms) ======
[2025-06-12T05:07:12.235Z] ====== dec-tree (apache-spark) [default], iteration 38 started ======
[2025-06-12T05:07:12.235Z] GC before operation: completed in 340.625 ms, heap usage 165.517 MB -> 73.134 MB.
[2025-06-12T05:07:15.257Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2813.273 ms) ======
[2025-06-12T05:07:15.257Z] ====== dec-tree (apache-spark) [default], iteration 39 started ======
[2025-06-12T05:07:15.257Z] GC before operation: completed in 235.548 ms, heap usage 215.980 MB -> 73.151 MB.
[2025-06-12T05:07:19.257Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3296.525 ms) ======
[2025-06-12T05:07:19.257Z] -----------------------------------
[2025-06-12T05:07:19.257Z] renaissance-dec-tree_0_PASSED
[2025-06-12T05:07:19.257Z] -----------------------------------
[2025-06-12T05:07:19.257Z]
[2025-06-12T05:07:19.257Z] TEST TEARDOWN:
[2025-06-12T05:07:19.257Z] Nothing to be done for teardown.
[2025-06-12T05:07:19.257Z] renaissance-dec-tree_0 Finish Time: Thu Jun 12 01:07:19 2025 Epoch Time (ms): 1749704839123