[2024-08-16T19:40:22.911Z] Running test renaissance-als_0 ... [2024-08-16T19:40:22.911Z] =============================================== [2024-08-16T19:40:22.911Z] renaissance-als_0 Start Time: Fri Aug 16 19:40:22 2024 Epoch Time (ms): 1723837222138 [2024-08-16T19:40:22.911Z] variation: NoOptions [2024-08-16T19:40:22.911Z] JVM_OPTIONS: [2024-08-16T19:40:22.911Z] { \ [2024-08-16T19:40:22.911Z] echo ""; echo "TEST SETUP:"; \ [2024-08-16T19:40:22.911Z] echo "Nothing to be done for setup."; \ [2024-08-16T19:40:22.911Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17238371767414/renaissance-als_0"; \ [2024-08-16T19:40:22.911Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17238371767414/renaissance-als_0"; \ [2024-08-16T19:40:22.911Z] echo ""; echo "TESTING:"; \ [2024-08-16T19:40:22.911Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/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_ppc64_aix_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17238371767414/renaissance-als_0"/als.json" als; \ [2024-08-16T19:40:22.911Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17238371767414/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-16T19:40:22.911Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-16T19:40:22.911Z] echo "Nothing to be done for teardown."; \ [2024-08-16T19:40:22.911Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/../TKG/output_17238371767414/TestTargetResult"; [2024-08-16T19:40:22.911Z] [2024-08-16T19:40:22.911Z] TEST SETUP: [2024-08-16T19:40:22.911Z] Nothing to be done for setup. [2024-08-16T19:40:22.911Z] [2024-08-16T19:40:22.911Z] TESTING: [2024-08-16T19:40:27.345Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-16T19:40:29.802Z] NOTE: 'als' benchmark uses Spark local executor with 12 (out of 24) threads. [2024-08-16T19:40:34.242Z] WARNING: An illegal reflective access operation has occurred [2024-08-16T19:40:34.242Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64_aix_testList_0/aqa-tests/TKG/output_17238371767414/renaissance-als_0/harness-194023-7942606702694579220/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-16T19:40:34.242Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-16T19:40:34.242Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-16T19:40:34.242Z] WARNING: All illegal access operations will be denied in a future release [2024-08-16T19:40:37.642Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-16T19:40:37.642Z] GC before operation: completed in 111.608 ms, heap usage 270.786 MB -> 35.292 MB. [2024-08-16T19:40:51.478Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:40:51.478Z] There is no way to check that no silent failure occurred. [2024-08-16T19:40:51.478Z] ====== als (apache-spark) [default], iteration 0 completed (13635.942 ms) ====== [2024-08-16T19:40:51.478Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-16T19:40:51.478Z] GC before operation: completed in 100.711 ms, heap usage 245.746 MB -> 57.466 MB. [2024-08-16T19:40:57.067Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:40:57.067Z] There is no way to check that no silent failure occurred. [2024-08-16T19:40:57.067Z] ====== als (apache-spark) [default], iteration 1 completed (5623.409 ms) ====== [2024-08-16T19:40:57.067Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-16T19:40:57.067Z] GC before operation: completed in 110.159 ms, heap usage 405.222 MB -> 60.216 MB. [2024-08-16T19:41:02.670Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:02.670Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:02.670Z] ====== als (apache-spark) [default], iteration 2 completed (5392.186 ms) ====== [2024-08-16T19:41:02.670Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-16T19:41:02.670Z] GC before operation: completed in 115.514 ms, heap usage 541.754 MB -> 60.869 MB. [2024-08-16T19:41:08.252Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:08.252Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:08.252Z] ====== als (apache-spark) [default], iteration 3 completed (5226.334 ms) ====== [2024-08-16T19:41:08.252Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-16T19:41:08.252Z] GC before operation: completed in 119.687 ms, heap usage 167.736 MB -> 60.658 MB. [2024-08-16T19:41:12.707Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:12.707Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:12.707Z] ====== als (apache-spark) [default], iteration 4 completed (5142.094 ms) ====== [2024-08-16T19:41:12.707Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-16T19:41:12.707Z] GC before operation: completed in 123.060 ms, heap usage 311.557 MB -> 61.303 MB. [2024-08-16T19:41:18.290Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:18.290Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:18.290Z] ====== als (apache-spark) [default], iteration 5 completed (5259.051 ms) ====== [2024-08-16T19:41:18.291Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-16T19:41:18.291Z] GC before operation: completed in 138.005 ms, heap usage 1.365 GB -> 62.875 MB. [2024-08-16T19:41:23.861Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:23.861Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:23.861Z] ====== als (apache-spark) [default], iteration 6 completed (5236.791 ms) ====== [2024-08-16T19:41:23.861Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-16T19:41:23.861Z] GC before operation: completed in 138.217 ms, heap usage 621.777 MB -> 62.356 MB. [2024-08-16T19:41:29.448Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:29.448Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:29.448Z] ====== als (apache-spark) [default], iteration 7 completed (5085.795 ms) ====== [2024-08-16T19:41:29.448Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-16T19:41:29.448Z] GC before operation: completed in 122.192 ms, heap usage 615.364 MB -> 62.622 MB. [2024-08-16T19:41:33.597Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:33.597Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:33.597Z] ====== als (apache-spark) [default], iteration 8 completed (5099.897 ms) ====== [2024-08-16T19:41:33.597Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-16T19:41:34.362Z] GC before operation: completed in 136.249 ms, heap usage 456.694 MB -> 62.832 MB. [2024-08-16T19:41:38.802Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:38.802Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:38.802Z] ====== als (apache-spark) [default], iteration 9 completed (4920.100 ms) ====== [2024-08-16T19:41:38.802Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-16T19:41:38.802Z] GC before operation: completed in 123.398 ms, heap usage 285.449 MB -> 62.890 MB. [2024-08-16T19:41:44.389Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:44.389Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:44.389Z] ====== als (apache-spark) [default], iteration 10 completed (5196.001 ms) ====== [2024-08-16T19:41:44.389Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-16T19:41:44.389Z] GC before operation: completed in 123.050 ms, heap usage 415.117 MB -> 63.372 MB. [2024-08-16T19:41:49.956Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:49.956Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:49.956Z] ====== als (apache-spark) [default], iteration 11 completed (5135.974 ms) ====== [2024-08-16T19:41:49.956Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-16T19:41:49.956Z] GC before operation: completed in 144.188 ms, heap usage 844.415 MB -> 64.329 MB. [2024-08-16T19:41:55.550Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:55.550Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:55.550Z] ====== als (apache-spark) [default], iteration 12 completed (5184.832 ms) ====== [2024-08-16T19:41:55.550Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-16T19:41:55.550Z] GC before operation: completed in 146.735 ms, heap usage 332.164 MB -> 64.101 MB. [2024-08-16T19:41:59.990Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:41:59.990Z] There is no way to check that no silent failure occurred. [2024-08-16T19:41:59.990Z] ====== als (apache-spark) [default], iteration 13 completed (5134.286 ms) ====== [2024-08-16T19:41:59.990Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-16T19:41:59.990Z] GC before operation: completed in 130.205 ms, heap usage 878.320 MB -> 65.116 MB. [2024-08-16T19:42:05.576Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:05.576Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:05.576Z] ====== als (apache-spark) [default], iteration 14 completed (5108.827 ms) ====== [2024-08-16T19:42:05.576Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-16T19:42:05.576Z] GC before operation: completed in 129.633 ms, heap usage 533.407 MB -> 65.023 MB. [2024-08-16T19:42:11.319Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:11.319Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:11.319Z] ====== als (apache-spark) [default], iteration 15 completed (5069.480 ms) ====== [2024-08-16T19:42:11.319Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-16T19:42:11.319Z] GC before operation: completed in 148.596 ms, heap usage 242.474 MB -> 64.981 MB. [2024-08-16T19:42:15.775Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:15.775Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:15.775Z] ====== als (apache-spark) [default], iteration 16 completed (4978.683 ms) ====== [2024-08-16T19:42:15.775Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-16T19:42:15.775Z] GC before operation: completed in 145.806 ms, heap usage 276.665 MB -> 65.304 MB. [2024-08-16T19:42:21.368Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:21.368Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:21.368Z] ====== als (apache-spark) [default], iteration 17 completed (5107.060 ms) ====== [2024-08-16T19:42:21.368Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-16T19:42:21.368Z] GC before operation: completed in 132.136 ms, heap usage 537.275 MB -> 66.214 MB. [2024-08-16T19:42:26.950Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:26.950Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:26.950Z] ====== als (apache-spark) [default], iteration 18 completed (5166.102 ms) ====== [2024-08-16T19:42:26.950Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-16T19:42:26.950Z] GC before operation: completed in 131.126 ms, heap usage 251.906 MB -> 65.693 MB. [2024-08-16T19:42:31.400Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:31.400Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:31.400Z] ====== als (apache-spark) [default], iteration 19 completed (5076.451 ms) ====== [2024-08-16T19:42:31.400Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-16T19:42:31.400Z] GC before operation: completed in 149.198 ms, heap usage 1.587 GB -> 67.667 MB. [2024-08-16T19:42:36.993Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:36.993Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:36.993Z] ====== als (apache-spark) [default], iteration 20 completed (4941.016 ms) ====== [2024-08-16T19:42:36.993Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-16T19:42:36.993Z] GC before operation: completed in 154.954 ms, heap usage 1.326 GB -> 67.378 MB. [2024-08-16T19:42:42.573Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:42.573Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:42.573Z] ====== als (apache-spark) [default], iteration 21 completed (5048.948 ms) ====== [2024-08-16T19:42:42.573Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-16T19:42:42.573Z] GC before operation: completed in 151.055 ms, heap usage 806.438 MB -> 67.138 MB. [2024-08-16T19:42:47.015Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:47.015Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:47.015Z] ====== als (apache-spark) [default], iteration 22 completed (5068.200 ms) ====== [2024-08-16T19:42:47.015Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-16T19:42:47.015Z] GC before operation: completed in 151.698 ms, heap usage 1.337 GB -> 67.797 MB. [2024-08-16T19:42:52.599Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:52.599Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:52.599Z] ====== als (apache-spark) [default], iteration 23 completed (4982.684 ms) ====== [2024-08-16T19:42:52.599Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-16T19:42:52.599Z] GC before operation: completed in 129.494 ms, heap usage 482.078 MB -> 67.217 MB. [2024-08-16T19:42:58.197Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:42:58.197Z] There is no way to check that no silent failure occurred. [2024-08-16T19:42:58.197Z] ====== als (apache-spark) [default], iteration 24 completed (5139.105 ms) ====== [2024-08-16T19:42:58.197Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-16T19:42:58.197Z] GC before operation: completed in 128.529 ms, heap usage 854.720 MB -> 67.849 MB. [2024-08-16T19:43:02.667Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:43:02.667Z] There is no way to check that no silent failure occurred. [2024-08-16T19:43:02.667Z] ====== als (apache-spark) [default], iteration 25 completed (4993.783 ms) ====== [2024-08-16T19:43:02.667Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-16T19:43:02.667Z] GC before operation: completed in 145.994 ms, heap usage 765.141 MB -> 67.692 MB. [2024-08-16T19:43:08.259Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:43:08.259Z] There is no way to check that no silent failure occurred. [2024-08-16T19:43:08.259Z] ====== als (apache-spark) [default], iteration 26 completed (4936.144 ms) ====== [2024-08-16T19:43:08.259Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-16T19:43:08.259Z] GC before operation: completed in 142.112 ms, heap usage 255.673 MB -> 67.423 MB. [2024-08-16T19:43:12.873Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:43:12.873Z] There is no way to check that no silent failure occurred. [2024-08-16T19:43:12.873Z] ====== als (apache-spark) [default], iteration 27 completed (4990.801 ms) ====== [2024-08-16T19:43:12.873Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-16T19:43:12.873Z] GC before operation: completed in 133.629 ms, heap usage 185.220 MB -> 67.440 MB. [2024-08-16T19:43:18.467Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:43:18.467Z] There is no way to check that no silent failure occurred. [2024-08-16T19:43:18.467Z] ====== als (apache-spark) [default], iteration 28 completed (5103.031 ms) ====== [2024-08-16T19:43:18.467Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-16T19:43:18.467Z] GC before operation: completed in 140.554 ms, heap usage 542.798 MB -> 68.343 MB. [2024-08-16T19:43:22.911Z] WARNING: This benchmark provides no result that can be validated. [2024-08-16T19:43:22.911Z] There is no way to check that no silent failure occurred. [2024-08-16T19:43:22.911Z] ====== als (apache-spark) [default], iteration 29 completed (4968.974 ms) ====== [2024-08-16T19:43:23.677Z] ----------------------------------- [2024-08-16T19:43:23.677Z] renaissance-als_0_PASSED [2024-08-16T19:43:23.677Z] ----------------------------------- [2024-08-16T19:43:23.677Z] [2024-08-16T19:43:23.677Z] TEST TEARDOWN: [2024-08-16T19:43:23.677Z] Nothing to be done for teardown. [2024-08-16T19:43:23.677Z] renaissance-als_0 Finish Time: Fri Aug 16 19:43:23 2024 Epoch Time (ms): 1723837403369