[2025-02-06T11:11:21.505Z] Running test renaissance-als_0 ... [2025-02-06T11:11:21.505Z] =============================================== [2025-02-06T11:11:21.505Z] renaissance-als_0 Start Time: Thu Feb 6 11:11:21 2025 Epoch Time (ms): 1738840281359 [2025-02-06T11:11:21.505Z] variation: NoOptions [2025-02-06T11:11:21.505Z] JVM_OPTIONS: [2025-02-06T11:11:21.505Z] { \ [2025-02-06T11:11:21.505Z] echo ""; echo "TEST SETUP:"; \ [2025-02-06T11:11:21.505Z] echo "Nothing to be done for setup."; \ [2025-02-06T11:11:21.505Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17388402802782/renaissance-als_0"; \ [2025-02-06T11:11:21.505Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17388402802782/renaissance-als_0"; \ [2025-02-06T11:11:21.505Z] echo ""; echo "TESTING:"; \ [2025-02-06T11:11:21.505Z] "/home/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17388402802782/renaissance-als_0"/als.json" als; \ [2025-02-06T11:11:21.505Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17388402802782/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-06T11:11:21.505Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-06T11:11:21.505Z] echo "Nothing to be done for teardown."; \ [2025-02-06T11:11:21.505Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17388402802782/TestTargetResult"; [2025-02-06T11:11:21.505Z] [2025-02-06T11:11:21.505Z] TEST SETUP: [2025-02-06T11:11:21.505Z] Nothing to be done for setup. [2025-02-06T11:11:21.505Z] [2025-02-06T11:11:21.505Z] TESTING: [2025-02-06T11:11:32.377Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-06T11:11:39.579Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-06T11:11:49.884Z] WARNING: An illegal reflective access operation has occurred [2025-02-06T11:11:49.884Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/output_17388402802782/renaissance-als_0/harness-111123-8237147944776221160/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-06T11:11:49.884Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-06T11:11:49.884Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-06T11:11:49.884Z] WARNING: All illegal access operations will be denied in a future release [2025-02-06T11:11:58.745Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-02-06T11:11:58.745Z] GC before operation: completed in 349.749 ms, heap usage 93.503 MB -> 33.851 MB. [2025-02-06T11:13:48.708Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:13:48.709Z] There is no way to check that no silent failure occurred. [2025-02-06T11:13:48.709Z] ====== als (apache-spark) [default], iteration 0 completed (95945.405 ms) ====== [2025-02-06T11:13:48.709Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-02-06T11:13:48.709Z] GC before operation: completed in 566.391 ms, heap usage 154.411 MB -> 56.821 MB. [2025-02-06T11:14:30.942Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:14:30.943Z] There is no way to check that no silent failure occurred. [2025-02-06T11:14:30.943Z] ====== als (apache-spark) [default], iteration 1 completed (50073.259 ms) ====== [2025-02-06T11:14:30.943Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-02-06T11:14:30.943Z] GC before operation: completed in 454.664 ms, heap usage 320.729 MB -> 58.569 MB. [2025-02-06T11:15:14.036Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:15:14.036Z] There is no way to check that no silent failure occurred. [2025-02-06T11:15:14.036Z] ====== als (apache-spark) [default], iteration 2 completed (43421.137 ms) ====== [2025-02-06T11:15:14.036Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-02-06T11:15:14.036Z] GC before operation: completed in 385.873 ms, heap usage 233.900 MB -> 58.758 MB. [2025-02-06T11:15:45.112Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:15:45.112Z] There is no way to check that no silent failure occurred. [2025-02-06T11:15:45.112Z] ====== als (apache-spark) [default], iteration 3 completed (33666.180 ms) ====== [2025-02-06T11:15:45.112Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-02-06T11:15:45.112Z] GC before operation: completed in 440.199 ms, heap usage 413.899 MB -> 59.471 MB. [2025-02-06T11:16:21.441Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:16:21.441Z] There is no way to check that no silent failure occurred. [2025-02-06T11:16:21.441Z] ====== als (apache-spark) [default], iteration 4 completed (34208.881 ms) ====== [2025-02-06T11:16:21.441Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-02-06T11:16:21.441Z] GC before operation: completed in 461.547 ms, heap usage 378.553 MB -> 59.809 MB. [2025-02-06T11:16:52.678Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:16:52.678Z] There is no way to check that no silent failure occurred. [2025-02-06T11:16:52.678Z] ====== als (apache-spark) [default], iteration 5 completed (33246.616 ms) ====== [2025-02-06T11:16:52.678Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-02-06T11:16:52.678Z] GC before operation: completed in 374.414 ms, heap usage 415.667 MB -> 60.222 MB. [2025-02-06T11:17:29.096Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:17:29.096Z] There is no way to check that no silent failure occurred. [2025-02-06T11:17:29.096Z] ====== als (apache-spark) [default], iteration 6 completed (32836.245 ms) ====== [2025-02-06T11:17:29.096Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-02-06T11:17:29.096Z] GC before operation: completed in 429.649 ms, heap usage 421.234 MB -> 60.577 MB. [2025-02-06T11:17:59.536Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:17:59.536Z] There is no way to check that no silent failure occurred. [2025-02-06T11:17:59.536Z] ====== als (apache-spark) [default], iteration 7 completed (31593.380 ms) ====== [2025-02-06T11:17:59.536Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-02-06T11:17:59.536Z] GC before operation: completed in 447.453 ms, heap usage 239.720 MB -> 60.709 MB. [2025-02-06T11:18:30.142Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:18:30.142Z] There is no way to check that no silent failure occurred. [2025-02-06T11:18:30.142Z] ====== als (apache-spark) [default], iteration 8 completed (30883.196 ms) ====== [2025-02-06T11:18:30.142Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-02-06T11:18:30.142Z] GC before operation: completed in 476.803 ms, heap usage 215.351 MB -> 60.845 MB. [2025-02-06T11:19:00.657Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:19:00.657Z] There is no way to check that no silent failure occurred. [2025-02-06T11:19:00.657Z] ====== als (apache-spark) [default], iteration 9 completed (31672.094 ms) ====== [2025-02-06T11:19:00.657Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-02-06T11:19:00.657Z] GC before operation: completed in 407.778 ms, heap usage 354.646 MB -> 61.460 MB. [2025-02-06T11:19:36.346Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:19:36.346Z] There is no way to check that no silent failure occurred. [2025-02-06T11:19:36.346Z] ====== als (apache-spark) [default], iteration 10 completed (31259.038 ms) ====== [2025-02-06T11:19:36.346Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-02-06T11:19:36.346Z] GC before operation: completed in 383.137 ms, heap usage 294.997 MB -> 61.705 MB. [2025-02-06T11:20:07.400Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:20:07.400Z] There is no way to check that no silent failure occurred. [2025-02-06T11:20:07.400Z] ====== als (apache-spark) [default], iteration 11 completed (32166.121 ms) ====== [2025-02-06T11:20:07.400Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-02-06T11:20:07.400Z] GC before operation: completed in 504.603 ms, heap usage 195.004 MB -> 61.845 MB. [2025-02-06T11:20:37.878Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:20:37.878Z] There is no way to check that no silent failure occurred. [2025-02-06T11:20:37.878Z] ====== als (apache-spark) [default], iteration 12 completed (31826.501 ms) ====== [2025-02-06T11:20:37.878Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-02-06T11:20:37.878Z] GC before operation: completed in 699.679 ms, heap usage 427.368 MB -> 62.561 MB. [2025-02-06T11:21:08.228Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:21:08.228Z] There is no way to check that no silent failure occurred. [2025-02-06T11:21:08.228Z] ====== als (apache-spark) [default], iteration 13 completed (30088.362 ms) ====== [2025-02-06T11:21:08.228Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-02-06T11:21:08.228Z] GC before operation: completed in 231.708 ms, heap usage 558.384 MB -> 63.218 MB. [2025-02-06T11:21:44.107Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:21:44.107Z] There is no way to check that no silent failure occurred. [2025-02-06T11:21:44.107Z] ====== als (apache-spark) [default], iteration 14 completed (35014.412 ms) ====== [2025-02-06T11:21:44.107Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-02-06T11:21:44.107Z] GC before operation: completed in 658.298 ms, heap usage 343.249 MB -> 63.236 MB. [2025-02-06T11:22:20.009Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:22:20.009Z] There is no way to check that no silent failure occurred. [2025-02-06T11:22:20.009Z] ====== als (apache-spark) [default], iteration 15 completed (33325.459 ms) ====== [2025-02-06T11:22:20.009Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-02-06T11:22:20.009Z] GC before operation: completed in 610.557 ms, heap usage 410.267 MB -> 63.762 MB. [2025-02-06T11:22:55.734Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:22:55.734Z] There is no way to check that no silent failure occurred. [2025-02-06T11:22:55.734Z] ====== als (apache-spark) [default], iteration 16 completed (33961.267 ms) ====== [2025-02-06T11:22:55.734Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-02-06T11:22:55.734Z] GC before operation: completed in 644.622 ms, heap usage 347.927 MB -> 64.002 MB. [2025-02-06T11:23:31.337Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:23:31.337Z] There is no way to check that no silent failure occurred. [2025-02-06T11:23:31.337Z] ====== als (apache-spark) [default], iteration 17 completed (35215.604 ms) ====== [2025-02-06T11:23:31.337Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-02-06T11:23:31.337Z] GC before operation: completed in 488.538 ms, heap usage 378.404 MB -> 64.364 MB. [2025-02-06T11:24:07.547Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:24:07.547Z] There is no way to check that no silent failure occurred. [2025-02-06T11:24:07.547Z] ====== als (apache-spark) [default], iteration 18 completed (38314.208 ms) ====== [2025-02-06T11:24:07.547Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-02-06T11:24:07.547Z] GC before operation: completed in 596.668 ms, heap usage 463.161 MB -> 64.464 MB. [2025-02-06T11:24:51.816Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:24:51.816Z] There is no way to check that no silent failure occurred. [2025-02-06T11:24:51.816Z] ====== als (apache-spark) [default], iteration 19 completed (42541.138 ms) ====== [2025-02-06T11:24:51.816Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-02-06T11:24:51.816Z] GC before operation: completed in 633.320 ms, heap usage 301.806 MB -> 64.668 MB. [2025-02-06T11:25:27.938Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:25:27.938Z] There is no way to check that no silent failure occurred. [2025-02-06T11:25:27.938Z] ====== als (apache-spark) [default], iteration 20 completed (33527.177 ms) ====== [2025-02-06T11:25:27.938Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-02-06T11:25:27.938Z] GC before operation: completed in 456.099 ms, heap usage 477.883 MB -> 65.088 MB. [2025-02-06T11:26:04.233Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:26:04.233Z] There is no way to check that no silent failure occurred. [2025-02-06T11:26:04.233Z] ====== als (apache-spark) [default], iteration 21 completed (36850.952 ms) ====== [2025-02-06T11:26:04.233Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-02-06T11:26:04.233Z] GC before operation: completed in 640.218 ms, heap usage 323.366 MB -> 65.215 MB. [2025-02-06T11:26:47.088Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:26:47.089Z] There is no way to check that no silent failure occurred. [2025-02-06T11:26:47.089Z] ====== als (apache-spark) [default], iteration 22 completed (41832.482 ms) ====== [2025-02-06T11:26:47.089Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-02-06T11:26:47.089Z] GC before operation: completed in 770.208 ms, heap usage 510.720 MB -> 65.523 MB. [2025-02-06T11:27:23.576Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:27:23.576Z] There is no way to check that no silent failure occurred. [2025-02-06T11:27:23.576Z] ====== als (apache-spark) [default], iteration 23 completed (39383.288 ms) ====== [2025-02-06T11:27:23.576Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-02-06T11:27:24.403Z] GC before operation: completed in 581.675 ms, heap usage 492.504 MB -> 66.010 MB. [2025-02-06T11:28:01.719Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:28:01.719Z] There is no way to check that no silent failure occurred. [2025-02-06T11:28:01.719Z] ====== als (apache-spark) [default], iteration 24 completed (36592.122 ms) ====== [2025-02-06T11:28:01.719Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-02-06T11:28:01.719Z] GC before operation: completed in 687.830 ms, heap usage 256.854 MB -> 65.419 MB. [2025-02-06T11:28:44.429Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:28:44.430Z] There is no way to check that no silent failure occurred. [2025-02-06T11:28:44.430Z] ====== als (apache-spark) [default], iteration 25 completed (41576.563 ms) ====== [2025-02-06T11:28:44.430Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-02-06T11:28:44.430Z] GC before operation: completed in 539.326 ms, heap usage 179.755 MB -> 65.494 MB. [2025-02-06T11:29:27.151Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:29:27.151Z] There is no way to check that no silent failure occurred. [2025-02-06T11:29:27.151Z] ====== als (apache-spark) [default], iteration 26 completed (42925.019 ms) ====== [2025-02-06T11:29:27.151Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-02-06T11:29:27.151Z] GC before operation: completed in 505.010 ms, heap usage 242.023 MB -> 66.059 MB. [2025-02-06T11:30:09.968Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:30:09.968Z] There is no way to check that no silent failure occurred. [2025-02-06T11:30:09.968Z] ====== als (apache-spark) [default], iteration 27 completed (37414.954 ms) ====== [2025-02-06T11:30:09.968Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-02-06T11:30:09.968Z] GC before operation: completed in 677.070 ms, heap usage 474.880 MB -> 66.387 MB. [2025-02-06T11:30:47.314Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:30:47.314Z] There is no way to check that no silent failure occurred. [2025-02-06T11:30:47.314Z] ====== als (apache-spark) [default], iteration 28 completed (41241.638 ms) ====== [2025-02-06T11:30:47.314Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-02-06T11:30:47.314Z] GC before operation: completed in 728.737 ms, heap usage 271.433 MB -> 66.260 MB. [2025-02-06T11:31:30.349Z] WARNING: This benchmark provides no result that can be validated. [2025-02-06T11:31:30.349Z] There is no way to check that no silent failure occurred. [2025-02-06T11:31:30.349Z] ====== als (apache-spark) [default], iteration 29 completed (38385.915 ms) ====== [2025-02-06T11:31:30.349Z] ----------------------------------- [2025-02-06T11:31:30.349Z] renaissance-als_0_PASSED [2025-02-06T11:31:30.349Z] ----------------------------------- [2025-02-06T11:31:30.349Z] [2025-02-06T11:31:30.349Z] TEST TEARDOWN: [2025-02-06T11:31:30.349Z] Nothing to be done for teardown. [2025-02-06T11:31:30.349Z] renaissance-als_0 Finish Time: Thu Feb 6 11:31:26 2025 Epoch Time (ms): 1738841486631