[2025-01-22T04:03:59.028Z] Running test renaissance-als_0 ... [2025-01-22T04:03:59.028Z] =============================================== [2025-01-22T04:03:59.028Z] renaissance-als_0 Start Time: Wed Jan 22 04:03:58 2025 Epoch Time (ms): 1737518638198 [2025-01-22T04:03:59.028Z] variation: NoOptions [2025-01-22T04:03:59.028Z] JVM_OPTIONS: [2025-01-22T04:03:59.028Z] { \ [2025-01-22T04:03:59.028Z] echo ""; echo "TEST SETUP:"; \ [2025-01-22T04:03:59.028Z] echo "Nothing to be done for setup."; \ [2025-01-22T04:03:59.028Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-als_0"; \ [2025-01-22T04:03:59.028Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-als_0"; \ [2025-01-22T04:03:59.028Z] echo ""; echo "TESTING:"; \ [2025-01-22T04:03:59.028Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-als_0"/als.json" als; \ [2025-01-22T04:03:59.028Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-01-22T04:03:59.028Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-01-22T04:03:59.028Z] echo "Nothing to be done for teardown."; \ [2025-01-22T04:03:59.028Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17375186001189/TestTargetResult"; [2025-01-22T04:03:59.028Z] [2025-01-22T04:03:59.028Z] TEST SETUP: [2025-01-22T04:03:59.028Z] Nothing to be done for setup. [2025-01-22T04:03:59.028Z] [2025-01-22T04:03:59.028Z] TESTING: [2025-01-22T04:04:01.920Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-01-22T04:04:03.980Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-01-22T04:04:06.930Z] WARNING: An illegal reflective access operation has occurred [2025-01-22T04:04:06.930Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17375186001189/renaissance-als_0/harness-040359-10122429298182459986/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-01-22T04:04:06.930Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-01-22T04:04:06.930Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-01-22T04:04:06.930Z] WARNING: All illegal access operations will be denied in a future release [2025-01-22T04:04:08.251Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-01-22T04:04:08.890Z] GC before operation: completed in 144.080 ms, heap usage 90.000 MB -> 33.777 MB. [2025-01-22T04:04:32.668Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:04:32.668Z] There is no way to check that no silent failure occurred. [2025-01-22T04:04:32.668Z] ====== als (apache-spark) [default], iteration 0 completed (23220.404 ms) ====== [2025-01-22T04:04:32.668Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-01-22T04:04:32.668Z] GC before operation: completed in 202.711 ms, heap usage 257.686 MB -> 55.986 MB. [2025-01-22T04:04:47.865Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:04:47.865Z] There is no way to check that no silent failure occurred. [2025-01-22T04:04:47.865Z] ====== als (apache-spark) [default], iteration 1 completed (15154.478 ms) ====== [2025-01-22T04:04:47.865Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-01-22T04:04:47.865Z] GC before operation: completed in 198.798 ms, heap usage 374.729 MB -> 58.784 MB. [2025-01-22T04:05:02.398Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:05:02.398Z] There is no way to check that no silent failure occurred. [2025-01-22T04:05:02.398Z] ====== als (apache-spark) [default], iteration 2 completed (14013.076 ms) ====== [2025-01-22T04:05:02.398Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-01-22T04:05:02.398Z] GC before operation: completed in 143.381 ms, heap usage 193.846 MB -> 58.815 MB. [2025-01-22T04:05:14.690Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:05:14.690Z] There is no way to check that no silent failure occurred. [2025-01-22T04:05:14.690Z] ====== als (apache-spark) [default], iteration 3 completed (13312.509 ms) ====== [2025-01-22T04:05:14.690Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-01-22T04:05:15.322Z] GC before operation: completed in 144.300 ms, heap usage 330.800 MB -> 59.582 MB. [2025-01-22T04:05:29.898Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:05:29.898Z] There is no way to check that no silent failure occurred. [2025-01-22T04:05:29.898Z] ====== als (apache-spark) [default], iteration 4 completed (13660.884 ms) ====== [2025-01-22T04:05:29.898Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-01-22T04:05:29.898Z] GC before operation: completed in 221.296 ms, heap usage 268.268 MB -> 59.684 MB. [2025-01-22T04:05:42.216Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:05:42.216Z] There is no way to check that no silent failure occurred. [2025-01-22T04:05:42.216Z] ====== als (apache-spark) [default], iteration 5 completed (13224.229 ms) ====== [2025-01-22T04:05:42.216Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-01-22T04:05:42.216Z] GC before operation: completed in 203.618 ms, heap usage 361.684 MB -> 60.131 MB. [2025-01-22T04:05:56.731Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:05:56.731Z] There is no way to check that no silent failure occurred. [2025-01-22T04:05:56.731Z] ====== als (apache-spark) [default], iteration 6 completed (12914.991 ms) ====== [2025-01-22T04:05:56.731Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-01-22T04:05:56.731Z] GC before operation: completed in 182.423 ms, heap usage 219.461 MB -> 60.268 MB. [2025-01-22T04:06:08.962Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:06:08.962Z] There is no way to check that no silent failure occurred. [2025-01-22T04:06:08.962Z] ====== als (apache-spark) [default], iteration 7 completed (12804.771 ms) ====== [2025-01-22T04:06:08.962Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-01-22T04:06:08.962Z] GC before operation: completed in 188.678 ms, heap usage 256.245 MB -> 60.788 MB. [2025-01-22T04:06:21.373Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:06:21.373Z] There is no way to check that no silent failure occurred. [2025-01-22T04:06:21.373Z] ====== als (apache-spark) [default], iteration 8 completed (12998.014 ms) ====== [2025-01-22T04:06:21.373Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-01-22T04:06:21.373Z] GC before operation: completed in 168.892 ms, heap usage 163.949 MB -> 61.027 MB. [2025-01-22T04:06:35.885Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:06:35.885Z] There is no way to check that no silent failure occurred. [2025-01-22T04:06:35.885Z] ====== als (apache-spark) [default], iteration 9 completed (13208.999 ms) ====== [2025-01-22T04:06:35.885Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-01-22T04:06:35.885Z] GC before operation: completed in 179.716 ms, heap usage 208.194 MB -> 61.333 MB. [2025-01-22T04:06:48.875Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:06:48.875Z] There is no way to check that no silent failure occurred. [2025-01-22T04:06:48.875Z] ====== als (apache-spark) [default], iteration 10 completed (12610.182 ms) ====== [2025-01-22T04:06:48.875Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-01-22T04:06:48.875Z] GC before operation: completed in 147.390 ms, heap usage 191.384 MB -> 61.668 MB. [2025-01-22T04:07:01.129Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:07:01.129Z] There is no way to check that no silent failure occurred. [2025-01-22T04:07:01.129Z] ====== als (apache-spark) [default], iteration 11 completed (12667.320 ms) ====== [2025-01-22T04:07:01.129Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-01-22T04:07:01.129Z] GC before operation: completed in 184.327 ms, heap usage 343.169 MB -> 62.218 MB. [2025-01-22T04:07:13.394Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:07:13.394Z] There is no way to check that no silent failure occurred. [2025-01-22T04:07:13.394Z] ====== als (apache-spark) [default], iteration 12 completed (12598.471 ms) ====== [2025-01-22T04:07:13.394Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-01-22T04:07:13.394Z] GC before operation: completed in 201.692 ms, heap usage 355.657 MB -> 62.718 MB. [2025-01-22T04:07:27.953Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:07:27.953Z] There is no way to check that no silent failure occurred. [2025-01-22T04:07:27.953Z] ====== als (apache-spark) [default], iteration 13 completed (12933.763 ms) ====== [2025-01-22T04:07:27.953Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-01-22T04:07:27.953Z] GC before operation: completed in 170.647 ms, heap usage 258.824 MB -> 62.807 MB. [2025-01-22T04:07:40.293Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:07:40.293Z] There is no way to check that no silent failure occurred. [2025-01-22T04:07:40.293Z] ====== als (apache-spark) [default], iteration 14 completed (12763.768 ms) ====== [2025-01-22T04:07:40.293Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-01-22T04:07:40.293Z] GC before operation: completed in 198.677 ms, heap usage 410.988 MB -> 63.344 MB. [2025-01-22T04:07:54.894Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:07:54.894Z] There is no way to check that no silent failure occurred. [2025-01-22T04:07:54.894Z] ====== als (apache-spark) [default], iteration 15 completed (13813.725 ms) ====== [2025-01-22T04:07:54.894Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-01-22T04:07:54.894Z] GC before operation: completed in 194.860 ms, heap usage 211.690 MB -> 63.315 MB. [2025-01-22T04:08:07.191Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:08:07.191Z] There is no way to check that no silent failure occurred. [2025-01-22T04:08:07.191Z] ====== als (apache-spark) [default], iteration 16 completed (12728.095 ms) ====== [2025-01-22T04:08:07.191Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-01-22T04:08:07.191Z] GC before operation: completed in 239.353 ms, heap usage 277.332 MB -> 63.835 MB. [2025-01-22T04:08:19.461Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:08:19.461Z] There is no way to check that no silent failure occurred. [2025-01-22T04:08:19.461Z] ====== als (apache-spark) [default], iteration 17 completed (12241.946 ms) ====== [2025-01-22T04:08:19.461Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-01-22T04:08:19.461Z] GC before operation: completed in 198.359 ms, heap usage 275.998 MB -> 64.237 MB. [2025-01-22T04:08:32.182Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:08:32.182Z] There is no way to check that no silent failure occurred. [2025-01-22T04:08:32.182Z] ====== als (apache-spark) [default], iteration 18 completed (13476.274 ms) ====== [2025-01-22T04:08:32.182Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-01-22T04:08:32.810Z] GC before operation: completed in 216.343 ms, heap usage 410.828 MB -> 64.464 MB. [2025-01-22T04:08:47.888Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:08:47.888Z] There is no way to check that no silent failure occurred. [2025-01-22T04:08:47.888Z] ====== als (apache-spark) [default], iteration 19 completed (13654.641 ms) ====== [2025-01-22T04:08:47.888Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-01-22T04:08:47.888Z] GC before operation: completed in 195.822 ms, heap usage 430.490 MB -> 64.798 MB. [2025-01-22T04:09:00.185Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:09:00.185Z] There is no way to check that no silent failure occurred. [2025-01-22T04:09:00.185Z] ====== als (apache-spark) [default], iteration 20 completed (12593.425 ms) ====== [2025-01-22T04:09:00.185Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-01-22T04:09:00.185Z] GC before operation: completed in 210.553 ms, heap usage 185.189 MB -> 64.559 MB. [2025-01-22T04:09:12.482Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:09:12.482Z] There is no way to check that no silent failure occurred. [2025-01-22T04:09:12.482Z] ====== als (apache-spark) [default], iteration 21 completed (12954.892 ms) ====== [2025-01-22T04:09:12.482Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-01-22T04:09:12.482Z] GC before operation: completed in 170.655 ms, heap usage 328.751 MB -> 65.108 MB. [2025-01-22T04:09:26.992Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:09:26.992Z] There is no way to check that no silent failure occurred. [2025-01-22T04:09:26.992Z] ====== als (apache-spark) [default], iteration 22 completed (13271.319 ms) ====== [2025-01-22T04:09:26.992Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-01-22T04:09:26.992Z] GC before operation: completed in 196.441 ms, heap usage 306.866 MB -> 65.090 MB. [2025-01-22T04:09:39.450Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:09:39.450Z] There is no way to check that no silent failure occurred. [2025-01-22T04:09:39.450Z] ====== als (apache-spark) [default], iteration 23 completed (13675.337 ms) ====== [2025-01-22T04:09:39.450Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-01-22T04:09:40.076Z] GC before operation: completed in 260.865 ms, heap usage 301.131 MB -> 65.478 MB. [2025-01-22T04:09:52.326Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:09:52.326Z] There is no way to check that no silent failure occurred. [2025-01-22T04:09:52.326Z] ====== als (apache-spark) [default], iteration 24 completed (12516.772 ms) ====== [2025-01-22T04:09:52.326Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-01-22T04:09:52.326Z] GC before operation: completed in 264.786 ms, heap usage 381.085 MB -> 65.688 MB. [2025-01-22T04:10:06.796Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:10:06.796Z] There is no way to check that no silent failure occurred. [2025-01-22T04:10:06.796Z] ====== als (apache-spark) [default], iteration 25 completed (12733.783 ms) ====== [2025-01-22T04:10:06.796Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-01-22T04:10:06.796Z] GC before operation: completed in 146.438 ms, heap usage 350.563 MB -> 65.699 MB. [2025-01-22T04:10:19.121Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:10:19.121Z] There is no way to check that no silent failure occurred. [2025-01-22T04:10:19.121Z] ====== als (apache-spark) [default], iteration 26 completed (12136.114 ms) ====== [2025-01-22T04:10:19.121Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-01-22T04:10:19.121Z] GC before operation: completed in 215.509 ms, heap usage 292.065 MB -> 66.001 MB. [2025-01-22T04:10:31.407Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:10:31.407Z] There is no way to check that no silent failure occurred. [2025-01-22T04:10:31.407Z] ====== als (apache-spark) [default], iteration 27 completed (12508.186 ms) ====== [2025-01-22T04:10:31.407Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-01-22T04:10:31.407Z] GC before operation: completed in 207.673 ms, heap usage 197.928 MB -> 65.825 MB. [2025-01-22T04:10:43.810Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:10:43.810Z] There is no way to check that no silent failure occurred. [2025-01-22T04:10:43.810Z] ====== als (apache-spark) [default], iteration 28 completed (13343.873 ms) ====== [2025-01-22T04:10:43.810Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-01-22T04:10:43.810Z] GC before operation: completed in 181.755 ms, heap usage 259.119 MB -> 66.344 MB. [2025-01-22T04:10:58.882Z] WARNING: This benchmark provides no result that can be validated. [2025-01-22T04:10:58.882Z] There is no way to check that no silent failure occurred. [2025-01-22T04:10:58.882Z] ====== als (apache-spark) [default], iteration 29 completed (13003.900 ms) ====== [2025-01-22T04:10:58.882Z] ----------------------------------- [2025-01-22T04:10:58.882Z] renaissance-als_0_PASSED [2025-01-22T04:10:58.882Z] ----------------------------------- [2025-01-22T04:10:58.882Z] [2025-01-22T04:10:58.882Z] TEST TEARDOWN: [2025-01-22T04:10:58.882Z] Nothing to be done for teardown. [2025-01-22T04:10:58.882Z] renaissance-als_0 Finish Time: Wed Jan 22 04:10:57 2025 Epoch Time (ms): 1737519057253