[2025-12-18T01:04:26.168Z] Running test renaissance-dec-tree_0 ... [2025-12-18T01:04:26.168Z] =============================================== [2025-12-18T01:04:26.168Z] renaissance-dec-tree_0 Start Time: Wed Dec 17 17:04:24 2025 Epoch Time (ms): 1766019864824 [2025-12-18T01:04:26.168Z] variation: NoOptions [2025-12-18T01:04:26.168Z] JVM_OPTIONS: [2025-12-18T01:04:26.168Z] { \ [2025-12-18T01:04:26.168Z] echo ""; echo "TEST SETUP:"; \ [2025-12-18T01:04:26.168Z] echo "Nothing to be done for setup."; \ [2025-12-18T01:04:26.168Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17660192194901/renaissance-dec-tree_0"; \ [2025-12-18T01:04:26.168Z] cd "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17660192194901/renaissance-dec-tree_0"; \ [2025-12-18T01:04:26.168Z] echo ""; echo "TESTING:"; \ [2025-12-18T01:04:26.168Z] "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17660192194901/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-12-18T01:04:26.168Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17660192194901/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-18T01:04:26.168Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-18T01:04:26.168Z] echo "Nothing to be done for teardown."; \ [2025-12-18T01:04:26.168Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_mac_testList_1/aqa-tests/TKG/../TKG/output_17660192194901/TestTargetResult"; [2025-12-18T01:04:26.168Z] [2025-12-18T01:04:26.168Z] TEST SETUP: [2025-12-18T01:04:26.168Z] Nothing to be done for setup. [2025-12-18T01:04:26.168Z] [2025-12-18T01:04:26.168Z] TESTING: [2025-12-18T01:04:43.922Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-12-18T01:04:48.472Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-12-18T01:04:48.472Z] GC before operation: completed in 59.202 ms, heap usage 79.825 MB -> 34.165 MB. [2025-12-18T01:05:18.668Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (26711.041 ms) ====== [2025-12-18T01:05:18.668Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-12-18T01:05:18.668Z] GC before operation: completed in 251.565 ms, heap usage 233.145 MB -> 70.213 MB. [2025-12-18T01:05:22.614Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7944.113 ms) ====== [2025-12-18T01:05:22.614Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-12-18T01:05:23.250Z] GC before operation: completed in 204.136 ms, heap usage 320.516 MB -> 98.155 MB. [2025-12-18T01:05:30.415Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (6659.461 ms) ====== [2025-12-18T01:05:30.415Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-12-18T01:05:30.415Z] GC before operation: completed in 149.056 ms, heap usage 135.899 MB -> 70.265 MB. [2025-12-18T01:05:34.021Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (3698.180 ms) ====== [2025-12-18T01:05:34.021Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-12-18T01:05:34.021Z] GC before operation: completed in 142.794 ms, heap usage 308.763 MB -> 98.317 MB. [2025-12-18T01:05:36.832Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (3359.921 ms) ====== [2025-12-18T01:05:36.832Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-12-18T01:05:37.263Z] GC before operation: completed in 102.228 ms, heap usage 524.444 MB -> 82.458 MB. [2025-12-18T01:05:38.758Z] 17:05:37.186 WARN [block-manager-storage-async-thread-pool-15] org.apache.spark.storage.BlockManager - Block broadcast_65_piece0 was not removed normally. [2025-12-18T01:05:38.758Z] 17:05:37.190 ERROR [block-manager-storage-async-thread-pool-15] org.apache.spark.storage.BlockManagerStorageEndpoint - Error in removing broadcast 65 [2025-12-18T01:05:38.758Z] org.apache.spark.SparkException: Block broadcast_65_piece0 does not exist [2025-12-18T01:05:38.758Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?] [2025-12-18T01:05:38.759Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?] [2025-12-18T01:05:38.759Z] at java.lang.Thread.run(Thread.java:840) [?:?] [2025-12-18T01:05:38.759Z] 17:05:37.202 WARN [block-manager-ask-thread-pool-11] org.apache.spark.storage.BlockManagerMaster - Failed to remove broadcast 65 with removeFromMaster = true - Block broadcast_65_piece0 does not exist [2025-12-18T01:05:38.759Z] org.apache.spark.SparkException: Block broadcast_65_piece0 does not exist [2025-12-18T01:05:38.759Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) [scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) [?:?] [2025-12-18T01:05:38.759Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) [?:?] [2025-12-18T01:05:38.759Z] at java.lang.Thread.run(Thread.java:840) [?:?] [2025-12-18T01:05:38.759Z] 17:05:37.202 ERROR [Spark Context Cleaner] org.apache.spark.ContextCleaner - Error cleaning broadcast 65 [2025-12-18T01:05:38.759Z] org.apache.spark.SparkException: Exception thrown in awaitResult: [2025-12-18T01:05:38.759Z] at org.apache.spark.util.SparkThreadUtils$.awaitResult(SparkThreadUtils.scala:56) ~[spark-common-utils_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.util.ThreadUtils$.awaitResult(ThreadUtils.scala:310) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.rpc.RpcTimeout.awaitResult(RpcTimeout.scala:75) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManagerMaster.removeBroadcast(BlockManagerMaster.scala:222) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.broadcast.TorrentBroadcast$.unpersist(TorrentBroadcast.scala:395) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.broadcast.TorrentBroadcastFactory.unbroadcast(TorrentBroadcastFactory.scala:49) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.broadcast.BroadcastManager.unbroadcast(BroadcastManager.scala:82) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.ContextCleaner.doCleanupBroadcast(ContextCleaner.scala:256) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3(ContextCleaner.scala:204) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$3$adapted(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at scala.Option.foreach(Option.scala:437) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.ContextCleaner.$anonfun$keepCleaning$1(ContextCleaner.scala:195) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.util.Utils$.tryOrStopSparkContext(Utils.scala:1356) [spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at org.apache.spark.ContextCleaner$$anon$1.run(ContextCleaner.scala:79) [spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] Caused by: org.apache.spark.SparkException: Block broadcast_65_piece0 does not exist [2025-12-18T01:05:38.759Z] at org.apache.spark.errors.SparkCoreErrors$.blockDoesNotExistError(SparkCoreErrors.scala:318) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockInfoManager.blockInfo(BlockInfoManager.scala:269) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockInfoManager.removeBlock(BlockInfoManager.scala:547) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBlockInternal(BlockManager.scala:2091) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBlock(BlockManager.scala:2057) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.$anonfun$removeBroadcast$3(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:619) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:617) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.collection.AbstractIterator.foreach(Iterator.scala:1303) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManager.removeBroadcast(BlockManager.scala:2029) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] 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-12-18T01:05:38.759Z] at scala.runtime.java8.JFunction0$mcI$sp.apply(JFunction0$mcI$sp.scala:17) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at org.apache.spark.storage.BlockManagerStorageEndpoint.$anonfun$doAsync$1(BlockManagerStorageEndpoint.scala:101) ~[spark-core_2.13-3.5.3.jar:3.5.3] [2025-12-18T01:05:38.759Z] at scala.concurrent.Future$.$anonfun$apply$1(Future.scala:687) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at scala.concurrent.impl.Promise$Transformation.run(Promise.scala:467) ~[scala-library-2.13.15.jar:?] [2025-12-18T01:05:38.759Z] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) ~[?:?] [2025-12-18T01:05:38.759Z] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) ~[?:?] [2025-12-18T01:05:38.759Z] at java.lang.Thread.run(Thread.java:840) ~[?:?] [2025-12-18T01:05:42.474Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (5253.418 ms) ====== [2025-12-18T01:05:42.474Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-12-18T01:05:42.474Z] GC before operation: completed in 86.456 ms, heap usage 247.209 MB -> 72.483 MB. [2025-12-18T01:05:45.935Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3217.341 ms) ====== [2025-12-18T01:05:45.935Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-12-18T01:05:45.935Z] GC before operation: completed in 122.155 ms, heap usage 248.522 MB -> 72.645 MB. [2025-12-18T01:05:48.205Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (2530.672 ms) ====== [2025-12-18T01:05:48.205Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-12-18T01:05:48.205Z] GC before operation: completed in 75.961 ms, heap usage 315.491 MB -> 72.782 MB. [2025-12-18T01:05:53.058Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4483.814 ms) ====== [2025-12-18T01:05:53.058Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-12-18T01:05:53.059Z] GC before operation: completed in 172.369 ms, heap usage 381.586 MB -> 72.911 MB. [2025-12-18T01:05:57.820Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (4028.436 ms) ====== [2025-12-18T01:05:57.820Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-12-18T01:05:57.820Z] GC before operation: completed in 670.598 ms, heap usage 224.370 MB -> 72.884 MB. [2025-12-18T01:06:02.534Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4864.181 ms) ====== [2025-12-18T01:06:02.534Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-12-18T01:06:02.954Z] GC before operation: completed in 182.458 ms, heap usage 601.174 MB -> 79.054 MB. [2025-12-18T01:06:06.695Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (3871.253 ms) ====== [2025-12-18T01:06:06.695Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-12-18T01:06:06.695Z] GC before operation: completed in 202.057 ms, heap usage 240.173 MB -> 73.174 MB. [2025-12-18T01:06:11.677Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (4469.894 ms) ====== [2025-12-18T01:06:11.677Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-12-18T01:06:12.189Z] GC before operation: completed in 787.951 ms, heap usage 335.803 MB -> 73.570 MB. [2025-12-18T01:06:16.816Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (4481.264 ms) ====== [2025-12-18T01:06:16.816Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-12-18T01:06:16.816Z] GC before operation: completed in 234.921 ms, heap usage 454.331 MB -> 101.124 MB. [2025-12-18T01:06:22.717Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4889.227 ms) ====== [2025-12-18T01:06:22.717Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-12-18T01:06:22.717Z] GC before operation: completed in 220.872 ms, heap usage 531.016 MB -> 74.097 MB. [2025-12-18T01:06:26.886Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (4458.483 ms) ====== [2025-12-18T01:06:26.886Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-12-18T01:06:26.886Z] GC before operation: completed in 207.818 ms, heap usage 203.967 MB -> 73.964 MB. [2025-12-18T01:06:31.438Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4991.683 ms) ====== [2025-12-18T01:06:31.438Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-12-18T01:06:31.876Z] GC before operation: completed in 226.809 ms, heap usage 220.500 MB -> 74.027 MB. [2025-12-18T01:06:35.453Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (3223.592 ms) ====== [2025-12-18T01:06:35.453Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-12-18T01:06:35.453Z] GC before operation: completed in 112.961 ms, heap usage 180.390 MB -> 73.816 MB. [2025-12-18T01:06:37.557Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2408.629 ms) ====== [2025-12-18T01:06:37.557Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-12-18T01:06:38.005Z] GC before operation: completed in 167.493 ms, heap usage 454.456 MB -> 101.740 MB. [2025-12-18T01:06:41.686Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (3738.335 ms) ====== [2025-12-18T01:06:41.686Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-12-18T01:06:41.686Z] GC before operation: completed in 189.458 ms, heap usage 406.896 MB -> 74.662 MB. [2025-12-18T01:06:45.464Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (3670.739 ms) ====== [2025-12-18T01:06:45.464Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-12-18T01:06:45.464Z] GC before operation: completed in 124.911 ms, heap usage 108.653 MB -> 73.905 MB. [2025-12-18T01:06:49.098Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (3043.304 ms) ====== [2025-12-18T01:06:49.098Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-12-18T01:06:49.098Z] GC before operation: completed in 120.089 ms, heap usage 514.805 MB -> 74.498 MB. [2025-12-18T01:06:52.777Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (3663.908 ms) ====== [2025-12-18T01:06:52.777Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-12-18T01:06:52.777Z] GC before operation: completed in 166.206 ms, heap usage 149.209 MB -> 102.049 MB. [2025-12-18T01:06:55.549Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2731.893 ms) ====== [2025-12-18T01:06:55.550Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-12-18T01:06:55.550Z] GC before operation: completed in 136.421 ms, heap usage 479.594 MB -> 74.724 MB. [2025-12-18T01:06:59.262Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (4001.141 ms) ====== [2025-12-18T01:06:59.262Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-12-18T01:06:59.711Z] GC before operation: completed in 211.613 ms, heap usage 390.434 MB -> 74.903 MB. [2025-12-18T01:07:03.576Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3219.591 ms) ====== [2025-12-18T01:07:03.576Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-12-18T01:07:03.576Z] GC before operation: completed in 278.443 ms, heap usage 293.655 MB -> 102.433 MB. [2025-12-18T01:07:07.117Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4145.482 ms) ====== [2025-12-18T01:07:07.117Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-12-18T01:07:07.573Z] GC before operation: completed in 106.784 ms, heap usage 148.476 MB -> 103.219 MB. [2025-12-18T01:07:11.208Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (3648.062 ms) ====== [2025-12-18T01:07:11.208Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-12-18T01:07:11.208Z] GC before operation: completed in 348.006 ms, heap usage 605.292 MB -> 75.348 MB. [2025-12-18T01:07:14.896Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3700.652 ms) ====== [2025-12-18T01:07:14.896Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-12-18T01:07:15.341Z] GC before operation: completed in 281.051 ms, heap usage 253.281 MB -> 102.865 MB. [2025-12-18T01:07:18.908Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (3695.513 ms) ====== [2025-12-18T01:07:18.908Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-12-18T01:07:19.438Z] GC before operation: completed in 412.752 ms, heap usage 458.236 MB -> 75.310 MB. [2025-12-18T01:07:24.085Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4191.206 ms) ====== [2025-12-18T01:07:24.085Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-12-18T01:07:24.085Z] GC before operation: completed in 228.230 ms, heap usage 398.618 MB -> 75.293 MB. [2025-12-18T01:07:27.947Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (3935.148 ms) ====== [2025-12-18T01:07:27.947Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-12-18T01:07:27.947Z] GC before operation: completed in 326.123 ms, heap usage 125.636 MB -> 74.936 MB. [2025-12-18T01:07:31.710Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (3696.089 ms) ====== [2025-12-18T01:07:31.710Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-12-18T01:07:32.166Z] GC before operation: completed in 233.352 ms, heap usage 506.095 MB -> 91.890 MB. [2025-12-18T01:07:35.778Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (3589.793 ms) ====== [2025-12-18T01:07:35.778Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-12-18T01:07:35.778Z] GC before operation: completed in 160.634 ms, heap usage 155.170 MB -> 75.325 MB. [2025-12-18T01:07:40.519Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (4170.112 ms) ====== [2025-12-18T01:07:40.519Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-12-18T01:07:40.519Z] GC before operation: completed in 223.311 ms, heap usage 303.082 MB -> 92.323 MB. [2025-12-18T01:07:44.322Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4074.179 ms) ====== [2025-12-18T01:07:44.322Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-12-18T01:07:44.322Z] GC before operation: completed in 156.101 ms, heap usage 236.260 MB -> 75.888 MB. [2025-12-18T01:07:48.244Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (3663.375 ms) ====== [2025-12-18T01:07:48.244Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-12-18T01:07:49.204Z] GC before operation: completed in 863.690 ms, heap usage 380.909 MB -> 76.000 MB. [2025-12-18T01:07:52.895Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (3835.476 ms) ====== [2025-12-18T01:07:52.895Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-12-18T01:07:52.895Z] GC before operation: completed in 239.172 ms, heap usage 221.202 MB -> 104.193 MB. [2025-12-18T01:07:57.431Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4555.786 ms) ====== [2025-12-18T01:07:57.431Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-12-18T01:07:57.904Z] GC before operation: completed in 159.950 ms, heap usage 678.120 MB -> 76.635 MB. [2025-12-18T01:08:01.596Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (3947.829 ms) ====== [2025-12-18T01:08:02.518Z] ----------------------------------- [2025-12-18T01:08:02.518Z] renaissance-dec-tree_0_PASSED [2025-12-18T01:08:02.518Z] ----------------------------------- [2025-12-18T01:08:02.518Z] [2025-12-18T01:08:02.518Z] TEST TEARDOWN: [2025-12-18T01:08:02.518Z] Nothing to be done for teardown. [2025-12-18T01:08:02.518Z] renaissance-dec-tree_0 Finish Time: Wed Dec 17 17:08:01 2025 Epoch Time (ms): 1766020081151