[2025-02-13T22:10:19.390Z] Running test renaissance-dec-tree_0 ... [2025-02-13T22:10:19.390Z] =============================================== [2025-02-13T22:10:19.390Z] renaissance-dec-tree_0 Start Time: Thu Feb 13 16:10:19 2025 Epoch Time (ms): 1739484619179 [2025-02-13T22:10:19.390Z] variation: NoOptions [2025-02-13T22:10:19.390Z] JVM_OPTIONS: [2025-02-13T22:10:19.390Z] { \ [2025-02-13T22:10:19.390Z] echo ""; echo "TEST SETUP:"; \ [2025-02-13T22:10:19.390Z] echo "Nothing to be done for setup."; \ [2025-02-13T22:10:19.390Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17394841722889/renaissance-dec-tree_0"; \ [2025-02-13T22:10:19.390Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17394841722889/renaissance-dec-tree_0"; \ [2025-02-13T22:10:19.390Z] echo ""; echo "TESTING:"; \ [2025-02-13T22:10:19.390Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17394841722889/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-13T22:10:19.390Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17394841722889/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-13T22:10:19.390Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-13T22:10:19.390Z] echo "Nothing to be done for teardown."; \ [2025-02-13T22:10:19.390Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17394841722889/TestTargetResult"; [2025-02-13T22:10:19.390Z] [2025-02-13T22:10:19.390Z] TEST SETUP: [2025-02-13T22:10:19.390Z] Nothing to be done for setup. [2025-02-13T22:10:19.390Z] [2025-02-13T22:10:19.390Z] TESTING: [2025-02-13T22:10:21.824Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-13T22:10:24.255Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2025-02-13T22:10:27.644Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-13T22:10:27.644Z] GC before operation: completed in 144.468 ms, heap usage 149.647 MB -> 32.223 MB. [2025-02-13T22:10:35.858Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (7750.044 ms) ====== [2025-02-13T22:10:35.858Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-13T22:10:35.858Z] GC before operation: completed in 494.012 ms, heap usage 370.244 MB -> 56.187 MB. [2025-02-13T22:10:37.457Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1936.038 ms) ====== [2025-02-13T22:10:37.457Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-13T22:10:37.457Z] GC before operation: completed in 289.459 ms, heap usage 391.120 MB -> 78.821 MB. [2025-02-13T22:10:39.033Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1515.172 ms) ====== [2025-02-13T22:10:39.033Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-13T22:10:39.796Z] GC before operation: completed in 247.984 ms, heap usage 391.982 MB -> 68.034 MB. [2025-02-13T22:10:40.556Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1368.319 ms) ====== [2025-02-13T22:10:40.556Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-13T22:10:41.315Z] GC before operation: completed in 202.306 ms, heap usage 347.131 MB -> 57.126 MB. [2025-02-13T22:10:42.881Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1694.915 ms) ====== [2025-02-13T22:10:42.881Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-13T22:10:42.881Z] GC before operation: completed in 184.283 ms, heap usage 309.650 MB -> 57.223 MB. [2025-02-13T22:10:44.467Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1223.533 ms) ====== [2025-02-13T22:10:44.467Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-13T22:10:44.467Z] GC before operation: completed in 198.425 ms, heap usage 308.662 MB -> 57.608 MB. [2025-02-13T22:10:46.039Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1255.748 ms) ====== [2025-02-13T22:10:46.039Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-13T22:10:46.039Z] GC before operation: completed in 206.545 ms, heap usage 282.867 MB -> 57.855 MB. [2025-02-13T22:10:46.798Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1226.689 ms) ====== [2025-02-13T22:10:46.798Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-13T22:10:47.558Z] GC before operation: completed in 194.691 ms, heap usage 278.742 MB -> 58.008 MB. [2025-02-13T22:10:48.315Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1254.985 ms) ====== [2025-02-13T22:10:48.315Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-13T22:10:49.075Z] GC before operation: completed in 232.019 ms, heap usage 269.301 MB -> 69.045 MB. [2025-02-13T22:10:49.832Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1232.432 ms) ====== [2025-02-13T22:10:49.832Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-13T22:10:49.832Z] GC before operation: completed in 237.366 ms, heap usage 289.896 MB -> 85.752 MB. [2025-02-13T22:10:51.399Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1464.656 ms) ====== [2025-02-13T22:10:51.399Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-13T22:10:52.157Z] GC before operation: completed in 228.362 ms, heap usage 305.673 MB -> 69.395 MB. [2025-02-13T22:10:52.915Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1338.312 ms) ====== [2025-02-13T22:10:52.915Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-13T22:10:53.673Z] GC before operation: completed in 220.195 ms, heap usage 292.488 MB -> 69.387 MB. [2025-02-13T22:10:54.452Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1204.503 ms) ====== [2025-02-13T22:10:54.452Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-13T22:10:55.211Z] GC before operation: completed in 183.535 ms, heap usage 297.171 MB -> 75.149 MB. [2025-02-13T22:10:55.968Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1280.040 ms) ====== [2025-02-13T22:10:55.968Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-13T22:10:56.724Z] GC before operation: completed in 226.031 ms, heap usage 296.845 MB -> 58.808 MB. [2025-02-13T22:10:57.481Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1260.512 ms) ====== [2025-02-13T22:10:57.481Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-13T22:10:57.481Z] GC before operation: completed in 209.992 ms, heap usage 273.656 MB -> 58.953 MB. [2025-02-13T22:10:59.060Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1197.104 ms) ====== [2025-02-13T22:10:59.061Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-13T22:10:59.061Z] GC before operation: completed in 229.256 ms, heap usage 273.618 MB -> 59.271 MB. [2025-02-13T22:11:00.634Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1296.181 ms) ====== [2025-02-13T22:11:00.634Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-13T22:11:00.634Z] GC before operation: completed in 285.649 ms, heap usage 278.558 MB -> 59.461 MB. [2025-02-13T22:11:02.201Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1212.238 ms) ====== [2025-02-13T22:11:02.201Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-13T22:11:02.201Z] GC before operation: completed in 285.445 ms, heap usage 263.307 MB -> 87.002 MB. [2025-02-13T22:11:03.769Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1306.894 ms) ====== [2025-02-13T22:11:03.769Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-13T22:11:03.769Z] GC before operation: completed in 264.557 ms, heap usage 309.890 MB -> 70.436 MB. [2025-02-13T22:11:05.338Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1226.765 ms) ====== [2025-02-13T22:11:05.338Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-13T22:11:05.338Z] GC before operation: completed in 203.968 ms, heap usage 297.680 MB -> 76.343 MB. [2025-02-13T22:11:06.909Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1374.272 ms) ====== [2025-02-13T22:11:06.909Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-13T22:11:06.909Z] GC before operation: completed in 220.052 ms, heap usage 303.530 MB -> 87.410 MB. [2025-02-13T22:11:07.667Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1093.076 ms) ====== [2025-02-13T22:11:07.667Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-13T22:11:08.427Z] GC before operation: completed in 234.084 ms, heap usage 326.344 MB -> 87.554 MB. [2025-02-13T22:11:08.427Z] 25/02/13 16:11:08 WARN BlockManager: Asked to remove block rdd_1075_2, which does not exist [2025-02-13T22:11:09.185Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1182.955 ms) ====== [2025-02-13T22:11:09.185Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-13T22:11:09.943Z] GC before operation: completed in 238.994 ms, heap usage 327.555 MB -> 60.069 MB. [2025-02-13T22:11:10.709Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1238.265 ms) ====== [2025-02-13T22:11:10.709Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-13T22:11:11.468Z] GC before operation: completed in 186.239 ms, heap usage 305.196 MB -> 76.693 MB. [2025-02-13T22:11:11.468Z] 25/02/13 16:11:10 WARN BlockManager: Asked to remove block rdd_1173_1, which does not exist [2025-02-13T22:11:11.468Z] 25/02/13 16:11:10 WARN BlockManager: Asked to remove block rdd_1173_2, which does not exist [2025-02-13T22:11:12.226Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1145.698 ms) ====== [2025-02-13T22:11:12.226Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-13T22:11:12.226Z] GC before operation: completed in 201.291 ms, heap usage 310.198 MB -> 71.453 MB. [2025-02-13T22:11:12.226Z] 25/02/13 16:11:12 WARN BlockManager: Asked to remove block broadcast_344, which does not exist [2025-02-13T22:11:13.796Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1114.826 ms) ====== [2025-02-13T22:11:13.796Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-13T22:11:13.796Z] GC before operation: completed in 205.054 ms, heap usage 301.269 MB -> 60.615 MB. [2025-02-13T22:11:15.912Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1227.344 ms) ====== [2025-02-13T22:11:15.912Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-13T22:11:15.912Z] GC before operation: completed in 190.707 ms, heap usage 275.635 MB -> 88.206 MB. [2025-02-13T22:11:16.679Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1158.514 ms) ====== [2025-02-13T22:11:16.679Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-13T22:11:16.679Z] GC before operation: completed in 217.920 ms, heap usage 319.248 MB -> 77.238 MB. [2025-02-13T22:11:16.679Z] 25/02/13 16:11:16 WARN BlockManager: Asked to remove block broadcast_386_piece0, which does not exist [2025-02-13T22:11:17.446Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1191.005 ms) ====== [2025-02-13T22:11:17.446Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-13T22:11:18.204Z] GC before operation: completed in 222.041 ms, heap usage 309.419 MB -> 60.874 MB. [2025-02-13T22:11:18.964Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1283.527 ms) ====== [2025-02-13T22:11:18.964Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-13T22:11:19.724Z] GC before operation: completed in 213.380 ms, heap usage 291.418 MB -> 61.169 MB. [2025-02-13T22:11:20.484Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1367.433 ms) ====== [2025-02-13T22:11:20.484Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-13T22:11:21.245Z] GC before operation: completed in 263.538 ms, heap usage 285.675 MB -> 72.412 MB. [2025-02-13T22:11:22.005Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1149.565 ms) ====== [2025-02-13T22:11:22.005Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-13T22:11:22.763Z] GC before operation: completed in 223.561 ms, heap usage 281.538 MB -> 61.414 MB. [2025-02-13T22:11:23.522Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1267.114 ms) ====== [2025-02-13T22:11:23.522Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-13T22:11:24.281Z] GC before operation: completed in 244.980 ms, heap usage 283.739 MB -> 88.996 MB. [2025-02-13T22:11:25.040Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1088.182 ms) ====== [2025-02-13T22:11:25.040Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-13T22:11:25.040Z] GC before operation: completed in 209.765 ms, heap usage 320.414 MB -> 78.023 MB. [2025-02-13T22:11:26.608Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1082.291 ms) ====== [2025-02-13T22:11:26.608Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-13T22:11:26.608Z] GC before operation: completed in 193.089 ms, heap usage 306.403 MB -> 72.734 MB. [2025-02-13T22:11:28.184Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1167.658 ms) ====== [2025-02-13T22:11:28.184Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-13T22:11:28.184Z] GC before operation: completed in 200.147 ms, heap usage 296.879 MB -> 78.537 MB. [2025-02-13T22:11:29.753Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1405.248 ms) ====== [2025-02-13T22:11:29.753Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-13T22:11:29.753Z] GC before operation: completed in 196.948 ms, heap usage 291.171 MB -> 61.940 MB. [2025-02-13T22:11:30.514Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1124.271 ms) ====== [2025-02-13T22:11:30.514Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-13T22:11:30.514Z] GC before operation: completed in 182.814 ms, heap usage 280.912 MB -> 67.668 MB. [2025-02-13T22:11:32.083Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1124.858 ms) ====== [2025-02-13T22:11:32.083Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-13T22:11:32.083Z] GC before operation: completed in 240.346 ms, heap usage 279.674 MB -> 89.803 MB. [2025-02-13T22:11:33.688Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1324.519 ms) ====== [2025-02-13T22:11:34.447Z] ----------------------------------- [2025-02-13T22:11:34.447Z] renaissance-dec-tree_0_PASSED [2025-02-13T22:11:34.447Z] ----------------------------------- [2025-02-13T22:11:34.447Z] [2025-02-13T22:11:34.447Z] TEST TEARDOWN: [2025-02-13T22:11:34.447Z] Nothing to be done for teardown. [2025-02-13T22:11:34.447Z] renaissance-dec-tree_0 Finish Time: Thu Feb 13 16:11:34 2025 Epoch Time (ms): 1739484694051