[2025-12-04T04:41:33.679Z] Running test renaissance-log-regression_0 ... [2025-12-04T04:41:33.679Z] =============================================== [2025-12-04T04:41:33.679Z] renaissance-log-regression_0 Start Time: Wed Dec 3 23:41:33 2025 Epoch Time (ms): 1764823293311 [2025-12-04T04:41:33.679Z] variation: NoOptions [2025-12-04T04:41:33.679Z] JVM_OPTIONS: [2025-12-04T04:41:33.679Z] { \ [2025-12-04T04:41:33.679Z] echo ""; echo "TEST SETUP:"; \ [2025-12-04T04:41:33.679Z] echo "Nothing to be done for setup."; \ [2025-12-04T04:41:33.679Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648204437955/renaissance-log-regression_0"; \ [2025-12-04T04:41:33.679Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648204437955/renaissance-log-regression_0"; \ [2025-12-04T04:41:33.679Z] echo ""; echo "TESTING:"; \ [2025-12-04T04:41:33.679Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/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_s390x_linux/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648204437955/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2025-12-04T04:41:33.679Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648204437955/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-12-04T04:41:33.679Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-12-04T04:41:33.679Z] echo "Nothing to be done for teardown."; \ [2025-12-04T04:41:33.679Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/../TKG/output_17648204437955/TestTargetResult"; [2025-12-04T04:41:33.679Z] [2025-12-04T04:41:33.679Z] TEST SETUP: [2025-12-04T04:41:33.679Z] Nothing to be done for setup. [2025-12-04T04:41:33.679Z] [2025-12-04T04:41:33.679Z] TESTING: [2025-12-04T04:41:41.258Z] NOTE: 'log-regression' benchmark uses Spark local executor with 2 (out of 2) threads. [2025-12-04T04:41:42.664Z] WARNING: An illegal reflective access operation has occurred [2025-12-04T04:41:42.664Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_s390x_linux/aqa-tests/TKG/output_17648204437955/renaissance-log-regression_0/harness-234134-13882314207429218120/apache-spark/lib/spark-core_2.13-3.5.3.jar) to field java.net.URI.scheme [2025-12-04T04:41:42.664Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2025-12-04T04:41:42.664Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2025-12-04T04:41:42.664Z] WARNING: All illegal access operations will be denied in a future release [2025-12-04T04:41:44.191Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-12-04T04:41:44.191Z] GC before operation: completed in 83.090 ms, heap usage 62.201 MB -> 34.398 MB. [2025-12-04T04:42:09.579Z] ====== log-regression (apache-spark) [default], iteration 0 completed (22269.294 ms) ====== [2025-12-04T04:42:09.579Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-12-04T04:42:09.579Z] GC before operation: completed in 242.351 ms, heap usage 243.127 MB -> 115.520 MB. [2025-12-04T04:42:13.027Z] ====== log-regression (apache-spark) [default], iteration 1 completed (6110.480 ms) ====== [2025-12-04T04:42:13.027Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-12-04T04:42:13.027Z] GC before operation: completed in 246.135 ms, heap usage 248.216 MB -> 115.901 MB. [2025-12-04T04:42:18.397Z] ====== log-regression (apache-spark) [default], iteration 2 completed (4938.934 ms) ====== [2025-12-04T04:42:18.397Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-12-04T04:42:18.397Z] GC before operation: completed in 193.293 ms, heap usage 283.091 MB -> 116.478 MB. [2025-12-04T04:42:23.916Z] ====== log-regression (apache-spark) [default], iteration 3 completed (5209.873 ms) ====== [2025-12-04T04:42:23.916Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-12-04T04:42:23.916Z] GC before operation: completed in 173.115 ms, heap usage 267.285 MB -> 116.715 MB. [2025-12-04T04:42:28.131Z] ====== log-regression (apache-spark) [default], iteration 4 completed (4961.856 ms) ====== [2025-12-04T04:42:28.131Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-12-04T04:42:28.861Z] GC before operation: completed in 153.124 ms, heap usage 236.659 MB -> 116.813 MB. [2025-12-04T04:42:33.236Z] ====== log-regression (apache-spark) [default], iteration 5 completed (4523.404 ms) ====== [2025-12-04T04:42:33.236Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-12-04T04:42:33.236Z] GC before operation: completed in 292.813 ms, heap usage 294.556 MB -> 117.247 MB. [2025-12-04T04:42:38.842Z] ====== log-regression (apache-spark) [default], iteration 6 completed (5056.717 ms) ====== [2025-12-04T04:42:38.842Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-12-04T04:42:38.842Z] GC before operation: completed in 464.392 ms, heap usage 273.677 MB -> 117.345 MB. [2025-12-04T04:42:44.082Z] ====== log-regression (apache-spark) [default], iteration 7 completed (4701.404 ms) ====== [2025-12-04T04:42:44.082Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-12-04T04:42:44.082Z] GC before operation: completed in 223.362 ms, heap usage 303.427 MB -> 117.616 MB. [2025-12-04T04:42:48.777Z] ====== log-regression (apache-spark) [default], iteration 8 completed (4985.410 ms) ====== [2025-12-04T04:42:48.777Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-12-04T04:42:48.777Z] GC before operation: completed in 193.836 ms, heap usage 290.244 MB -> 117.715 MB. [2025-12-04T04:42:52.944Z] ====== log-regression (apache-spark) [default], iteration 9 completed (4284.036 ms) ====== [2025-12-04T04:42:52.944Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-12-04T04:42:53.698Z] GC before operation: completed in 266.566 ms, heap usage 316.248 MB -> 118.058 MB. [2025-12-04T04:42:58.897Z] ====== log-regression (apache-spark) [default], iteration 10 completed (4850.347 ms) ====== [2025-12-04T04:42:58.898Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-12-04T04:42:58.898Z] GC before operation: completed in 389.441 ms, heap usage 279.306 MB -> 118.060 MB. [2025-12-04T04:43:03.746Z] ====== log-regression (apache-spark) [default], iteration 11 completed (4159.723 ms) ====== [2025-12-04T04:43:03.746Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-12-04T04:43:03.746Z] GC before operation: completed in 204.675 ms, heap usage 292.613 MB -> 118.326 MB. [2025-12-04T04:43:07.907Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3735.576 ms) ====== [2025-12-04T04:43:07.907Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-12-04T04:43:07.907Z] GC before operation: completed in 203.331 ms, heap usage 258.149 MB -> 118.321 MB. [2025-12-04T04:43:17.893Z] ====== log-regression (apache-spark) [default], iteration 13 completed (4673.527 ms) ====== [2025-12-04T04:43:17.893Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-12-04T04:43:17.893Z] GC before operation: completed in 304.471 ms, heap usage 275.787 MB -> 118.577 MB. [2025-12-04T04:43:18.658Z] ====== log-regression (apache-spark) [default], iteration 14 completed (4458.379 ms) ====== [2025-12-04T04:43:18.658Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-12-04T04:43:18.658Z] GC before operation: completed in 234.762 ms, heap usage 251.341 MB -> 118.657 MB. [2025-12-04T04:43:21.837Z] ====== log-regression (apache-spark) [default], iteration 15 completed (4615.184 ms) ====== [2025-12-04T04:43:21.837Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-12-04T04:43:21.837Z] GC before operation: completed in 196.864 ms, heap usage 251.902 MB -> 118.885 MB. [2025-12-04T04:43:26.077Z] ====== log-regression (apache-spark) [default], iteration 16 completed (4353.855 ms) ====== [2025-12-04T04:43:26.077Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-12-04T04:43:26.077Z] GC before operation: completed in 297.190 ms, heap usage 290.251 MB -> 119.145 MB. [2025-12-04T04:43:31.333Z] ====== log-regression (apache-spark) [default], iteration 17 completed (4986.412 ms) ====== [2025-12-04T04:43:31.333Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-12-04T04:43:31.333Z] GC before operation: completed in 193.052 ms, heap usage 273.749 MB -> 119.321 MB. [2025-12-04T04:43:35.687Z] ====== log-regression (apache-spark) [default], iteration 18 completed (4494.532 ms) ====== [2025-12-04T04:43:35.687Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-12-04T04:43:36.380Z] GC before operation: completed in 309.513 ms, heap usage 280.573 MB -> 119.487 MB. [2025-12-04T04:43:42.256Z] ====== log-regression (apache-spark) [default], iteration 19 completed (4256.181 ms) ====== [2025-12-04T04:43:42.256Z] ----------------------------------- [2025-12-04T04:43:42.256Z] renaissance-log-regression_0_PASSED [2025-12-04T04:43:42.256Z] ----------------------------------- [2025-12-04T04:43:42.256Z] [2025-12-04T04:43:42.256Z] TEST TEARDOWN: [2025-12-04T04:43:42.256Z] Nothing to be done for teardown. [2025-12-04T04:43:42.256Z] renaissance-log-regression_0 Finish Time: Wed Dec 3 23:43:40 2025 Epoch Time (ms): 1764823420604