[2024-07-31T22:12:22.752Z] Running test renaissance-dec-tree_0 ... [2024-07-31T22:12:22.752Z] =============================================== [2024-07-31T22:12:22.752Z] renaissance-dec-tree_0 Start Time: Wed Jul 31 22:12:22 2024 Epoch Time (ms): 1722463942457 [2024-07-31T22:12:22.752Z] variation: NoOptions [2024-07-31T22:12:22.752Z] JVM_OPTIONS: [2024-07-31T22:12:22.752Z] { \ [2024-07-31T22:12:22.752Z] echo ""; echo "TEST SETUP:"; \ [2024-07-31T22:12:22.752Z] echo "Nothing to be done for setup."; \ [2024-07-31T22:12:22.752Z] mkdir -p "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17224635699248/renaissance-dec-tree_0"; \ [2024-07-31T22:12:22.752Z] cd "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17224635699248/renaissance-dec-tree_0"; \ [2024-07-31T22:12:22.752Z] echo ""; echo "TESTING:"; \ [2024-07-31T22:12:22.752Z] "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_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_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17224635699248/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-07-31T22:12:22.752Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17224635699248/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-07-31T22:12:22.752Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-07-31T22:12:22.752Z] echo "Nothing to be done for teardown."; \ [2024-07-31T22:12:22.752Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk17_hs_extended.perf_s390x_linux_testList_0/aqa-tests/TKG/../TKG/output_17224635699248/TestTargetResult"; [2024-07-31T22:12:22.752Z] [2024-07-31T22:12:22.752Z] TEST SETUP: [2024-07-31T22:12:22.752Z] Nothing to be done for setup. [2024-07-31T22:12:22.752Z] [2024-07-31T22:12:22.752Z] TESTING: [2024-07-31T22:12:25.442Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-07-31T22:12:26.666Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 2 (out of 2) threads. [2024-07-31T22:12:28.587Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-07-31T22:12:28.587Z] GC before operation: completed in 44.563 ms, heap usage 41.146 MB -> 34.921 MB. [2024-07-31T22:12:35.409Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (6826.420 ms) ====== [2024-07-31T22:12:35.409Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-07-31T22:12:35.409Z] GC before operation: completed in 82.266 ms, heap usage 100.898 MB -> 90.889 MB. [2024-07-31T22:12:37.328Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (2130.463 ms) ====== [2024-07-31T22:12:37.328Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-07-31T22:12:37.328Z] GC before operation: completed in 89.657 ms, heap usage 381.989 MB -> 63.637 MB. [2024-07-31T22:12:39.264Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1917.098 ms) ====== [2024-07-31T22:12:39.264Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-07-31T22:12:39.850Z] GC before operation: completed in 102.382 ms, heap usage 160.331 MB -> 63.656 MB. [2024-07-31T22:12:41.094Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1780.466 ms) ====== [2024-07-31T22:12:41.094Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-07-31T22:12:41.681Z] GC before operation: completed in 109.036 ms, heap usage 294.862 MB -> 64.544 MB. [2024-07-31T22:12:43.630Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1861.621 ms) ====== [2024-07-31T22:12:43.630Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-07-31T22:12:43.630Z] GC before operation: completed in 94.448 ms, heap usage 109.158 MB -> 63.979 MB. [2024-07-31T22:12:45.554Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1787.433 ms) ====== [2024-07-31T22:12:45.554Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-07-31T22:12:45.554Z] GC before operation: completed in 74.369 ms, heap usage 287.466 MB -> 64.588 MB. [2024-07-31T22:12:46.789Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1717.661 ms) ====== [2024-07-31T22:12:46.789Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-07-31T22:12:47.376Z] GC before operation: completed in 96.639 ms, heap usage 181.980 MB -> 64.938 MB. [2024-07-31T22:12:48.598Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1733.310 ms) ====== [2024-07-31T22:12:48.599Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-07-31T22:12:49.187Z] GC before operation: completed in 102.893 ms, heap usage 183.580 MB -> 64.982 MB. [2024-07-31T22:12:50.412Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1614.885 ms) ====== [2024-07-31T22:12:50.412Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-07-31T22:12:50.412Z] GC before operation: completed in 94.698 ms, heap usage 181.935 MB -> 65.217 MB. [2024-07-31T22:12:52.344Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1507.142 ms) ====== [2024-07-31T22:12:52.344Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-07-31T22:12:52.344Z] GC before operation: completed in 97.294 ms, heap usage 182.660 MB -> 65.192 MB. [2024-07-31T22:12:53.597Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1560.512 ms) ====== [2024-07-31T22:12:53.597Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-07-31T22:12:54.189Z] GC before operation: completed in 102.937 ms, heap usage 174.973 MB -> 65.713 MB. [2024-07-31T22:12:55.420Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1409.416 ms) ====== [2024-07-31T22:12:55.420Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-07-31T22:12:55.420Z] GC before operation: completed in 110.912 ms, heap usage 176.908 MB -> 65.418 MB. [2024-07-31T22:12:57.416Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1497.377 ms) ====== [2024-07-31T22:12:57.416Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-07-31T22:12:57.416Z] GC before operation: completed in 82.849 ms, heap usage 183.996 MB -> 65.490 MB. [2024-07-31T22:12:58.647Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1526.116 ms) ====== [2024-07-31T22:12:58.647Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-07-31T22:12:58.647Z] GC before operation: completed in 93.521 ms, heap usage 173.748 MB -> 65.605 MB. [2024-07-31T22:13:00.576Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1589.242 ms) ====== [2024-07-31T22:13:00.576Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-07-31T22:13:00.576Z] GC before operation: completed in 96.483 ms, heap usage 167.386 MB -> 65.627 MB. [2024-07-31T22:13:02.500Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1821.711 ms) ====== [2024-07-31T22:13:02.500Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-07-31T22:13:02.500Z] GC before operation: completed in 111.477 ms, heap usage 136.875 MB -> 65.741 MB. [2024-07-31T22:13:03.741Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1487.180 ms) ====== [2024-07-31T22:13:03.741Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-07-31T22:13:03.741Z] GC before operation: completed in 94.308 ms, heap usage 323.057 MB -> 66.044 MB. [2024-07-31T22:13:05.125Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1346.729 ms) ====== [2024-07-31T22:13:05.125Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-07-31T22:13:05.125Z] GC before operation: completed in 78.283 ms, heap usage 185.405 MB -> 66.187 MB. [2024-07-31T22:13:07.145Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1543.391 ms) ====== [2024-07-31T22:13:07.145Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-07-31T22:13:07.145Z] GC before operation: completed in 116.303 ms, heap usage 166.456 MB -> 66.086 MB. [2024-07-31T22:13:08.447Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1575.385 ms) ====== [2024-07-31T22:13:08.447Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-07-31T22:13:08.447Z] GC before operation: completed in 131.313 ms, heap usage 138.587 MB -> 74.564 MB. [2024-07-31T22:13:10.375Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1630.145 ms) ====== [2024-07-31T22:13:10.375Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-07-31T22:13:10.375Z] GC before operation: completed in 103.040 ms, heap usage 252.870 MB -> 66.624 MB. [2024-07-31T22:13:11.603Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1415.590 ms) ====== [2024-07-31T22:13:11.603Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-07-31T22:13:11.603Z] GC before operation: completed in 83.861 ms, heap usage 108.174 MB -> 66.012 MB. [2024-07-31T22:13:13.543Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1489.572 ms) ====== [2024-07-31T22:13:13.543Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-07-31T22:13:13.543Z] GC before operation: completed in 106.625 ms, heap usage 202.083 MB -> 66.924 MB. [2024-07-31T22:13:14.770Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1442.675 ms) ====== [2024-07-31T22:13:14.770Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-07-31T22:13:14.770Z] GC before operation: completed in 93.394 ms, heap usage 251.978 MB -> 66.849 MB. [2024-07-31T22:13:16.697Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1558.347 ms) ====== [2024-07-31T22:13:16.697Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-07-31T22:13:16.697Z] GC before operation: completed in 96.620 ms, heap usage 194.218 MB -> 66.982 MB. [2024-07-31T22:13:17.926Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1341.143 ms) ====== [2024-07-31T22:13:17.926Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-07-31T22:13:17.926Z] GC before operation: completed in 109.322 ms, heap usage 140.666 MB -> 66.645 MB. [2024-07-31T22:13:19.853Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1429.980 ms) ====== [2024-07-31T22:13:19.853Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-07-31T22:13:19.853Z] GC before operation: completed in 149.662 ms, heap usage 209.602 MB -> 67.041 MB. [2024-07-31T22:13:21.080Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1548.604 ms) ====== [2024-07-31T22:13:21.080Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-07-31T22:13:21.080Z] GC before operation: completed in 115.012 ms, heap usage 153.559 MB -> 66.837 MB. [2024-07-31T22:13:23.009Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1504.570 ms) ====== [2024-07-31T22:13:23.009Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-07-31T22:13:23.009Z] GC before operation: completed in 102.014 ms, heap usage 319.377 MB -> 67.259 MB. [2024-07-31T22:13:24.933Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1694.895 ms) ====== [2024-07-31T22:13:24.933Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-07-31T22:13:24.933Z] GC before operation: completed in 124.838 ms, heap usage 184.957 MB -> 67.380 MB. [2024-07-31T22:13:26.158Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1364.145 ms) ====== [2024-07-31T22:13:26.158Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-07-31T22:13:26.158Z] GC before operation: completed in 114.257 ms, heap usage 141.643 MB -> 67.256 MB. [2024-07-31T22:13:28.080Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1635.264 ms) ====== [2024-07-31T22:13:28.080Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-07-31T22:13:28.080Z] GC before operation: completed in 103.880 ms, heap usage 303.622 MB -> 67.571 MB. [2024-07-31T22:13:29.311Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1345.944 ms) ====== [2024-07-31T22:13:29.311Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-07-31T22:13:29.311Z] GC before operation: completed in 113.465 ms, heap usage 225.956 MB -> 67.818 MB. [2024-07-31T22:13:31.240Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1379.761 ms) ====== [2024-07-31T22:13:31.240Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-07-31T22:13:31.240Z] GC before operation: completed in 114.696 ms, heap usage 138.073 MB -> 67.595 MB. [2024-07-31T22:13:32.464Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1381.035 ms) ====== [2024-07-31T22:13:32.464Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-07-31T22:13:32.464Z] GC before operation: completed in 123.917 ms, heap usage 296.116 MB -> 76.374 MB. [2024-07-31T22:13:33.692Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1373.818 ms) ====== [2024-07-31T22:13:33.692Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-07-31T22:13:33.692Z] GC before operation: completed in 90.139 ms, heap usage 262.725 MB -> 68.074 MB. [2024-07-31T22:13:35.669Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1404.445 ms) ====== [2024-07-31T22:13:35.669Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-07-31T22:13:35.669Z] GC before operation: completed in 115.921 ms, heap usage 263.840 MB -> 68.189 MB. [2024-07-31T22:13:36.894Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1374.623 ms) ====== [2024-07-31T22:13:36.894Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-07-31T22:13:36.894Z] GC before operation: completed in 111.596 ms, heap usage 153.729 MB -> 68.057 MB. [2024-07-31T22:13:38.125Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1359.180 ms) ====== [2024-07-31T22:13:38.125Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-07-31T22:13:38.714Z] GC before operation: completed in 123.232 ms, heap usage 304.469 MB -> 68.444 MB. [2024-07-31T22:13:39.946Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1622.778 ms) ====== [2024-07-31T22:13:40.533Z] ----------------------------------- [2024-07-31T22:13:40.533Z] renaissance-dec-tree_0_PASSED [2024-07-31T22:13:40.533Z] ----------------------------------- [2024-07-31T22:13:40.533Z] [2024-07-31T22:13:40.533Z] TEST TEARDOWN: [2024-07-31T22:13:40.533Z] Nothing to be done for teardown. [2024-07-31T22:13:40.533Z] renaissance-dec-tree_0 Finish Time: Wed Jul 31 22:13:39 2024 Epoch Time (ms): 1722464019943