[2025-02-17T17:18:43.802Z] Running test renaissance-log-regression_0 ... [2025-02-17T17:18:43.802Z] =============================================== [2025-02-17T17:18:43.802Z] renaissance-log-regression_0 Start Time: Mon Feb 17 17:18:43 2025 Epoch Time (ms): 1739812723665 [2025-02-17T17:18:43.802Z] variation: NoOptions [2025-02-17T17:18:44.134Z] JVM_OPTIONS: [2025-02-17T17:18:44.134Z] { \ [2025-02-17T17:18:44.134Z] echo ""; echo "TEST SETUP:"; \ [2025-02-17T17:18:44.134Z] echo "Nothing to be done for setup."; \ [2025-02-17T17:18:44.134Z] mkdir -p "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398114432264\\renaissance-log-regression_0"; \ [2025-02-17T17:18:44.134Z] cd "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398114432264\\renaissance-log-regression_0"; \ [2025-02-17T17:18:44.134Z] echo ""; echo "TESTING:"; \ [2025-02-17T17:18:44.134Z] "c:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/jdkbinary/j2sdk-image\\bin\\java" -jar "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398114432264\\renaissance-log-regression_0"\\log-regression.json" log-regression; \ [2025-02-17T17:18:44.135Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398114432264\\renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-02-17T17:18:44.135Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-02-17T17:18:44.135Z] echo "Nothing to be done for teardown."; \ [2025-02-17T17:18:44.135Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17398114432264\\TestTargetResult"; [2025-02-17T17:18:44.135Z] [2025-02-17T17:18:44.135Z] TEST SETUP: [2025-02-17T17:18:44.135Z] Nothing to be done for setup. [2025-02-17T17:18:44.135Z] [2025-02-17T17:18:44.135Z] TESTING: [2025-02-17T17:18:57.129Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2025-02-17T17:18:59.365Z] NOTE: 'log-regression' benchmark uses Spark local executor with 4 (out of 4) threads. [2025-02-17T17:19:03.100Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2025-02-17T17:19:03.437Z] GC before operation: completed in 163.108 ms, heap usage 115.078 MB -> 28.093 MB. [2025-02-17T17:19:12.493Z] ====== log-regression (apache-spark) [default], iteration 0 completed (8016.340 ms) ====== [2025-02-17T17:19:12.493Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2025-02-17T17:19:12.493Z] GC before operation: completed in 373.875 ms, heap usage 586.319 MB -> 102.575 MB. [2025-02-17T17:19:13.637Z] ====== log-regression (apache-spark) [default], iteration 1 completed (1872.928 ms) ====== [2025-02-17T17:19:13.637Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2025-02-17T17:19:14.020Z] GC before operation: completed in 240.328 ms, heap usage 326.431 MB -> 101.184 MB. [2025-02-17T17:19:15.674Z] ====== log-regression (apache-spark) [default], iteration 2 completed (1464.037 ms) ====== [2025-02-17T17:19:15.674Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2025-02-17T17:19:15.674Z] GC before operation: completed in 199.472 ms, heap usage 279.829 MB -> 101.562 MB. [2025-02-17T17:19:16.824Z] ====== log-regression (apache-spark) [default], iteration 3 completed (1263.698 ms) ====== [2025-02-17T17:19:16.824Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2025-02-17T17:19:17.234Z] GC before operation: completed in 195.119 ms, heap usage 355.431 MB -> 102.547 MB. [2025-02-17T17:19:18.550Z] ====== log-regression (apache-spark) [default], iteration 4 completed (1294.539 ms) ====== [2025-02-17T17:19:18.550Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2025-02-17T17:19:18.550Z] GC before operation: completed in 206.373 ms, heap usage 405.597 MB -> 103.232 MB. [2025-02-17T17:19:19.691Z] ====== log-regression (apache-spark) [default], iteration 5 completed (1291.727 ms) ====== [2025-02-17T17:19:19.691Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2025-02-17T17:19:20.027Z] GC before operation: completed in 218.143 ms, heap usage 434.885 MB -> 103.761 MB. [2025-02-17T17:19:21.162Z] ====== log-regression (apache-spark) [default], iteration 6 completed (1173.815 ms) ====== [2025-02-17T17:19:21.163Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2025-02-17T17:19:21.527Z] GC before operation: completed in 166.866 ms, heap usage 389.402 MB -> 103.580 MB. [2025-02-17T17:19:22.779Z] ====== log-regression (apache-spark) [default], iteration 7 completed (1212.219 ms) ====== [2025-02-17T17:19:22.779Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2025-02-17T17:19:22.779Z] GC before operation: completed in 158.986 ms, heap usage 339.588 MB -> 103.460 MB. [2025-02-17T17:19:23.939Z] ====== log-regression (apache-spark) [default], iteration 8 completed (1162.860 ms) ====== [2025-02-17T17:19:23.939Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2025-02-17T17:19:23.939Z] GC before operation: completed in 179.058 ms, heap usage 308.954 MB -> 103.498 MB. [2025-02-17T17:19:25.151Z] ====== log-regression (apache-spark) [default], iteration 9 completed (1058.023 ms) ====== [2025-02-17T17:19:25.151Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2025-02-17T17:19:25.522Z] GC before operation: completed in 183.093 ms, heap usage 287.742 MB -> 103.488 MB. [2025-02-17T17:19:26.699Z] ====== log-regression (apache-spark) [default], iteration 10 completed (1089.268 ms) ====== [2025-02-17T17:19:26.699Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2025-02-17T17:19:26.699Z] GC before operation: completed in 179.125 ms, heap usage 264.740 MB -> 103.580 MB. [2025-02-17T17:19:27.908Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1146.637 ms) ====== [2025-02-17T17:19:27.908Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2025-02-17T17:19:27.908Z] GC before operation: completed in 207.114 ms, heap usage 258.186 MB -> 103.793 MB. [2025-02-17T17:19:29.048Z] ====== log-regression (apache-spark) [default], iteration 12 completed (1101.859 ms) ====== [2025-02-17T17:19:29.048Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2025-02-17T17:19:29.384Z] GC before operation: completed in 209.773 ms, heap usage 252.128 MB -> 103.908 MB. [2025-02-17T17:19:30.566Z] ====== log-regression (apache-spark) [default], iteration 13 completed (1125.774 ms) ====== [2025-02-17T17:19:30.566Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2025-02-17T17:19:30.566Z] GC before operation: completed in 153.891 ms, heap usage 244.485 MB -> 104.103 MB. [2025-02-17T17:19:31.708Z] ====== log-regression (apache-spark) [default], iteration 14 completed (1281.782 ms) ====== [2025-02-17T17:19:31.708Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2025-02-17T17:19:32.027Z] GC before operation: completed in 209.880 ms, heap usage 232.594 MB -> 104.245 MB. [2025-02-17T17:19:33.169Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1087.471 ms) ====== [2025-02-17T17:19:33.169Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2025-02-17T17:19:33.169Z] GC before operation: completed in 212.132 ms, heap usage 233.902 MB -> 104.517 MB. [2025-02-17T17:19:34.938Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1241.805 ms) ====== [2025-02-17T17:19:34.938Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2025-02-17T17:19:34.938Z] GC before operation: completed in 245.291 ms, heap usage 243.348 MB -> 104.987 MB. [2025-02-17T17:19:36.099Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1145.516 ms) ====== [2025-02-17T17:19:36.099Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2025-02-17T17:19:36.099Z] GC before operation: completed in 265.958 ms, heap usage 251.295 MB -> 105.199 MB. [2025-02-17T17:19:37.338Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1172.141 ms) ====== [2025-02-17T17:19:37.338Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2025-02-17T17:19:37.776Z] GC before operation: completed in 180.516 ms, heap usage 252.483 MB -> 105.481 MB. [2025-02-17T17:19:38.927Z] ====== log-regression (apache-spark) [default], iteration 19 completed (1200.441 ms) ====== [2025-02-17T17:19:39.256Z] ----------------------------------- [2025-02-17T17:19:39.256Z] renaissance-log-regression_0_PASSED [2025-02-17T17:19:39.256Z] ----------------------------------- [2025-02-17T17:19:39.256Z] [2025-02-17T17:19:39.256Z] TEST TEARDOWN: [2025-02-17T17:19:39.256Z] Nothing to be done for teardown. [2025-02-17T17:19:39.573Z] renaissance-log-regression_0 Finish Time: Mon Feb 17 17:19:39 2025 Epoch Time (ms): 1739812779340