[2025-02-20T20:54:30.494Z] Running test renaissance-als_0 ... [2025-02-20T20:54:30.494Z] =============================================== [2025-02-20T20:54:31.319Z] renaissance-als_0 Start Time: Thu Feb 20 20:54:30 2025 Epoch Time (ms): 1740084870431 [2025-02-20T20:54:31.319Z] variation: NoOptions [2025-02-20T20:54:31.319Z] JVM_OPTIONS: [2025-02-20T20:54:31.319Z] { \ [2025-02-20T20:54:31.319Z] echo ""; echo "TEST SETUP:"; \ [2025-02-20T20:54:31.319Z] echo "Nothing to be done for setup."; \ [2025-02-20T20:54:31.319Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17400848694977/renaissance-als_0"; \ [2025-02-20T20:54:31.319Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17400848694977/renaissance-als_0"; \ [2025-02-20T20:54:31.319Z] echo ""; echo "TESTING:"; \ [2025-02-20T20:54:31.319Z] "/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_17400848694977/renaissance-als_0"/als.json" als; \ [2025-02-20T20:54:31.319Z] 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_17400848694977/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-20T20:54:31.319Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-20T20:54:31.319Z] echo "Nothing to be done for teardown."; \ [2025-02-20T20:54:31.319Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17400848694977/TestTargetResult"; [2025-02-20T20:54:31.319Z] [2025-02-20T20:54:31.319Z] TEST SETUP: [2025-02-20T20:54:31.319Z] Nothing to be done for setup. [2025-02-20T20:54:31.319Z] [2025-02-20T20:54:31.319Z] TESTING: [2025-02-20T20:54:40.039Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-20T20:54:47.412Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-20T20:54:59.717Z] WARNING: An illegal reflective access operation has occurred [2025-02-20T20:54:59.717Z] 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_17400848694977/renaissance-als_0/harness-205432-17207066046852980281/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-02-20T20:54:59.717Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-02-20T20:54:59.717Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-02-20T20:54:59.717Z] WARNING: All illegal access operations will be denied in a future release [2025-02-20T20:55:10.106Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-02-20T20:55:10.106Z] GC before operation: completed in 337.173 ms, heap usage 94.502 MB -> 33.850 MB. [2025-02-20T20:57:01.273Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T20:57:01.273Z] There is no way to check that no silent failure occurred. [2025-02-20T20:57:01.273Z] ====== als (apache-spark) [default], iteration 0 completed (103678.297 ms) ====== [2025-02-20T20:57:01.273Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-02-20T20:57:01.274Z] GC before operation: completed in 516.570 ms, heap usage 384.799 MB -> 56.138 MB. [2025-02-20T20:57:51.897Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T20:57:51.897Z] There is no way to check that no silent failure occurred. [2025-02-20T20:57:51.897Z] ====== als (apache-spark) [default], iteration 1 completed (51707.787 ms) ====== [2025-02-20T20:57:51.897Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-02-20T20:57:51.897Z] GC before operation: completed in 565.572 ms, heap usage 279.987 MB -> 58.643 MB. [2025-02-20T20:58:35.222Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T20:58:35.222Z] There is no way to check that no silent failure occurred. [2025-02-20T20:58:35.222Z] ====== als (apache-spark) [default], iteration 2 completed (46120.616 ms) ====== [2025-02-20T20:58:35.222Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-02-20T20:58:35.222Z] GC before operation: completed in 529.742 ms, heap usage 214.535 MB -> 58.752 MB. [2025-02-20T20:59:18.423Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T20:59:18.423Z] There is no way to check that no silent failure occurred. [2025-02-20T20:59:18.423Z] ====== als (apache-spark) [default], iteration 3 completed (41381.415 ms) ====== [2025-02-20T20:59:18.423Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-02-20T20:59:18.423Z] GC before operation: completed in 455.067 ms, heap usage 403.530 MB -> 59.499 MB. [2025-02-20T21:00:02.550Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:00:02.550Z] There is no way to check that no silent failure occurred. [2025-02-20T21:00:02.550Z] ====== als (apache-spark) [default], iteration 4 completed (44019.236 ms) ====== [2025-02-20T21:00:02.550Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-02-20T21:00:02.550Z] GC before operation: completed in 688.695 ms, heap usage 429.189 MB -> 59.865 MB. [2025-02-20T21:00:46.623Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:00:46.623Z] There is no way to check that no silent failure occurred. [2025-02-20T21:00:46.623Z] ====== als (apache-spark) [default], iteration 5 completed (44026.889 ms) ====== [2025-02-20T21:00:46.623Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-02-20T21:00:46.623Z] GC before operation: completed in 591.906 ms, heap usage 323.158 MB -> 60.162 MB. [2025-02-20T21:01:37.375Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:01:37.375Z] There is no way to check that no silent failure occurred. [2025-02-20T21:01:37.375Z] ====== als (apache-spark) [default], iteration 6 completed (47908.121 ms) ====== [2025-02-20T21:01:37.375Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-02-20T21:01:37.375Z] GC before operation: completed in 463.892 ms, heap usage 459.848 MB -> 60.688 MB. [2025-02-20T21:02:18.927Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:02:18.927Z] There is no way to check that no silent failure occurred. [2025-02-20T21:02:18.927Z] ====== als (apache-spark) [default], iteration 7 completed (43228.411 ms) ====== [2025-02-20T21:02:18.927Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-02-20T21:02:18.927Z] GC before operation: completed in 515.980 ms, heap usage 462.682 MB -> 61.063 MB. [2025-02-20T21:03:00.571Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:03:00.571Z] There is no way to check that no silent failure occurred. [2025-02-20T21:03:00.571Z] ====== als (apache-spark) [default], iteration 8 completed (43933.557 ms) ====== [2025-02-20T21:03:00.571Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-02-20T21:03:00.571Z] GC before operation: completed in 578.196 ms, heap usage 294.577 MB -> 61.082 MB. [2025-02-20T21:03:42.302Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:03:42.302Z] There is no way to check that no silent failure occurred. [2025-02-20T21:03:42.302Z] ====== als (apache-spark) [default], iteration 9 completed (37455.382 ms) ====== [2025-02-20T21:03:42.302Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-02-20T21:03:42.302Z] GC before operation: completed in 654.778 ms, heap usage 549.832 MB -> 61.842 MB. [2025-02-20T21:04:16.962Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:04:16.962Z] There is no way to check that no silent failure occurred. [2025-02-20T21:04:16.962Z] ====== als (apache-spark) [default], iteration 10 completed (35197.854 ms) ====== [2025-02-20T21:04:16.962Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-02-20T21:04:16.962Z] GC before operation: completed in 498.568 ms, heap usage 201.305 MB -> 61.633 MB. [2025-02-20T21:04:58.666Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:04:58.666Z] There is no way to check that no silent failure occurred. [2025-02-20T21:04:58.666Z] ====== als (apache-spark) [default], iteration 11 completed (40291.469 ms) ====== [2025-02-20T21:04:58.666Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-02-20T21:04:58.666Z] GC before operation: completed in 615.619 ms, heap usage 508.387 MB -> 62.384 MB. [2025-02-20T21:05:40.503Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:05:40.503Z] There is no way to check that no silent failure occurred. [2025-02-20T21:05:40.503Z] ====== als (apache-spark) [default], iteration 12 completed (41607.591 ms) ====== [2025-02-20T21:05:40.503Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-02-20T21:05:40.503Z] GC before operation: completed in 423.910 ms, heap usage 581.984 MB -> 62.732 MB. [2025-02-20T21:06:22.458Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:06:22.458Z] There is no way to check that no silent failure occurred. [2025-02-20T21:06:22.458Z] ====== als (apache-spark) [default], iteration 13 completed (41716.960 ms) ====== [2025-02-20T21:06:22.458Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-02-20T21:06:22.458Z] GC before operation: completed in 590.968 ms, heap usage 275.154 MB -> 62.789 MB. [2025-02-20T21:07:04.842Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:07:04.842Z] There is no way to check that no silent failure occurred. [2025-02-20T21:07:04.842Z] ====== als (apache-spark) [default], iteration 14 completed (40239.237 ms) ====== [2025-02-20T21:07:04.842Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-02-20T21:07:04.842Z] GC before operation: completed in 488.848 ms, heap usage 214.768 MB -> 62.949 MB. [2025-02-20T21:07:46.617Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:07:46.617Z] There is no way to check that no silent failure occurred. [2025-02-20T21:07:46.617Z] ====== als (apache-spark) [default], iteration 15 completed (43379.442 ms) ====== [2025-02-20T21:07:46.617Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-02-20T21:07:46.617Z] GC before operation: completed in 844.012 ms, heap usage 378.596 MB -> 63.594 MB. [2025-02-20T21:08:28.377Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:08:28.377Z] There is no way to check that no silent failure occurred. [2025-02-20T21:08:28.377Z] ====== als (apache-spark) [default], iteration 16 completed (38767.897 ms) ====== [2025-02-20T21:08:28.377Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-02-20T21:08:28.377Z] GC before operation: completed in 565.202 ms, heap usage 373.248 MB -> 63.945 MB. [2025-02-20T21:09:10.109Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:09:10.109Z] There is no way to check that no silent failure occurred. [2025-02-20T21:09:10.109Z] ====== als (apache-spark) [default], iteration 17 completed (42636.085 ms) ====== [2025-02-20T21:09:10.109Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-02-20T21:09:10.109Z] GC before operation: completed in 636.786 ms, heap usage 276.442 MB -> 64.161 MB. [2025-02-20T21:09:51.777Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:09:51.777Z] There is no way to check that no silent failure occurred. [2025-02-20T21:09:51.777Z] ====== als (apache-spark) [default], iteration 18 completed (42563.605 ms) ====== [2025-02-20T21:09:51.777Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-02-20T21:09:51.777Z] GC before operation: completed in 728.158 ms, heap usage 397.005 MB -> 64.501 MB. [2025-02-20T21:10:40.752Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:10:40.752Z] There is no way to check that no silent failure occurred. [2025-02-20T21:10:40.752Z] ====== als (apache-spark) [default], iteration 19 completed (42997.051 ms) ====== [2025-02-20T21:10:40.752Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-02-20T21:10:40.752Z] GC before operation: completed in 318.810 ms, heap usage 238.024 MB -> 64.416 MB. [2025-02-20T21:11:15.775Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:11:15.775Z] There is no way to check that no silent failure occurred. [2025-02-20T21:11:15.775Z] ====== als (apache-spark) [default], iteration 20 completed (39813.040 ms) ====== [2025-02-20T21:11:15.775Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-02-20T21:11:15.775Z] GC before operation: completed in 642.135 ms, heap usage 432.572 MB -> 65.005 MB. [2025-02-20T21:12:04.923Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:12:04.923Z] There is no way to check that no silent failure occurred. [2025-02-20T21:12:04.923Z] ====== als (apache-spark) [default], iteration 21 completed (43887.030 ms) ====== [2025-02-20T21:12:04.923Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-02-20T21:12:04.923Z] GC before operation: completed in 568.886 ms, heap usage 382.243 MB -> 65.178 MB. [2025-02-20T21:12:45.907Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:12:45.907Z] There is no way to check that no silent failure occurred. [2025-02-20T21:12:45.907Z] ====== als (apache-spark) [default], iteration 22 completed (42799.315 ms) ====== [2025-02-20T21:12:45.907Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-02-20T21:12:45.907Z] GC before operation: completed in 709.326 ms, heap usage 379.012 MB -> 65.259 MB. [2025-02-20T21:13:27.010Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:13:27.010Z] There is no way to check that no silent failure occurred. [2025-02-20T21:13:27.010Z] ====== als (apache-spark) [default], iteration 23 completed (40203.045 ms) ====== [2025-02-20T21:13:27.010Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-02-20T21:13:27.010Z] GC before operation: completed in 604.769 ms, heap usage 196.848 MB -> 65.238 MB. [2025-02-20T21:14:08.194Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:14:08.194Z] There is no way to check that no silent failure occurred. [2025-02-20T21:14:08.194Z] ====== als (apache-spark) [default], iteration 24 completed (38757.845 ms) ====== [2025-02-20T21:14:08.194Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-02-20T21:14:08.194Z] GC before operation: completed in 533.998 ms, heap usage 571.959 MB -> 65.985 MB. [2025-02-20T21:14:43.618Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:14:43.618Z] There is no way to check that no silent failure occurred. [2025-02-20T21:14:43.618Z] ====== als (apache-spark) [default], iteration 25 completed (41249.242 ms) ====== [2025-02-20T21:14:43.618Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-02-20T21:14:44.368Z] GC before operation: completed in 674.705 ms, heap usage 256.464 MB -> 65.415 MB. [2025-02-20T21:15:25.408Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:15:25.408Z] There is no way to check that no silent failure occurred. [2025-02-20T21:15:25.408Z] ====== als (apache-spark) [default], iteration 26 completed (39556.590 ms) ====== [2025-02-20T21:15:25.408Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-02-20T21:15:25.408Z] GC before operation: completed in 626.608 ms, heap usage 392.282 MB -> 66.142 MB. [2025-02-20T21:16:13.889Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:16:13.889Z] There is no way to check that no silent failure occurred. [2025-02-20T21:16:13.889Z] ====== als (apache-spark) [default], iteration 27 completed (44916.030 ms) ====== [2025-02-20T21:16:13.889Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-02-20T21:16:13.889Z] GC before operation: completed in 732.165 ms, heap usage 521.824 MB -> 66.413 MB. [2025-02-20T21:16:54.870Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:16:54.870Z] There is no way to check that no silent failure occurred. [2025-02-20T21:16:54.870Z] ====== als (apache-spark) [default], iteration 28 completed (41187.861 ms) ====== [2025-02-20T21:16:54.870Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-02-20T21:16:54.870Z] GC before operation: completed in 684.216 ms, heap usage 481.682 MB -> 66.590 MB. [2025-02-20T21:17:36.728Z] WARNING: This benchmark provides no result that can be validated. [2025-02-20T21:17:36.728Z] There is no way to check that no silent failure occurred. [2025-02-20T21:17:36.728Z] ====== als (apache-spark) [default], iteration 29 completed (40053.858 ms) ====== [2025-02-20T21:17:36.728Z] ----------------------------------- [2025-02-20T21:17:36.728Z] renaissance-als_0_PASSED [2025-02-20T21:17:36.728Z] ----------------------------------- [2025-02-20T21:17:36.728Z] [2025-02-20T21:17:36.728Z] TEST TEARDOWN: [2025-02-20T21:17:36.728Z] Nothing to be done for teardown. [2025-02-20T21:17:36.728Z] renaissance-als_0 Finish Time: Thu Feb 20 21:17:33 2025 Epoch Time (ms): 1740086253702