[2024-08-08T03:48:41.457Z] Running test renaissance-dec-tree_0 ... [2024-08-08T03:48:41.457Z] =============================================== [2024-08-08T03:48:41.457Z] renaissance-dec-tree_0 Start Time: Thu Aug 8 03:48:40 2024 Epoch Time (ms): 1723088920707 [2024-08-08T03:48:41.457Z] variation: NoOptions [2024-08-08T03:48:41.457Z] JVM_OPTIONS: [2024-08-08T03:48:41.457Z] { \ [2024-08-08T03:48:41.457Z] echo ""; echo "TEST SETUP:"; \ [2024-08-08T03:48:41.457Z] echo "Nothing to be done for setup."; \ [2024-08-08T03:48:41.457Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17230873725470/renaissance-dec-tree_0"; \ [2024-08-08T03:48:41.457Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17230873725470/renaissance-dec-tree_0"; \ [2024-08-08T03:48:41.457Z] echo ""; echo "TESTING:"; \ [2024-08-08T03:48:41.458Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/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_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17230873725470/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-08T03:48:41.458Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17230873725470/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-08T03:48:41.458Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-08T03:48:41.458Z] echo "Nothing to be done for teardown."; \ [2024-08-08T03:48:41.458Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/../TKG/output_17230873725470/TestTargetResult"; [2024-08-08T03:48:41.458Z] [2024-08-08T03:48:41.458Z] TEST SETUP: [2024-08-08T03:48:41.458Z] Nothing to be done for setup. [2024-08-08T03:48:41.458Z] [2024-08-08T03:48:41.458Z] TESTING: [2024-08-08T03:48:49.492Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-08T03:48:55.464Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 4 (out of 4) threads. [2024-08-08T03:48:58.760Z] WARNING: An illegal reflective access operation has occurred [2024-08-08T03:48:58.760Z] WARNING: Illegal reflective access by org.apache.spark.util.SizeEstimator$ (file:/home/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_alpine-linux_testList_0/aqa-tests/TKG/output_17230873725470/renaissance-dec-tree_0/harness-034842-15570227907195587804/apache-spark/lib/spark-core_2.13-3.2.0.jar) to field java.net.URI.scheme [2024-08-08T03:48:58.760Z] WARNING: Please consider reporting this to the maintainers of org.apache.spark.util.SizeEstimator$ [2024-08-08T03:48:58.760Z] WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations [2024-08-08T03:48:58.760Z] WARNING: All illegal access operations will be denied in a future release [2024-08-08T03:49:08.375Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-08T03:49:08.375Z] GC before operation: completed in 309.491 ms, heap usage 71.144 MB -> 33.800 MB. [2024-08-08T03:49:43.271Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (34530.294 ms) ====== [2024-08-08T03:49:43.271Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-08T03:49:44.017Z] GC before operation: completed in 485.905 ms, heap usage 173.496 MB -> 63.404 MB. [2024-08-08T03:49:57.526Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (13234.364 ms) ====== [2024-08-08T03:49:57.526Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-08T03:49:57.526Z] GC before operation: completed in 428.140 ms, heap usage 143.933 MB -> 63.969 MB. [2024-08-08T03:50:09.167Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (10776.400 ms) ====== [2024-08-08T03:50:09.167Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-08T03:50:09.167Z] GC before operation: completed in 440.259 ms, heap usage 229.342 MB -> 64.509 MB. [2024-08-08T03:50:17.826Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (9152.476 ms) ====== [2024-08-08T03:50:17.826Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-08T03:50:18.575Z] GC before operation: completed in 480.728 ms, heap usage 230.055 MB -> 64.890 MB. [2024-08-08T03:50:26.652Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (8253.627 ms) ====== [2024-08-08T03:50:26.652Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-08T03:50:26.652Z] GC before operation: completed in 413.428 ms, heap usage 150.895 MB -> 64.549 MB. [2024-08-08T03:50:34.763Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (7613.928 ms) ====== [2024-08-08T03:50:34.763Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-08T03:50:34.763Z] GC before operation: completed in 453.519 ms, heap usage 204.922 MB -> 64.899 MB. [2024-08-08T03:50:41.481Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (6612.554 ms) ====== [2024-08-08T03:50:41.481Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-08T03:50:42.227Z] GC before operation: completed in 431.954 ms, heap usage 187.542 MB -> 65.090 MB. [2024-08-08T03:50:49.062Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (6676.698 ms) ====== [2024-08-08T03:50:49.062Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-08T03:50:49.062Z] GC before operation: completed in 428.517 ms, heap usage 108.845 MB -> 64.910 MB. [2024-08-08T03:50:55.732Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (6351.223 ms) ====== [2024-08-08T03:50:55.732Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-08T03:50:55.732Z] GC before operation: completed in 368.886 ms, heap usage 243.930 MB -> 65.464 MB. [2024-08-08T03:51:02.439Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (6770.734 ms) ====== [2024-08-08T03:51:02.439Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-08T03:51:03.186Z] GC before operation: completed in 478.859 ms, heap usage 226.718 MB -> 65.423 MB. [2024-08-08T03:51:10.415Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (6587.602 ms) ====== [2024-08-08T03:51:10.416Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-08T03:51:10.416Z] GC before operation: completed in 405.081 ms, heap usage 171.943 MB -> 65.409 MB. [2024-08-08T03:51:15.931Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (5497.661 ms) ====== [2024-08-08T03:51:15.931Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-08T03:51:15.931Z] GC before operation: completed in 485.356 ms, heap usage 237.017 MB -> 65.783 MB. [2024-08-08T03:51:21.497Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (5421.425 ms) ====== [2024-08-08T03:51:21.497Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-08T03:51:22.251Z] GC before operation: completed in 390.176 ms, heap usage 129.744 MB -> 65.597 MB. [2024-08-08T03:51:27.769Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (5656.746 ms) ====== [2024-08-08T03:51:27.769Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-08T03:51:27.769Z] GC before operation: completed in 341.984 ms, heap usage 225.611 MB -> 66.002 MB. [2024-08-08T03:51:33.244Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (4969.055 ms) ====== [2024-08-08T03:51:33.244Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-08T03:51:33.244Z] GC before operation: completed in 415.910 ms, heap usage 226.513 MB -> 66.103 MB. [2024-08-08T03:51:38.693Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (5401.044 ms) ====== [2024-08-08T03:51:38.693Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-08T03:51:39.444Z] GC before operation: completed in 509.728 ms, heap usage 107.587 MB -> 65.992 MB. [2024-08-08T03:51:44.939Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (5191.379 ms) ====== [2024-08-08T03:51:44.939Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-08T03:51:44.939Z] GC before operation: completed in 554.378 ms, heap usage 257.116 MB -> 66.227 MB. [2024-08-08T03:51:50.387Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (4860.758 ms) ====== [2024-08-08T03:51:50.387Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-08T03:51:50.387Z] GC before operation: completed in 433.049 ms, heap usage 218.655 MB -> 66.339 MB. [2024-08-08T03:51:55.876Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (5316.353 ms) ====== [2024-08-08T03:51:55.876Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-08T03:51:55.876Z] GC before operation: completed in 453.784 ms, heap usage 108.120 MB -> 66.019 MB. [2024-08-08T03:52:01.395Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (4740.262 ms) ====== [2024-08-08T03:52:01.395Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-08T03:52:01.395Z] GC before operation: completed in 469.389 ms, heap usage 230.606 MB -> 67.360 MB. [2024-08-08T03:52:06.239Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (5048.263 ms) ====== [2024-08-08T03:52:06.240Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-08T03:52:06.979Z] GC before operation: completed in 411.646 ms, heap usage 158.937 MB -> 66.512 MB. [2024-08-08T03:52:12.399Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (5035.092 ms) ====== [2024-08-08T03:52:12.399Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-08T03:52:12.399Z] GC before operation: completed in 441.196 ms, heap usage 170.414 MB -> 66.607 MB. [2024-08-08T03:52:16.736Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (4829.380 ms) ====== [2024-08-08T03:52:16.736Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-08T03:52:17.490Z] GC before operation: completed in 477.268 ms, heap usage 133.939 MB -> 66.846 MB. [2024-08-08T03:52:21.845Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (4743.762 ms) ====== [2024-08-08T03:52:21.845Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-08T03:52:22.591Z] GC before operation: completed in 504.208 ms, heap usage 306.471 MB -> 66.957 MB. [2024-08-08T03:52:28.432Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (5047.152 ms) ====== [2024-08-08T03:52:28.432Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-08T03:52:28.432Z] GC before operation: completed in 503.861 ms, heap usage 98.481 MB -> 66.929 MB. [2024-08-08T03:52:33.101Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (5026.454 ms) ====== [2024-08-08T03:52:33.101Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-08T03:52:33.907Z] GC before operation: completed in 399.113 ms, heap usage 148.250 MB -> 66.859 MB. [2024-08-08T03:52:38.577Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (4586.303 ms) ====== [2024-08-08T03:52:38.577Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-08T03:52:38.577Z] GC before operation: completed in 412.425 ms, heap usage 174.421 MB -> 67.131 MB. [2024-08-08T03:52:43.286Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (4796.492 ms) ====== [2024-08-08T03:52:43.286Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-08T03:52:44.109Z] GC before operation: completed in 417.510 ms, heap usage 284.321 MB -> 67.498 MB. [2024-08-08T03:52:48.808Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (4434.133 ms) ====== [2024-08-08T03:52:48.809Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-08T03:52:48.809Z] GC before operation: completed in 446.416 ms, heap usage 222.485 MB -> 95.052 MB. [2024-08-08T03:52:54.729Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (5242.695 ms) ====== [2024-08-08T03:52:54.729Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-08T03:52:54.729Z] GC before operation: completed in 458.409 ms, heap usage 301.667 MB -> 67.541 MB. [2024-08-08T03:52:58.737Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (4396.575 ms) ====== [2024-08-08T03:52:58.737Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-08T03:52:59.551Z] GC before operation: completed in 474.183 ms, heap usage 229.751 MB -> 67.787 MB. [2024-08-08T03:53:04.232Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (4408.299 ms) ====== [2024-08-08T03:53:04.232Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-08T03:53:04.232Z] GC before operation: completed in 413.600 ms, heap usage 224.455 MB -> 68.134 MB. [2024-08-08T03:53:09.130Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (4237.046 ms) ====== [2024-08-08T03:53:09.131Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-08T03:53:09.131Z] GC before operation: completed in 421.192 ms, heap usage 237.206 MB -> 67.973 MB. [2024-08-08T03:53:12.718Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (4249.574 ms) ====== [2024-08-08T03:53:12.719Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-08T03:53:13.536Z] GC before operation: completed in 457.851 ms, heap usage 184.122 MB -> 95.552 MB. [2024-08-08T03:53:18.229Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (4912.152 ms) ====== [2024-08-08T03:53:18.229Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-08T03:53:19.040Z] GC before operation: completed in 382.367 ms, heap usage 218.158 MB -> 68.206 MB. [2024-08-08T03:53:23.697Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (4663.428 ms) ====== [2024-08-08T03:53:23.697Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-08T03:53:23.697Z] GC before operation: completed in 416.242 ms, heap usage 281.501 MB -> 68.291 MB. [2024-08-08T03:53:28.438Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (4473.967 ms) ====== [2024-08-08T03:53:28.438Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-08T03:53:29.274Z] GC before operation: completed in 439.759 ms, heap usage 114.750 MB -> 95.285 MB. [2024-08-08T03:53:34.004Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (5005.283 ms) ====== [2024-08-08T03:53:34.004Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-08T03:53:34.004Z] GC before operation: completed in 407.739 ms, heap usage 307.285 MB -> 68.480 MB. [2024-08-08T03:53:38.695Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (4761.364 ms) ====== [2024-08-08T03:53:38.695Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-08T03:53:39.509Z] GC before operation: completed in 568.147 ms, heap usage 221.274 MB -> 68.577 MB. [2024-08-08T03:53:44.419Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (4445.300 ms) ====== [2024-08-08T03:53:45.231Z] ----------------------------------- [2024-08-08T03:53:45.231Z] renaissance-dec-tree_0_PASSED [2024-08-08T03:53:45.231Z] ----------------------------------- [2024-08-08T03:53:45.231Z] [2024-08-08T03:53:45.231Z] TEST TEARDOWN: [2024-08-08T03:53:45.231Z] Nothing to be done for teardown. [2024-08-08T03:53:45.232Z] renaissance-dec-tree_0 Finish Time: Thu Aug 8 03:53:44 2024 Epoch Time (ms): 1723089224460