[2025-02-13T22:50:53.509Z] Running test renaissance-dec-tree_0 ... [2025-02-13T22:50:53.509Z] =============================================== [2025-02-13T22:50:53.509Z] renaissance-dec-tree_0 Start Time: Thu Feb 13 22:50:52 2025 Epoch Time (ms): 1739487052886 [2025-02-13T22:50:53.509Z] variation: NoOptions [2025-02-13T22:50:53.509Z] JVM_OPTIONS: [2025-02-13T22:50:53.509Z] { \ [2025-02-13T22:50:53.509Z] echo ""; echo "TEST SETUP:"; \ [2025-02-13T22:50:53.509Z] echo "Nothing to be done for setup."; \ [2025-02-13T22:50:53.510Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394846239083/renaissance-dec-tree_0"; \ [2025-02-13T22:50:53.510Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394846239083/renaissance-dec-tree_0"; \ [2025-02-13T22:50:53.510Z] echo ""; echo "TESTING:"; \ [2025-02-13T22:50:53.510Z] "/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_17394846239083/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2025-02-13T22:50:53.510Z] 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_17394846239083/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-13T22:50:53.510Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-13T22:50:53.510Z] echo "Nothing to be done for teardown."; \ [2025-02-13T22:50:53.510Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17394846239083/TestTargetResult"; [2025-02-13T22:50:53.510Z] [2025-02-13T22:50:53.510Z] TEST SETUP: [2025-02-13T22:50:53.510Z] Nothing to be done for setup. [2025-02-13T22:50:53.510Z] [2025-02-13T22:50:53.510Z] TESTING: [2025-02-13T22:51:07.686Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-13T22:51:24.343Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-13T22:51:51.326Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2025-02-13T22:51:51.326Z] GC before operation: completed in 990.788 ms, heap usage 135.936 MB -> 29.543 MB. [2025-02-13T22:53:11.588Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (73660.409 ms) ====== [2025-02-13T22:53:11.588Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2025-02-13T22:53:11.588Z] GC before operation: completed in 2879.923 ms, heap usage 466.062 MB -> 55.354 MB. [2025-02-13T22:53:28.278Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (21452.004 ms) ====== [2025-02-13T22:53:28.278Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2025-02-13T22:53:29.960Z] GC before operation: completed in 2299.556 ms, heap usage 417.279 MB -> 56.250 MB. [2025-02-13T22:53:46.836Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (15976.419 ms) ====== [2025-02-13T22:53:46.836Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2025-02-13T22:53:46.836Z] GC before operation: completed in 1430.877 ms, heap usage 376.632 MB -> 55.474 MB. [2025-02-13T22:54:03.563Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (14540.591 ms) ====== [2025-02-13T22:54:03.563Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2025-02-13T22:54:03.563Z] GC before operation: completed in 1370.988 ms, heap usage 340.831 MB -> 56.196 MB. [2025-02-13T22:54:15.586Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (12197.348 ms) ====== [2025-02-13T22:54:15.587Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2025-02-13T22:54:16.387Z] GC before operation: completed in 1399.285 ms, heap usage 345.609 MB -> 56.509 MB. [2025-02-13T22:54:28.505Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (11567.877 ms) ====== [2025-02-13T22:54:28.505Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2025-02-13T22:54:30.204Z] GC before operation: completed in 1530.200 ms, heap usage 331.409 MB -> 56.237 MB. [2025-02-13T22:54:42.293Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (11371.486 ms) ====== [2025-02-13T22:54:42.293Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2025-02-13T22:54:43.105Z] GC before operation: completed in 1892.155 ms, heap usage 325.748 MB -> 56.645 MB. [2025-02-13T22:54:54.015Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (9834.374 ms) ====== [2025-02-13T22:54:54.016Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2025-02-13T22:54:54.838Z] GC before operation: completed in 1686.372 ms, heap usage 328.327 MB -> 56.606 MB. [2025-02-13T22:55:04.999Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (10358.665 ms) ====== [2025-02-13T22:55:04.999Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2025-02-13T22:55:06.659Z] GC before operation: completed in 1482.015 ms, heap usage 322.282 MB -> 56.956 MB. [2025-02-13T22:55:18.711Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (11386.344 ms) ====== [2025-02-13T22:55:18.711Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2025-02-13T22:55:19.525Z] GC before operation: completed in 1910.238 ms, heap usage 325.375 MB -> 57.049 MB. [2025-02-13T22:55:31.759Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (11558.110 ms) ====== [2025-02-13T22:55:31.759Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2025-02-13T22:55:32.613Z] GC before operation: completed in 1285.568 ms, heap usage 323.718 MB -> 57.059 MB. [2025-02-13T22:55:41.203Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (8863.362 ms) ====== [2025-02-13T22:55:41.203Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2025-02-13T22:55:42.878Z] GC before operation: completed in 1640.188 ms, heap usage 324.655 MB -> 68.391 MB. [2025-02-13T22:55:55.162Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (11567.974 ms) ====== [2025-02-13T22:55:55.162Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2025-02-13T22:55:56.001Z] GC before operation: completed in 1448.730 ms, heap usage 338.912 MB -> 58.396 MB. [2025-02-13T22:56:06.827Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (10972.519 ms) ====== [2025-02-13T22:56:06.827Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2025-02-13T22:56:08.463Z] GC before operation: completed in 1611.573 ms, heap usage 328.436 MB -> 57.636 MB. [2025-02-13T22:56:20.496Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (11280.688 ms) ====== [2025-02-13T22:56:20.496Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2025-02-13T22:56:21.328Z] GC before operation: completed in 1176.739 ms, heap usage 335.458 MB -> 57.792 MB. [2025-02-13T22:56:31.731Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (10305.848 ms) ====== [2025-02-13T22:56:31.731Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2025-02-13T22:56:33.361Z] GC before operation: completed in 1429.165 ms, heap usage 327.858 MB -> 57.961 MB. [2025-02-13T22:56:45.623Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (11884.191 ms) ====== [2025-02-13T22:56:45.623Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2025-02-13T22:56:46.424Z] GC before operation: completed in 1614.627 ms, heap usage 328.798 MB -> 58.002 MB. [2025-02-13T22:56:56.527Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (10018.257 ms) ====== [2025-02-13T22:56:56.527Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2025-02-13T22:56:57.315Z] GC before operation: completed in 1149.626 ms, heap usage 316.060 MB -> 58.494 MB. [2025-02-13T22:57:09.872Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (11942.196 ms) ====== [2025-02-13T22:57:09.872Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2025-02-13T22:57:11.624Z] GC before operation: completed in 1500.621 ms, heap usage 327.211 MB -> 70.394 MB. [2025-02-13T22:57:21.978Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (10881.735 ms) ====== [2025-02-13T22:57:21.978Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2025-02-13T22:57:23.659Z] GC before operation: completed in 1508.613 ms, heap usage 340.901 MB -> 58.605 MB. [2025-02-13T22:57:34.114Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (10934.401 ms) ====== [2025-02-13T22:57:34.114Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2025-02-13T22:57:35.793Z] GC before operation: completed in 1507.895 ms, heap usage 333.499 MB -> 59.060 MB. [2025-02-13T22:57:46.118Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (10458.953 ms) ====== [2025-02-13T22:57:46.118Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2025-02-13T22:57:47.785Z] GC before operation: completed in 1135.789 ms, heap usage 331.568 MB -> 58.746 MB. [2025-02-13T22:57:57.946Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (9992.918 ms) ====== [2025-02-13T22:57:57.946Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2025-02-13T22:57:58.757Z] GC before operation: completed in 1342.251 ms, heap usage 325.590 MB -> 59.256 MB. [2025-02-13T22:58:09.551Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (10759.601 ms) ====== [2025-02-13T22:58:09.551Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2025-02-13T22:58:10.357Z] GC before operation: completed in 1004.722 ms, heap usage 326.956 MB -> 59.154 MB. [2025-02-13T22:58:20.796Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (9648.688 ms) ====== [2025-02-13T22:58:20.796Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2025-02-13T22:58:21.615Z] GC before operation: completed in 1205.597 ms, heap usage 322.425 MB -> 86.748 MB. [2025-02-13T22:58:21.615Z] 25/02/13 22:58:21 WARN BlockManager: Asked to remove block rdd_1222_0, which does not exist [2025-02-13T22:58:30.268Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (9107.668 ms) ====== [2025-02-13T22:58:30.268Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2025-02-13T22:58:32.905Z] GC before operation: completed in 1757.359 ms, heap usage 380.959 MB -> 59.448 MB. [2025-02-13T22:58:41.637Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (9490.052 ms) ====== [2025-02-13T22:58:41.637Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2025-02-13T22:58:43.327Z] GC before operation: completed in 1175.517 ms, heap usage 358.392 MB -> 59.449 MB. [2025-02-13T22:58:51.928Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (9250.694 ms) ====== [2025-02-13T22:58:51.928Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2025-02-13T22:58:53.590Z] GC before operation: completed in 1197.159 ms, heap usage 346.364 MB -> 70.842 MB. [2025-02-13T22:58:53.590Z] 25/02/13 22:58:53 WARN BlockManager: Asked to remove block rdd_1369_2, which does not exist [2025-02-13T22:58:53.590Z] 25/02/13 22:58:53 WARN BlockManager: Asked to remove block rdd_1369_0, which does not exist [2025-02-13T22:59:03.846Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (9249.122 ms) ====== [2025-02-13T22:59:03.846Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2025-02-13T22:59:03.846Z] GC before operation: completed in 1148.625 ms, heap usage 348.521 MB -> 59.679 MB. [2025-02-13T22:59:14.607Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (10233.650 ms) ====== [2025-02-13T22:59:14.607Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2025-02-13T22:59:15.500Z] GC before operation: completed in 1225.447 ms, heap usage 330.458 MB -> 59.814 MB. [2025-02-13T22:59:24.229Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (8582.857 ms) ====== [2025-02-13T22:59:24.229Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2025-02-13T22:59:25.051Z] GC before operation: completed in 1016.288 ms, heap usage 333.551 MB -> 59.956 MB. [2025-02-13T22:59:37.212Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (12184.831 ms) ====== [2025-02-13T22:59:37.212Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2025-02-13T22:59:38.872Z] GC before operation: completed in 1425.267 ms, heap usage 330.012 MB -> 60.095 MB. [2025-02-13T22:59:49.212Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (9812.213 ms) ====== [2025-02-13T22:59:49.212Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2025-02-13T22:59:50.032Z] GC before operation: completed in 1391.763 ms, heap usage 325.707 MB -> 60.355 MB. [2025-02-13T22:59:58.754Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (8966.416 ms) ====== [2025-02-13T22:59:58.754Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2025-02-13T22:59:59.544Z] GC before operation: completed in 1062.236 ms, heap usage 322.240 MB -> 60.492 MB. [2025-02-13T23:00:10.401Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (9221.158 ms) ====== [2025-02-13T23:00:10.401Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2025-02-13T23:00:11.224Z] GC before operation: completed in 1412.278 ms, heap usage 324.378 MB -> 83.263 MB. [2025-02-13T23:00:23.407Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (12345.761 ms) ====== [2025-02-13T23:00:23.407Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2025-02-13T23:00:24.227Z] GC before operation: completed in 1320.745 ms, heap usage 370.114 MB -> 60.627 MB. [2025-02-13T23:00:34.796Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (10340.959 ms) ====== [2025-02-13T23:00:34.796Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2025-02-13T23:00:35.612Z] GC before operation: completed in 908.928 ms, heap usage 346.121 MB -> 60.774 MB. [2025-02-13T23:00:45.750Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (9397.457 ms) ====== [2025-02-13T23:00:45.750Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2025-02-13T23:00:45.750Z] GC before operation: completed in 935.941 ms, heap usage 345.407 MB -> 61.049 MB. [2025-02-13T23:00:54.319Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (8111.373 ms) ====== [2025-02-13T23:00:54.319Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2025-02-13T23:00:55.140Z] GC before operation: completed in 1378.713 ms, heap usage 336.905 MB -> 61.160 MB. [2025-02-13T23:01:05.354Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (9241.575 ms) ====== [2025-02-13T23:01:07.045Z] ----------------------------------- [2025-02-13T23:01:07.045Z] renaissance-dec-tree_0_PASSED [2025-02-13T23:01:07.045Z] ----------------------------------- [2025-02-13T23:01:07.045Z] [2025-02-13T23:01:07.045Z] TEST TEARDOWN: [2025-02-13T23:01:07.045Z] Nothing to be done for teardown. [2025-02-13T23:01:07.045Z] renaissance-dec-tree_0 Finish Time: Thu Feb 13 23:01:06 2025 Epoch Time (ms): 1739487666818