[2024-08-28T20:53:30.228Z] Running test renaissance-als_0 ... [2024-08-28T20:53:30.228Z] =============================================== [2024-08-28T20:53:30.585Z] renaissance-als_0 Start Time: Wed Aug 28 16:53:30 2024 Epoch Time (ms): 1724878410213 [2024-08-28T20:53:30.585Z] variation: NoOptions [2024-08-28T20:53:30.585Z] JVM_OPTIONS: [2024-08-28T20:53:30.585Z] { \ [2024-08-28T20:53:30.585Z] echo ""; echo "TEST SETUP:"; \ [2024-08-28T20:53:30.585Z] echo "Nothing to be done for setup."; \ [2024-08-28T20:53:30.585Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1724878409841/renaissance-als_0"; \ [2024-08-28T20:53:30.585Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1724878409841/renaissance-als_0"; \ [2024-08-28T20:53:30.585Z] echo ""; echo "TESTING:"; \ [2024-08-28T20:53:30.585Z] "/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_1724878409841/renaissance-als_0"/als.json" als; \ [2024-08-28T20:53:30.585Z] 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_1724878409841/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-28T20:53:30.585Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-28T20:53:30.585Z] echo "Nothing to be done for teardown."; \ [2024-08-28T20:53:30.585Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_aarch64_mac/aqa-tests/TKG/../TKG/output_1724878409841/TestTargetResult"; [2024-08-28T20:53:30.585Z] [2024-08-28T20:53:30.585Z] TEST SETUP: [2024-08-28T20:53:30.585Z] Nothing to be done for setup. [2024-08-28T20:53:30.585Z] [2024-08-28T20:53:30.585Z] TESTING: [2024-08-28T20:53:32.979Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-28T20:53:35.390Z] NOTE: 'als' benchmark uses Spark local executor with 3 (out of 3) threads. [2024-08-28T20:53:37.895Z] WARNING: An illegal reflective access operation has occurred [2024-08-28T20:53:37.895Z] 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_1724878409841/renaissance-als_0/harness-165330-9881340886288617236/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-28T20:53:37.895Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-28T20:53:37.895Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-28T20:53:37.895Z] WARNING: All illegal access operations will be denied in a future release [2024-08-28T20:53:39.144Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-28T20:53:39.502Z] GC before operation: completed in 43.566 ms, heap usage 86.486 MB -> 33.896 MB. [2024-08-28T20:53:53.227Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:53:53.227Z] There is no way to check that no silent failure occurred. [2024-08-28T20:53:53.227Z] ====== als (apache-spark) [default], iteration 0 completed (11819.436 ms) ====== [2024-08-28T20:53:53.227Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-28T20:53:53.227Z] GC before operation: completed in 59.429 ms, heap usage 228.900 MB -> 55.928 MB. [2024-08-28T20:53:57.303Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:53:57.303Z] There is no way to check that no silent failure occurred. [2024-08-28T20:53:57.303Z] ====== als (apache-spark) [default], iteration 1 completed (5414.980 ms) ====== [2024-08-28T20:53:57.303Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-28T20:53:57.303Z] GC before operation: completed in 66.890 ms, heap usage 404.433 MB -> 58.795 MB. [2024-08-28T20:54:02.428Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:02.428Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:02.428Z] ====== als (apache-spark) [default], iteration 2 completed (4940.155 ms) ====== [2024-08-28T20:54:02.428Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-28T20:54:02.428Z] GC before operation: completed in 69.882 ms, heap usage 270.584 MB -> 59.063 MB. [2024-08-28T20:54:06.636Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:06.636Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:06.636Z] ====== als (apache-spark) [default], iteration 3 completed (4963.043 ms) ====== [2024-08-28T20:54:06.636Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-28T20:54:06.636Z] GC before operation: completed in 68.553 ms, heap usage 460.132 MB -> 59.698 MB. [2024-08-28T20:54:11.669Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:11.669Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:11.669Z] ====== als (apache-spark) [default], iteration 4 completed (4770.137 ms) ====== [2024-08-28T20:54:11.669Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-28T20:54:11.669Z] GC before operation: completed in 64.026 ms, heap usage 368.279 MB -> 59.939 MB. [2024-08-28T20:54:16.829Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:16.829Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:16.829Z] ====== als (apache-spark) [default], iteration 5 completed (4650.060 ms) ====== [2024-08-28T20:54:16.829Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-28T20:54:16.829Z] GC before operation: completed in 90.162 ms, heap usage 430.172 MB -> 60.286 MB. [2024-08-28T20:54:20.907Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:20.907Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:20.907Z] ====== als (apache-spark) [default], iteration 6 completed (4469.585 ms) ====== [2024-08-28T20:54:20.907Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-28T20:54:20.907Z] GC before operation: completed in 81.765 ms, heap usage 185.748 MB -> 60.270 MB. [2024-08-28T20:54:26.047Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:26.047Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:26.047Z] ====== als (apache-spark) [default], iteration 7 completed (4616.815 ms) ====== [2024-08-28T20:54:26.047Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-28T20:54:26.047Z] GC before operation: completed in 61.489 ms, heap usage 384.473 MB -> 60.918 MB. [2024-08-28T20:54:30.075Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:30.075Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:30.075Z] ====== als (apache-spark) [default], iteration 8 completed (4538.015 ms) ====== [2024-08-28T20:54:30.075Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-28T20:54:30.075Z] GC before operation: completed in 72.636 ms, heap usage 172.181 MB -> 61.033 MB. [2024-08-28T20:54:35.212Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:35.212Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:35.212Z] ====== als (apache-spark) [default], iteration 9 completed (4495.154 ms) ====== [2024-08-28T20:54:35.212Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-28T20:54:35.212Z] GC before operation: completed in 65.818 ms, heap usage 187.884 MB -> 61.305 MB. [2024-08-28T20:54:39.438Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:39.438Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:39.438Z] ====== als (apache-spark) [default], iteration 10 completed (4723.131 ms) ====== [2024-08-28T20:54:39.438Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-28T20:54:39.438Z] GC before operation: completed in 66.885 ms, heap usage 469.751 MB -> 62.018 MB. [2024-08-28T20:54:44.559Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:44.559Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:44.559Z] ====== als (apache-spark) [default], iteration 11 completed (4359.311 ms) ====== [2024-08-28T20:54:44.559Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-28T20:54:44.559Z] GC before operation: completed in 62.902 ms, heap usage 380.069 MB -> 62.336 MB. [2024-08-28T20:54:48.619Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:48.619Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:48.619Z] ====== als (apache-spark) [default], iteration 12 completed (4442.051 ms) ====== [2024-08-28T20:54:48.619Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-28T20:54:48.619Z] GC before operation: completed in 94.863 ms, heap usage 138.336 MB -> 62.318 MB. [2024-08-28T20:54:53.767Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:53.767Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:53.767Z] ====== als (apache-spark) [default], iteration 13 completed (4543.082 ms) ====== [2024-08-28T20:54:53.767Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-28T20:54:53.767Z] GC before operation: completed in 68.455 ms, heap usage 402.129 MB -> 62.955 MB. [2024-08-28T20:54:57.869Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:54:57.869Z] There is no way to check that no silent failure occurred. [2024-08-28T20:54:57.870Z] ====== als (apache-spark) [default], iteration 14 completed (4579.530 ms) ====== [2024-08-28T20:54:57.870Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-28T20:54:57.870Z] GC before operation: completed in 85.348 ms, heap usage 376.932 MB -> 63.303 MB. [2024-08-28T20:55:02.937Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:02.938Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:02.938Z] ====== als (apache-spark) [default], iteration 15 completed (4974.638 ms) ====== [2024-08-28T20:55:02.938Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-28T20:55:02.938Z] GC before operation: completed in 106.099 ms, heap usage 371.706 MB -> 63.648 MB. [2024-08-28T20:55:07.111Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:07.111Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:07.111Z] ====== als (apache-spark) [default], iteration 16 completed (4369.733 ms) ====== [2024-08-28T20:55:07.111Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-28T20:55:07.111Z] GC before operation: completed in 75.066 ms, heap usage 360.433 MB -> 64.019 MB. [2024-08-28T20:55:12.381Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:12.381Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:12.381Z] ====== als (apache-spark) [default], iteration 17 completed (4395.788 ms) ====== [2024-08-28T20:55:12.381Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-28T20:55:12.381Z] GC before operation: completed in 78.592 ms, heap usage 244.941 MB -> 64.056 MB. [2024-08-28T20:55:16.502Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:16.502Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:16.502Z] ====== als (apache-spark) [default], iteration 18 completed (4470.691 ms) ====== [2024-08-28T20:55:16.502Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-28T20:55:16.502Z] GC before operation: completed in 78.732 ms, heap usage 205.016 MB -> 64.156 MB. [2024-08-28T20:55:20.645Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:20.645Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:20.645Z] ====== als (apache-spark) [default], iteration 19 completed (4435.141 ms) ====== [2024-08-28T20:55:20.645Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-28T20:55:20.645Z] GC before operation: completed in 81.499 ms, heap usage 287.866 MB -> 64.668 MB. [2024-08-28T20:55:25.774Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:25.774Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:25.774Z] ====== als (apache-spark) [default], iteration 20 completed (4600.516 ms) ====== [2024-08-28T20:55:25.774Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-28T20:55:25.774Z] GC before operation: completed in 69.218 ms, heap usage 380.182 MB -> 64.938 MB. [2024-08-28T20:55:30.966Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:30.966Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:30.966Z] ====== als (apache-spark) [default], iteration 21 completed (4826.696 ms) ====== [2024-08-28T20:55:30.966Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-28T20:55:30.966Z] GC before operation: completed in 76.746 ms, heap usage 357.938 MB -> 65.181 MB. [2024-08-28T20:55:35.039Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:35.039Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:35.039Z] ====== als (apache-spark) [default], iteration 22 completed (4516.750 ms) ====== [2024-08-28T20:55:35.039Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-28T20:55:35.039Z] GC before operation: completed in 73.123 ms, heap usage 208.911 MB -> 65.050 MB. [2024-08-28T20:55:40.141Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:40.141Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:40.141Z] ====== als (apache-spark) [default], iteration 23 completed (4529.013 ms) ====== [2024-08-28T20:55:40.141Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-28T20:55:40.141Z] GC before operation: completed in 66.987 ms, heap usage 176.509 MB -> 65.425 MB. [2024-08-28T20:55:44.270Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:44.270Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:44.270Z] ====== als (apache-spark) [default], iteration 24 completed (4397.978 ms) ====== [2024-08-28T20:55:44.270Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-28T20:55:44.270Z] GC before operation: completed in 86.596 ms, heap usage 271.691 MB -> 65.617 MB. [2024-08-28T20:55:48.517Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:48.517Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:48.517Z] ====== als (apache-spark) [default], iteration 25 completed (4503.456 ms) ====== [2024-08-28T20:55:48.517Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-28T20:55:48.517Z] GC before operation: completed in 75.689 ms, heap usage 200.142 MB -> 65.491 MB. [2024-08-28T20:55:53.589Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:53.589Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:53.589Z] ====== als (apache-spark) [default], iteration 26 completed (4413.690 ms) ====== [2024-08-28T20:55:53.589Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-28T20:55:53.589Z] GC before operation: completed in 89.201 ms, heap usage 654.685 MB -> 66.501 MB. [2024-08-28T20:55:57.727Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:55:57.727Z] There is no way to check that no silent failure occurred. [2024-08-28T20:55:57.727Z] ====== als (apache-spark) [default], iteration 27 completed (4736.927 ms) ====== [2024-08-28T20:55:57.727Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-28T20:55:58.088Z] GC before operation: completed in 85.187 ms, heap usage 363.092 MB -> 66.284 MB. [2024-08-28T20:56:03.200Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:56:03.200Z] There is no way to check that no silent failure occurred. [2024-08-28T20:56:03.200Z] ====== als (apache-spark) [default], iteration 28 completed (4458.045 ms) ====== [2024-08-28T20:56:03.200Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-28T20:56:03.200Z] GC before operation: completed in 84.607 ms, heap usage 289.248 MB -> 66.643 MB. [2024-08-28T20:56:07.294Z] WARNING: This benchmark provides no result that can be validated. [2024-08-28T20:56:07.295Z] There is no way to check that no silent failure occurred. [2024-08-28T20:56:07.295Z] ====== als (apache-spark) [default], iteration 29 completed (4268.348 ms) ====== [2024-08-28T20:56:07.295Z] ----------------------------------- [2024-08-28T20:56:07.295Z] renaissance-als_0_PASSED [2024-08-28T20:56:07.295Z] ----------------------------------- [2024-08-28T20:56:07.295Z] [2024-08-28T20:56:07.295Z] TEST TEARDOWN: [2024-08-28T20:56:07.295Z] Nothing to be done for teardown. [2024-08-28T20:56:07.295Z] renaissance-als_0 Finish Time: Wed Aug 28 16:56:06 2024 Epoch Time (ms): 1724878566910