[2024-08-02T05:07:45.321Z] Running test renaissance-dec-tree_0 ... [2024-08-02T05:07:45.321Z] =============================================== [2024-08-02T05:07:45.321Z] renaissance-dec-tree_0 Start Time: Fri Aug 2 00:07:44 2024 Epoch Time (ms): 1722575264980 [2024-08-02T05:07:45.321Z] variation: NoOptions [2024-08-02T05:07:45.321Z] JVM_OPTIONS: [2024-08-02T05:07:45.321Z] { \ [2024-08-02T05:07:45.321Z] echo ""; echo "TEST SETUP:"; \ [2024-08-02T05:07:45.321Z] echo "Nothing to be done for setup."; \ [2024-08-02T05:07:45.321Z] mkdir -p "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225748014076/renaissance-dec-tree_0"; \ [2024-08-02T05:07:45.321Z] cd "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225748014076/renaissance-dec-tree_0"; \ [2024-08-02T05:07:45.321Z] echo ""; echo "TESTING:"; \ [2024-08-02T05:07:45.321Z] "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/jdkbinary/j2sdk-image/jdk8u432-b01/bin/..//bin/java" -jar "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../../jvmtest/perf/renaissance/renaissance.jar" --json ""/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225748014076/renaissance-dec-tree_0"/dec-tree.json" dec-tree; \ [2024-08-02T05:07:45.321Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-dec-tree_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/..; rm -f -r "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225748014076/renaissance-dec-tree_0"; else echo "-----------------------------------"; echo "renaissance-dec-tree_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-08-02T05:07:45.321Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-08-02T05:07:45.321Z] echo "Nothing to be done for teardown."; \ [2024-08-02T05:07:45.321Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk8_hs_extended.perf_x86-64_linux_testList_0/aqa-tests/TKG/../TKG/output_17225748014076/TestTargetResult"; [2024-08-02T05:07:45.321Z] [2024-08-02T05:07:45.321Z] TEST SETUP: [2024-08-02T05:07:45.321Z] Nothing to be done for setup. [2024-08-02T05:07:45.321Z] [2024-08-02T05:07:45.321Z] TESTING: [2024-08-02T05:07:48.418Z] Using Spark's default log4j profile: org/apache/spark/log4j-defaults.properties [2024-08-02T05:07:50.747Z] NOTE: 'dec-tree' benchmark uses Spark local executor with 6 (out of 8) threads. [2024-08-02T05:07:53.802Z] ====== dec-tree (apache-spark) [default], iteration 0 started ====== [2024-08-02T05:07:53.802Z] GC before operation: completed in 206.986 ms, heap usage 132.533 MB -> 30.995 MB. [2024-08-02T05:08:02.874Z] ====== dec-tree (apache-spark) [default], iteration 0 completed (8032.519 ms) ====== [2024-08-02T05:08:02.874Z] ====== dec-tree (apache-spark) [default], iteration 1 started ====== [2024-08-02T05:08:02.874Z] GC before operation: completed in 358.661 ms, heap usage 120.965 MB -> 55.454 MB. [2024-08-02T05:08:04.285Z] ====== dec-tree (apache-spark) [default], iteration 1 completed (1822.386 ms) ====== [2024-08-02T05:08:04.286Z] ====== dec-tree (apache-spark) [default], iteration 2 started ====== [2024-08-02T05:08:04.286Z] GC before operation: completed in 312.491 ms, heap usage 413.571 MB -> 67.635 MB. [2024-08-02T05:08:06.475Z] ====== dec-tree (apache-spark) [default], iteration 2 completed (1580.596 ms) ====== [2024-08-02T05:08:06.475Z] ====== dec-tree (apache-spark) [default], iteration 3 started ====== [2024-08-02T05:08:06.475Z] GC before operation: completed in 280.412 ms, heap usage 339.002 MB -> 68.044 MB. [2024-08-02T05:08:07.875Z] ====== dec-tree (apache-spark) [default], iteration 3 completed (1653.911 ms) ====== [2024-08-02T05:08:07.875Z] ====== dec-tree (apache-spark) [default], iteration 4 started ====== [2024-08-02T05:08:08.562Z] GC before operation: completed in 245.417 ms, heap usage 313.800 MB -> 73.722 MB. [2024-08-02T05:08:09.970Z] ====== dec-tree (apache-spark) [default], iteration 4 completed (1448.784 ms) ====== [2024-08-02T05:08:09.970Z] ====== dec-tree (apache-spark) [default], iteration 5 started ====== [2024-08-02T05:08:09.970Z] GC before operation: completed in 185.339 ms, heap usage 304.310 MB -> 68.532 MB. [2024-08-02T05:08:11.375Z] ====== dec-tree (apache-spark) [default], iteration 5 completed (1335.759 ms) ====== [2024-08-02T05:08:11.375Z] ====== dec-tree (apache-spark) [default], iteration 6 started ====== [2024-08-02T05:08:11.375Z] GC before operation: completed in 219.360 ms, heap usage 320.934 MB -> 63.359 MB. [2024-08-02T05:08:12.808Z] ====== dec-tree (apache-spark) [default], iteration 6 completed (1351.554 ms) ====== [2024-08-02T05:08:12.808Z] ====== dec-tree (apache-spark) [default], iteration 7 started ====== [2024-08-02T05:08:12.808Z] GC before operation: completed in 187.031 ms, heap usage 278.543 MB -> 68.862 MB. [2024-08-02T05:08:14.217Z] ====== dec-tree (apache-spark) [default], iteration 7 completed (1242.585 ms) ====== [2024-08-02T05:08:14.217Z] ====== dec-tree (apache-spark) [default], iteration 8 started ====== [2024-08-02T05:08:14.217Z] GC before operation: completed in 266.594 ms, heap usage 281.211 MB -> 57.925 MB. [2024-08-02T05:08:15.636Z] ====== dec-tree (apache-spark) [default], iteration 8 completed (1427.638 ms) ====== [2024-08-02T05:08:15.636Z] ====== dec-tree (apache-spark) [default], iteration 9 started ====== [2024-08-02T05:08:16.312Z] GC before operation: completed in 248.171 ms, heap usage 270.139 MB -> 74.574 MB. [2024-08-02T05:08:17.712Z] ====== dec-tree (apache-spark) [default], iteration 9 completed (1199.627 ms) ====== [2024-08-02T05:08:17.712Z] ====== dec-tree (apache-spark) [default], iteration 10 started ====== [2024-08-02T05:08:17.712Z] GC before operation: completed in 223.716 ms, heap usage 293.674 MB -> 85.807 MB. [2024-08-02T05:08:19.115Z] ====== dec-tree (apache-spark) [default], iteration 10 completed (1388.827 ms) ====== [2024-08-02T05:08:19.115Z] ====== dec-tree (apache-spark) [default], iteration 11 started ====== [2024-08-02T05:08:19.115Z] GC before operation: completed in 243.896 ms, heap usage 322.553 MB -> 58.446 MB. [2024-08-02T05:08:20.516Z] ====== dec-tree (apache-spark) [default], iteration 11 completed (1215.987 ms) ====== [2024-08-02T05:08:20.516Z] ====== dec-tree (apache-spark) [default], iteration 12 started ====== [2024-08-02T05:08:20.516Z] GC before operation: completed in 246.310 ms, heap usage 291.377 MB -> 69.654 MB. [2024-08-02T05:08:21.925Z] ====== dec-tree (apache-spark) [default], iteration 12 completed (1259.595 ms) ====== [2024-08-02T05:08:21.925Z] ====== dec-tree (apache-spark) [default], iteration 13 started ====== [2024-08-02T05:08:21.925Z] GC before operation: completed in 224.588 ms, heap usage 296.151 MB -> 86.299 MB. [2024-08-02T05:08:23.331Z] ====== dec-tree (apache-spark) [default], iteration 13 completed (1184.105 ms) ====== [2024-08-02T05:08:23.331Z] ====== dec-tree (apache-spark) [default], iteration 14 started ====== [2024-08-02T05:08:23.331Z] GC before operation: completed in 208.355 ms, heap usage 308.547 MB -> 81.045 MB. [2024-08-02T05:08:23.331Z] 24/08/02 00:08:23 WARN BlockManager: Asked to remove block broadcast_190_piece0, which does not exist [2024-08-02T05:08:24.738Z] ====== dec-tree (apache-spark) [default], iteration 14 completed (1196.527 ms) ====== [2024-08-02T05:08:24.738Z] ====== dec-tree (apache-spark) [default], iteration 15 started ====== [2024-08-02T05:08:24.738Z] GC before operation: completed in 259.481 ms, heap usage 317.535 MB -> 75.520 MB. [2024-08-02T05:08:26.141Z] ====== dec-tree (apache-spark) [default], iteration 15 completed (1175.727 ms) ====== [2024-08-02T05:08:26.141Z] ====== dec-tree (apache-spark) [default], iteration 16 started ====== [2024-08-02T05:08:26.141Z] GC before operation: completed in 224.520 ms, heap usage 314.123 MB -> 59.334 MB. [2024-08-02T05:08:27.547Z] ====== dec-tree (apache-spark) [default], iteration 16 completed (1167.408 ms) ====== [2024-08-02T05:08:27.547Z] ====== dec-tree (apache-spark) [default], iteration 17 started ====== [2024-08-02T05:08:28.221Z] GC before operation: completed in 283.040 ms, heap usage 291.038 MB -> 59.372 MB. [2024-08-02T05:08:28.894Z] ====== dec-tree (apache-spark) [default], iteration 17 completed (1179.968 ms) ====== [2024-08-02T05:08:28.894Z] ====== dec-tree (apache-spark) [default], iteration 18 started ====== [2024-08-02T05:08:29.567Z] GC before operation: completed in 314.353 ms, heap usage 281.883 MB -> 59.813 MB. [2024-08-02T05:08:30.968Z] ====== dec-tree (apache-spark) [default], iteration 18 completed (1462.067 ms) ====== [2024-08-02T05:08:30.968Z] ====== dec-tree (apache-spark) [default], iteration 19 started ====== [2024-08-02T05:08:30.968Z] GC before operation: completed in 247.578 ms, heap usage 276.897 MB -> 76.081 MB. [2024-08-02T05:08:30.968Z] 24/08/02 00:08:30 WARN BlockManager: Asked to remove block rdd_928_0, which does not exist [2024-08-02T05:08:32.369Z] ====== dec-tree (apache-spark) [default], iteration 19 completed (1399.734 ms) ====== [2024-08-02T05:08:32.370Z] ====== dec-tree (apache-spark) [default], iteration 20 started ====== [2024-08-02T05:08:33.048Z] GC before operation: completed in 215.705 ms, heap usage 290.388 MB -> 87.325 MB. [2024-08-02T05:08:33.740Z] ====== dec-tree (apache-spark) [default], iteration 20 completed (1304.100 ms) ====== [2024-08-02T05:08:33.740Z] ====== dec-tree (apache-spark) [default], iteration 21 started ====== [2024-08-02T05:08:34.419Z] 24/08/02 00:08:33 WARN BlockManager: Asked to remove block rdd_1026_1, which does not exist [2024-08-02T05:08:34.419Z] GC before operation: completed in 262.957 ms, heap usage 321.746 MB -> 87.480 MB. [2024-08-02T05:08:34.419Z] 24/08/02 00:08:33 WARN BlockManager: Asked to remove block rdd_1026_2, which does not exist [2024-08-02T05:08:34.419Z] 24/08/02 00:08:33 WARN BlockManager: Asked to remove block rdd_1026_0, which does not exist [2024-08-02T05:08:35.095Z] ====== dec-tree (apache-spark) [default], iteration 21 completed (1140.765 ms) ====== [2024-08-02T05:08:35.095Z] ====== dec-tree (apache-spark) [default], iteration 22 started ====== [2024-08-02T05:08:35.772Z] GC before operation: completed in 232.504 ms, heap usage 332.431 MB -> 76.707 MB. [2024-08-02T05:08:37.182Z] ====== dec-tree (apache-spark) [default], iteration 22 completed (1134.305 ms) ====== [2024-08-02T05:08:37.182Z] ====== dec-tree (apache-spark) [default], iteration 23 started ====== [2024-08-02T05:08:37.182Z] GC before operation: completed in 202.945 ms, heap usage 319.722 MB -> 60.130 MB. [2024-08-02T05:08:38.587Z] ====== dec-tree (apache-spark) [default], iteration 23 completed (1462.018 ms) ====== [2024-08-02T05:08:38.587Z] ====== dec-tree (apache-spark) [default], iteration 24 started ====== [2024-08-02T05:08:38.587Z] GC before operation: completed in 220.068 ms, heap usage 292.005 MB -> 60.263 MB. [2024-08-02T05:08:40.001Z] ====== dec-tree (apache-spark) [default], iteration 24 completed (1145.647 ms) ====== [2024-08-02T05:08:40.001Z] ====== dec-tree (apache-spark) [default], iteration 25 started ====== [2024-08-02T05:08:40.001Z] GC before operation: completed in 204.736 ms, heap usage 286.907 MB -> 87.997 MB. [2024-08-02T05:08:40.001Z] 24/08/02 00:08:39 WARN BlockManager: Asked to remove block broadcast_344_piece0, which does not exist [2024-08-02T05:08:40.001Z] 24/08/02 00:08:39 WARN BlockManager: Asked to remove block broadcast_344, which does not exist [2024-08-02T05:08:41.404Z] ====== dec-tree (apache-spark) [default], iteration 25 completed (1213.944 ms) ====== [2024-08-02T05:08:41.404Z] ====== dec-tree (apache-spark) [default], iteration 26 started ====== [2024-08-02T05:08:41.404Z] GC before operation: completed in 260.124 ms, heap usage 311.272 MB -> 77.239 MB. [2024-08-02T05:08:42.813Z] ====== dec-tree (apache-spark) [default], iteration 26 completed (1192.708 ms) ====== [2024-08-02T05:08:42.813Z] ====== dec-tree (apache-spark) [default], iteration 27 started ====== [2024-08-02T05:08:42.813Z] GC before operation: completed in 217.321 ms, heap usage 311.211 MB -> 60.853 MB. [2024-08-02T05:08:44.216Z] ====== dec-tree (apache-spark) [default], iteration 27 completed (1176.700 ms) ====== [2024-08-02T05:08:44.216Z] ====== dec-tree (apache-spark) [default], iteration 28 started ====== [2024-08-02T05:08:44.216Z] GC before operation: completed in 230.328 ms, heap usage 289.435 MB -> 77.513 MB. [2024-08-02T05:08:44.216Z] 24/08/02 00:08:43 WARN BlockManager: Asked to remove block rdd_1369_2, which does not exist [2024-08-02T05:08:44.216Z] 24/08/02 00:08:43 WARN BlockManager: Asked to remove block rdd_1369_0, which does not exist [2024-08-02T05:08:45.628Z] ====== dec-tree (apache-spark) [default], iteration 28 completed (1237.762 ms) ====== [2024-08-02T05:08:45.628Z] ====== dec-tree (apache-spark) [default], iteration 29 started ====== [2024-08-02T05:08:45.628Z] GC before operation: completed in 241.920 ms, heap usage 300.316 MB -> 82.927 MB. [2024-08-02T05:08:47.059Z] ====== dec-tree (apache-spark) [default], iteration 29 completed (1182.216 ms) ====== [2024-08-02T05:08:47.059Z] ====== dec-tree (apache-spark) [default], iteration 30 started ====== [2024-08-02T05:08:47.059Z] GC before operation: completed in 218.473 ms, heap usage 306.739 MB -> 72.343 MB. [2024-08-02T05:08:48.459Z] ====== dec-tree (apache-spark) [default], iteration 30 completed (1138.826 ms) ====== [2024-08-02T05:08:48.459Z] ====== dec-tree (apache-spark) [default], iteration 31 started ====== [2024-08-02T05:08:48.459Z] GC before operation: completed in 211.873 ms, heap usage 301.647 MB -> 61.181 MB. [2024-08-02T05:08:49.874Z] ====== dec-tree (apache-spark) [default], iteration 31 completed (1394.686 ms) ====== [2024-08-02T05:08:49.874Z] ====== dec-tree (apache-spark) [default], iteration 32 started ====== [2024-08-02T05:08:49.874Z] GC before operation: completed in 252.310 ms, heap usage 297.341 MB -> 61.315 MB. [2024-08-02T05:08:51.278Z] ====== dec-tree (apache-spark) [default], iteration 32 completed (1214.007 ms) ====== [2024-08-02T05:08:51.278Z] ====== dec-tree (apache-spark) [default], iteration 33 started ====== [2024-08-02T05:08:51.955Z] GC before operation: completed in 261.530 ms, heap usage 276.716 MB -> 78.151 MB. [2024-08-02T05:08:53.358Z] ====== dec-tree (apache-spark) [default], iteration 33 completed (1335.485 ms) ====== [2024-08-02T05:08:53.359Z] ====== dec-tree (apache-spark) [default], iteration 34 started ====== [2024-08-02T05:08:53.359Z] GC before operation: completed in 199.302 ms, heap usage 291.141 MB -> 61.731 MB. [2024-08-02T05:08:54.038Z] ====== dec-tree (apache-spark) [default], iteration 34 completed (1136.025 ms) ====== [2024-08-02T05:08:54.038Z] ====== dec-tree (apache-spark) [default], iteration 35 started ====== [2024-08-02T05:08:54.716Z] GC before operation: completed in 223.083 ms, heap usage 277.060 MB -> 61.698 MB. [2024-08-02T05:08:56.120Z] ====== dec-tree (apache-spark) [default], iteration 35 completed (1286.181 ms) ====== [2024-08-02T05:08:56.120Z] ====== dec-tree (apache-spark) [default], iteration 36 started ====== [2024-08-02T05:08:56.120Z] GC before operation: completed in 245.581 ms, heap usage 276.779 MB -> 78.398 MB. [2024-08-02T05:08:57.524Z] ====== dec-tree (apache-spark) [default], iteration 36 completed (1261.986 ms) ====== [2024-08-02T05:08:57.524Z] ====== dec-tree (apache-spark) [default], iteration 37 started ====== [2024-08-02T05:08:57.524Z] GC before operation: completed in 243.672 ms, heap usage 290.622 MB -> 78.716 MB. [2024-08-02T05:08:57.524Z] 24/08/02 00:08:57 WARN BlockManager: Asked to remove block broadcast_512, which does not exist [2024-08-02T05:08:57.524Z] 24/08/02 00:08:57 WARN BlockManager: Asked to remove block broadcast_512_piece0, which does not exist [2024-08-02T05:08:58.928Z] ====== dec-tree (apache-spark) [default], iteration 37 completed (1351.583 ms) ====== [2024-08-02T05:08:58.928Z] ====== dec-tree (apache-spark) [default], iteration 38 started ====== [2024-08-02T05:08:58.928Z] GC before operation: completed in 204.413 ms, heap usage 299.388 MB -> 89.737 MB. [2024-08-02T05:09:00.334Z] ====== dec-tree (apache-spark) [default], iteration 38 completed (1210.074 ms) ====== [2024-08-02T05:09:00.334Z] ====== dec-tree (apache-spark) [default], iteration 39 started ====== [2024-08-02T05:09:00.334Z] GC before operation: completed in 211.490 ms, heap usage 325.997 MB -> 78.953 MB. [2024-08-02T05:09:01.737Z] ====== dec-tree (apache-spark) [default], iteration 39 completed (1201.806 ms) ====== [2024-08-02T05:09:02.412Z] ----------------------------------- [2024-08-02T05:09:02.412Z] renaissance-dec-tree_0_PASSED [2024-08-02T05:09:02.412Z] ----------------------------------- [2024-08-02T05:09:02.412Z] [2024-08-02T05:09:02.412Z] TEST TEARDOWN: [2024-08-02T05:09:02.412Z] Nothing to be done for teardown. [2024-08-02T05:09:02.412Z] renaissance-dec-tree_0 Finish Time: Fri Aug 2 00:09:01 2024 Epoch Time (ms): 1722575341866