[2024-11-24T20:56:17.023Z] Running test renaissance-dec-tree_0 ... [2024-11-24T20:56:17.023Z] =============================================== [2024-11-24T20:56:17.827Z] renaissance-dec-tree_0 Start Time: Sun Nov 24 20:56:16 2024 Epoch Time (ms): 1732481776990 [2024-11-24T20:56:17.827Z] variation: NoOptions [2024-11-24T20:56:17.827Z] JVM_OPTIONS: [2024-11-24T20:56:17.827Z] { \ [2024-11-24T20:56:17.827Z] echo ""; echo "TEST SETUP:"; \ [2024-11-24T20:56:17.827Z] echo "Nothing to be done for setup."; \ [2024-11-24T20:56:17.827Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17324810153759/renaissance-dec-tree_0"; \ [2024-11-24T20:56:17.827Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17324810153759/renaissance-dec-tree_0"; \ [2024-11-24T20:56:17.827Z] echo ""; echo "TESTING:"; \ [2024-11-24T20:56:17.827Z] "/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_17324810153759/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-24T20:56:17.827Z] 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_17324810153759/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-24T20:56:17.827Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-24T20:56:17.827Z] echo "Nothing to be done for teardown."; \ [2024-11-24T20:56:17.827Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17324810153759/TestTargetResult"; [2024-11-24T20:56:17.827Z] [2024-11-24T20:56:17.827Z] TEST SETUP: [2024-11-24T20:56:17.827Z] Nothing to be done for setup. [2024-11-24T20:56:17.827Z] [2024-11-24T20:56:17.827Z] TESTING: [2024-11-24T20:56:23.638Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-24T20:56:29.498Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-24T20:56:38.113Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-24T20:56:38.113Z] GC before operation: completed in 160.131 ms, heap usage 37.929 MB -> 35.032 MB. [2024-11-24T20:57:04.456Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (23603.308 ms) ====== [2024-11-24T20:57:04.456Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-24T20:57:04.456Z] GC before operation: completed in 246.588 ms, heap usage 165.659 MB -> 64.601 MB. [2024-11-24T20:57:09.123Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (7796.757 ms) ====== [2024-11-24T20:57:09.123Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-24T20:57:09.123Z] GC before operation: completed in 39.411 ms, heap usage 326.816 MB -> 78.459 MB. [2024-11-24T20:57:15.016Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (5655.842 ms) ====== [2024-11-24T20:57:15.016Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-24T20:57:15.016Z] GC before operation: completed in 328.380 ms, heap usage 199.746 MB -> 65.021 MB. [2024-11-24T20:57:21.448Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (6502.843 ms) ====== [2024-11-24T20:57:21.448Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-24T20:57:22.253Z] GC before operation: completed in 252.960 ms, heap usage 114.903 MB -> 64.855 MB. [2024-11-24T20:57:28.112Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (5566.176 ms) ====== [2024-11-24T20:57:28.112Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-24T20:57:28.112Z] GC before operation: completed in 294.393 ms, heap usage 197.161 MB -> 92.971 MB. [2024-11-24T20:57:32.727Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (4732.885 ms) ====== [2024-11-24T20:57:32.727Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-24T20:57:32.727Z] GC before operation: completed in 216.541 ms, heap usage 391.617 MB -> 65.851 MB. [2024-11-24T20:57:37.325Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (3892.728 ms) ====== [2024-11-24T20:57:37.325Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-24T20:57:37.325Z] GC before operation: completed in 210.022 ms, heap usage 342.709 MB -> 66.062 MB. [2024-11-24T20:57:40.989Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (3517.807 ms) ====== [2024-11-24T20:57:40.989Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-24T20:57:40.989Z] GC before operation: completed in 199.571 ms, heap usage 307.345 MB -> 66.155 MB. [2024-11-24T20:57:43.573Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (3184.166 ms) ====== [2024-11-24T20:57:43.573Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-24T20:57:44.385Z] GC before operation: completed in 167.720 ms, heap usage 189.577 MB -> 66.313 MB. [2024-11-24T20:57:46.048Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (2295.539 ms) ====== [2024-11-24T20:57:46.048Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-24T20:57:46.847Z] GC before operation: completed in 164.448 ms, heap usage 192.704 MB -> 66.279 MB. [2024-11-24T20:57:49.418Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (2467.487 ms) ====== [2024-11-24T20:57:49.418Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-24T20:57:49.418Z] GC before operation: completed in 136.346 ms, heap usage 254.699 MB -> 66.404 MB. [2024-11-24T20:57:51.987Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (2758.174 ms) ====== [2024-11-24T20:57:51.987Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-24T20:57:51.987Z] GC before operation: completed in 206.976 ms, heap usage 315.603 MB -> 66.627 MB. [2024-11-24T20:57:54.597Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (2225.635 ms) ====== [2024-11-24T20:57:54.597Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-24T20:57:54.597Z] GC before operation: completed in 234.403 ms, heap usage 314.654 MB -> 77.573 MB. [2024-11-24T20:57:57.165Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (2609.466 ms) ====== [2024-11-24T20:57:57.165Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-24T20:57:57.165Z] GC before operation: completed in 163.013 ms, heap usage 308.992 MB -> 66.901 MB. [2024-11-24T20:58:00.759Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (3481.920 ms) ====== [2024-11-24T20:58:00.759Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-24T20:58:00.759Z] GC before operation: completed in 272.431 ms, heap usage 316.934 MB -> 66.805 MB. [2024-11-24T20:58:04.336Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (2750.877 ms) ====== [2024-11-24T20:58:04.336Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-24T20:58:04.336Z] GC before operation: completed in 292.565 ms, heap usage 314.826 MB -> 67.176 MB. [2024-11-24T20:58:06.905Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (2856.389 ms) ====== [2024-11-24T20:58:06.905Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-24T20:58:06.905Z] GC before operation: completed in 193.240 ms, heap usage 145.941 MB -> 66.939 MB. [2024-11-24T20:58:10.730Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (2876.682 ms) ====== [2024-11-24T20:58:10.730Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-24T20:58:10.730Z] GC before operation: completed in 236.299 ms, heap usage 219.459 MB -> 67.349 MB. [2024-11-24T20:58:13.351Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (2837.734 ms) ====== [2024-11-24T20:58:13.351Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-24T20:58:13.351Z] GC before operation: completed in 206.564 ms, heap usage 258.673 MB -> 67.501 MB. [2024-11-24T20:58:15.922Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (2714.278 ms) ====== [2024-11-24T20:58:15.922Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-24T20:58:15.922Z] GC before operation: completed in 252.890 ms, heap usage 328.879 MB -> 67.452 MB. [2024-11-24T20:58:18.484Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1685.915 ms) ====== [2024-11-24T20:58:18.484Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-24T20:58:18.484Z] GC before operation: completed in 118.940 ms, heap usage 311.341 MB -> 73.205 MB. [2024-11-24T20:58:20.131Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1671.046 ms) ====== [2024-11-24T20:58:20.131Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-24T20:58:20.131Z] GC before operation: completed in 131.541 ms, heap usage 220.218 MB -> 67.694 MB. [2024-11-24T20:58:21.780Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1806.511 ms) ====== [2024-11-24T20:58:21.780Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-24T20:58:21.780Z] GC before operation: completed in 143.112 ms, heap usage 264.609 MB -> 78.783 MB. [2024-11-24T20:58:23.430Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1262.618 ms) ====== [2024-11-24T20:58:23.430Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-24T20:58:23.430Z] GC before operation: completed in 112.435 ms, heap usage 197.143 MB -> 67.852 MB. [2024-11-24T20:58:24.231Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1274.833 ms) ====== [2024-11-24T20:58:24.231Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-24T20:58:24.231Z] GC before operation: completed in 103.286 ms, heap usage 263.262 MB -> 68.125 MB. [2024-11-24T20:58:25.877Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1532.758 ms) ====== [2024-11-24T20:58:25.877Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-24T20:58:26.683Z] GC before operation: completed in 191.177 ms, heap usage 303.689 MB -> 68.192 MB. [2024-11-24T20:58:28.348Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (2369.236 ms) ====== [2024-11-24T20:58:28.348Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-24T20:58:29.155Z] GC before operation: completed in 231.802 ms, heap usage 270.041 MB -> 68.337 MB. [2024-11-24T20:58:30.810Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (2252.183 ms) ====== [2024-11-24T20:58:30.810Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-24T20:58:31.619Z] GC before operation: completed in 153.593 ms, heap usage 283.013 MB -> 68.480 MB. [2024-11-24T20:58:33.282Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1898.988 ms) ====== [2024-11-24T20:58:33.282Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-24T20:58:33.282Z] GC before operation: completed in 201.424 ms, heap usage 127.093 MB -> 68.312 MB. [2024-11-24T20:58:35.872Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (2442.853 ms) ====== [2024-11-24T20:58:35.872Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-24T20:58:35.872Z] GC before operation: completed in 240.374 ms, heap usage 469.122 MB -> 68.877 MB. [2024-11-24T20:58:37.677Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1694.804 ms) ====== [2024-11-24T20:58:37.677Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-24T20:58:37.677Z] GC before operation: completed in 168.557 ms, heap usage 274.305 MB -> 68.796 MB. [2024-11-24T20:58:40.264Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1935.651 ms) ====== [2024-11-24T20:58:40.264Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-24T20:58:40.264Z] GC before operation: completed in 236.727 ms, heap usage 376.584 MB -> 68.874 MB. [2024-11-24T20:58:42.852Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (2673.978 ms) ====== [2024-11-24T20:58:42.852Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-24T20:58:42.852Z] GC before operation: completed in 255.012 ms, heap usage 366.793 MB -> 69.174 MB. [2024-11-24T20:58:45.473Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (2410.337 ms) ====== [2024-11-24T20:58:45.473Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-24T20:58:45.473Z] GC before operation: completed in 193.246 ms, heap usage 226.347 MB -> 69.040 MB. [2024-11-24T20:58:48.071Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (2646.966 ms) ====== [2024-11-24T20:58:48.071Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-24T20:58:48.877Z] GC before operation: completed in 263.498 ms, heap usage 229.665 MB -> 69.114 MB. [2024-11-24T20:58:51.457Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (2653.533 ms) ====== [2024-11-24T20:58:51.457Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-24T20:58:51.457Z] GC before operation: completed in 253.539 ms, heap usage 254.500 MB -> 69.045 MB. [2024-11-24T20:58:54.130Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (2613.910 ms) ====== [2024-11-24T20:58:54.130Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-24T20:58:54.130Z] GC before operation: completed in 239.345 ms, heap usage 262.416 MB -> 69.575 MB. [2024-11-24T20:58:56.696Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (2610.301 ms) ====== [2024-11-24T20:58:56.696Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-24T20:58:57.504Z] GC before operation: completed in 302.562 ms, heap usage 253.800 MB -> 69.695 MB. [2024-11-24T20:59:00.221Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (2564.433 ms) ====== [2024-11-24T20:59:00.221Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-24T20:59:00.221Z] GC before operation: completed in 234.333 ms, heap usage 361.064 MB -> 69.570 MB. [2024-11-24T20:59:02.459Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (2605.753 ms) ====== [2024-11-24T20:59:03.266Z] ----------------------------------- [2024-11-24T20:59:03.266Z] renaissance-dec-tree_0_PASSED [2024-11-24T20:59:03.266Z] ----------------------------------- [2024-11-24T20:59:03.266Z] [2024-11-24T20:59:03.266Z] TEST TEARDOWN: [2024-11-24T20:59:03.266Z] Nothing to be done for teardown. [2024-11-24T20:59:03.266Z] renaissance-dec-tree_0 Finish Time: Sun Nov 24 20:59:02 2024 Epoch Time (ms): 1732481942860