[2025-02-12T23:52:32.187Z] Running test renaissance-dec-tree_0 ... [2025-02-12T23:52:32.187Z] =============================================== [2025-02-12T23:52:32.187Z] renaissance-dec-tree_0 Start Time: Wed Feb 12 23:52:31 2025 Epoch Time (ms): 1739404351750 [2025-02-12T23:52:32.187Z] variation: NoOptions [2025-02-12T23:52:32.187Z] JVM_OPTIONS: [2025-02-12T23:52:32.187Z] { \ [2025-02-12T23:52:32.187Z] echo ""; echo "TEST SETUP:"; \ [2025-02-12T23:52:32.187Z] echo "Nothing to be done for setup."; \ [2025-02-12T23:52:32.187Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394024543185/renaissance-dec-tree_0"; \ [2025-02-12T23:52:32.187Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394024543185/renaissance-dec-tree_0"; \ [2025-02-12T23:52:32.187Z] echo ""; echo "TESTING:"; \ [2025-02-12T23:52:32.187Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-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_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394024543185/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-12T23:52:32.187Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394024543185/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-12T23:52:32.187Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-12T23:52:32.187Z] echo "Nothing to be done for teardown."; \ [2025-02-12T23:52:32.187Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394024543185/TestTargetResult"; [2025-02-12T23:52:32.187Z] [2025-02-12T23:52:32.187Z] TEST SETUP: [2025-02-12T23:52:32.187Z] Nothing to be done for setup. [2025-02-12T23:52:32.187Z] [2025-02-12T23:52:32.187Z] TESTING: [2025-02-12T23:52:43.147Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-12T23:52:55.961Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-12T23:53:19.695Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-12T23:53:19.695Z] GC before operation: completed in 398.038 ms, heap usage 54.713 MB -> 35.095 MB. [2025-02-12T23:54:29.593Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (63611.684 ms) ====== [2025-02-12T23:54:29.593Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-12T23:54:29.593Z] GC before operation: completed in 548.507 ms, heap usage 225.461 MB -> 64.735 MB. [2025-02-12T23:54:42.818Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (20307.817 ms) ====== [2025-02-12T23:54:42.818Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-12T23:54:42.818Z] GC before operation: completed in 480.478 ms, heap usage 200.020 MB -> 65.095 MB. [2025-02-12T23:54:57.981Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (14312.815 ms) ====== [2025-02-12T23:54:57.981Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-12T23:54:57.981Z] GC before operation: completed in 467.729 ms, heap usage 238.042 MB -> 65.373 MB. [2025-02-12T23:55:11.063Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (13815.568 ms) ====== [2025-02-12T23:55:11.063Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-12T23:55:11.949Z] GC before operation: completed in 716.008 ms, heap usage 230.024 MB -> 65.625 MB. [2025-02-12T23:55:29.775Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (16356.460 ms) ====== [2025-02-12T23:55:29.775Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-12T23:55:29.775Z] GC before operation: completed in 514.725 ms, heap usage 248.718 MB -> 65.923 MB. [2025-02-12T23:55:41.699Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (11870.560 ms) ====== [2025-02-12T23:55:41.699Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-12T23:55:41.699Z] GC before operation: completed in 522.182 ms, heap usage 149.934 MB -> 65.820 MB. [2025-02-12T23:55:51.896Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (10463.683 ms) ====== [2025-02-12T23:55:51.896Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-12T23:55:51.896Z] GC before operation: completed in 426.027 ms, heap usage 331.217 MB -> 66.192 MB. [2025-02-12T23:56:00.583Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (9069.790 ms) ====== [2025-02-12T23:56:00.583Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-12T23:56:01.373Z] GC before operation: completed in 378.239 ms, heap usage 333.942 MB -> 66.347 MB. [2025-02-12T23:56:08.418Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (7358.608 ms) ====== [2025-02-12T23:56:08.418Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-12T23:56:09.215Z] GC before operation: completed in 374.593 ms, heap usage 314.791 MB -> 66.422 MB. [2025-02-12T23:56:17.722Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (8908.407 ms) ====== [2025-02-12T23:56:17.722Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-12T23:56:18.522Z] GC before operation: completed in 315.540 ms, heap usage 305.165 MB -> 66.583 MB. [2025-02-12T23:56:25.567Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (7451.783 ms) ====== [2025-02-12T23:56:25.567Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-12T23:56:26.374Z] GC before operation: completed in 554.496 ms, heap usage 208.786 MB -> 66.544 MB. [2025-02-12T23:56:36.550Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (9256.021 ms) ====== [2025-02-12T23:56:36.550Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-12T23:56:36.550Z] GC before operation: completed in 513.566 ms, heap usage 333.490 MB -> 66.841 MB. [2025-02-12T23:56:46.522Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (10265.286 ms) ====== [2025-02-12T23:56:46.522Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-12T23:56:47.364Z] GC before operation: completed in 626.828 ms, heap usage 294.443 MB -> 66.910 MB. [2025-02-12T23:56:57.440Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (9416.793 ms) ====== [2025-02-12T23:56:57.440Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-12T23:56:57.440Z] GC before operation: completed in 578.917 ms, heap usage 307.452 MB -> 67.085 MB. [2025-02-12T23:57:04.541Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (7265.285 ms) ====== [2025-02-12T23:57:04.541Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-12T23:57:04.541Z] GC before operation: completed in 594.382 ms, heap usage 306.461 MB -> 67.139 MB. [2025-02-12T23:57:14.950Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (9276.375 ms) ====== [2025-02-12T23:57:14.950Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-12T23:57:14.950Z] GC before operation: completed in 640.893 ms, heap usage 292.850 MB -> 67.340 MB. [2025-02-12T23:57:23.613Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (8784.123 ms) ====== [2025-02-12T23:57:23.613Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-12T23:57:24.418Z] GC before operation: completed in 583.922 ms, heap usage 311.339 MB -> 67.414 MB. [2025-02-12T23:57:31.592Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6749.141 ms) ====== [2025-02-12T23:57:31.592Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-12T23:57:31.592Z] GC before operation: completed in 535.749 ms, heap usage 305.878 MB -> 67.545 MB. [2025-02-12T23:57:40.187Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (8999.490 ms) ====== [2025-02-12T23:57:40.187Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-12T23:57:41.015Z] GC before operation: completed in 584.577 ms, heap usage 275.059 MB -> 67.615 MB. [2025-02-12T23:57:49.716Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (8703.397 ms) ====== [2025-02-12T23:57:49.716Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-12T23:57:50.542Z] GC before operation: completed in 619.990 ms, heap usage 301.809 MB -> 68.038 MB. [2025-02-12T23:57:59.918Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (8827.057 ms) ====== [2025-02-12T23:57:59.918Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-12T23:57:59.918Z] GC before operation: completed in 565.929 ms, heap usage 294.105 MB -> 67.948 MB. [2025-02-12T23:58:08.639Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (8315.753 ms) ====== [2025-02-12T23:58:08.639Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-12T23:58:08.639Z] GC before operation: completed in 556.007 ms, heap usage 296.089 MB -> 67.969 MB. [2025-02-12T23:58:15.810Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (7398.843 ms) ====== [2025-02-12T23:58:15.810Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-12T23:58:16.625Z] GC before operation: completed in 533.336 ms, heap usage 293.178 MB -> 68.371 MB. [2025-02-12T23:58:25.326Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (8570.215 ms) ====== [2025-02-12T23:58:25.326Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-12T23:58:26.130Z] GC before operation: completed in 832.599 ms, heap usage 266.127 MB -> 68.226 MB. [2025-02-12T23:58:34.894Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (9288.596 ms) ====== [2025-02-12T23:58:34.895Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-12T23:58:35.706Z] GC before operation: completed in 633.881 ms, heap usage 165.809 MB -> 68.073 MB. [2025-02-12T23:58:44.425Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (8834.824 ms) ====== [2025-02-12T23:58:44.425Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-12T23:58:45.275Z] GC before operation: completed in 575.617 ms, heap usage 315.419 MB -> 68.263 MB. [2025-02-12T23:58:53.945Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (8325.103 ms) ====== [2025-02-12T23:58:53.945Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-12T23:58:53.945Z] GC before operation: completed in 559.354 ms, heap usage 163.004 MB -> 68.081 MB. [2025-02-12T23:59:02.477Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (8441.483 ms) ====== [2025-02-12T23:59:02.477Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-12T23:59:03.267Z] GC before operation: completed in 618.175 ms, heap usage 217.283 MB -> 68.666 MB. [2025-02-12T23:59:10.470Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (7524.051 ms) ====== [2025-02-12T23:59:10.470Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-12T23:59:11.304Z] GC before operation: completed in 555.945 ms, heap usage 286.568 MB -> 68.694 MB. [2025-02-12T23:59:17.754Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (6674.206 ms) ====== [2025-02-12T23:59:17.754Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-12T23:59:18.547Z] GC before operation: completed in 580.344 ms, heap usage 144.567 MB -> 68.409 MB. [2025-02-12T23:59:27.055Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (8814.093 ms) ====== [2025-02-12T23:59:27.055Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-12T23:59:27.854Z] GC before operation: completed in 730.655 ms, heap usage 215.055 MB -> 68.785 MB. [2025-02-12T23:59:36.361Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (8184.900 ms) ====== [2025-02-12T23:59:36.361Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-12T23:59:37.168Z] GC before operation: completed in 641.844 ms, heap usage 276.651 MB -> 69.074 MB. [2025-02-12T23:59:45.640Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (8536.044 ms) ====== [2025-02-12T23:59:45.640Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-12T23:59:46.453Z] GC before operation: completed in 672.153 ms, heap usage 116.973 MB -> 68.434 MB. [2025-02-12T23:59:54.985Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (8214.589 ms) ====== [2025-02-12T23:59:54.985Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-12T23:59:54.985Z] GC before operation: completed in 781.173 ms, heap usage 215.966 MB -> 74.873 MB. [2025-02-13T00:00:03.557Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (8347.960 ms) ====== [2025-02-13T00:00:03.557Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-13T00:00:04.361Z] GC before operation: completed in 685.287 ms, heap usage 224.001 MB -> 69.272 MB. [2025-02-13T00:00:15.794Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (11206.084 ms) ====== [2025-02-13T00:00:15.794Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-13T00:00:15.794Z] GC before operation: completed in 649.400 ms, heap usage 138.267 MB -> 69.462 MB. [2025-02-13T00:00:23.020Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6923.999 ms) ====== [2025-02-13T00:00:23.020Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-13T00:00:23.816Z] GC before operation: completed in 597.582 ms, heap usage 134.168 MB -> 69.241 MB. [2025-02-13T00:00:30.982Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6870.323 ms) ====== [2025-02-13T00:00:30.983Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-13T00:00:30.983Z] GC before operation: completed in 598.628 ms, heap usage 108.249 MB -> 69.322 MB. [2025-02-13T00:00:39.611Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (8477.528 ms) ====== [2025-02-13T00:00:39.611Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-13T00:00:40.413Z] GC before operation: completed in 657.776 ms, heap usage 436.912 MB -> 69.787 MB. [2025-02-13T00:00:47.560Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (7193.201 ms) ====== [2025-02-13T00:00:49.211Z] ----------------------------------- [2025-02-13T00:00:49.211Z] renaissance-dec-tree_0_PASSED [2025-02-13T00:00:49.211Z] ----------------------------------- [2025-02-13T00:00:49.211Z] [2025-02-13T00:00:49.211Z] TEST TEARDOWN: [2025-02-13T00:00:49.211Z] Nothing to be done for teardown. [2025-02-13T00:00:49.211Z] renaissance-dec-tree_0 Finish Time: Thu Feb 13 00:00:48 2025 Epoch Time (ms): 1739404848369