[2024-09-02T10:25:40.746Z] Running test renaissance-log-regression_0 ... [2024-09-02T10:25:40.746Z] =============================================== [2024-09-02T10:25:40.746Z] renaissance-log-regression_0 Start Time: Mon Sep 2 11:25:40 2024 Epoch Time (ms): 1725272740590 [2024-09-02T10:25:40.746Z] variation: NoOptions [2024-09-02T10:25:40.747Z] JVM_OPTIONS: [2024-09-02T10:25:40.747Z] { \ [2024-09-02T10:25:40.747Z] echo ""; echo "TEST SETUP:"; \ [2024-09-02T10:25:40.747Z] echo "Nothing to be done for setup."; \ [2024-09-02T10:25:40.747Z] mkdir -p "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17252715867334/renaissance-log-regression_0"; \ [2024-09-02T10:25:40.747Z] cd "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17252715867334/renaissance-log-regression_0"; \ [2024-09-02T10:25:40.747Z] echo ""; echo "TESTING:"; \ [2024-09-02T10:25:40.747Z] "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/jdkbinary/j2sdk-image/bin/java" -jar "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17252715867334/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-09-02T10:25:40.747Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-log-regression_0""_PASSED"; echo "-----------------------------------"; cd /export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/..; rm -f -r "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17252715867334/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-09-02T10:25:40.747Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-09-02T10:25:40.747Z] echo "Nothing to be done for teardown."; \ [2024-09-02T10:25:40.747Z] } 2>&1 | tee -a "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17252715867334/TestTargetResult"; [2024-09-02T10:25:40.747Z] [2024-09-02T10:25:40.747Z] TEST SETUP: [2024-09-02T10:25:40.747Z] Nothing to be done for setup. [2024-09-02T10:25:40.747Z] [2024-09-02T10:25:40.747Z] TESTING: [2024-09-02T10:25:46.591Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-09-02T10:25:51.275Z] NOTE: 'log-regression' benchmark uses Spark local executor with 1 (out of 1) threads. [2024-09-02T10:25:55.973Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-09-02T10:25:55.973Z] GC before operation: completed in 107.501 ms, heap usage 44.880 MB -> 23.549 MB. [2024-09-02T10:26:14.266Z] ====== log-regression (apache-spark) [default], iteration 0 completed (17192.609 ms) ====== [2024-09-02T10:26:14.266Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-09-02T10:26:14.266Z] GC before operation: completed in 143.733 ms, heap usage 238.991 MB -> 116.415 MB. [2024-09-02T10:26:17.232Z] ====== log-regression (apache-spark) [default], iteration 1 completed (3856.392 ms) ====== [2024-09-02T10:26:17.232Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-09-02T10:26:17.232Z] GC before operation: completed in 123.805 ms, heap usage 194.977 MB -> 109.666 MB. [2024-09-02T10:26:20.050Z] ====== log-regression (apache-spark) [default], iteration 2 completed (2873.396 ms) ====== [2024-09-02T10:26:20.050Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-09-02T10:26:20.815Z] GC before operation: completed in 149.284 ms, heap usage 194.378 MB -> 163.536 MB. [2024-09-02T10:26:23.807Z] ====== log-regression (apache-spark) [default], iteration 3 completed (3460.650 ms) ====== [2024-09-02T10:26:23.807Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-09-02T10:26:23.807Z] GC before operation: completed in 169.464 ms, heap usage 268.192 MB -> 107.728 MB. [2024-09-02T10:26:27.278Z] ====== log-regression (apache-spark) [default], iteration 4 completed (3074.202 ms) ====== [2024-09-02T10:26:27.278Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-09-02T10:26:27.278Z] GC before operation: completed in 152.009 ms, heap usage 255.452 MB -> 110.267 MB. [2024-09-02T10:26:30.137Z] ====== log-regression (apache-spark) [default], iteration 5 completed (2459.419 ms) ====== [2024-09-02T10:26:30.138Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-09-02T10:26:30.138Z] GC before operation: completed in 151.562 ms, heap usage 246.228 MB -> 111.366 MB. [2024-09-02T10:26:32.183Z] ====== log-regression (apache-spark) [default], iteration 6 completed (2242.335 ms) ====== [2024-09-02T10:26:32.183Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-09-02T10:26:32.183Z] GC before operation: completed in 207.738 ms, heap usage 244.287 MB -> 102.632 MB. [2024-09-02T10:26:35.060Z] ====== log-regression (apache-spark) [default], iteration 7 completed (2280.667 ms) ====== [2024-09-02T10:26:35.060Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-09-02T10:26:35.060Z] GC before operation: completed in 131.231 ms, heap usage 236.054 MB -> 113.362 MB. [2024-09-02T10:26:37.179Z] ====== log-regression (apache-spark) [default], iteration 8 completed (2406.154 ms) ====== [2024-09-02T10:26:37.179Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-09-02T10:26:37.179Z] GC before operation: completed in 151.829 ms, heap usage 248.776 MB -> 115.082 MB. [2024-09-02T10:26:40.063Z] ====== log-regression (apache-spark) [default], iteration 9 completed (2411.021 ms) ====== [2024-09-02T10:26:40.063Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-09-02T10:26:40.063Z] GC before operation: completed in 261.143 ms, heap usage 247.976 MB -> 116.649 MB. [2024-09-02T10:26:42.081Z] ====== log-regression (apache-spark) [default], iteration 10 completed (2044.509 ms) ====== [2024-09-02T10:26:42.081Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-09-02T10:26:42.081Z] GC before operation: completed in 177.068 ms, heap usage 247.794 MB -> 165.399 MB. [2024-09-02T10:26:44.127Z] ====== log-regression (apache-spark) [default], iteration 11 completed (1966.726 ms) ====== [2024-09-02T10:26:44.127Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-09-02T10:26:44.127Z] GC before operation: completed in 157.653 ms, heap usage 282.634 MB -> 116.008 MB. [2024-09-02T10:26:46.245Z] ====== log-regression (apache-spark) [default], iteration 12 completed (2124.754 ms) ====== [2024-09-02T10:26:46.245Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-09-02T10:26:46.860Z] GC before operation: completed in 152.779 ms, heap usage 231.758 MB -> 114.973 MB. [2024-09-02T10:26:48.896Z] ====== log-regression (apache-spark) [default], iteration 13 completed (2083.172 ms) ====== [2024-09-02T10:26:48.896Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-09-02T10:26:48.896Z] GC before operation: completed in 145.638 ms, heap usage 230.936 MB -> 116.508 MB. [2024-09-02T10:26:50.916Z] ====== log-regression (apache-spark) [default], iteration 14 completed (2108.786 ms) ====== [2024-09-02T10:26:50.916Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-09-02T10:26:50.916Z] GC before operation: completed in 159.818 ms, heap usage 233.698 MB -> 104.085 MB. [2024-09-02T10:26:52.928Z] ====== log-regression (apache-spark) [default], iteration 15 completed (1846.797 ms) ====== [2024-09-02T10:26:52.928Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-09-02T10:26:52.928Z] GC before operation: completed in 133.897 ms, heap usage 219.964 MB -> 115.695 MB. [2024-09-02T10:26:54.940Z] ====== log-regression (apache-spark) [default], iteration 16 completed (1914.901 ms) ====== [2024-09-02T10:26:54.940Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-09-02T10:26:54.940Z] GC before operation: completed in 155.759 ms, heap usage 232.942 MB -> 182.397 MB. [2024-09-02T10:26:56.966Z] ====== log-regression (apache-spark) [default], iteration 17 completed (1851.705 ms) ====== [2024-09-02T10:26:56.966Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-09-02T10:26:56.966Z] GC before operation: completed in 169.219 ms, heap usage 280.394 MB -> 117.462 MB. [2024-09-02T10:26:59.110Z] ====== log-regression (apache-spark) [default], iteration 18 completed (1960.139 ms) ====== [2024-09-02T10:26:59.110Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-09-02T10:26:59.110Z] GC before operation: completed in 201.846 ms, heap usage 217.213 MB -> 104.677 MB. [2024-09-02T10:27:02.106Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2439.979 ms) ====== [2024-09-02T10:27:02.106Z] ----------------------------------- [2024-09-02T10:27:02.106Z] renaissance-log-regression_0_PASSED [2024-09-02T10:27:02.106Z] ----------------------------------- [2024-09-02T10:27:02.106Z] [2024-09-02T10:27:02.106Z] TEST TEARDOWN: [2024-09-02T10:27:02.106Z] Nothing to be done for teardown. [2024-09-02T10:27:02.106Z] renaissance-log-regression_0 Finish Time: Mon Sep 2 11:27:01 2024 Epoch Time (ms): 1725272821941