[2025-03-05T22:43:44.060Z] Running test renaissance-als_0 ... [2025-03-05T22:43:44.060Z] =============================================== [2025-03-05T22:43:44.606Z] renaissance-als_0 Start Time: Wed Mar 5 14:43:43 2025 Epoch Time (ms): 1741214623920 [2025-03-05T22:43:44.606Z] variation: NoOptions [2025-03-05T22:43:44.606Z] JVM_OPTIONS: [2025-03-05T22:43:44.606Z] { \ [2025-03-05T22:43:44.606Z] echo ""; echo "TEST SETUP:"; \ [2025-03-05T22:43:44.606Z] echo "Nothing to be done for setup."; \ [2025-03-05T22:43:44.606Z] mkdir -p "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17412146205632/renaissance-als_0"; \ [2025-03-05T22:43:44.606Z] cd "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17412146205632/renaissance-als_0"; \ [2025-03-05T22:43:44.606Z] echo ""; echo "TESTING:"; \ [2025-03-05T22:43:44.606Z] "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/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_x86-64_mac_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17412146205632/renaissance-als_0"/als.json" als; \ [2025-03-05T22:43:44.606Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/..; rm -f -r "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17412146205632/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-03-05T22:43:44.606Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-03-05T22:43:44.606Z] echo "Nothing to be done for teardown."; \ [2025-03-05T22:43:44.606Z] } 2>&1 | tee -a "/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/../TKG/output_17412146205632/TestTargetResult"; [2025-03-05T22:43:44.606Z] [2025-03-05T22:43:44.606Z] TEST SETUP: [2025-03-05T22:43:44.606Z] Nothing to be done for setup. [2025-03-05T22:43:44.606Z] [2025-03-05T22:43:44.606Z] TESTING: [2025-03-05T22:44:03.780Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-03-05T22:44:11.299Z] NOTE: 'als' benchmark uses Spark local executor with 3 (out of 3) threads. [2025-03-05T22:44:22.738Z] WARNING: An illegal reflective access operation has occurred [2025-03-05T22:44:22.738Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/Users/admin/workspace/workspace/Test_openjdk11_hs_extended.perf_x86-64_mac_testList_0/aqa-tests/TKG/output_17412146205632/renaissance-als_0/harness-144347-7494951512094872559/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2025-03-05T22:44:22.738Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-03-05T22:44:22.738Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-03-05T22:44:22.738Z] WARNING: All illegal access operations will be denied in a future release [2025-03-05T22:44:29.187Z] ====== als (apache-spark) [default], iteration 0 started ====== [2025-03-05T22:44:29.695Z] GC before operation: completed in 181.036 ms, heap usage 120.366 MB -> 33.955 MB. [2025-03-05T22:46:30.910Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:46:30.910Z] There is no way to check that no silent failure occurred. [2025-03-05T22:46:30.910Z] ====== als (apache-spark) [default], iteration 0 completed (112009.493 ms) ====== [2025-03-05T22:46:30.910Z] ====== als (apache-spark) [default], iteration 1 started ====== [2025-03-05T22:46:30.910Z] GC before operation: completed in 346.291 ms, heap usage 678.788 MB -> 56.500 MB. [2025-03-05T22:47:35.624Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:47:35.624Z] There is no way to check that no silent failure occurred. [2025-03-05T22:47:35.624Z] ====== als (apache-spark) [default], iteration 1 completed (67525.087 ms) ====== [2025-03-05T22:47:35.624Z] ====== als (apache-spark) [default], iteration 2 started ====== [2025-03-05T22:47:35.624Z] GC before operation: completed in 961.425 ms, heap usage 572.124 MB -> 58.967 MB. [2025-03-05T22:48:29.423Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:48:29.423Z] There is no way to check that no silent failure occurred. [2025-03-05T22:48:29.423Z] ====== als (apache-spark) [default], iteration 2 completed (55828.332 ms) ====== [2025-03-05T22:48:29.423Z] ====== als (apache-spark) [default], iteration 3 started ====== [2025-03-05T22:48:29.423Z] GC before operation: completed in 331.018 ms, heap usage 340.497 MB -> 59.116 MB. [2025-03-05T22:49:25.383Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:49:25.383Z] There is no way to check that no silent failure occurred. [2025-03-05T22:49:25.383Z] ====== als (apache-spark) [default], iteration 3 completed (56388.459 ms) ====== [2025-03-05T22:49:25.383Z] ====== als (apache-spark) [default], iteration 4 started ====== [2025-03-05T22:49:25.383Z] GC before operation: completed in 290.324 ms, heap usage 201.566 MB -> 59.178 MB. [2025-03-05T22:50:18.906Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:50:18.906Z] There is no way to check that no silent failure occurred. [2025-03-05T22:50:18.906Z] ====== als (apache-spark) [default], iteration 4 completed (48648.229 ms) ====== [2025-03-05T22:50:18.906Z] ====== als (apache-spark) [default], iteration 5 started ====== [2025-03-05T22:50:18.906Z] GC before operation: completed in 742.023 ms, heap usage 358.124 MB -> 59.812 MB. [2025-03-05T22:51:13.532Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:51:13.532Z] There is no way to check that no silent failure occurred. [2025-03-05T22:51:13.532Z] ====== als (apache-spark) [default], iteration 5 completed (53127.497 ms) ====== [2025-03-05T22:51:13.532Z] ====== als (apache-spark) [default], iteration 6 started ====== [2025-03-05T22:51:13.532Z] GC before operation: completed in 415.476 ms, heap usage 430.926 MB -> 60.377 MB. [2025-03-05T22:51:59.967Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:51:59.967Z] There is no way to check that no silent failure occurred. [2025-03-05T22:51:59.967Z] ====== als (apache-spark) [default], iteration 6 completed (52168.692 ms) ====== [2025-03-05T22:51:59.967Z] ====== als (apache-spark) [default], iteration 7 started ====== [2025-03-05T22:51:59.967Z] GC before operation: completed in 424.462 ms, heap usage 237.498 MB -> 60.208 MB. [2025-03-05T22:53:03.933Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:53:03.933Z] There is no way to check that no silent failure occurred. [2025-03-05T22:53:03.933Z] ====== als (apache-spark) [default], iteration 7 completed (58737.019 ms) ====== [2025-03-05T22:53:03.933Z] ====== als (apache-spark) [default], iteration 8 started ====== [2025-03-05T22:53:03.933Z] GC before operation: completed in 396.204 ms, heap usage 468.141 MB -> 61.022 MB. [2025-03-05T22:53:58.496Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:53:58.496Z] There is no way to check that no silent failure occurred. [2025-03-05T22:53:58.496Z] ====== als (apache-spark) [default], iteration 8 completed (52842.501 ms) ====== [2025-03-05T22:53:58.496Z] ====== als (apache-spark) [default], iteration 9 started ====== [2025-03-05T22:53:58.496Z] GC before operation: completed in 406.571 ms, heap usage 481.969 MB -> 61.364 MB. [2025-03-05T22:54:45.271Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:54:45.271Z] There is no way to check that no silent failure occurred. [2025-03-05T22:54:45.271Z] ====== als (apache-spark) [default], iteration 9 completed (52454.889 ms) ====== [2025-03-05T22:54:45.271Z] ====== als (apache-spark) [default], iteration 10 started ====== [2025-03-05T22:54:45.271Z] GC before operation: completed in 310.613 ms, heap usage 449.637 MB -> 61.675 MB. [2025-03-05T22:55:38.715Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:55:38.715Z] There is no way to check that no silent failure occurred. [2025-03-05T22:55:38.715Z] ====== als (apache-spark) [default], iteration 10 completed (49313.890 ms) ====== [2025-03-05T22:55:38.715Z] ====== als (apache-spark) [default], iteration 11 started ====== [2025-03-05T22:55:38.715Z] GC before operation: completed in 414.496 ms, heap usage 192.255 MB -> 61.632 MB. [2025-03-05T22:56:32.268Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:56:32.268Z] There is no way to check that no silent failure occurred. [2025-03-05T22:56:32.268Z] ====== als (apache-spark) [default], iteration 11 completed (54191.896 ms) ====== [2025-03-05T22:56:32.268Z] ====== als (apache-spark) [default], iteration 12 started ====== [2025-03-05T22:56:32.268Z] GC before operation: completed in 410.241 ms, heap usage 501.983 MB -> 62.378 MB. [2025-03-05T22:57:26.970Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:57:26.970Z] There is no way to check that no silent failure occurred. [2025-03-05T22:57:26.970Z] ====== als (apache-spark) [default], iteration 12 completed (56167.600 ms) ====== [2025-03-05T22:57:26.970Z] ====== als (apache-spark) [default], iteration 13 started ====== [2025-03-05T22:57:26.970Z] GC before operation: completed in 278.496 ms, heap usage 429.738 MB -> 62.644 MB. [2025-03-05T22:58:23.239Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:58:23.239Z] There is no way to check that no silent failure occurred. [2025-03-05T22:58:23.239Z] ====== als (apache-spark) [default], iteration 13 completed (54523.409 ms) ====== [2025-03-05T22:58:23.239Z] ====== als (apache-spark) [default], iteration 14 started ====== [2025-03-05T22:58:23.239Z] GC before operation: completed in 418.136 ms, heap usage 153.593 MB -> 62.616 MB. [2025-03-05T22:59:09.719Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:59:09.719Z] There is no way to check that no silent failure occurred. [2025-03-05T22:59:09.719Z] ====== als (apache-spark) [default], iteration 14 completed (48611.351 ms) ====== [2025-03-05T22:59:09.719Z] ====== als (apache-spark) [default], iteration 15 started ====== [2025-03-05T22:59:09.719Z] GC before operation: completed in 312.115 ms, heap usage 345.255 MB -> 63.227 MB. [2025-03-05T22:59:53.786Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T22:59:53.786Z] There is no way to check that no silent failure occurred. [2025-03-05T22:59:53.786Z] ====== als (apache-spark) [default], iteration 15 completed (41603.676 ms) ====== [2025-03-05T22:59:53.786Z] ====== als (apache-spark) [default], iteration 16 started ====== [2025-03-05T22:59:53.786Z] GC before operation: completed in 490.591 ms, heap usage 342.709 MB -> 63.584 MB. [2025-03-05T23:00:31.767Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:00:31.767Z] There is no way to check that no silent failure occurred. [2025-03-05T23:00:31.767Z] ====== als (apache-spark) [default], iteration 16 completed (36711.996 ms) ====== [2025-03-05T23:00:31.767Z] ====== als (apache-spark) [default], iteration 17 started ====== [2025-03-05T23:00:31.767Z] GC before operation: completed in 469.054 ms, heap usage 444.752 MB -> 64.017 MB. [2025-03-05T23:01:09.427Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:01:09.427Z] There is no way to check that no silent failure occurred. [2025-03-05T23:01:09.427Z] ====== als (apache-spark) [default], iteration 17 completed (39033.263 ms) ====== [2025-03-05T23:01:09.427Z] ====== als (apache-spark) [default], iteration 18 started ====== [2025-03-05T23:01:09.427Z] GC before operation: completed in 218.217 ms, heap usage 198.055 MB -> 64.051 MB. [2025-03-05T23:01:54.304Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:01:54.304Z] There is no way to check that no silent failure occurred. [2025-03-05T23:01:54.304Z] ====== als (apache-spark) [default], iteration 18 completed (43239.143 ms) ====== [2025-03-05T23:01:54.304Z] ====== als (apache-spark) [default], iteration 19 started ====== [2025-03-05T23:01:54.304Z] GC before operation: completed in 426.417 ms, heap usage 307.221 MB -> 64.337 MB. [2025-03-05T23:02:32.458Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:02:32.458Z] There is no way to check that no silent failure occurred. [2025-03-05T23:02:32.458Z] ====== als (apache-spark) [default], iteration 19 completed (40308.789 ms) ====== [2025-03-05T23:02:32.458Z] ====== als (apache-spark) [default], iteration 20 started ====== [2025-03-05T23:02:32.458Z] GC before operation: completed in 258.690 ms, heap usage 572.486 MB -> 65.093 MB. [2025-03-05T23:03:10.085Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:03:10.085Z] There is no way to check that no silent failure occurred. [2025-03-05T23:03:10.085Z] ====== als (apache-spark) [default], iteration 20 completed (38622.824 ms) ====== [2025-03-05T23:03:10.086Z] ====== als (apache-spark) [default], iteration 21 started ====== [2025-03-05T23:03:10.605Z] GC before operation: completed in 899.420 ms, heap usage 700.157 MB -> 65.393 MB. [2025-03-05T23:03:56.096Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:03:56.096Z] There is no way to check that no silent failure occurred. [2025-03-05T23:03:56.096Z] ====== als (apache-spark) [default], iteration 21 completed (41025.892 ms) ====== [2025-03-05T23:03:56.096Z] ====== als (apache-spark) [default], iteration 22 started ====== [2025-03-05T23:03:56.096Z] GC before operation: completed in 1165.606 ms, heap usage 255.415 MB -> 64.967 MB. [2025-03-05T23:04:34.406Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:04:34.406Z] There is no way to check that no silent failure occurred. [2025-03-05T23:04:34.406Z] ====== als (apache-spark) [default], iteration 22 completed (40409.641 ms) ====== [2025-03-05T23:04:34.406Z] ====== als (apache-spark) [default], iteration 23 started ====== [2025-03-05T23:04:34.406Z] GC before operation: completed in 274.933 ms, heap usage 677.702 MB -> 65.683 MB. [2025-03-05T23:05:18.676Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:05:18.676Z] There is no way to check that no silent failure occurred. [2025-03-05T23:05:18.676Z] ====== als (apache-spark) [default], iteration 23 completed (41035.411 ms) ====== [2025-03-05T23:05:18.676Z] ====== als (apache-spark) [default], iteration 24 started ====== [2025-03-05T23:05:18.676Z] GC before operation: completed in 1425.949 ms, heap usage 195.849 MB -> 65.248 MB. [2025-03-05T23:06:02.994Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:06:02.994Z] There is no way to check that no silent failure occurred. [2025-03-05T23:06:02.994Z] ====== als (apache-spark) [default], iteration 24 completed (43333.123 ms) ====== [2025-03-05T23:06:02.994Z] ====== als (apache-spark) [default], iteration 25 started ====== [2025-03-05T23:06:02.994Z] GC before operation: completed in 398.643 ms, heap usage 788.311 MB -> 66.327 MB. [2025-03-05T23:06:41.015Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:06:41.015Z] There is no way to check that no silent failure occurred. [2025-03-05T23:06:41.015Z] ====== als (apache-spark) [default], iteration 25 completed (39255.867 ms) ====== [2025-03-05T23:06:41.015Z] ====== als (apache-spark) [default], iteration 26 started ====== [2025-03-05T23:06:41.015Z] GC before operation: completed in 932.664 ms, heap usage 459.214 MB -> 65.913 MB. [2025-03-05T23:07:25.485Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:07:25.485Z] There is no way to check that no silent failure occurred. [2025-03-05T23:07:25.485Z] ====== als (apache-spark) [default], iteration 26 completed (39047.561 ms) ====== [2025-03-05T23:07:25.485Z] ====== als (apache-spark) [default], iteration 27 started ====== [2025-03-05T23:07:25.485Z] GC before operation: completed in 541.198 ms, heap usage 575.725 MB -> 66.335 MB. [2025-03-05T23:08:02.742Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:08:02.742Z] There is no way to check that no silent failure occurred. [2025-03-05T23:08:02.742Z] ====== als (apache-spark) [default], iteration 27 completed (41440.562 ms) ====== [2025-03-05T23:08:02.742Z] ====== als (apache-spark) [default], iteration 28 started ====== [2025-03-05T23:08:02.742Z] GC before operation: completed in 1001.499 ms, heap usage 534.354 MB -> 66.416 MB. [2025-03-05T23:08:56.652Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:08:56.652Z] There is no way to check that no silent failure occurred. [2025-03-05T23:08:56.652Z] ====== als (apache-spark) [default], iteration 28 completed (48968.251 ms) ====== [2025-03-05T23:08:56.652Z] ====== als (apache-spark) [default], iteration 29 started ====== [2025-03-05T23:08:56.652Z] GC before operation: completed in 294.647 ms, heap usage 333.583 MB -> 66.467 MB. [2025-03-05T23:09:28.950Z] WARNING: This benchmark provides no result that can be validated. [2025-03-05T23:09:28.950Z] There is no way to check that no silent failure occurred. [2025-03-05T23:09:28.950Z] ====== als (apache-spark) [default], iteration 29 completed (37276.626 ms) ====== [2025-03-05T23:09:31.376Z] ----------------------------------- [2025-03-05T23:09:31.376Z] renaissance-als_0_PASSED [2025-03-05T23:09:31.376Z] ----------------------------------- [2025-03-05T23:09:31.376Z] [2025-03-05T23:09:31.376Z] TEST TEARDOWN: [2025-03-05T23:09:31.376Z] Nothing to be done for teardown. [2025-03-05T23:09:31.376Z] renaissance-als_0 Finish Time: Wed Mar 5 15:09:30 2025 Epoch Time (ms): 1741216170770