[2024-11-17T04:12:44.653Z] Running test renaissance-dec-tree_0 ... [2024-11-17T04:12:44.653Z] =============================================== [2024-11-17T04:12:44.653Z] renaissance-dec-tree_0 Start Time: Sun Nov 17 04:12:44 2024 Epoch Time (ms): 1731816764297 [2024-11-17T04:12:44.653Z] variation: NoOptions [2024-11-17T04:12:44.653Z] JVM_OPTIONS: [2024-11-17T04:12:44.653Z] { \ [2024-11-17T04:12:44.653Z] echo ""; echo "TEST SETUP:"; \ [2024-11-17T04:12:44.653Z] echo "Nothing to be done for setup."; \ [2024-11-17T04:12:44.653Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17318151552169/renaissance-dec-tree_0"; \ [2024-11-17T04:12:44.653Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17318151552169/renaissance-dec-tree_0"; \ [2024-11-17T04:12:44.653Z] echo ""; echo "TESTING:"; \ [2024-11-17T04:12:44.653Z] "/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_17318151552169/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-11-17T04:12:44.653Z] 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_17318151552169/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-17T04:12:44.653Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-17T04:12:44.653Z] echo "Nothing to be done for teardown."; \ [2024-11-17T04:12:44.653Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17318151552169/TestTargetResult"; [2024-11-17T04:12:44.653Z] [2024-11-17T04:12:44.653Z] TEST SETUP: [2024-11-17T04:12:44.653Z] Nothing to be done for setup. [2024-11-17T04:12:44.653Z] [2024-11-17T04:12:44.653Z] TESTING: [2024-11-17T04:12:57.029Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-17T04:13:09.484Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-11-17T04:13:32.307Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-11-17T04:13:32.307Z] GC before operation: completed in 260.520 ms, heap usage 43.258 MB -> 35.042 MB. [2024-11-17T04:14:30.598Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (58455.453 ms) ====== [2024-11-17T04:14:30.598Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-11-17T04:14:30.598Z] GC before operation: completed in 448.176 ms, heap usage 118.193 MB -> 64.336 MB. [2024-11-17T04:14:48.477Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (18604.524 ms) ====== [2024-11-17T04:14:48.477Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-11-17T04:14:48.477Z] GC before operation: completed in 539.541 ms, heap usage 225.130 MB -> 65.121 MB. [2024-11-17T04:15:03.304Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (14755.647 ms) ====== [2024-11-17T04:15:03.304Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-11-17T04:15:04.172Z] GC before operation: completed in 492.523 ms, heap usage 197.276 MB -> 65.277 MB. [2024-11-17T04:15:18.930Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (13366.214 ms) ====== [2024-11-17T04:15:18.930Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-11-17T04:15:18.930Z] GC before operation: completed in 562.277 ms, heap usage 216.631 MB -> 65.662 MB. [2024-11-17T04:15:29.474Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (11919.090 ms) ====== [2024-11-17T04:15:29.474Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-11-17T04:15:30.310Z] GC before operation: completed in 515.457 ms, heap usage 246.755 MB -> 65.736 MB. [2024-11-17T04:15:42.747Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (11420.551 ms) ====== [2024-11-17T04:15:42.747Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-11-17T04:15:42.747Z] GC before operation: completed in 489.644 ms, heap usage 347.286 MB -> 65.810 MB. [2024-11-17T04:15:53.896Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (11235.612 ms) ====== [2024-11-17T04:15:53.896Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-11-17T04:15:54.718Z] GC before operation: completed in 465.515 ms, heap usage 115.660 MB -> 65.459 MB. [2024-11-17T04:16:05.508Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (10827.945 ms) ====== [2024-11-17T04:16:05.508Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-11-17T04:16:05.508Z] GC before operation: completed in 448.657 ms, heap usage 187.284 MB -> 66.317 MB. [2024-11-17T04:16:16.131Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (9867.255 ms) ====== [2024-11-17T04:16:16.131Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-11-17T04:16:16.131Z] GC before operation: completed in 410.592 ms, heap usage 334.861 MB -> 66.449 MB. [2024-11-17T04:16:25.055Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (9340.419 ms) ====== [2024-11-17T04:16:25.055Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-11-17T04:16:25.055Z] GC before operation: completed in 532.327 ms, heap usage 337.016 MB -> 66.431 MB. [2024-11-17T04:16:35.690Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (9239.137 ms) ====== [2024-11-17T04:16:35.690Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-11-17T04:16:35.690Z] GC before operation: completed in 550.888 ms, heap usage 296.344 MB -> 66.691 MB. [2024-11-17T04:16:43.079Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (8098.487 ms) ====== [2024-11-17T04:16:43.079Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-11-17T04:16:43.952Z] GC before operation: completed in 423.507 ms, heap usage 213.642 MB -> 66.650 MB. [2024-11-17T04:16:51.349Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (7485.197 ms) ====== [2024-11-17T04:16:51.349Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-11-17T04:16:51.349Z] GC before operation: completed in 371.998 ms, heap usage 331.461 MB -> 66.956 MB. [2024-11-17T04:16:58.654Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (7192.446 ms) ====== [2024-11-17T04:16:58.654Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-11-17T04:16:59.506Z] GC before operation: completed in 542.312 ms, heap usage 313.922 MB -> 66.987 MB. [2024-11-17T04:17:07.092Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (7680.945 ms) ====== [2024-11-17T04:17:07.092Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-11-17T04:17:07.092Z] GC before operation: completed in 463.905 ms, heap usage 317.332 MB -> 66.994 MB. [2024-11-17T04:17:16.040Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (8226.036 ms) ====== [2024-11-17T04:17:16.040Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-11-17T04:17:16.040Z] GC before operation: completed in 492.462 ms, heap usage 312.598 MB -> 67.291 MB. [2024-11-17T04:17:23.414Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (6829.262 ms) ====== [2024-11-17T04:17:23.414Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-11-17T04:17:23.414Z] GC before operation: completed in 401.545 ms, heap usage 303.028 MB -> 67.419 MB. [2024-11-17T04:17:30.898Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (6942.704 ms) ====== [2024-11-17T04:17:30.898Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-11-17T04:17:30.898Z] GC before operation: completed in 447.554 ms, heap usage 302.836 MB -> 67.485 MB. [2024-11-17T04:17:36.927Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (6502.233 ms) ====== [2024-11-17T04:17:36.927Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-11-17T04:17:37.787Z] GC before operation: completed in 468.488 ms, heap usage 275.562 MB -> 67.655 MB. [2024-11-17T04:17:45.202Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (7183.679 ms) ====== [2024-11-17T04:17:45.202Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-11-17T04:17:45.202Z] GC before operation: completed in 498.589 ms, heap usage 286.496 MB -> 67.737 MB. [2024-11-17T04:17:52.627Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (7377.650 ms) ====== [2024-11-17T04:17:52.627Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-11-17T04:17:53.458Z] GC before operation: completed in 463.166 ms, heap usage 298.166 MB -> 68.185 MB. [2024-11-17T04:18:00.748Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (7633.566 ms) ====== [2024-11-17T04:18:00.748Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-11-17T04:18:01.592Z] GC before operation: completed in 571.055 ms, heap usage 151.245 MB -> 67.643 MB. [2024-11-17T04:18:08.869Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (7860.360 ms) ====== [2024-11-17T04:18:08.869Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-11-17T04:18:09.695Z] GC before operation: completed in 532.315 ms, heap usage 225.133 MB -> 68.103 MB. [2024-11-17T04:18:17.704Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (7461.824 ms) ====== [2024-11-17T04:18:17.704Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-11-17T04:18:17.704Z] GC before operation: completed in 556.185 ms, heap usage 295.449 MB -> 68.189 MB. [2024-11-17T04:18:26.672Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (8255.970 ms) ====== [2024-11-17T04:18:26.672Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-11-17T04:18:26.672Z] GC before operation: completed in 542.769 ms, heap usage 298.701 MB -> 68.121 MB. [2024-11-17T04:18:34.401Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (7523.016 ms) ====== [2024-11-17T04:18:34.401Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-11-17T04:18:34.401Z] GC before operation: completed in 519.411 ms, heap usage 279.007 MB -> 68.428 MB. [2024-11-17T04:18:42.040Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (7146.187 ms) ====== [2024-11-17T04:18:42.040Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-11-17T04:18:42.040Z] GC before operation: completed in 566.946 ms, heap usage 288.789 MB -> 68.467 MB. [2024-11-17T04:18:49.680Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (6988.449 ms) ====== [2024-11-17T04:18:49.680Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-11-17T04:18:49.680Z] GC before operation: completed in 591.220 ms, heap usage 266.625 MB -> 68.719 MB. [2024-11-17T04:18:57.328Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (7063.082 ms) ====== [2024-11-17T04:18:57.328Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-11-17T04:18:57.328Z] GC before operation: completed in 502.608 ms, heap usage 264.349 MB -> 68.655 MB. [2024-11-17T04:19:04.985Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (6746.753 ms) ====== [2024-11-17T04:19:04.985Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-11-17T04:19:04.985Z] GC before operation: completed in 510.538 ms, heap usage 305.809 MB -> 68.808 MB. [2024-11-17T04:19:12.677Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (7912.372 ms) ====== [2024-11-17T04:19:12.678Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-11-17T04:19:13.546Z] GC before operation: completed in 600.785 ms, heap usage 293.923 MB -> 68.826 MB. [2024-11-17T04:19:21.227Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (7364.146 ms) ====== [2024-11-17T04:19:21.227Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-11-17T04:19:21.227Z] GC before operation: completed in 584.104 ms, heap usage 281.027 MB -> 68.877 MB. [2024-11-17T04:19:29.380Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (7389.543 ms) ====== [2024-11-17T04:19:29.380Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-11-17T04:19:29.380Z] GC before operation: completed in 747.949 ms, heap usage 286.960 MB -> 96.659 MB. [2024-11-17T04:19:36.833Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (6918.267 ms) ====== [2024-11-17T04:19:36.833Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-11-17T04:19:36.833Z] GC before operation: completed in 566.962 ms, heap usage 306.642 MB -> 69.344 MB. [2024-11-17T04:19:44.305Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (7773.736 ms) ====== [2024-11-17T04:19:44.305Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-11-17T04:19:45.160Z] GC before operation: completed in 607.978 ms, heap usage 403.714 MB -> 69.232 MB. [2024-11-17T04:19:52.661Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (7221.760 ms) ====== [2024-11-17T04:19:52.661Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-11-17T04:19:53.519Z] GC before operation: completed in 607.649 ms, heap usage 261.349 MB -> 96.507 MB. [2024-11-17T04:19:59.637Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (6811.965 ms) ====== [2024-11-17T04:19:59.637Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-11-17T04:20:00.490Z] GC before operation: completed in 612.732 ms, heap usage 324.991 MB -> 69.441 MB. [2024-11-17T04:20:07.955Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (6831.537 ms) ====== [2024-11-17T04:20:07.955Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-11-17T04:20:07.955Z] GC before operation: completed in 605.113 ms, heap usage 143.638 MB -> 69.245 MB. [2024-11-17T04:20:15.411Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (6489.787 ms) ====== [2024-11-17T04:20:15.411Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-11-17T04:20:15.411Z] GC before operation: completed in 556.362 ms, heap usage 112.042 MB -> 69.056 MB. [2024-11-17T04:20:21.526Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (6406.652 ms) ====== [2024-11-17T04:20:22.381Z] ----------------------------------- [2024-11-17T04:20:22.381Z] renaissance-dec-tree_0_PASSED [2024-11-17T04:20:22.381Z] ----------------------------------- [2024-11-17T04:20:22.381Z] [2024-11-17T04:20:22.381Z] TEST TEARDOWN: [2024-11-17T04:20:22.381Z] Nothing to be done for teardown. [2024-11-17T04:20:22.381Z] renaissance-dec-tree_0 Finish Time: Sun Nov 17 04:20:22 2024 Epoch Time (ms): 1731817222268