[2024-10-03T00:34:31.185Z] Running test renaissance-als_0 ... [2024-10-03T00:34:31.185Z] =============================================== [2024-10-03T00:34:31.185Z] renaissance-als_0 Start Time: Wed Oct 2 20:34:30 2024 Epoch Time (ms): 1727915670617 [2024-10-03T00:34:31.185Z] variation: NoOptions [2024-10-03T00:34:31.185Z] JVM_OPTIONS: [2024-10-03T00:34:31.185Z] { \ [2024-10-03T00:34:31.185Z] echo ""; echo "TEST SETUP:"; \ [2024-10-03T00:34:31.185Z] echo "Nothing to be done for setup."; \ [2024-10-03T00:34:31.185Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1727915543675/renaissance-als_0"; \ [2024-10-03T00:34:31.185Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1727915543675/renaissance-als_0"; \ [2024-10-03T00:34:31.185Z] echo ""; echo "TESTING:"; \ [2024-10-03T00:34:31.186Z] "/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_1727915543675/renaissance-als_0"/als.json" als; \ [2024-10-03T00:34:31.186Z] 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_1727915543675/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-10-03T00:34:31.186Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-10-03T00:34:31.186Z] echo "Nothing to be done for teardown."; \ [2024-10-03T00:34:31.186Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_1727915543675/TestTargetResult"; [2024-10-03T00:34:31.186Z] [2024-10-03T00:34:31.186Z] TEST SETUP: [2024-10-03T00:34:31.186Z] Nothing to be done for setup. [2024-10-03T00:34:31.186Z] [2024-10-03T00:34:31.186Z] TESTING: [2024-10-03T00:34:45.147Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-10-03T00:34:53.961Z] NOTE: 'als' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-10-03T00:35:03.770Z] WARNING: An illegal reflective access operation has occurred [2024-10-03T00:35:03.770Z] 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_1727915543675/renaissance-als_0/harness-203435-18021373161784006701/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-10-03T00:35:03.770Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-10-03T00:35:03.770Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-10-03T00:35:03.770Z] WARNING: All illegal access operations will be denied in a future release [2024-10-03T00:35:15.343Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-10-03T00:35:15.343Z] GC before operation: completed in 467.374 ms, heap usage 97.000 MB -> 33.844 MB. [2024-10-03T00:37:05.574Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:37:05.574Z] There is no way to check that no silent failure occurred. [2024-10-03T00:37:05.574Z] ====== als (apache-spark) [default], iteration 0 completed (96020.590 ms) ====== [2024-10-03T00:37:05.574Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-10-03T00:37:05.574Z] GC before operation: completed in 565.501 ms, heap usage 197.937 MB -> 55.856 MB. [2024-10-03T00:37:56.860Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:37:56.860Z] There is no way to check that no silent failure occurred. [2024-10-03T00:37:56.860Z] ====== als (apache-spark) [default], iteration 1 completed (64583.737 ms) ====== [2024-10-03T00:37:56.860Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-10-03T00:37:57.678Z] GC before operation: completed in 1240.225 ms, heap usage 207.844 MB -> 58.454 MB. [2024-10-03T00:38:58.587Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:38:58.587Z] There is no way to check that no silent failure occurred. [2024-10-03T00:38:58.587Z] ====== als (apache-spark) [default], iteration 2 completed (52726.335 ms) ====== [2024-10-03T00:38:58.587Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-10-03T00:38:58.587Z] GC before operation: completed in 849.878 ms, heap usage 281.637 MB -> 59.000 MB. [2024-10-03T00:39:43.173Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:39:43.173Z] There is no way to check that no silent failure occurred. [2024-10-03T00:39:43.173Z] ====== als (apache-spark) [default], iteration 3 completed (49846.385 ms) ====== [2024-10-03T00:39:43.173Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-10-03T00:39:43.173Z] GC before operation: completed in 1022.513 ms, heap usage 322.328 MB -> 59.411 MB. [2024-10-03T00:40:32.891Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:40:32.891Z] There is no way to check that no silent failure occurred. [2024-10-03T00:40:32.891Z] ====== als (apache-spark) [default], iteration 4 completed (48689.078 ms) ====== [2024-10-03T00:40:32.891Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-10-03T00:40:32.891Z] GC before operation: completed in 1381.626 ms, heap usage 343.644 MB -> 59.846 MB. [2024-10-03T00:41:22.391Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:41:22.391Z] There is no way to check that no silent failure occurred. [2024-10-03T00:41:22.391Z] ====== als (apache-spark) [default], iteration 5 completed (47533.515 ms) ====== [2024-10-03T00:41:22.391Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-10-03T00:41:22.391Z] GC before operation: completed in 665.856 ms, heap usage 141.309 MB -> 59.877 MB. [2024-10-03T00:42:05.192Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:42:05.192Z] There is no way to check that no silent failure occurred. [2024-10-03T00:42:05.192Z] ====== als (apache-spark) [default], iteration 6 completed (45057.859 ms) ====== [2024-10-03T00:42:05.192Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-10-03T00:42:06.014Z] GC before operation: completed in 391.338 ms, heap usage 376.575 MB -> 60.567 MB. [2024-10-03T00:42:55.333Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:42:55.333Z] There is no way to check that no silent failure occurred. [2024-10-03T00:42:55.333Z] ====== als (apache-spark) [default], iteration 7 completed (44160.840 ms) ====== [2024-10-03T00:42:55.333Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-10-03T00:42:55.333Z] GC before operation: completed in 777.766 ms, heap usage 464.244 MB -> 61.064 MB. [2024-10-03T00:43:36.859Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:43:36.859Z] There is no way to check that no silent failure occurred. [2024-10-03T00:43:36.859Z] ====== als (apache-spark) [default], iteration 8 completed (41181.392 ms) ====== [2024-10-03T00:43:36.859Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-10-03T00:43:36.859Z] GC before operation: completed in 629.522 ms, heap usage 328.036 MB -> 61.138 MB. [2024-10-03T00:44:15.888Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:44:15.888Z] There is no way to check that no silent failure occurred. [2024-10-03T00:44:15.888Z] ====== als (apache-spark) [default], iteration 9 completed (41992.943 ms) ====== [2024-10-03T00:44:15.888Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-10-03T00:44:15.888Z] GC before operation: completed in 622.324 ms, heap usage 335.686 MB -> 61.501 MB. [2024-10-03T00:45:05.626Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:45:05.626Z] There is no way to check that no silent failure occurred. [2024-10-03T00:45:05.626Z] ====== als (apache-spark) [default], iteration 10 completed (49694.043 ms) ====== [2024-10-03T00:45:05.626Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-10-03T00:45:05.626Z] GC before operation: completed in 458.378 ms, heap usage 161.746 MB -> 61.545 MB. [2024-10-03T00:45:41.325Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:45:41.325Z] There is no way to check that no silent failure occurred. [2024-10-03T00:45:41.325Z] ====== als (apache-spark) [default], iteration 11 completed (32699.104 ms) ====== [2024-10-03T00:45:41.325Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-10-03T00:45:41.325Z] GC before operation: completed in 964.174 ms, heap usage 239.929 MB -> 62.017 MB. [2024-10-03T00:46:24.557Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:46:24.557Z] There is no way to check that no silent failure occurred. [2024-10-03T00:46:24.557Z] ====== als (apache-spark) [default], iteration 12 completed (42004.533 ms) ====== [2024-10-03T00:46:24.557Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-10-03T00:46:24.557Z] GC before operation: completed in 816.932 ms, heap usage 220.120 MB -> 62.366 MB. [2024-10-03T00:47:06.352Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:47:06.353Z] There is no way to check that no silent failure occurred. [2024-10-03T00:47:06.353Z] ====== als (apache-spark) [default], iteration 13 completed (41644.023 ms) ====== [2024-10-03T00:47:06.353Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-10-03T00:47:06.353Z] GC before operation: completed in 376.925 ms, heap usage 288.747 MB -> 62.836 MB. [2024-10-03T00:47:48.757Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:47:48.757Z] There is no way to check that no silent failure occurred. [2024-10-03T00:47:48.757Z] ====== als (apache-spark) [default], iteration 14 completed (43907.812 ms) ====== [2024-10-03T00:47:48.757Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-10-03T00:47:48.757Z] GC before operation: completed in 387.926 ms, heap usage 292.369 MB -> 63.175 MB. [2024-10-03T00:48:25.995Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:48:25.995Z] There is no way to check that no silent failure occurred. [2024-10-03T00:48:25.995Z] ====== als (apache-spark) [default], iteration 15 completed (36041.781 ms) ====== [2024-10-03T00:48:25.995Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-10-03T00:48:25.995Z] GC before operation: completed in 1411.229 ms, heap usage 391.432 MB -> 62.382 MB. [2024-10-03T00:49:10.125Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:49:10.125Z] There is no way to check that no silent failure occurred. [2024-10-03T00:49:10.125Z] ====== als (apache-spark) [default], iteration 16 completed (44127.408 ms) ====== [2024-10-03T00:49:10.125Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-10-03T00:49:10.125Z] GC before operation: completed in 657.164 ms, heap usage 209.690 MB -> 61.117 MB. [2024-10-03T00:49:52.658Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:49:52.658Z] There is no way to check that no silent failure occurred. [2024-10-03T00:49:52.658Z] ====== als (apache-spark) [default], iteration 17 completed (38006.895 ms) ====== [2024-10-03T00:49:52.658Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-10-03T00:49:52.658Z] GC before operation: completed in 806.166 ms, heap usage 299.984 MB -> 61.346 MB. [2024-10-03T00:50:34.814Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:50:34.814Z] There is no way to check that no silent failure occurred. [2024-10-03T00:50:34.814Z] ====== als (apache-spark) [default], iteration 18 completed (40568.626 ms) ====== [2024-10-03T00:50:34.814Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-10-03T00:50:34.814Z] GC before operation: completed in 786.898 ms, heap usage 415.877 MB -> 61.578 MB. [2024-10-03T00:51:25.318Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:51:25.318Z] There is no way to check that no silent failure occurred. [2024-10-03T00:51:25.318Z] ====== als (apache-spark) [default], iteration 19 completed (48407.462 ms) ====== [2024-10-03T00:51:25.318Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-10-03T00:51:25.318Z] GC before operation: completed in 1553.920 ms, heap usage 186.238 MB -> 61.808 MB. [2024-10-03T00:52:02.022Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:52:02.022Z] There is no way to check that no silent failure occurred. [2024-10-03T00:52:02.022Z] ====== als (apache-spark) [default], iteration 20 completed (39436.055 ms) ====== [2024-10-03T00:52:02.022Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-10-03T00:52:02.022Z] GC before operation: completed in 1604.278 ms, heap usage 330.728 MB -> 61.922 MB. [2024-10-03T00:52:44.903Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:52:44.903Z] There is no way to check that no silent failure occurred. [2024-10-03T00:52:44.903Z] ====== als (apache-spark) [default], iteration 21 completed (43169.638 ms) ====== [2024-10-03T00:52:44.903Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-10-03T00:52:45.673Z] GC before operation: completed in 812.139 ms, heap usage 381.544 MB -> 62.240 MB. [2024-10-03T00:53:27.722Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:53:27.723Z] There is no way to check that no silent failure occurred. [2024-10-03T00:53:27.723Z] ====== als (apache-spark) [default], iteration 22 completed (40065.899 ms) ====== [2024-10-03T00:53:27.723Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-10-03T00:53:27.723Z] GC before operation: completed in 1223.991 ms, heap usage 310.103 MB -> 62.230 MB. [2024-10-03T00:54:00.089Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:54:00.089Z] There is no way to check that no silent failure occurred. [2024-10-03T00:54:00.089Z] ====== als (apache-spark) [default], iteration 23 completed (32144.509 ms) ====== [2024-10-03T00:54:00.089Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-10-03T00:54:00.089Z] GC before operation: completed in 767.025 ms, heap usage 372.029 MB -> 62.662 MB. [2024-10-03T00:54:36.028Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:54:36.028Z] There is no way to check that no silent failure occurred. [2024-10-03T00:54:36.028Z] ====== als (apache-spark) [default], iteration 24 completed (35794.127 ms) ====== [2024-10-03T00:54:36.028Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-10-03T00:54:36.028Z] GC before operation: completed in 782.337 ms, heap usage 427.028 MB -> 62.838 MB. [2024-10-03T00:55:18.673Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:55:18.673Z] There is no way to check that no silent failure occurred. [2024-10-03T00:55:18.673Z] ====== als (apache-spark) [default], iteration 25 completed (37056.205 ms) ====== [2024-10-03T00:55:18.673Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-10-03T00:55:18.673Z] GC before operation: completed in 414.918 ms, heap usage 376.434 MB -> 62.839 MB. [2024-10-03T00:55:48.461Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:55:48.461Z] There is no way to check that no silent failure occurred. [2024-10-03T00:55:48.461Z] ====== als (apache-spark) [default], iteration 26 completed (32494.276 ms) ====== [2024-10-03T00:55:48.461Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-10-03T00:55:48.461Z] GC before operation: completed in 979.570 ms, heap usage 417.255 MB -> 63.240 MB. [2024-10-03T00:56:24.652Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:56:24.652Z] There is no way to check that no silent failure occurred. [2024-10-03T00:56:24.652Z] ====== als (apache-spark) [default], iteration 27 completed (37300.196 ms) ====== [2024-10-03T00:56:24.652Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-10-03T00:56:25.580Z] GC before operation: completed in 457.108 ms, heap usage 333.746 MB -> 63.321 MB. [2024-10-03T00:57:00.845Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:57:00.845Z] There is no way to check that no silent failure occurred. [2024-10-03T00:57:00.845Z] ====== als (apache-spark) [default], iteration 28 completed (35109.927 ms) ====== [2024-10-03T00:57:00.845Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-10-03T00:57:01.635Z] GC before operation: completed in 1132.777 ms, heap usage 416.933 MB -> 63.650 MB. [2024-10-03T00:57:37.944Z] WARNING: This benchmark provides no result that can be validated. [2024-10-03T00:57:37.944Z] There is no way to check that no silent failure occurred. [2024-10-03T00:57:37.944Z] ====== als (apache-spark) [default], iteration 29 completed (35293.911 ms) ====== [2024-10-03T00:57:38.632Z] ----------------------------------- [2024-10-03T00:57:38.632Z] renaissance-als_0_PASSED [2024-10-03T00:57:38.632Z] ----------------------------------- [2024-10-03T00:57:38.632Z] [2024-10-03T00:57:38.632Z] TEST TEARDOWN: [2024-10-03T00:57:38.632Z] Nothing to be done for teardown. [2024-10-03T00:57:38.632Z] renaissance-als_0 Finish Time: Wed Oct 2 20:57:38 2024 Epoch Time (ms): 1727917058279