[2024-08-24T01:58:42.084Z] Running test renaissance-als_0 ... [2024-08-24T01:58:42.400Z] =============================================== [2024-08-24T01:58:42.400Z] renaissance-als_0 Start Time: Sat Aug 24 01:58:42 2024 Epoch Time (ms): 1724464722258 [2024-08-24T01:58:43.058Z] variation: NoOptions [2024-08-24T01:58:43.362Z] JVM_OPTIONS: [2024-08-24T01:58:43.362Z] { \ [2024-08-24T01:58:43.362Z] echo ""; echo "TEST SETUP:"; \ [2024-08-24T01:58:43.362Z] echo "Nothing to be done for setup."; \ [2024-08-24T01:58:43.362Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\renaissance-als_0"; \ [2024-08-24T01:58:43.362Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\renaissance-als_0"; \ [2024-08-24T01:58:43.362Z] echo ""; echo "TESTING:"; \ [2024-08-24T01:58:43.362Z] "c:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/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 "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\renaissance-als_0"\\als.json" als; \ [2024-08-24T01:58:43.362Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-24T01:58:43.362Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-24T01:58:43.362Z] echo "Nothing to be done for teardown."; \ [2024-08-24T01:58:43.362Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17244646614105\\TestTargetResult"; [2024-08-24T01:58:43.678Z] [2024-08-24T01:58:43.678Z] TEST SETUP: [2024-08-24T01:58:43.678Z] Nothing to be done for setup. [2024-08-24T01:58:43.678Z] [2024-08-24T01:58:43.678Z] TESTING: [2024-08-24T01:58:54.205Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-24T01:58:55.786Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-24T01:58:58.635Z] WARNING: An illegal reflective access operation has occurred [2024-08-24T01:58:58.635Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/TKG/output_17244646614105/renaissance-als_0/harness-015844-6723745597241961357/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-24T01:58:58.635Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-24T01:58:58.635Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-24T01:58:58.635Z] WARNING: All illegal access operations will be denied in a future release [2024-08-24T01:59:00.210Z] ====== als (apache-spark) [default], iteration 0 started ====== [2024-08-24T01:59:00.210Z] GC before operation: completed in 88.957 ms, heap usage 95.500 MB -> 34.296 MB. [2024-08-24T01:59:28.028Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T01:59:28.028Z] There is no way to check that no silent failure occurred. [2024-08-24T01:59:28.029Z] ====== als (apache-spark) [default], iteration 0 completed (25590.865 ms) ====== [2024-08-24T01:59:28.029Z] ====== als (apache-spark) [default], iteration 1 started ====== [2024-08-24T01:59:28.029Z] GC before operation: completed in 106.485 ms, heap usage 329.941 MB -> 56.606 MB. [2024-08-24T01:59:43.843Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T01:59:43.843Z] There is no way to check that no silent failure occurred. [2024-08-24T01:59:43.843Z] ====== als (apache-spark) [default], iteration 1 completed (16965.665 ms) ====== [2024-08-24T01:59:43.843Z] ====== als (apache-spark) [default], iteration 2 started ====== [2024-08-24T01:59:43.843Z] GC before operation: completed in 127.986 ms, heap usage 457.400 MB -> 59.309 MB. [2024-08-24T01:59:59.478Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T01:59:59.478Z] There is no way to check that no silent failure occurred. [2024-08-24T01:59:59.478Z] ====== als (apache-spark) [default], iteration 2 completed (15802.016 ms) ====== [2024-08-24T01:59:59.478Z] ====== als (apache-spark) [default], iteration 3 started ====== [2024-08-24T01:59:59.478Z] GC before operation: completed in 123.659 ms, heap usage 132.647 MB -> 59.524 MB. [2024-08-24T02:00:15.345Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:00:15.345Z] There is no way to check that no silent failure occurred. [2024-08-24T02:00:15.345Z] ====== als (apache-spark) [default], iteration 3 completed (15991.467 ms) ====== [2024-08-24T02:00:15.345Z] ====== als (apache-spark) [default], iteration 4 started ====== [2024-08-24T02:00:15.345Z] GC before operation: completed in 136.615 ms, heap usage 443.076 MB -> 60.081 MB. [2024-08-24T02:00:31.263Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:00:31.263Z] There is no way to check that no silent failure occurred. [2024-08-24T02:00:31.263Z] ====== als (apache-spark) [default], iteration 4 completed (15587.319 ms) ====== [2024-08-24T02:00:31.263Z] ====== als (apache-spark) [default], iteration 5 started ====== [2024-08-24T02:00:31.263Z] GC before operation: completed in 137.682 ms, heap usage 248.663 MB -> 60.101 MB. [2024-08-24T02:00:46.865Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:00:46.865Z] There is no way to check that no silent failure occurred. [2024-08-24T02:00:46.865Z] ====== als (apache-spark) [default], iteration 5 completed (15469.751 ms) ====== [2024-08-24T02:00:46.865Z] ====== als (apache-spark) [default], iteration 6 started ====== [2024-08-24T02:00:46.865Z] GC before operation: completed in 120.315 ms, heap usage 388.596 MB -> 60.730 MB. [2024-08-24T02:01:02.561Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:01:02.561Z] There is no way to check that no silent failure occurred. [2024-08-24T02:01:02.561Z] ====== als (apache-spark) [default], iteration 6 completed (15521.351 ms) ====== [2024-08-24T02:01:02.561Z] ====== als (apache-spark) [default], iteration 7 started ====== [2024-08-24T02:01:02.561Z] GC before operation: completed in 142.224 ms, heap usage 324.216 MB -> 60.980 MB. [2024-08-24T02:01:18.189Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:01:18.189Z] There is no way to check that no silent failure occurred. [2024-08-24T02:01:18.189Z] ====== als (apache-spark) [default], iteration 7 completed (15313.048 ms) ====== [2024-08-24T02:01:18.189Z] ====== als (apache-spark) [default], iteration 8 started ====== [2024-08-24T02:01:18.189Z] GC before operation: completed in 119.772 ms, heap usage 471.988 MB -> 61.455 MB. [2024-08-24T02:01:33.856Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:01:33.856Z] There is no way to check that no silent failure occurred. [2024-08-24T02:01:33.856Z] ====== als (apache-spark) [default], iteration 8 completed (15412.546 ms) ====== [2024-08-24T02:01:33.856Z] ====== als (apache-spark) [default], iteration 9 started ====== [2024-08-24T02:01:33.856Z] GC before operation: completed in 122.464 ms, heap usage 575.713 MB -> 61.961 MB. [2024-08-24T02:01:49.531Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:01:49.531Z] There is no way to check that no silent failure occurred. [2024-08-24T02:01:49.531Z] ====== als (apache-spark) [default], iteration 9 completed (15205.552 ms) ====== [2024-08-24T02:01:49.531Z] ====== als (apache-spark) [default], iteration 10 started ====== [2024-08-24T02:01:49.531Z] GC before operation: completed in 125.462 ms, heap usage 543.945 MB -> 62.233 MB. [2024-08-24T02:02:05.235Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:02:05.235Z] There is no way to check that no silent failure occurred. [2024-08-24T02:02:05.235Z] ====== als (apache-spark) [default], iteration 10 completed (15430.244 ms) ====== [2024-08-24T02:02:05.235Z] ====== als (apache-spark) [default], iteration 11 started ====== [2024-08-24T02:02:05.235Z] GC before operation: completed in 168.919 ms, heap usage 386.005 MB -> 62.373 MB. [2024-08-24T02:02:20.884Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:02:20.884Z] There is no way to check that no silent failure occurred. [2024-08-24T02:02:20.884Z] ====== als (apache-spark) [default], iteration 11 completed (15298.263 ms) ====== [2024-08-24T02:02:20.884Z] ====== als (apache-spark) [default], iteration 12 started ====== [2024-08-24T02:02:20.884Z] GC before operation: completed in 140.018 ms, heap usage 340.158 MB -> 62.713 MB. [2024-08-24T02:02:36.470Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:02:36.470Z] There is no way to check that no silent failure occurred. [2024-08-24T02:02:36.470Z] ====== als (apache-spark) [default], iteration 12 completed (15114.882 ms) ====== [2024-08-24T02:02:36.470Z] ====== als (apache-spark) [default], iteration 13 started ====== [2024-08-24T02:02:36.470Z] GC before operation: completed in 124.421 ms, heap usage 534.281 MB -> 63.283 MB. [2024-08-24T02:02:52.022Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:02:52.022Z] There is no way to check that no silent failure occurred. [2024-08-24T02:02:52.022Z] ====== als (apache-spark) [default], iteration 13 completed (14929.998 ms) ====== [2024-08-24T02:02:52.022Z] ====== als (apache-spark) [default], iteration 14 started ====== [2024-08-24T02:02:52.022Z] GC before operation: completed in 136.189 ms, heap usage 331.988 MB -> 63.398 MB. [2024-08-24T02:03:07.582Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:03:07.582Z] There is no way to check that no silent failure occurred. [2024-08-24T02:03:07.582Z] ====== als (apache-spark) [default], iteration 14 completed (15439.792 ms) ====== [2024-08-24T02:03:07.582Z] ====== als (apache-spark) [default], iteration 15 started ====== [2024-08-24T02:03:07.582Z] GC before operation: completed in 136.711 ms, heap usage 370.903 MB -> 63.771 MB. [2024-08-24T02:03:20.816Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:03:20.816Z] There is no way to check that no silent failure occurred. [2024-08-24T02:03:20.816Z] ====== als (apache-spark) [default], iteration 15 completed (15169.265 ms) ====== [2024-08-24T02:03:20.816Z] ====== als (apache-spark) [default], iteration 16 started ====== [2024-08-24T02:03:20.816Z] GC before operation: completed in 123.850 ms, heap usage 482.540 MB -> 64.297 MB. [2024-08-24T02:03:36.443Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:03:36.443Z] There is no way to check that no silent failure occurred. [2024-08-24T02:03:36.443Z] ====== als (apache-spark) [default], iteration 16 completed (15207.550 ms) ====== [2024-08-24T02:03:36.443Z] ====== als (apache-spark) [default], iteration 17 started ====== [2024-08-24T02:03:36.443Z] GC before operation: completed in 129.584 ms, heap usage 517.156 MB -> 64.732 MB. [2024-08-24T02:03:52.157Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:03:52.157Z] There is no way to check that no silent failure occurred. [2024-08-24T02:03:52.157Z] ====== als (apache-spark) [default], iteration 17 completed (15222.505 ms) ====== [2024-08-24T02:03:52.157Z] ====== als (apache-spark) [default], iteration 18 started ====== [2024-08-24T02:03:52.157Z] GC before operation: completed in 130.683 ms, heap usage 500.114 MB -> 64.989 MB. [2024-08-24T02:04:07.784Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:04:07.784Z] There is no way to check that no silent failure occurred. [2024-08-24T02:04:07.784Z] ====== als (apache-spark) [default], iteration 18 completed (15325.313 ms) ====== [2024-08-24T02:04:07.784Z] ====== als (apache-spark) [default], iteration 19 started ====== [2024-08-24T02:04:07.784Z] GC before operation: completed in 136.848 ms, heap usage 312.735 MB -> 64.801 MB. [2024-08-24T02:04:23.528Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:04:23.528Z] There is no way to check that no silent failure occurred. [2024-08-24T02:04:23.528Z] ====== als (apache-spark) [default], iteration 19 completed (15110.624 ms) ====== [2024-08-24T02:04:23.528Z] ====== als (apache-spark) [default], iteration 20 started ====== [2024-08-24T02:04:23.528Z] GC before operation: completed in 133.987 ms, heap usage 462.172 MB -> 65.321 MB. [2024-08-24T02:04:39.145Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:04:39.145Z] There is no way to check that no silent failure occurred. [2024-08-24T02:04:39.145Z] ====== als (apache-spark) [default], iteration 20 completed (15127.369 ms) ====== [2024-08-24T02:04:39.145Z] ====== als (apache-spark) [default], iteration 21 started ====== [2024-08-24T02:04:39.145Z] GC before operation: completed in 138.540 ms, heap usage 488.804 MB -> 65.567 MB. [2024-08-24T02:04:55.020Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:04:55.020Z] There is no way to check that no silent failure occurred. [2024-08-24T02:04:55.020Z] ====== als (apache-spark) [default], iteration 21 completed (15772.565 ms) ====== [2024-08-24T02:04:55.020Z] ====== als (apache-spark) [default], iteration 22 started ====== [2024-08-24T02:04:55.020Z] GC before operation: completed in 132.013 ms, heap usage 398.970 MB -> 65.709 MB. [2024-08-24T02:05:10.669Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:05:10.669Z] There is no way to check that no silent failure occurred. [2024-08-24T02:05:10.669Z] ====== als (apache-spark) [default], iteration 22 completed (15502.026 ms) ====== [2024-08-24T02:05:10.669Z] ====== als (apache-spark) [default], iteration 23 started ====== [2024-08-24T02:05:10.669Z] GC before operation: completed in 134.349 ms, heap usage 315.372 MB -> 65.619 MB. [2024-08-24T02:05:26.201Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:05:26.201Z] There is no way to check that no silent failure occurred. [2024-08-24T02:05:26.201Z] ====== als (apache-spark) [default], iteration 23 completed (14993.268 ms) ====== [2024-08-24T02:05:26.201Z] ====== als (apache-spark) [default], iteration 24 started ====== [2024-08-24T02:05:26.201Z] GC before operation: completed in 124.121 ms, heap usage 258.379 MB -> 65.943 MB. [2024-08-24T02:05:39.148Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:05:39.148Z] There is no way to check that no silent failure occurred. [2024-08-24T02:05:39.148Z] ====== als (apache-spark) [default], iteration 24 completed (15175.183 ms) ====== [2024-08-24T02:05:39.148Z] ====== als (apache-spark) [default], iteration 25 started ====== [2024-08-24T02:05:39.668Z] GC before operation: completed in 133.676 ms, heap usage 197.007 MB -> 66.011 MB. [2024-08-24T02:05:55.397Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:05:55.397Z] There is no way to check that no silent failure occurred. [2024-08-24T02:05:55.397Z] ====== als (apache-spark) [default], iteration 25 completed (15434.476 ms) ====== [2024-08-24T02:05:55.397Z] ====== als (apache-spark) [default], iteration 26 started ====== [2024-08-24T02:05:55.397Z] GC before operation: completed in 135.713 ms, heap usage 207.620 MB -> 66.012 MB. [2024-08-24T02:06:11.033Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:06:11.033Z] There is no way to check that no silent failure occurred. [2024-08-24T02:06:11.033Z] ====== als (apache-spark) [default], iteration 26 completed (15396.866 ms) ====== [2024-08-24T02:06:11.033Z] ====== als (apache-spark) [default], iteration 27 started ====== [2024-08-24T02:06:11.033Z] GC before operation: completed in 127.877 ms, heap usage 165.906 MB -> 66.288 MB. [2024-08-24T02:06:26.619Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:06:26.619Z] There is no way to check that no silent failure occurred. [2024-08-24T02:06:26.619Z] ====== als (apache-spark) [default], iteration 27 completed (15068.066 ms) ====== [2024-08-24T02:06:26.619Z] ====== als (apache-spark) [default], iteration 28 started ====== [2024-08-24T02:06:26.619Z] GC before operation: completed in 128.419 ms, heap usage 297.789 MB -> 66.565 MB. [2024-08-24T02:06:42.135Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:06:42.135Z] There is no way to check that no silent failure occurred. [2024-08-24T02:06:42.135Z] ====== als (apache-spark) [default], iteration 28 completed (14959.988 ms) ====== [2024-08-24T02:06:42.135Z] ====== als (apache-spark) [default], iteration 29 started ====== [2024-08-24T02:06:42.135Z] GC before operation: completed in 131.982 ms, heap usage 199.848 MB -> 66.694 MB. [2024-08-24T02:06:57.782Z] WARNING: This benchmark provides no result that can be validated. [2024-08-24T02:06:57.782Z] There is no way to check that no silent failure occurred. [2024-08-24T02:06:57.782Z] ====== als (apache-spark) [default], iteration 29 completed (14942.549 ms) ====== [2024-08-24T02:06:57.782Z] ----------------------------------- [2024-08-24T02:06:57.782Z] renaissance-als_0_PASSED [2024-08-24T02:06:57.782Z] ----------------------------------- [2024-08-24T02:06:57.782Z] [2024-08-24T02:06:57.782Z] TEST TEARDOWN: [2024-08-24T02:06:57.782Z] Nothing to be done for teardown. [2024-08-24T02:06:57.782Z] renaissance-als_0 Finish Time: Sat Aug 24 02:06:56 2024 Epoch Time (ms): 1724465216496