[2024-11-29T15:21:51.387Z] Running test renaissance-log-regression_0 ... [2024-11-29T15:21:51.387Z] =============================================== [2024-11-29T15:21:51.387Z] renaissance-log-regression_0 Start Time: Fri Nov 29 15:21:50 2024 Epoch Time (ms): 1732893710668 [2024-11-29T15:21:51.387Z] variation: NoOptions [2024-11-29T15:21:51.387Z] JVM_OPTIONS: [2024-11-29T15:21:51.387Z] { \ [2024-11-29T15:21:51.387Z] echo ""; echo "TEST SETUP:"; \ [2024-11-29T15:21:51.387Z] echo "Nothing to be done for setup."; \ [2024-11-29T15:21:51.387Z] mkdir -p "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17328918013078/renaissance-log-regression_0"; \ [2024-11-29T15:21:51.387Z] cd "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17328918013078/renaissance-log-regression_0"; \ [2024-11-29T15:21:51.387Z] echo ""; echo "TESTING:"; \ [2024-11-29T15:21:51.387Z] "/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_17328918013078/renaissance-log-regression_0"/log-regression.json" log-regression; \ [2024-11-29T15:21:51.387Z] 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_17328918013078/renaissance-log-regression_0"; else echo "-----------------------------------"; echo "renaissance-log-regression_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-29T15:21:51.387Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-29T15:21:51.387Z] echo "Nothing to be done for teardown."; \ [2024-11-29T15:21:51.387Z] } 2>&1 | tee -a "/export/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_solaris/aqa-tests/TKG/../TKG/output_17328918013078/TestTargetResult"; [2024-11-29T15:21:51.387Z] [2024-11-29T15:21:51.387Z] TEST SETUP: [2024-11-29T15:21:51.387Z] Nothing to be done for setup. [2024-11-29T15:21:51.387Z] [2024-11-29T15:21:51.387Z] TESTING: [2024-11-29T15:22:01.803Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-11-29T15:22:06.719Z] NOTE: 'log-regression' benchmark uses Spark local executor with 1 (out of 1) threads. [2024-11-29T15:22:17.244Z] ====== log-regression (apache-spark) [default], iteration 0 started ====== [2024-11-29T15:22:17.245Z] GC before operation: completed in 142.682 ms, heap usage 40.425 MB -> 22.408 MB. [2024-11-29T15:22:42.288Z] ====== log-regression (apache-spark) [default], iteration 0 completed (23987.344 ms) ====== [2024-11-29T15:22:42.288Z] ====== log-regression (apache-spark) [default], iteration 1 started ====== [2024-11-29T15:22:42.289Z] GC before operation: completed in 217.138 ms, heap usage 200.735 MB -> 110.581 MB. [2024-11-29T15:22:48.365Z] ====== log-regression (apache-spark) [default], iteration 1 completed (7742.018 ms) ====== [2024-11-29T15:22:48.365Z] ====== log-regression (apache-spark) [default], iteration 2 started ====== [2024-11-29T15:22:48.365Z] GC before operation: completed in 327.195 ms, heap usage 233.554 MB -> 110.296 MB. [2024-11-29T15:22:54.602Z] ====== log-regression (apache-spark) [default], iteration 2 completed (5084.180 ms) ====== [2024-11-29T15:22:54.602Z] ====== log-regression (apache-spark) [default], iteration 3 started ====== [2024-11-29T15:22:54.602Z] GC before operation: completed in 347.107 ms, heap usage 234.401 MB -> 102.538 MB. [2024-11-29T15:23:00.020Z] ====== log-regression (apache-spark) [default], iteration 3 completed (4907.184 ms) ====== [2024-11-29T15:23:00.020Z] ====== log-regression (apache-spark) [default], iteration 4 started ====== [2024-11-29T15:23:00.020Z] GC before operation: completed in 217.731 ms, heap usage 233.828 MB -> 109.200 MB. [2024-11-29T15:23:03.086Z] ====== log-regression (apache-spark) [default], iteration 4 completed (4142.472 ms) ====== [2024-11-29T15:23:03.087Z] ====== log-regression (apache-spark) [default], iteration 5 started ====== [2024-11-29T15:23:03.828Z] GC before operation: completed in 262.486 ms, heap usage 177.626 MB -> 110.118 MB. [2024-11-29T15:23:07.751Z] ====== log-regression (apache-spark) [default], iteration 5 completed (4166.594 ms) ====== [2024-11-29T15:23:07.751Z] ====== log-regression (apache-spark) [default], iteration 6 started ====== [2024-11-29T15:23:07.751Z] GC before operation: completed in 242.124 ms, heap usage 234.850 MB -> 111.315 MB. [2024-11-29T15:23:11.756Z] ====== log-regression (apache-spark) [default], iteration 6 completed (3634.800 ms) ====== [2024-11-29T15:23:11.756Z] ====== log-regression (apache-spark) [default], iteration 7 started ====== [2024-11-29T15:23:11.756Z] GC before operation: completed in 253.971 ms, heap usage 226.474 MB -> 102.356 MB. [2024-11-29T15:23:15.663Z] ====== log-regression (apache-spark) [default], iteration 7 completed (3566.875 ms) ====== [2024-11-29T15:23:15.663Z] ====== log-regression (apache-spark) [default], iteration 8 started ====== [2024-11-29T15:23:15.663Z] GC before operation: completed in 238.626 ms, heap usage 211.166 MB -> 110.899 MB. [2024-11-29T15:23:19.520Z] ====== log-regression (apache-spark) [default], iteration 8 completed (3405.096 ms) ====== [2024-11-29T15:23:19.520Z] ====== log-regression (apache-spark) [default], iteration 9 started ====== [2024-11-29T15:23:19.520Z] GC before operation: completed in 228.824 ms, heap usage 219.905 MB -> 111.948 MB. [2024-11-29T15:23:22.478Z] ====== log-regression (apache-spark) [default], iteration 9 completed (3386.529 ms) ====== [2024-11-29T15:23:22.478Z] ====== log-regression (apache-spark) [default], iteration 10 started ====== [2024-11-29T15:23:23.134Z] GC before operation: completed in 355.850 ms, heap usage 216.035 MB -> 112.860 MB. [2024-11-29T15:23:26.085Z] ====== log-regression (apache-spark) [default], iteration 10 completed (3381.673 ms) ====== [2024-11-29T15:23:26.085Z] ====== log-regression (apache-spark) [default], iteration 11 started ====== [2024-11-29T15:23:26.882Z] GC before operation: completed in 301.781 ms, heap usage 205.712 MB -> 102.948 MB. [2024-11-29T15:23:30.895Z] ====== log-regression (apache-spark) [default], iteration 11 completed (4043.862 ms) ====== [2024-11-29T15:23:30.895Z] ====== log-regression (apache-spark) [default], iteration 12 started ====== [2024-11-29T15:23:30.895Z] GC before operation: completed in 228.216 ms, heap usage 196.437 MB -> 112.333 MB. [2024-11-29T15:23:34.861Z] ====== log-regression (apache-spark) [default], iteration 12 completed (3531.090 ms) ====== [2024-11-29T15:23:34.861Z] ====== log-regression (apache-spark) [default], iteration 13 started ====== [2024-11-29T15:23:34.861Z] GC before operation: completed in 238.376 ms, heap usage 205.969 MB -> 112.672 MB. [2024-11-29T15:23:37.825Z] ====== log-regression (apache-spark) [default], iteration 13 completed (3084.142 ms) ====== [2024-11-29T15:23:37.825Z] ====== log-regression (apache-spark) [default], iteration 14 started ====== [2024-11-29T15:23:37.825Z] GC before operation: completed in 256.839 ms, heap usage 200.475 MB -> 113.325 MB. [2024-11-29T15:23:41.679Z] ====== log-regression (apache-spark) [default], iteration 14 completed (3256.727 ms) ====== [2024-11-29T15:23:41.679Z] ====== log-regression (apache-spark) [default], iteration 15 started ====== [2024-11-29T15:23:41.679Z] GC before operation: completed in 258.536 ms, heap usage 196.709 MB -> 103.738 MB. [2024-11-29T15:23:44.752Z] ====== log-regression (apache-spark) [default], iteration 15 completed (3237.357 ms) ====== [2024-11-29T15:23:44.752Z] ====== log-regression (apache-spark) [default], iteration 16 started ====== [2024-11-29T15:23:44.752Z] GC before operation: completed in 231.942 ms, heap usage 188.116 MB -> 107.023 MB. [2024-11-29T15:23:49.119Z] ====== log-regression (apache-spark) [default], iteration 16 completed (3613.198 ms) ====== [2024-11-29T15:23:49.119Z] ====== log-regression (apache-spark) [default], iteration 17 started ====== [2024-11-29T15:23:49.119Z] GC before operation: completed in 236.821 ms, heap usage 191.149 MB -> 110.644 MB. [2024-11-29T15:23:52.051Z] ====== log-regression (apache-spark) [default], iteration 17 completed (3152.436 ms) ====== [2024-11-29T15:23:52.051Z] ====== log-regression (apache-spark) [default], iteration 18 started ====== [2024-11-29T15:23:52.051Z] GC before operation: completed in 231.047 ms, heap usage 194.152 MB -> 112.686 MB. [2024-11-29T15:23:55.932Z] ====== log-regression (apache-spark) [default], iteration 18 completed (3099.831 ms) ====== [2024-11-29T15:23:55.932Z] ====== log-regression (apache-spark) [default], iteration 19 started ====== [2024-11-29T15:23:55.932Z] GC before operation: completed in 272.294 ms, heap usage 196.502 MB -> 104.939 MB. [2024-11-29T15:23:58.915Z] ====== log-regression (apache-spark) [default], iteration 19 completed (2995.467 ms) ====== [2024-11-29T15:23:59.757Z] ----------------------------------- [2024-11-29T15:23:59.757Z] renaissance-log-regression_0_PASSED [2024-11-29T15:23:59.757Z] ----------------------------------- [2024-11-29T15:23:59.757Z] [2024-11-29T15:23:59.757Z] TEST TEARDOWN: [2024-11-29T15:23:59.757Z] Nothing to be done for teardown. [2024-11-29T15:23:59.757Z] renaissance-log-regression_0 Finish Time: Fri Nov 29 15:23:59 2024 Epoch Time (ms): 1732893839275