[2025-02-25T22:18:29.037Z] Running test renaissance-dec-tree_0 ... [2025-02-25T22:18:29.037Z] =============================================== [2025-02-25T22:18:29.037Z] renaissance-dec-tree_0 Start Time: Tue Feb 25 22:18:28 2025 Epoch Time (ms): 1740521908851 [2025-02-25T22:18:29.037Z] variation: NoOptions [2025-02-25T22:18:29.037Z] JVM_OPTIONS: [2025-02-25T22:18:29.037Z] { \ [2025-02-25T22:18:29.037Z] echo ""; echo "TEST SETUP:"; \ [2025-02-25T22:18:29.037Z] echo "Nothing to be done for setup."; \ [2025-02-25T22:18:29.037Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17405209215578/renaissance-dec-tree_0"; \ [2025-02-25T22:18:29.037Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17405209215578/renaissance-dec-tree_0"; \ [2025-02-25T22:18:29.037Z] echo ""; echo "TESTING:"; \ [2025-02-25T22:18:29.037Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/jdkbinary/j2sdk-image/bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17405209215578/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-25T22:18:29.037Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17405209215578/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-25T22:18:29.037Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-25T22:18:29.037Z] echo "Nothing to be done for teardown."; \ [2025-02-25T22:18:29.037Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17405209215578/TestTargetResult"; [2025-02-25T22:18:29.037Z] [2025-02-25T22:18:29.037Z] TEST SETUP: [2025-02-25T22:18:29.037Z] Nothing to be done for setup. [2025-02-25T22:18:29.037Z] [2025-02-25T22:18:29.037Z] TESTING: [2025-02-25T22:18:36.090Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-25T22:18:44.646Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-25T22:18:58.750Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-25T22:18:58.750Z] GC before operation: completed in 708.218 ms, heap usage 151.032 MB -> 30.918 MB. [2025-02-25T22:19:35.643Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (36080.017 ms) ====== [2025-02-25T22:19:35.643Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-25T22:19:36.461Z] GC before operation: completed in 1592.493 ms, heap usage 115.588 MB -> 55.711 MB. [2025-02-25T22:19:48.431Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (11904.780 ms) ====== [2025-02-25T22:19:48.431Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-25T22:19:49.244Z] GC before operation: completed in 1097.259 ms, heap usage 235.260 MB -> 55.183 MB. [2025-02-25T22:19:57.836Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (8609.860 ms) ====== [2025-02-25T22:19:57.837Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-25T22:19:58.632Z] GC before operation: completed in 757.151 ms, heap usage 184.102 MB -> 55.968 MB. [2025-02-25T22:20:05.812Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (7129.863 ms) ====== [2025-02-25T22:20:05.812Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-25T22:20:06.618Z] GC before operation: completed in 824.370 ms, heap usage 181.951 MB -> 56.550 MB. [2025-02-25T22:20:12.456Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (5637.419 ms) ====== [2025-02-25T22:20:12.456Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-25T22:20:13.287Z] GC before operation: completed in 732.209 ms, heap usage 206.791 MB -> 56.134 MB. [2025-02-25T22:20:19.138Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (5841.289 ms) ====== [2025-02-25T22:20:19.138Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-25T22:20:19.963Z] GC before operation: completed in 623.525 ms, heap usage 221.868 MB -> 56.363 MB. [2025-02-25T22:20:25.755Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (5702.371 ms) ====== [2025-02-25T22:20:25.755Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-25T22:20:25.755Z] GC before operation: completed in 614.432 ms, heap usage 202.120 MB -> 56.915 MB. [2025-02-25T22:20:31.544Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (5375.809 ms) ====== [2025-02-25T22:20:31.544Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-25T22:20:32.352Z] GC before operation: completed in 702.395 ms, heap usage 200.946 MB -> 56.623 MB. [2025-02-25T22:20:36.986Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (4585.088 ms) ====== [2025-02-25T22:20:36.986Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-25T22:20:36.986Z] GC before operation: completed in 714.483 ms, heap usage 201.718 MB -> 56.925 MB. [2025-02-25T22:20:43.436Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (5387.780 ms) ====== [2025-02-25T22:20:43.436Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-25T22:20:43.436Z] GC before operation: completed in 698.805 ms, heap usage 204.696 MB -> 57.141 MB. [2025-02-25T22:20:48.090Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (4949.521 ms) ====== [2025-02-25T22:20:48.090Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-25T22:20:49.751Z] GC before operation: completed in 898.939 ms, heap usage 194.923 MB -> 57.246 MB. [2025-02-25T22:20:53.294Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (4097.020 ms) ====== [2025-02-25T22:20:53.294Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-25T22:20:54.099Z] GC before operation: completed in 551.499 ms, heap usage 198.309 MB -> 57.205 MB. [2025-02-25T22:20:57.691Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (3915.662 ms) ====== [2025-02-25T22:20:57.691Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-25T22:20:58.502Z] GC before operation: completed in 577.152 ms, heap usage 193.274 MB -> 57.509 MB. [2025-02-25T22:21:02.052Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (3758.207 ms) ====== [2025-02-25T22:21:02.052Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-25T22:21:02.864Z] GC before operation: completed in 489.059 ms, heap usage 197.752 MB -> 57.649 MB. [2025-02-25T22:21:06.435Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4057.294 ms) ====== [2025-02-25T22:21:06.435Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-25T22:21:07.247Z] GC before operation: completed in 642.903 ms, heap usage 196.645 MB -> 57.792 MB. [2025-02-25T22:21:14.313Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (3798.737 ms) ====== [2025-02-25T22:21:14.313Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-25T22:21:14.313Z] GC before operation: completed in 746.264 ms, heap usage 201.616 MB -> 57.988 MB. [2025-02-25T22:21:16.889Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (4481.451 ms) ====== [2025-02-25T22:21:16.889Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-25T22:21:16.889Z] GC before operation: completed in 767.865 ms, heap usage 197.097 MB -> 58.293 MB. [2025-02-25T22:21:21.533Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4408.705 ms) ====== [2025-02-25T22:21:21.533Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-25T22:21:22.334Z] GC before operation: completed in 602.597 ms, heap usage 195.676 MB -> 58.257 MB. [2025-02-25T22:21:27.025Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (4349.436 ms) ====== [2025-02-25T22:21:27.025Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-25T22:21:27.025Z] GC before operation: completed in 702.001 ms, heap usage 198.906 MB -> 58.387 MB. [2025-02-25T22:21:31.664Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4506.412 ms) ====== [2025-02-25T22:21:31.664Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-25T22:21:32.489Z] GC before operation: completed in 583.903 ms, heap usage 196.960 MB -> 58.595 MB. [2025-02-25T22:21:37.136Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (4663.649 ms) ====== [2025-02-25T22:21:37.136Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-25T22:21:37.949Z] GC before operation: completed in 937.546 ms, heap usage 193.354 MB -> 58.675 MB. [2025-02-25T22:21:42.634Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (4514.041 ms) ====== [2025-02-25T22:21:42.634Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-25T22:21:42.634Z] GC before operation: completed in 442.060 ms, heap usage 200.212 MB -> 75.013 MB. [2025-02-25T22:21:46.181Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (2634.714 ms) ====== [2025-02-25T22:21:46.181Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-25T22:21:46.181Z] GC before operation: completed in 545.026 ms, heap usage 216.512 MB -> 58.949 MB. [2025-02-25T22:21:48.768Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (2693.817 ms) ====== [2025-02-25T22:21:48.768Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-25T22:21:49.565Z] GC before operation: completed in 542.180 ms, heap usage 201.509 MB -> 58.978 MB. [2025-02-25T22:21:54.193Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (4534.211 ms) ====== [2025-02-25T22:21:54.193Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-25T22:21:54.993Z] GC before operation: completed in 733.544 ms, heap usage 203.808 MB -> 59.328 MB. [2025-02-25T22:21:58.591Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (3768.689 ms) ====== [2025-02-25T22:21:58.591Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-25T22:21:59.406Z] GC before operation: completed in 632.187 ms, heap usage 200.373 MB -> 59.300 MB. [2025-02-25T22:22:03.042Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (3429.608 ms) ====== [2025-02-25T22:22:03.042Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-25T22:22:03.042Z] GC before operation: completed in 585.415 ms, heap usage 201.939 MB -> 59.611 MB. [2025-02-25T22:22:05.747Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2834.209 ms) ====== [2025-02-25T22:22:05.747Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-25T22:22:06.550Z] GC before operation: completed in 635.150 ms, heap usage 203.970 MB -> 59.738 MB. [2025-02-25T22:22:10.105Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (3454.131 ms) ====== [2025-02-25T22:22:10.105Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-25T22:22:10.105Z] GC before operation: completed in 503.174 ms, heap usage 197.438 MB -> 59.895 MB. [2025-02-25T22:22:13.868Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2285.686 ms) ====== [2025-02-25T22:22:13.868Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-25T22:22:13.868Z] GC before operation: completed in 314.630 ms, heap usage 196.598 MB -> 76.153 MB. [2025-02-25T22:22:13.868Z] 25/02/25 22:22:12 WARN BlockManager: Asked to remove block rdd_1467_2, which does not exist [2025-02-25T22:22:13.868Z] 25/02/25 22:22:12 WARN BlockManager: Asked to remove block rdd_1467_1, which does not exist [2025-02-25T22:22:16.468Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (2918.406 ms) ====== [2025-02-25T22:22:16.468Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-25T22:22:16.468Z] GC before operation: completed in 531.667 ms, heap usage 213.772 MB -> 71.174 MB. [2025-02-25T22:22:19.048Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (2031.984 ms) ====== [2025-02-25T22:22:19.048Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-25T22:22:19.048Z] GC before operation: completed in 400.655 ms, heap usage 214.177 MB -> 87.714 MB. [2025-02-25T22:22:21.602Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2294.149 ms) ====== [2025-02-25T22:22:21.602Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-25T22:22:21.602Z] GC before operation: completed in 315.457 ms, heap usage 253.843 MB -> 60.238 MB. [2025-02-25T22:22:24.136Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2174.061 ms) ====== [2025-02-25T22:22:24.137Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-25T22:22:24.137Z] GC before operation: completed in 430.197 ms, heap usage 213.433 MB -> 60.517 MB. [2025-02-25T22:22:27.669Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (3266.995 ms) ====== [2025-02-25T22:22:27.669Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-25T22:22:28.459Z] GC before operation: completed in 624.347 ms, heap usage 206.468 MB -> 60.642 MB. [2025-02-25T22:22:31.046Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2633.540 ms) ====== [2025-02-25T22:22:31.046Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-25T22:22:31.046Z] GC before operation: completed in 428.858 ms, heap usage 205.567 MB -> 60.632 MB. [2025-02-25T22:22:33.842Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2019.147 ms) ====== [2025-02-25T22:22:33.842Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-25T22:22:33.842Z] GC before operation: completed in 523.716 ms, heap usage 203.214 MB -> 60.764 MB. [2025-02-25T22:22:36.515Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2345.386 ms) ====== [2025-02-25T22:22:36.515Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-25T22:22:36.515Z] GC before operation: completed in 222.050 ms, heap usage 199.482 MB -> 66.310 MB. [2025-02-25T22:22:38.138Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1696.796 ms) ====== [2025-02-25T22:22:38.138Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-25T22:22:38.138Z] GC before operation: completed in 270.491 ms, heap usage 201.302 MB -> 61.414 MB. [2025-02-25T22:22:39.773Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1715.256 ms) ====== [2025-02-25T22:22:40.563Z] ----------------------------------- [2025-02-25T22:22:40.563Z] renaissance-dec-tree_0_PASSED [2025-02-25T22:22:40.563Z] ----------------------------------- [2025-02-25T22:22:40.563Z] [2025-02-25T22:22:40.563Z] TEST TEARDOWN: [2025-02-25T22:22:40.563Z] Nothing to be done for teardown. [2025-02-25T22:22:40.563Z] renaissance-dec-tree_0 Finish Time: Tue Feb 25 22:22:40 2025 Epoch Time (ms): 1740522160344