[2024-09-25T21:04:17.190Z] Running test renaissance-als_0 ... [2024-09-25T21:04:17.190Z] =============================================== [2024-09-25T21:04:17.190Z] renaissance-als_0 Start Time: Wed Sep 25 17:04:16 2024 Epoch Time (ms): 1727298256824 [2024-09-25T21:04:17.190Z] variation: NoOptions [2024-09-25T21:04:17.190Z] JVM_OPTIONS: [2024-09-25T21:04:17.190Z] { \ [2024-09-25T21:04:17.190Z] echo ""; echo "TEST SETUP:"; \ [2024-09-25T21:04:17.190Z] echo "Nothing to be done for setup."; \ [2024-09-25T21:04:17.190Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-als_0"; \ [2024-09-25T21:04:17.190Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-als_0"; \ [2024-09-25T21:04:17.190Z] echo ""; echo "TESTING:"; \ [2024-09-25T21:04:17.190Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/jdkbinary/j2sdk-image/Contents/Home/bin/..//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 "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-als_0"/als.json" als; \ [2024-09-25T21:04:17.190Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-25T21:04:17.190Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-25T21:04:17.190Z] echo "Nothing to be done for teardown."; \ [2024-09-25T21:04:17.190Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_17272982564732/TestTargetResult"; [2024-09-25T21:04:17.190Z] [2024-09-25T21:04:17.190Z] TEST SETUP: [2024-09-25T21:04:17.190Z] Nothing to be done for setup. [2024-09-25T21:04:17.190Z] [2024-09-25T21:04:17.190Z] TESTING: [2024-09-25T21:04:20.319Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-25T21:04:22.121Z] NOTE: 'als' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-09-25T21:04:23.900Z] WARNING: An illegal reflective access operation has occurred [2024-09-25T21:04:23.900Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/output_17272982564732/renaissance-als_0/harness-170417-14510985342420868276/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-09-25T21:04:23.900Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-09-25T21:04:23.900Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-09-25T21:04:23.900Z] WARNING: All illegal access operations will be denied in a future release [2024-09-25T21:04:25.151Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-09-25T21:04:25.151Z] GC before operation: completed in 26.738 ms, heap usage 91.009 MB -> 33.900 MB. [2024-09-25T21:04:36.480Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:04:36.480Z] There is no way to check that no silent failure occurred. [2024-09-25T21:04:36.480Z] ====== als (apache-spark) [default], iteration 0 completed (10463.189 ms) ====== [2024-09-25T21:04:36.480Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-09-25T21:04:36.480Z] GC before operation: completed in 55.872 ms, heap usage 282.254 MB -> 56.121 MB. [2024-09-25T21:04:40.591Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:04:40.591Z] There is no way to check that no silent failure occurred. [2024-09-25T21:04:40.591Z] ====== als (apache-spark) [default], iteration 1 completed (4588.534 ms) ====== [2024-09-25T21:04:40.591Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-09-25T21:04:40.591Z] GC before operation: completed in 49.718 ms, heap usage 203.387 MB -> 58.469 MB. [2024-09-25T21:04:45.726Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:04:45.727Z] There is no way to check that no silent failure occurred. [2024-09-25T21:04:45.727Z] ====== als (apache-spark) [default], iteration 2 completed (4797.629 ms) ====== [2024-09-25T21:04:45.727Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-09-25T21:04:45.727Z] GC before operation: completed in 55.531 ms, heap usage 433.626 MB -> 59.162 MB. [2024-09-25T21:04:49.832Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:04:49.832Z] There is no way to check that no silent failure occurred. [2024-09-25T21:04:49.832Z] ====== als (apache-spark) [default], iteration 3 completed (4588.617 ms) ====== [2024-09-25T21:04:49.832Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-09-25T21:04:49.832Z] GC before operation: completed in 59.120 ms, heap usage 288.209 MB -> 59.558 MB. [2024-09-25T21:04:54.979Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:04:54.979Z] There is no way to check that no silent failure occurred. [2024-09-25T21:04:54.979Z] ====== als (apache-spark) [default], iteration 4 completed (4748.924 ms) ====== [2024-09-25T21:04:54.979Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-09-25T21:04:54.979Z] GC before operation: completed in 68.977 ms, heap usage 352.814 MB -> 59.884 MB. [2024-09-25T21:05:00.123Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:00.123Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:00.123Z] ====== als (apache-spark) [default], iteration 5 completed (4847.959 ms) ====== [2024-09-25T21:05:00.123Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-09-25T21:05:00.123Z] GC before operation: completed in 72.591 ms, heap usage 444.145 MB -> 60.827 MB. [2024-09-25T21:05:04.263Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:04.263Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:04.263Z] ====== als (apache-spark) [default], iteration 6 completed (4521.580 ms) ====== [2024-09-25T21:05:04.263Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-09-25T21:05:04.263Z] GC before operation: completed in 71.888 ms, heap usage 317.560 MB -> 60.493 MB. [2024-09-25T21:05:09.438Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:09.438Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:09.438Z] ====== als (apache-spark) [default], iteration 7 completed (4537.918 ms) ====== [2024-09-25T21:05:09.438Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-09-25T21:05:09.438Z] GC before operation: completed in 67.566 ms, heap usage 476.651 MB -> 61.090 MB. [2024-09-25T21:05:13.486Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:13.486Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:13.486Z] ====== als (apache-spark) [default], iteration 8 completed (4371.258 ms) ====== [2024-09-25T21:05:13.486Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-09-25T21:05:13.486Z] GC before operation: completed in 74.196 ms, heap usage 358.398 MB -> 61.277 MB. [2024-09-25T21:05:18.621Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:18.621Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:18.621Z] ====== als (apache-spark) [default], iteration 9 completed (4543.355 ms) ====== [2024-09-25T21:05:18.621Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-09-25T21:05:18.621Z] GC before operation: completed in 65.562 ms, heap usage 317.671 MB -> 61.502 MB. [2024-09-25T21:05:22.672Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:22.672Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:22.672Z] ====== als (apache-spark) [default], iteration 10 completed (4151.295 ms) ====== [2024-09-25T21:05:22.672Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-09-25T21:05:22.672Z] GC before operation: completed in 72.932 ms, heap usage 181.856 MB -> 61.668 MB. [2024-09-25T21:05:26.751Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:26.751Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:26.751Z] ====== als (apache-spark) [default], iteration 11 completed (4316.486 ms) ====== [2024-09-25T21:05:26.751Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-09-25T21:05:26.751Z] GC before operation: completed in 73.258 ms, heap usage 346.673 MB -> 62.285 MB. [2024-09-25T21:05:31.844Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:31.844Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:31.844Z] ====== als (apache-spark) [default], iteration 12 completed (4609.357 ms) ====== [2024-09-25T21:05:31.844Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-09-25T21:05:31.844Z] GC before operation: completed in 61.266 ms, heap usage 254.372 MB -> 62.492 MB. [2024-09-25T21:05:36.025Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:36.025Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:36.025Z] ====== als (apache-spark) [default], iteration 13 completed (4467.450 ms) ====== [2024-09-25T21:05:36.025Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-09-25T21:05:36.025Z] GC before operation: completed in 70.532 ms, heap usage 360.076 MB -> 63.054 MB. [2024-09-25T21:05:40.211Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:40.212Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:40.212Z] ====== als (apache-spark) [default], iteration 14 completed (4570.182 ms) ====== [2024-09-25T21:05:40.212Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-09-25T21:05:40.603Z] GC before operation: completed in 64.238 ms, heap usage 290.253 MB -> 63.297 MB. [2024-09-25T21:05:45.794Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:45.794Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:45.794Z] ====== als (apache-spark) [default], iteration 15 completed (4527.919 ms) ====== [2024-09-25T21:05:45.794Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-09-25T21:05:45.794Z] GC before operation: completed in 68.656 ms, heap usage 348.424 MB -> 63.687 MB. [2024-09-25T21:05:49.973Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:49.973Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:49.973Z] ====== als (apache-spark) [default], iteration 16 completed (4430.084 ms) ====== [2024-09-25T21:05:49.973Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-09-25T21:05:49.973Z] GC before operation: completed in 65.163 ms, heap usage 281.610 MB -> 64.056 MB. [2024-09-25T21:05:54.161Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:54.161Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:54.161Z] ====== als (apache-spark) [default], iteration 17 completed (4281.588 ms) ====== [2024-09-25T21:05:54.161Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-09-25T21:05:54.161Z] GC before operation: completed in 64.871 ms, heap usage 225.141 MB -> 64.137 MB. [2024-09-25T21:05:58.362Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:05:58.362Z] There is no way to check that no silent failure occurred. [2024-09-25T21:05:58.362Z] ====== als (apache-spark) [default], iteration 18 completed (4416.060 ms) ====== [2024-09-25T21:05:58.362Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-09-25T21:05:58.362Z] GC before operation: completed in 77.174 ms, heap usage 591.157 MB -> 64.726 MB. [2024-09-25T21:06:03.516Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:03.516Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:03.516Z] ====== als (apache-spark) [default], iteration 19 completed (4532.565 ms) ====== [2024-09-25T21:06:03.516Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-09-25T21:06:03.516Z] GC before operation: completed in 76.373 ms, heap usage 371.707 MB -> 64.854 MB. [2024-09-25T21:06:07.560Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:07.560Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:07.560Z] ====== als (apache-spark) [default], iteration 20 completed (4513.380 ms) ====== [2024-09-25T21:06:07.560Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-09-25T21:06:07.560Z] GC before operation: completed in 66.403 ms, heap usage 395.106 MB -> 64.849 MB. [2024-09-25T21:06:12.704Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:12.704Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:12.704Z] ====== als (apache-spark) [default], iteration 21 completed (4381.502 ms) ====== [2024-09-25T21:06:12.704Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-09-25T21:06:12.704Z] GC before operation: completed in 63.580 ms, heap usage 166.529 MB -> 64.901 MB. [2024-09-25T21:06:16.880Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:16.880Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:16.880Z] ====== als (apache-spark) [default], iteration 22 completed (4241.604 ms) ====== [2024-09-25T21:06:16.880Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-09-25T21:06:16.880Z] GC before operation: completed in 67.286 ms, heap usage 244.452 MB -> 65.050 MB. [2024-09-25T21:06:21.001Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:21.002Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:21.002Z] ====== als (apache-spark) [default], iteration 23 completed (4232.978 ms) ====== [2024-09-25T21:06:21.002Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-09-25T21:06:21.002Z] GC before operation: completed in 65.833 ms, heap usage 367.293 MB -> 65.667 MB. [2024-09-25T21:06:25.101Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:25.101Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:25.101Z] ====== als (apache-spark) [default], iteration 24 completed (4373.339 ms) ====== [2024-09-25T21:06:25.101Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-09-25T21:06:25.101Z] GC before operation: completed in 66.492 ms, heap usage 327.375 MB -> 65.702 MB. [2024-09-25T21:06:30.220Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:30.220Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:30.220Z] ====== als (apache-spark) [default], iteration 25 completed (4496.386 ms) ====== [2024-09-25T21:06:30.220Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-09-25T21:06:30.220Z] GC before operation: completed in 70.865 ms, heap usage 297.704 MB -> 65.680 MB. [2024-09-25T21:06:34.428Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:34.428Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:34.428Z] ====== als (apache-spark) [default], iteration 26 completed (4241.908 ms) ====== [2024-09-25T21:06:34.428Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-09-25T21:06:34.428Z] GC before operation: completed in 77.220 ms, heap usage 324.351 MB -> 66.031 MB. [2024-09-25T21:06:38.601Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:38.601Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:38.601Z] ====== als (apache-spark) [default], iteration 27 completed (4149.377 ms) ====== [2024-09-25T21:06:38.601Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-09-25T21:06:38.601Z] GC before operation: completed in 69.268 ms, heap usage 365.049 MB -> 66.274 MB. [2024-09-25T21:06:42.699Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:42.699Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:42.699Z] ====== als (apache-spark) [default], iteration 28 completed (4180.675 ms) ====== [2024-09-25T21:06:42.699Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-09-25T21:06:42.700Z] GC before operation: completed in 66.770 ms, heap usage 410.818 MB -> 66.600 MB. [2024-09-25T21:06:46.763Z] WARNING: This benchmark provides no result that can be validated. [2024-09-25T21:06:46.763Z] There is no way to check that no silent failure occurred. [2024-09-25T21:06:46.763Z] ====== als (apache-spark) [default], iteration 29 completed (4260.591 ms) ====== [2024-09-25T21:06:47.126Z] ----------------------------------- [2024-09-25T21:06:47.126Z] renaissance-als_0_PASSED [2024-09-25T21:06:47.126Z] ----------------------------------- [2024-09-25T21:06:47.126Z] [2024-09-25T21:06:47.126Z] TEST TEARDOWN: [2024-09-25T21:06:47.126Z] Nothing to be done for teardown. [2024-09-25T21:06:47.126Z] renaissance-als_0 Finish Time: Wed Sep 25 17:06:46 2024 Epoch Time (ms): 1727298406985