[2024-10-02T23:07:31.663Z] Running test renaissance-dec-tree_0 ... [2024-10-02T23:07:31.663Z] =============================================== [2024-10-02T23:07:31.663Z] renaissance-dec-tree_0 Start Time: Wed Oct 2 23:07:27 2024 Epoch Time (ms): 1727910447322 [2024-10-02T23:07:31.663Z] variation: NoOptions [2024-10-02T23:07:31.663Z] JVM_OPTIONS: [2024-10-02T23:07:31.663Z] { \ [2024-10-02T23:07:31.663Z] echo ""; echo "TEST SETUP:"; \ [2024-10-02T23:07:31.663Z] echo "Nothing to be done for setup."; \ [2024-10-02T23:07:31.663Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17279065682162/renaissance-dec-tree_0"; \ [2024-10-02T23:07:31.663Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17279065682162/renaissance-dec-tree_0"; \ [2024-10-02T23:07:31.663Z] echo ""; echo "TESTING:"; \ [2024-10-02T23:07:31.663Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/jdkbinary/j2sdk-image/jdk-11.0.25+8/bin/..//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_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17279065682162/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-10-02T23:07:31.663Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17279065682162/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-02T23:07:31.663Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-02T23:07:31.663Z] echo "Nothing to be done for teardown."; \ [2024-10-02T23:07:31.663Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/../TKG/output_17279065682162/TestTargetResult"; [2024-10-02T23:07:31.663Z] [2024-10-02T23:07:31.663Z] TEST SETUP: [2024-10-02T23:07:31.663Z] Nothing to be done for setup. [2024-10-02T23:07:31.663Z] [2024-10-02T23:07:31.663Z] TESTING: [2024-10-02T23:07:39.827Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-02T23:07:51.413Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-10-02T23:07:56.968Z] WARNING: An illegal reflective access operation has occurred [2024-10-02T23:07:56.968Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_linux/aqa-tests/TKG/output_17279065682162/renaissance-dec-tree_0/harness-230730-15578853429083044679/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-02T23:07:56.968Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-02T23:07:56.968Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-02T23:07:56.968Z] WARNING: All illegal access operations will be denied in a future release [2024-10-02T23:08:13.116Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-10-02T23:08:13.116Z] GC before operation: completed in 439.518 ms, heap usage 57.441 MB -> 33.992 MB. [2024-10-02T23:09:21.001Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (64383.883 ms) ====== [2024-10-02T23:09:21.001Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-10-02T23:09:21.001Z] GC before operation: completed in 782.820 ms, heap usage 108.401 MB -> 63.912 MB. [2024-10-02T23:09:43.270Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (23980.345 ms) ====== [2024-10-02T23:09:43.270Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-10-02T23:09:43.270Z] GC before operation: completed in 670.594 ms, heap usage 185.310 MB -> 64.395 MB. [2024-10-02T23:10:02.349Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (18879.317 ms) ====== [2024-10-02T23:10:02.349Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-10-02T23:10:02.349Z] GC before operation: completed in 763.530 ms, heap usage 109.025 MB -> 64.158 MB. [2024-10-02T23:10:18.654Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (14928.223 ms) ====== [2024-10-02T23:10:18.654Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-10-02T23:10:18.654Z] GC before operation: completed in 812.489 ms, heap usage 171.354 MB -> 64.652 MB. [2024-10-02T23:10:32.740Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (13870.389 ms) ====== [2024-10-02T23:10:32.741Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-10-02T23:10:32.741Z] GC before operation: completed in 703.025 ms, heap usage 222.515 MB -> 64.871 MB. [2024-10-02T23:10:46.594Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (13184.518 ms) ====== [2024-10-02T23:10:46.594Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-10-02T23:10:46.594Z] GC before operation: completed in 760.095 ms, heap usage 182.560 MB -> 65.217 MB. [2024-10-02T23:11:00.424Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (12489.466 ms) ====== [2024-10-02T23:11:00.424Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-10-02T23:11:00.424Z] GC before operation: completed in 676.521 ms, heap usage 143.588 MB -> 65.236 MB. [2024-10-02T23:11:10.198Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (10558.999 ms) ====== [2024-10-02T23:11:10.198Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-10-02T23:11:10.971Z] GC before operation: completed in 460.374 ms, heap usage 148.730 MB -> 65.491 MB. [2024-10-02T23:11:19.152Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (8642.294 ms) ====== [2024-10-02T23:11:19.152Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-10-02T23:11:19.929Z] GC before operation: completed in 573.375 ms, heap usage 146.216 MB -> 65.598 MB. [2024-10-02T23:11:31.633Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (10558.701 ms) ====== [2024-10-02T23:11:31.633Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-10-02T23:11:31.633Z] GC before operation: completed in 723.643 ms, heap usage 181.616 MB -> 65.747 MB. [2024-10-02T23:11:41.418Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (9880.094 ms) ====== [2024-10-02T23:11:41.418Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-10-02T23:11:41.418Z] GC before operation: completed in 721.913 ms, heap usage 190.159 MB -> 65.690 MB. [2024-10-02T23:11:51.993Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (10363.080 ms) ====== [2024-10-02T23:11:51.993Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-10-02T23:11:52.769Z] GC before operation: completed in 691.330 ms, heap usage 98.374 MB -> 65.734 MB. [2024-10-02T23:12:01.123Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (8408.950 ms) ====== [2024-10-02T23:12:01.123Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-10-02T23:12:01.890Z] GC before operation: completed in 649.866 ms, heap usage 206.305 MB -> 66.082 MB. [2024-10-02T23:12:11.850Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (9763.589 ms) ====== [2024-10-02T23:12:11.850Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-10-02T23:12:12.611Z] GC before operation: completed in 757.502 ms, heap usage 130.955 MB -> 65.999 MB. [2024-10-02T23:12:20.895Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (8798.428 ms) ====== [2024-10-02T23:12:20.895Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-10-02T23:12:21.651Z] GC before operation: completed in 480.864 ms, heap usage 258.003 MB -> 66.266 MB. [2024-10-02T23:12:29.862Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (8342.537 ms) ====== [2024-10-02T23:12:29.862Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-10-02T23:12:30.633Z] GC before operation: completed in 934.454 ms, heap usage 246.208 MB -> 66.433 MB. [2024-10-02T23:12:44.520Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (11953.167 ms) ====== [2024-10-02T23:12:44.520Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-10-02T23:12:44.520Z] GC before operation: completed in 926.809 ms, heap usage 227.462 MB -> 66.383 MB. [2024-10-02T23:12:54.273Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (10284.609 ms) ====== [2024-10-02T23:12:54.273Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-10-02T23:12:55.029Z] GC before operation: completed in 711.751 ms, heap usage 166.222 MB -> 66.625 MB. [2024-10-02T23:13:05.407Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (8907.082 ms) ====== [2024-10-02T23:13:05.407Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-10-02T23:13:05.407Z] GC before operation: completed in 833.619 ms, heap usage 208.121 MB -> 66.734 MB. [2024-10-02T23:13:13.701Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (8887.688 ms) ====== [2024-10-02T23:13:13.701Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-10-02T23:13:14.500Z] GC before operation: completed in 961.269 ms, heap usage 108.203 MB -> 66.281 MB. [2024-10-02T23:13:24.547Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (10135.361 ms) ====== [2024-10-02T23:13:24.548Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-10-02T23:13:25.301Z] GC before operation: completed in 1063.454 ms, heap usage 262.927 MB -> 67.146 MB. [2024-10-02T23:13:35.066Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (9802.875 ms) ====== [2024-10-02T23:13:35.066Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-10-02T23:13:36.657Z] GC before operation: completed in 879.386 ms, heap usage 114.268 MB -> 66.897 MB. [2024-10-02T23:13:46.519Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (9809.697 ms) ====== [2024-10-02T23:13:46.519Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-10-02T23:13:47.293Z] GC before operation: completed in 858.234 ms, heap usage 200.142 MB -> 67.473 MB. [2024-10-02T23:13:57.094Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (10027.790 ms) ====== [2024-10-02T23:13:57.094Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-10-02T23:13:57.861Z] GC before operation: completed in 1051.094 ms, heap usage 157.768 MB -> 67.070 MB. [2024-10-02T23:14:07.602Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (9276.416 ms) ====== [2024-10-02T23:14:07.602Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-10-02T23:14:08.363Z] GC before operation: completed in 854.691 ms, heap usage 117.487 MB -> 66.783 MB. [2024-10-02T23:14:16.918Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (9037.769 ms) ====== [2024-10-02T23:14:16.918Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-10-02T23:14:17.685Z] GC before operation: completed in 801.205 ms, heap usage 129.930 MB -> 67.156 MB. [2024-10-02T23:14:29.498Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (10437.644 ms) ====== [2024-10-02T23:14:29.498Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-10-02T23:14:29.498Z] GC before operation: completed in 968.007 ms, heap usage 145.242 MB -> 67.252 MB. [2024-10-02T23:14:39.354Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (9963.551 ms) ====== [2024-10-02T23:14:39.354Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-10-02T23:14:40.127Z] GC before operation: completed in 944.683 ms, heap usage 158.183 MB -> 67.373 MB. [2024-10-02T23:14:49.957Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (8927.019 ms) ====== [2024-10-02T23:14:49.957Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-10-02T23:14:49.957Z] GC before operation: completed in 714.345 ms, heap usage 225.039 MB -> 67.959 MB. [2024-10-02T23:14:59.936Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (8962.118 ms) ====== [2024-10-02T23:14:59.936Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-10-02T23:14:59.936Z] GC before operation: completed in 853.530 ms, heap usage 232.769 MB -> 67.691 MB. [2024-10-02T23:15:09.852Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (9403.813 ms) ====== [2024-10-02T23:15:09.852Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-10-02T23:15:09.852Z] GC before operation: completed in 951.380 ms, heap usage 229.160 MB -> 67.786 MB. [2024-10-02T23:15:21.657Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (10336.139 ms) ====== [2024-10-02T23:15:21.658Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-10-02T23:15:21.658Z] GC before operation: completed in 820.202 ms, heap usage 191.233 MB -> 68.025 MB. [2024-10-02T23:15:31.554Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (9285.838 ms) ====== [2024-10-02T23:15:31.554Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-10-02T23:15:31.554Z] GC before operation: completed in 974.632 ms, heap usage 240.602 MB -> 68.557 MB. [2024-10-02T23:15:41.979Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (9745.158 ms) ====== [2024-10-02T23:15:41.979Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-10-02T23:15:41.979Z] GC before operation: completed in 814.149 ms, heap usage 211.501 MB -> 68.225 MB. [2024-10-02T23:15:51.859Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (9261.413 ms) ====== [2024-10-02T23:15:51.859Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-10-02T23:15:52.656Z] GC before operation: completed in 892.331 ms, heap usage 190.158 MB -> 68.507 MB. [2024-10-02T23:16:04.426Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (10871.556 ms) ====== [2024-10-02T23:16:04.426Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-10-02T23:16:04.426Z] GC before operation: completed in 977.759 ms, heap usage 237.537 MB -> 68.420 MB. [2024-10-02T23:16:14.264Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (10413.427 ms) ====== [2024-10-02T23:16:14.264Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-10-02T23:16:15.929Z] GC before operation: completed in 1089.165 ms, heap usage 120.497 MB -> 68.367 MB. [2024-10-02T23:16:24.346Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (9010.385 ms) ====== [2024-10-02T23:16:24.346Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-10-02T23:16:25.995Z] GC before operation: completed in 989.858 ms, heap usage 224.470 MB -> 68.623 MB. [2024-10-02T23:16:35.785Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (9883.723 ms) ====== [2024-10-02T23:16:35.785Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-10-02T23:16:36.538Z] GC before operation: completed in 852.481 ms, heap usage 227.822 MB -> 68.559 MB. [2024-10-02T23:16:46.567Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (9935.964 ms) ====== [2024-10-02T23:16:48.160Z] ----------------------------------- [2024-10-02T23:16:48.160Z] renaissance-dec-tree_0_PASSED [2024-10-02T23:16:48.160Z] ----------------------------------- [2024-10-02T23:16:48.160Z] [2024-10-02T23:16:48.160Z] TEST TEARDOWN: [2024-10-02T23:16:48.160Z] Nothing to be done for teardown. [2024-10-02T23:16:48.160Z] renaissance-dec-tree_0 Finish Time: Wed Oct 2 23:16:47 2024 Epoch Time (ms): 1727911007872