[2024-08-21T21:08:51.868Z] Running test renaissance-als_0 ... [2024-08-21T21:08:51.868Z] =============================================== [2024-08-21T21:08:51.868Z] renaissance-als_0 Start Time: Wed Aug 21 21:08:51 2024 Epoch Time (ms): 1724274531265 [2024-08-21T21:08:51.868Z] variation: NoOptions [2024-08-21T21:08:51.868Z] JVM_OPTIONS: [2024-08-21T21:08:51.868Z] { \ [2024-08-21T21:08:51.868Z] echo ""; echo "TEST SETUP:"; \ [2024-08-21T21:08:51.868Z] echo "Nothing to be done for setup."; \ [2024-08-21T21:08:51.868Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17242744846193/renaissance-als_0"; \ [2024-08-21T21:08:51.868Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17242744846193/renaissance-als_0"; \ [2024-08-21T21:08:51.868Z] echo ""; echo "TESTING:"; \ [2024-08-21T21:08:51.869Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_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_ppc64le_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17242744846193/renaissance-als_0"/als.json" als; \ [2024-08-21T21:08:51.869Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17242744846193/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-21T21:08:51.869Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-21T21:08:51.869Z] echo "Nothing to be done for teardown."; \ [2024-08-21T21:08:51.869Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/../TKG/output_17242744846193/TestTargetResult"; [2024-08-21T21:08:51.869Z] [2024-08-21T21:08:51.869Z] TEST SETUP: [2024-08-21T21:08:51.869Z] Nothing to be done for setup. [2024-08-21T21:08:51.869Z] [2024-08-21T21:08:51.869Z] TESTING: [2024-08-21T21:08:55.887Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-21T21:08:56.828Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-21T21:09:00.842Z] WARNING: An illegal reflective access operation has occurred [2024-08-21T21:09:00.842Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux/aqa-tests/TKG/output_17242744846193/renaissance-als_0/harness-210852-16848269583402260030/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-21T21:09:00.842Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-21T21:09:00.842Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-21T21:09:00.842Z] WARNING: All illegal access operations will be denied in a future release [2024-08-21T21:09:02.730Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-21T21:09:02.730Z] GC before operation: completed in 60.888 ms, heap usage 87.252 MB -> 33.802 MB. [2024-08-21T21:09:20.723Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:09:20.723Z] There is no way to check that no silent failure occurred. [2024-08-21T21:09:20.723Z] ====== als (apache-spark) [default], iteration 0 completed (17802.123 ms) ====== [2024-08-21T21:09:20.723Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-21T21:09:20.723Z] GC before operation: completed in 118.173 ms, heap usage 261.642 MB -> 56.017 MB. [2024-08-21T21:09:30.207Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:09:30.207Z] There is no way to check that no silent failure occurred. [2024-08-21T21:09:30.207Z] ====== als (apache-spark) [default], iteration 1 completed (8513.773 ms) ====== [2024-08-21T21:09:30.207Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-21T21:09:30.207Z] GC before operation: completed in 109.931 ms, heap usage 251.857 MB -> 58.577 MB. [2024-08-21T21:09:38.112Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:09:38.112Z] There is no way to check that no silent failure occurred. [2024-08-21T21:09:38.112Z] ====== als (apache-spark) [default], iteration 2 completed (7915.845 ms) ====== [2024-08-21T21:09:38.112Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-21T21:09:38.112Z] GC before operation: completed in 108.765 ms, heap usage 414.491 MB -> 59.275 MB. [2024-08-21T21:09:46.040Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:09:46.040Z] There is no way to check that no silent failure occurred. [2024-08-21T21:09:46.040Z] ====== als (apache-spark) [default], iteration 3 completed (7816.695 ms) ====== [2024-08-21T21:09:46.040Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-21T21:09:46.041Z] GC before operation: completed in 105.015 ms, heap usage 509.343 MB -> 59.673 MB. [2024-08-21T21:09:53.268Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:09:53.268Z] There is no way to check that no silent failure occurred. [2024-08-21T21:09:53.268Z] ====== als (apache-spark) [default], iteration 4 completed (7696.336 ms) ====== [2024-08-21T21:09:53.268Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-21T21:09:53.268Z] GC before operation: completed in 116.184 ms, heap usage 429.033 MB -> 59.890 MB. [2024-08-21T21:10:01.232Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:01.232Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:01.232Z] ====== als (apache-spark) [default], iteration 5 completed (7698.356 ms) ====== [2024-08-21T21:10:01.232Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-21T21:10:01.232Z] GC before operation: completed in 113.167 ms, heap usage 213.040 MB -> 59.865 MB. [2024-08-21T21:10:09.159Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:09.159Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:09.159Z] ====== als (apache-spark) [default], iteration 6 completed (7809.575 ms) ====== [2024-08-21T21:10:09.159Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-21T21:10:09.159Z] GC before operation: completed in 113.550 ms, heap usage 202.102 MB -> 60.229 MB. [2024-08-21T21:10:17.084Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:17.084Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:17.084Z] ====== als (apache-spark) [default], iteration 7 completed (7642.335 ms) ====== [2024-08-21T21:10:17.084Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-21T21:10:17.084Z] GC before operation: completed in 117.833 ms, heap usage 694.376 MB -> 61.242 MB. [2024-08-21T21:10:25.011Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:25.011Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:25.011Z] ====== als (apache-spark) [default], iteration 8 completed (7559.565 ms) ====== [2024-08-21T21:10:25.011Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-21T21:10:25.011Z] GC before operation: completed in 112.364 ms, heap usage 340.616 MB -> 61.213 MB. [2024-08-21T21:10:32.983Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:32.983Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:32.983Z] ====== als (apache-spark) [default], iteration 9 completed (7530.575 ms) ====== [2024-08-21T21:10:32.983Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-21T21:10:32.983Z] GC before operation: completed in 117.682 ms, heap usage 526.449 MB -> 61.813 MB. [2024-08-21T21:10:40.899Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:40.899Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:40.899Z] ====== als (apache-spark) [default], iteration 10 completed (7736.120 ms) ====== [2024-08-21T21:10:40.899Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-21T21:10:40.899Z] GC before operation: completed in 118.545 ms, heap usage 176.928 MB -> 61.598 MB. [2024-08-21T21:10:47.427Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:47.427Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:47.427Z] ====== als (apache-spark) [default], iteration 11 completed (7515.039 ms) ====== [2024-08-21T21:10:47.427Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-21T21:10:47.427Z] GC before operation: completed in 120.429 ms, heap usage 224.015 MB -> 61.969 MB. [2024-08-21T21:10:55.347Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:10:55.347Z] There is no way to check that no silent failure occurred. [2024-08-21T21:10:55.347Z] ====== als (apache-spark) [default], iteration 12 completed (7480.253 ms) ====== [2024-08-21T21:10:55.347Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-21T21:10:55.347Z] GC before operation: completed in 118.480 ms, heap usage 513.750 MB -> 62.828 MB. [2024-08-21T21:11:02.915Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:02.915Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:02.915Z] ====== als (apache-spark) [default], iteration 13 completed (7674.871 ms) ====== [2024-08-21T21:11:02.915Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-21T21:11:02.915Z] GC before operation: completed in 119.606 ms, heap usage 340.362 MB -> 62.906 MB. [2024-08-21T21:11:10.822Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:10.822Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:10.822Z] ====== als (apache-spark) [default], iteration 14 completed (7612.352 ms) ====== [2024-08-21T21:11:10.822Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-21T21:11:10.822Z] GC before operation: completed in 131.806 ms, heap usage 222.481 MB -> 63.116 MB. [2024-08-21T21:11:18.730Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:18.730Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:18.730Z] ====== als (apache-spark) [default], iteration 15 completed (7625.129 ms) ====== [2024-08-21T21:11:18.730Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-21T21:11:18.730Z] GC before operation: completed in 121.195 ms, heap usage 265.015 MB -> 63.520 MB. [2024-08-21T21:11:26.651Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:26.651Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:26.651Z] ====== als (apache-spark) [default], iteration 16 completed (7647.635 ms) ====== [2024-08-21T21:11:26.651Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-21T21:11:26.651Z] GC before operation: completed in 116.485 ms, heap usage 227.736 MB -> 63.650 MB. [2024-08-21T21:11:34.598Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:34.598Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:34.598Z] ====== als (apache-spark) [default], iteration 17 completed (7592.158 ms) ====== [2024-08-21T21:11:34.598Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-21T21:11:34.598Z] GC before operation: completed in 114.477 ms, heap usage 244.174 MB -> 64.142 MB. [2024-08-21T21:11:42.507Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:42.507Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:42.507Z] ====== als (apache-spark) [default], iteration 18 completed (7527.237 ms) ====== [2024-08-21T21:11:42.507Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-21T21:11:42.507Z] GC before operation: completed in 120.761 ms, heap usage 328.701 MB -> 64.417 MB. [2024-08-21T21:11:49.006Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:49.006Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:49.006Z] ====== als (apache-spark) [default], iteration 19 completed (7521.724 ms) ====== [2024-08-21T21:11:49.006Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-21T21:11:49.006Z] GC before operation: completed in 121.767 ms, heap usage 193.263 MB -> 64.425 MB. [2024-08-21T21:11:56.954Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:11:56.954Z] There is no way to check that no silent failure occurred. [2024-08-21T21:11:56.954Z] ====== als (apache-spark) [default], iteration 20 completed (7494.508 ms) ====== [2024-08-21T21:11:56.954Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-21T21:11:56.954Z] GC before operation: completed in 125.215 ms, heap usage 467.490 MB -> 64.885 MB. [2024-08-21T21:12:04.870Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:04.870Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:04.870Z] ====== als (apache-spark) [default], iteration 21 completed (7586.625 ms) ====== [2024-08-21T21:12:04.870Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-21T21:12:04.870Z] GC before operation: completed in 125.218 ms, heap usage 432.153 MB -> 65.189 MB. [2024-08-21T21:12:12.381Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:12.381Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:12.381Z] ====== als (apache-spark) [default], iteration 22 completed (7566.739 ms) ====== [2024-08-21T21:12:12.381Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-21T21:12:12.381Z] GC before operation: completed in 120.609 ms, heap usage 322.141 MB -> 65.302 MB. [2024-08-21T21:12:20.310Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:20.310Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:20.310Z] ====== als (apache-spark) [default], iteration 23 completed (7348.053 ms) ====== [2024-08-21T21:12:20.310Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-21T21:12:20.310Z] GC before operation: completed in 123.624 ms, heap usage 280.607 MB -> 65.439 MB. [2024-08-21T21:12:28.227Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:28.227Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:28.227Z] ====== als (apache-spark) [default], iteration 24 completed (7473.227 ms) ====== [2024-08-21T21:12:28.228Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-21T21:12:28.228Z] GC before operation: completed in 119.137 ms, heap usage 196.209 MB -> 65.386 MB. [2024-08-21T21:12:34.738Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:34.738Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:34.738Z] ====== als (apache-spark) [default], iteration 25 completed (7580.734 ms) ====== [2024-08-21T21:12:34.738Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-21T21:12:34.738Z] GC before operation: completed in 120.862 ms, heap usage 279.791 MB -> 65.652 MB. [2024-08-21T21:12:42.656Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:42.656Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:42.656Z] ====== als (apache-spark) [default], iteration 26 completed (7507.070 ms) ====== [2024-08-21T21:12:42.656Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-21T21:12:42.656Z] GC before operation: completed in 117.338 ms, heap usage 207.582 MB -> 65.804 MB. [2024-08-21T21:12:50.569Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:50.569Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:50.569Z] ====== als (apache-spark) [default], iteration 27 completed (7399.318 ms) ====== [2024-08-21T21:12:50.569Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-21T21:12:50.569Z] GC before operation: completed in 117.680 ms, heap usage 248.561 MB -> 65.946 MB. [2024-08-21T21:12:58.492Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:12:58.492Z] There is no way to check that no silent failure occurred. [2024-08-21T21:12:58.492Z] ====== als (apache-spark) [default], iteration 28 completed (7372.020 ms) ====== [2024-08-21T21:12:58.492Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-21T21:12:58.492Z] GC before operation: completed in 123.012 ms, heap usage 340.753 MB -> 66.575 MB. [2024-08-21T21:13:05.016Z] WARNING: This benchmark provides no result that can be validated. [2024-08-21T21:13:05.016Z] There is no way to check that no silent failure occurred. [2024-08-21T21:13:05.016Z] ====== als (apache-spark) [default], iteration 29 completed (7564.491 ms) ====== [2024-08-21T21:13:06.181Z] ----------------------------------- [2024-08-21T21:13:06.181Z] renaissance-als_0_PASSED [2024-08-21T21:13:06.181Z] ----------------------------------- [2024-08-21T21:13:06.181Z] [2024-08-21T21:13:06.181Z] TEST TEARDOWN: [2024-08-21T21:13:06.181Z] Nothing to be done for teardown. [2024-08-21T21:13:06.181Z] renaissance-als_0 Finish Time: Wed Aug 21 21:13:05 2024 Epoch Time (ms): 1724274785611