[2024-08-23T21:25:25.402Z] Running test renaissance-als_0 ... [2024-08-23T21:25:25.402Z] =============================================== [2024-08-23T21:25:25.402Z] renaissance-als_0 Start Time: Fri Aug 23 21:25:25 2024 Epoch Time (ms): 1724448325105 [2024-08-23T21:25:25.402Z] variation: NoOptions [2024-08-23T21:25:25.402Z] JVM_OPTIONS: [2024-08-23T21:25:25.402Z] { \ [2024-08-23T21:25:25.402Z] echo ""; echo "TEST SETUP:"; \ [2024-08-23T21:25:25.402Z] echo "Nothing to be done for setup."; \ [2024-08-23T21:25:25.402Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17244483233953/renaissance-als_0"; \ [2024-08-23T21:25:25.402Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17244483233953/renaissance-als_0"; \ [2024-08-23T21:25:25.402Z] echo ""; echo "TESTING:"; \ [2024-08-23T21:25:25.402Z] "/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_17244483233953/renaissance-als_0"/als.json" als; \ [2024-08-23T21:25:25.402Z] 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_17244483233953/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-23T21:25:25.402Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-23T21:25:25.402Z] echo "Nothing to be done for teardown."; \ [2024-08-23T21:25:25.402Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux/aqa-tests/TKG/../TKG/output_17244483233953/TestTargetResult"; [2024-08-23T21:25:25.402Z] [2024-08-23T21:25:25.402Z] TEST SETUP: [2024-08-23T21:25:25.402Z] Nothing to be done for setup. [2024-08-23T21:25:25.402Z] [2024-08-23T21:25:25.402Z] TESTING: [2024-08-23T21:25:36.985Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-23T21:25:45.688Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-23T21:25:59.465Z] WARNING: An illegal reflective access operation has occurred [2024-08-23T21:25:59.465Z] 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_17244483233953/renaissance-als_0/harness-212527-12985973051484880660/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-23T21:25:59.465Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-23T21:25:59.465Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-23T21:25:59.465Z] WARNING: All illegal access operations will be denied in a future release [2024-08-23T21:26:09.294Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-23T21:26:09.294Z] GC before operation: completed in 358.301 ms, heap usage 95.964 MB -> 33.845 MB. [2024-08-23T21:28:13.539Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:28:13.539Z] There is no way to check that no silent failure occurred. [2024-08-23T21:28:13.539Z] ====== als (apache-spark) [default], iteration 0 completed (115943.493 ms) ====== [2024-08-23T21:28:13.539Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-23T21:28:13.539Z] GC before operation: completed in 594.889 ms, heap usage 333.758 MB -> 56.065 MB. [2024-08-23T21:29:21.630Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:29:21.630Z] There is no way to check that no silent failure occurred. [2024-08-23T21:29:21.630Z] ====== als (apache-spark) [default], iteration 1 completed (67095.886 ms) ====== [2024-08-23T21:29:21.630Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-23T21:29:21.630Z] GC before operation: completed in 757.424 ms, heap usage 588.774 MB -> 58.904 MB. [2024-08-23T21:30:18.561Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:30:18.561Z] There is no way to check that no silent failure occurred. [2024-08-23T21:30:18.561Z] ====== als (apache-spark) [default], iteration 2 completed (61505.579 ms) ====== [2024-08-23T21:30:18.561Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-23T21:30:18.561Z] GC before operation: completed in 605.039 ms, heap usage 226.813 MB -> 58.737 MB. [2024-08-23T21:31:15.682Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:31:15.682Z] There is no way to check that no silent failure occurred. [2024-08-23T21:31:15.682Z] ====== als (apache-spark) [default], iteration 3 completed (58424.014 ms) ====== [2024-08-23T21:31:15.682Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-23T21:31:15.682Z] GC before operation: completed in 530.096 ms, heap usage 446.022 MB -> 59.505 MB. [2024-08-23T21:32:24.223Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:32:24.223Z] There is no way to check that no silent failure occurred. [2024-08-23T21:32:24.223Z] ====== als (apache-spark) [default], iteration 4 completed (60144.060 ms) ====== [2024-08-23T21:32:24.223Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-23T21:32:24.223Z] GC before operation: completed in 625.880 ms, heap usage 396.140 MB -> 59.767 MB. [2024-08-23T21:33:21.930Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:33:21.930Z] There is no way to check that no silent failure occurred. [2024-08-23T21:33:21.930Z] ====== als (apache-spark) [default], iteration 5 completed (59081.980 ms) ====== [2024-08-23T21:33:21.930Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-23T21:33:21.931Z] GC before operation: completed in 618.108 ms, heap usage 537.338 MB -> 60.282 MB. [2024-08-23T21:34:11.051Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:34:11.051Z] There is no way to check that no silent failure occurred. [2024-08-23T21:34:11.051Z] ====== als (apache-spark) [default], iteration 6 completed (51375.633 ms) ====== [2024-08-23T21:34:11.051Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-23T21:34:11.051Z] GC before operation: completed in 734.321 ms, heap usage 604.029 MB -> 60.737 MB. [2024-08-23T21:35:00.192Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:35:00.192Z] There is no way to check that no silent failure occurred. [2024-08-23T21:35:00.192Z] ====== als (apache-spark) [default], iteration 7 completed (46468.987 ms) ====== [2024-08-23T21:35:00.192Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-23T21:35:00.192Z] GC before operation: completed in 627.771 ms, heap usage 375.510 MB -> 60.879 MB. [2024-08-23T21:35:42.823Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:35:42.823Z] There is no way to check that no silent failure occurred. [2024-08-23T21:35:42.823Z] ====== als (apache-spark) [default], iteration 8 completed (43941.605 ms) ====== [2024-08-23T21:35:42.823Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-23T21:35:42.823Z] GC before operation: completed in 594.652 ms, heap usage 426.303 MB -> 61.306 MB. [2024-08-23T21:36:32.007Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:36:32.007Z] There is no way to check that no silent failure occurred. [2024-08-23T21:36:32.007Z] ====== als (apache-spark) [default], iteration 9 completed (49006.762 ms) ====== [2024-08-23T21:36:32.007Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-23T21:36:32.007Z] GC before operation: completed in 611.208 ms, heap usage 310.845 MB -> 61.549 MB. [2024-08-23T21:37:21.191Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:37:21.191Z] There is no way to check that no silent failure occurred. [2024-08-23T21:37:21.191Z] ====== als (apache-spark) [default], iteration 10 completed (49658.429 ms) ====== [2024-08-23T21:37:21.191Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-23T21:37:21.191Z] GC before operation: completed in 616.013 ms, heap usage 550.400 MB -> 62.051 MB. [2024-08-23T21:38:18.489Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:38:18.489Z] There is no way to check that no silent failure occurred. [2024-08-23T21:38:18.489Z] ====== als (apache-spark) [default], iteration 11 completed (54725.626 ms) ====== [2024-08-23T21:38:18.489Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-23T21:38:18.489Z] GC before operation: completed in 682.991 ms, heap usage 462.712 MB -> 62.281 MB. [2024-08-23T21:39:06.804Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:39:06.804Z] There is no way to check that no silent failure occurred. [2024-08-23T21:39:06.804Z] ====== als (apache-spark) [default], iteration 12 completed (48030.417 ms) ====== [2024-08-23T21:39:06.804Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-23T21:39:06.804Z] GC before operation: completed in 562.611 ms, heap usage 449.758 MB -> 62.635 MB. [2024-08-23T21:39:54.936Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:39:54.936Z] There is no way to check that no silent failure occurred. [2024-08-23T21:39:54.936Z] ====== als (apache-spark) [default], iteration 13 completed (48777.685 ms) ====== [2024-08-23T21:39:54.936Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-23T21:39:54.936Z] GC before operation: completed in 608.968 ms, heap usage 319.153 MB -> 62.851 MB. [2024-08-23T21:40:52.112Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:40:52.112Z] There is no way to check that no silent failure occurred. [2024-08-23T21:40:52.112Z] ====== als (apache-spark) [default], iteration 14 completed (55784.684 ms) ====== [2024-08-23T21:40:52.112Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-23T21:40:52.112Z] GC before operation: completed in 673.288 ms, heap usage 509.028 MB -> 63.523 MB. [2024-08-23T21:41:48.671Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:41:48.671Z] There is no way to check that no silent failure occurred. [2024-08-23T21:41:48.671Z] ====== als (apache-spark) [default], iteration 15 completed (53907.076 ms) ====== [2024-08-23T21:41:48.671Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-23T21:41:48.671Z] GC before operation: completed in 709.964 ms, heap usage 348.396 MB -> 63.588 MB. [2024-08-23T21:42:36.699Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:42:36.699Z] There is no way to check that no silent failure occurred. [2024-08-23T21:42:36.699Z] ====== als (apache-spark) [default], iteration 16 completed (51884.036 ms) ====== [2024-08-23T21:42:36.699Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-23T21:42:36.699Z] GC before operation: completed in 584.133 ms, heap usage 465.806 MB -> 64.116 MB. [2024-08-23T21:43:33.953Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:43:33.953Z] There is no way to check that no silent failure occurred. [2024-08-23T21:43:33.953Z] ====== als (apache-spark) [default], iteration 17 completed (50947.457 ms) ====== [2024-08-23T21:43:33.953Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-23T21:43:33.953Z] GC before operation: completed in 839.450 ms, heap usage 186.729 MB -> 63.966 MB. [2024-08-23T21:44:23.419Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:44:23.419Z] There is no way to check that no silent failure occurred. [2024-08-23T21:44:23.419Z] ====== als (apache-spark) [default], iteration 18 completed (51880.273 ms) ====== [2024-08-23T21:44:23.419Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-23T21:44:23.419Z] GC before operation: completed in 747.313 ms, heap usage 265.324 MB -> 64.252 MB. [2024-08-23T21:45:12.997Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:45:12.997Z] There is no way to check that no silent failure occurred. [2024-08-23T21:45:12.997Z] ====== als (apache-spark) [default], iteration 19 completed (48648.065 ms) ====== [2024-08-23T21:45:12.997Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-23T21:45:12.997Z] GC before operation: completed in 635.217 ms, heap usage 608.940 MB -> 65.054 MB. [2024-08-23T21:46:03.244Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:46:03.244Z] There is no way to check that no silent failure occurred. [2024-08-23T21:46:03.244Z] ====== als (apache-spark) [default], iteration 20 completed (53060.992 ms) ====== [2024-08-23T21:46:03.245Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-23T21:46:04.062Z] GC before operation: completed in 857.488 ms, heap usage 515.227 MB -> 64.955 MB. [2024-08-23T21:47:02.146Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:47:02.147Z] There is no way to check that no silent failure occurred. [2024-08-23T21:47:02.147Z] ====== als (apache-spark) [default], iteration 21 completed (56237.758 ms) ====== [2024-08-23T21:47:02.147Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-23T21:47:02.147Z] GC before operation: completed in 609.865 ms, heap usage 177.122 MB -> 64.820 MB. [2024-08-23T21:48:00.156Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:48:00.156Z] There is no way to check that no silent failure occurred. [2024-08-23T21:48:00.156Z] ====== als (apache-spark) [default], iteration 22 completed (55774.902 ms) ====== [2024-08-23T21:48:00.156Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-23T21:48:00.156Z] GC before operation: completed in 548.801 ms, heap usage 235.820 MB -> 64.900 MB. [2024-08-23T21:48:49.999Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:48:49.999Z] There is no way to check that no silent failure occurred. [2024-08-23T21:48:49.999Z] ====== als (apache-spark) [default], iteration 23 completed (53217.257 ms) ====== [2024-08-23T21:48:49.999Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-23T21:48:50.822Z] GC before operation: completed in 725.805 ms, heap usage 501.048 MB -> 65.112 MB. [2024-08-23T21:49:48.939Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:49:48.940Z] There is no way to check that no silent failure occurred. [2024-08-23T21:49:48.940Z] ====== als (apache-spark) [default], iteration 24 completed (53552.390 ms) ====== [2024-08-23T21:49:48.940Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-23T21:49:48.940Z] GC before operation: completed in 783.881 ms, heap usage 283.076 MB -> 62.767 MB. [2024-08-23T21:50:47.345Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:50:47.345Z] There is no way to check that no silent failure occurred. [2024-08-23T21:50:47.345Z] ====== als (apache-spark) [default], iteration 25 completed (56810.227 ms) ====== [2024-08-23T21:50:47.345Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-23T21:50:47.345Z] GC before operation: completed in 757.480 ms, heap usage 194.855 MB -> 62.685 MB. [2024-08-23T21:51:37.525Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:51:37.525Z] There is no way to check that no silent failure occurred. [2024-08-23T21:51:37.525Z] ====== als (apache-spark) [default], iteration 26 completed (52211.630 ms) ====== [2024-08-23T21:51:37.525Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-23T21:51:37.525Z] GC before operation: completed in 847.814 ms, heap usage 385.150 MB -> 63.215 MB. [2024-08-23T21:52:27.174Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:52:27.174Z] There is no way to check that no silent failure occurred. [2024-08-23T21:52:27.174Z] ====== als (apache-spark) [default], iteration 27 completed (48879.250 ms) ====== [2024-08-23T21:52:27.174Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-23T21:52:27.174Z] GC before operation: completed in 571.537 ms, heap usage 452.256 MB -> 63.529 MB. [2024-08-23T21:53:16.774Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:53:16.774Z] There is no way to check that no silent failure occurred. [2024-08-23T21:53:16.774Z] ====== als (apache-spark) [default], iteration 28 completed (47182.559 ms) ====== [2024-08-23T21:53:16.774Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-23T21:53:16.774Z] GC before operation: completed in 698.928 ms, heap usage 572.605 MB -> 64.118 MB. [2024-08-23T21:54:07.015Z] WARNING: This benchmark provides no result that can be validated. [2024-08-23T21:54:07.015Z] There is no way to check that no silent failure occurred. [2024-08-23T21:54:07.015Z] ====== als (apache-spark) [default], iteration 29 completed (51889.170 ms) ====== [2024-08-23T21:54:07.015Z] ----------------------------------- [2024-08-23T21:54:07.015Z] renaissance-als_0_PASSED [2024-08-23T21:54:07.015Z] ----------------------------------- [2024-08-23T21:54:07.015Z] [2024-08-23T21:54:07.015Z] TEST TEARDOWN: [2024-08-23T21:54:07.015Z] Nothing to be done for teardown. [2024-08-23T21:54:07.015Z] renaissance-als_0 Finish Time: Fri Aug 23 21:54:06 2024 Epoch Time (ms): 1724450046581