[2024-06-27T02:59:07.579Z] Running test renaissance-als_0 ... [2024-06-27T02:59:07.579Z] =============================================== [2024-06-27T02:59:07.579Z] renaissance-als_0 Start Time: Thu Jun 27 02:59:06 2024 Epoch Time (ms): 1719457146760 [2024-06-27T02:59:07.579Z] variation: NoOptions [2024-06-27T02:59:07.579Z] JVM_OPTIONS: [2024-06-27T02:59:07.579Z] { \ [2024-06-27T02:59:07.579Z] echo ""; echo "TEST SETUP:"; \ [2024-06-27T02:59:07.579Z] echo "Nothing to be done for setup."; \ [2024-06-27T02:59:07.579Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_1719457098935/renaissance-als_0"; \ [2024-06-27T02:59:07.579Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_1719457098935/renaissance-als_0"; \ [2024-06-27T02:59:07.579Z] echo ""; echo "TESTING:"; \ [2024-06-27T02:59:07.579Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_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_ppc64le_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_1719457098935/renaissance-als_0"/als.json" als; \ [2024-06-27T02:59:07.579Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_1719457098935/renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-06-27T02:59:07.579Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-06-27T02:59:07.579Z] echo "Nothing to be done for teardown."; \ [2024-06-27T02:59:07.579Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/../TKG/output_1719457098935/TestTargetResult"; [2024-06-27T02:59:07.579Z] [2024-06-27T02:59:07.579Z] TEST SETUP: [2024-06-27T02:59:07.579Z] Nothing to be done for setup. [2024-06-27T02:59:07.579Z] [2024-06-27T02:59:07.579Z] TESTING: [2024-06-27T02:59:10.527Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-06-27T02:59:12.441Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-06-27T02:59:17.389Z] WARNING: An illegal reflective access operation has occurred [2024-06-27T02:59:17.389Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_ppc64le_linux_testList_0/aqa-tests/TKG/output_1719457098935/renaissance-als_0/harness-025907-5068912871692989224/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-06-27T02:59:17.389Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-06-27T02:59:17.389Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-06-27T02:59:17.389Z] WARNING: All illegal access operations will be denied in a future release [2024-06-27T02:59:18.321Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-06-27T02:59:18.321Z] GC before operation: completed in 65.441 ms, heap usage 86.001 MB -> 33.809 MB. [2024-06-27T02:59:36.380Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T02:59:36.380Z] There is no way to check that no silent failure occurred. [2024-06-27T02:59:36.380Z] ====== als (apache-spark) [default], iteration 0 completed (17855.875 ms) ====== [2024-06-27T02:59:36.380Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-06-27T02:59:36.380Z] GC before operation: completed in 104.774 ms, heap usage 181.395 MB -> 55.954 MB. [2024-06-27T02:59:44.382Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T02:59:44.382Z] There is no way to check that no silent failure occurred. [2024-06-27T02:59:44.382Z] ====== als (apache-spark) [default], iteration 1 completed (8296.439 ms) ====== [2024-06-27T02:59:44.382Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-06-27T02:59:44.382Z] GC before operation: completed in 109.725 ms, heap usage 327.340 MB -> 58.661 MB. [2024-06-27T02:59:52.371Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T02:59:52.371Z] There is no way to check that no silent failure occurred. [2024-06-27T02:59:52.371Z] ====== als (apache-spark) [default], iteration 2 completed (7880.604 ms) ====== [2024-06-27T02:59:52.371Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-06-27T02:59:52.371Z] GC before operation: completed in 115.386 ms, heap usage 328.968 MB -> 59.103 MB. [2024-06-27T03:00:00.364Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:00.364Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:00.364Z] ====== als (apache-spark) [default], iteration 3 completed (7818.879 ms) ====== [2024-06-27T03:00:00.364Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-06-27T03:00:00.364Z] GC before operation: completed in 108.571 ms, heap usage 278.775 MB -> 59.280 MB. [2024-06-27T03:00:08.374Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:08.374Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:08.374Z] ====== als (apache-spark) [default], iteration 4 completed (7765.500 ms) ====== [2024-06-27T03:00:08.374Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-06-27T03:00:08.374Z] GC before operation: completed in 120.478 ms, heap usage 290.437 MB -> 59.740 MB. [2024-06-27T03:00:16.366Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:16.366Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:16.366Z] ====== als (apache-spark) [default], iteration 5 completed (7524.027 ms) ====== [2024-06-27T03:00:16.366Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-06-27T03:00:16.366Z] GC before operation: completed in 109.201 ms, heap usage 386.353 MB -> 60.200 MB. [2024-06-27T03:00:25.388Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:25.388Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:25.388Z] ====== als (apache-spark) [default], iteration 6 completed (7575.707 ms) ====== [2024-06-27T03:00:25.388Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-06-27T03:00:25.388Z] GC before operation: completed in 112.323 ms, heap usage 325.533 MB -> 60.524 MB. [2024-06-27T03:00:31.984Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:31.984Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:31.984Z] ====== als (apache-spark) [default], iteration 7 completed (7596.644 ms) ====== [2024-06-27T03:00:31.984Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-06-27T03:00:31.984Z] GC before operation: completed in 112.227 ms, heap usage 464.772 MB -> 60.992 MB. [2024-06-27T03:00:38.548Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:38.548Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:38.548Z] ====== als (apache-spark) [default], iteration 8 completed (7498.944 ms) ====== [2024-06-27T03:00:38.548Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-06-27T03:00:39.497Z] GC before operation: completed in 119.620 ms, heap usage 214.669 MB -> 60.953 MB. [2024-06-27T03:00:47.479Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:47.479Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:47.479Z] ====== als (apache-spark) [default], iteration 9 completed (7528.241 ms) ====== [2024-06-27T03:00:47.479Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-06-27T03:00:47.479Z] GC before operation: completed in 122.499 ms, heap usage 610.661 MB -> 61.889 MB. [2024-06-27T03:00:55.463Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:00:55.463Z] There is no way to check that no silent failure occurred. [2024-06-27T03:00:55.463Z] ====== als (apache-spark) [default], iteration 10 completed (7794.972 ms) ====== [2024-06-27T03:00:55.463Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-06-27T03:00:55.463Z] GC before operation: completed in 127.197 ms, heap usage 386.678 MB -> 61.930 MB. [2024-06-27T03:01:02.022Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:02.022Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:02.022Z] ====== als (apache-spark) [default], iteration 11 completed (7462.890 ms) ====== [2024-06-27T03:01:02.022Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-06-27T03:01:02.022Z] GC before operation: completed in 127.030 ms, heap usage 305.351 MB -> 62.261 MB. [2024-06-27T03:01:09.737Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:09.737Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:09.737Z] ====== als (apache-spark) [default], iteration 12 completed (7487.875 ms) ====== [2024-06-27T03:01:09.737Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-06-27T03:01:09.737Z] GC before operation: completed in 116.907 ms, heap usage 471.415 MB -> 62.730 MB. [2024-06-27T03:01:17.736Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:17.736Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:17.736Z] ====== als (apache-spark) [default], iteration 13 completed (7429.715 ms) ====== [2024-06-27T03:01:17.736Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-06-27T03:01:17.736Z] GC before operation: completed in 123.014 ms, heap usage 428.847 MB -> 63.051 MB. [2024-06-27T03:01:25.756Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:25.756Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:25.756Z] ====== als (apache-spark) [default], iteration 14 completed (7497.359 ms) ====== [2024-06-27T03:01:25.756Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-06-27T03:01:25.756Z] GC before operation: completed in 118.490 ms, heap usage 273.281 MB -> 63.217 MB. [2024-06-27T03:01:32.331Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:32.331Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:32.331Z] ====== als (apache-spark) [default], iteration 15 completed (7355.448 ms) ====== [2024-06-27T03:01:32.331Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-06-27T03:01:32.331Z] GC before operation: completed in 120.568 ms, heap usage 233.600 MB -> 63.384 MB. [2024-06-27T03:01:40.333Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:40.333Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:40.333Z] ====== als (apache-spark) [default], iteration 16 completed (7361.452 ms) ====== [2024-06-27T03:01:40.333Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-06-27T03:01:40.333Z] GC before operation: completed in 121.650 ms, heap usage 309.153 MB -> 63.973 MB. [2024-06-27T03:01:48.330Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:48.330Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:48.330Z] ====== als (apache-spark) [default], iteration 17 completed (7470.188 ms) ====== [2024-06-27T03:01:48.330Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-06-27T03:01:48.330Z] GC before operation: completed in 122.616 ms, heap usage 488.180 MB -> 64.507 MB. [2024-06-27T03:01:54.902Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:01:54.902Z] There is no way to check that no silent failure occurred. [2024-06-27T03:01:54.902Z] ====== als (apache-spark) [default], iteration 18 completed (7554.454 ms) ====== [2024-06-27T03:01:54.902Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-06-27T03:01:54.902Z] GC before operation: completed in 122.368 ms, heap usage 174.870 MB -> 64.152 MB. [2024-06-27T03:02:02.906Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:02.906Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:02.906Z] ====== als (apache-spark) [default], iteration 19 completed (7593.898 ms) ====== [2024-06-27T03:02:02.906Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-06-27T03:02:02.906Z] GC before operation: completed in 119.387 ms, heap usage 366.623 MB -> 64.770 MB. [2024-06-27T03:02:10.905Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:10.905Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:10.905Z] ====== als (apache-spark) [default], iteration 20 completed (7438.812 ms) ====== [2024-06-27T03:02:10.905Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-06-27T03:02:10.905Z] GC before operation: completed in 113.672 ms, heap usage 232.203 MB -> 64.560 MB. [2024-06-27T03:02:17.484Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:17.484Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:17.484Z] ====== als (apache-spark) [default], iteration 21 completed (7414.139 ms) ====== [2024-06-27T03:02:17.484Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-06-27T03:02:18.415Z] GC before operation: completed in 118.986 ms, heap usage 497.378 MB -> 65.455 MB. [2024-06-27T03:02:25.076Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:25.076Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:25.076Z] ====== als (apache-spark) [default], iteration 22 completed (7313.216 ms) ====== [2024-06-27T03:02:25.076Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-06-27T03:02:25.076Z] GC before operation: completed in 121.842 ms, heap usage 422.844 MB -> 65.468 MB. [2024-06-27T03:02:33.780Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:33.780Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:33.780Z] ====== als (apache-spark) [default], iteration 23 completed (7388.684 ms) ====== [2024-06-27T03:02:33.780Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-06-27T03:02:33.780Z] GC before operation: completed in 125.663 ms, heap usage 471.555 MB -> 65.674 MB. [2024-06-27T03:02:40.413Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:40.413Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:40.413Z] ====== als (apache-spark) [default], iteration 24 completed (7270.451 ms) ====== [2024-06-27T03:02:40.413Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-06-27T03:02:40.413Z] GC before operation: completed in 118.920 ms, heap usage 272.160 MB -> 65.652 MB. [2024-06-27T03:02:48.409Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:48.409Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:48.409Z] ====== als (apache-spark) [default], iteration 25 completed (7338.189 ms) ====== [2024-06-27T03:02:48.409Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-06-27T03:02:48.409Z] GC before operation: completed in 128.754 ms, heap usage 277.855 MB -> 65.814 MB. [2024-06-27T03:02:54.981Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:02:54.981Z] There is no way to check that no silent failure occurred. [2024-06-27T03:02:54.981Z] ====== als (apache-spark) [default], iteration 26 completed (7359.043 ms) ====== [2024-06-27T03:02:54.981Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-06-27T03:02:54.981Z] GC before operation: completed in 126.817 ms, heap usage 332.886 MB -> 66.011 MB. [2024-06-27T03:03:02.965Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:03:02.965Z] There is no way to check that no silent failure occurred. [2024-06-27T03:03:02.965Z] ====== als (apache-spark) [default], iteration 27 completed (7330.188 ms) ====== [2024-06-27T03:03:02.965Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-06-27T03:03:02.965Z] GC before operation: completed in 124.069 ms, heap usage 305.436 MB -> 66.078 MB. [2024-06-27T03:03:10.949Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:03:10.949Z] There is no way to check that no silent failure occurred. [2024-06-27T03:03:10.949Z] ====== als (apache-spark) [default], iteration 28 completed (7330.816 ms) ====== [2024-06-27T03:03:10.949Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-06-27T03:03:10.949Z] GC before operation: completed in 123.636 ms, heap usage 526.190 MB -> 66.783 MB. [2024-06-27T03:03:17.506Z] WARNING: This benchmark provides no result that can be validated. [2024-06-27T03:03:17.506Z] There is no way to check that no silent failure occurred. [2024-06-27T03:03:17.506Z] ====== als (apache-spark) [default], iteration 29 completed (7182.924 ms) ====== [2024-06-27T03:03:17.506Z] ----------------------------------- [2024-06-27T03:03:17.506Z] renaissance-als_0_PASSED [2024-06-27T03:03:17.506Z] ----------------------------------- [2024-06-27T03:03:17.506Z] [2024-06-27T03:03:17.506Z] TEST TEARDOWN: [2024-06-27T03:03:17.506Z] Nothing to be done for teardown. [2024-06-27T03:03:18.435Z] renaissance-als_0 Finish Time: Thu Jun 27 03:03:18 2024 Epoch Time (ms): 1719457398022