[2026-02-08T10:59:57.927Z] Running test renaissance-als_0 ... [2026-02-08T10:59:57.927Z] =============================================== [2026-02-08T10:59:58.273Z] renaissance-als_0 Start Time: Sun Feb 8 10:59:58 2026 Epoch Time (ms): 1770548398019 [2026-02-08T10:59:58.273Z] variation: NoOptions [2026-02-08T10:59:58.617Z] JVM_OPTIONS: [2026-02-08T10:59:58.617Z] { \ [2026-02-08T10:59:58.617Z] echo ""; echo "TEST SETUP:"; \ [2026-02-08T10:59:58.617Z] echo "Nothing to be done for setup."; \ [2026-02-08T10:59:58.617Z] mkdir -p "C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17705479975772\\renaissance-als_0"; \ [2026-02-08T10:59:58.617Z] cd "C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17705479975772\\renaissance-als_0"; \ [2026-02-08T10:59:58.617Z] echo ""; echo "TESTING:"; \ [2026-02-08T10:59:58.617Z] "c:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/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 "C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17705479975772\\renaissance-als_0"\\als.json" als; \ [2026-02-08T10:59:58.618Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-als_0""_PASSED"; echo "-----------------------------------"; cd C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17705479975772\\renaissance-als_0"; else echo "-----------------------------------"; echo "renaissance-als_0""_FAILED"; echo "-----------------------------------"; fi; \ [2026-02-08T10:59:58.618Z] echo ""; echo "TEST TEARDOWN:"; \ [2026-02-08T10:59:58.618Z] echo "Nothing to be done for teardown."; \ [2026-02-08T10:59:58.618Z] } 2>&1 | tee -a "C:/workspace/workspace/Test_openjdk17_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17705479975772\\TestTargetResult"; [2026-02-08T10:59:59.005Z] [2026-02-08T10:59:59.006Z] TEST SETUP: [2026-02-08T10:59:59.006Z] Nothing to be done for setup. [2026-02-08T10:59:59.006Z] [2026-02-08T10:59:59.006Z] TESTING: [2026-02-08T11:00:35.143Z] NOTE: 'als' benchmark uses Spark local executor with 4 (out of 4) threads. [2026-02-08T11:00:35.143Z] ====== als (apache-spark) [default], iteration 0 started ====== [2026-02-08T11:00:35.143Z] GC before operation: completed in 46.197 ms, heap usage 63.000 MB -> 35.601 MB. [2026-02-08T11:01:23.957Z] ====== als (apache-spark) [default], iteration 0 completed (45945.496 ms) ====== [2026-02-08T11:01:23.957Z] ====== als (apache-spark) [default], iteration 1 started ====== [2026-02-08T11:01:23.957Z] GC before operation: completed in 130.973 ms, heap usage 242.559 MB -> 62.632 MB. [2026-02-08T11:01:51.536Z] ====== als (apache-spark) [default], iteration 1 completed (27489.751 ms) ====== [2026-02-08T11:01:51.536Z] ====== als (apache-spark) [default], iteration 2 started ====== [2026-02-08T11:01:51.536Z] GC before operation: completed in 111.127 ms, heap usage 787.382 MB -> 64.214 MB. [2026-02-08T11:02:26.287Z] ====== als (apache-spark) [default], iteration 2 completed (35521.445 ms) ====== [2026-02-08T11:02:26.287Z] ====== als (apache-spark) [default], iteration 3 started ====== [2026-02-08T11:02:26.287Z] GC before operation: completed in 145.838 ms, heap usage 537.699 MB -> 64.495 MB. [2026-02-08T11:03:06.791Z] ====== als (apache-spark) [default], iteration 3 completed (36300.231 ms) ====== [2026-02-08T11:03:06.791Z] ====== als (apache-spark) [default], iteration 4 started ====== [2026-02-08T11:03:06.791Z] GC before operation: completed in 151.149 ms, heap usage 755.172 MB -> 65.438 MB. [2026-02-08T11:03:40.489Z] ====== als (apache-spark) [default], iteration 4 completed (35253.331 ms) ====== [2026-02-08T11:03:40.489Z] ====== als (apache-spark) [default], iteration 5 started ====== [2026-02-08T11:03:40.489Z] GC before operation: completed in 148.458 ms, heap usage 664.126 MB -> 65.844 MB. [2026-02-08T11:04:14.635Z] ====== als (apache-spark) [default], iteration 5 completed (35219.024 ms) ====== [2026-02-08T11:04:14.635Z] ====== als (apache-spark) [default], iteration 6 started ====== [2026-02-08T11:04:14.635Z] GC before operation: completed in 163.375 ms, heap usage 250.079 MB -> 65.823 MB. [2026-02-08T11:04:55.489Z] ====== als (apache-spark) [default], iteration 6 completed (34966.931 ms) ====== [2026-02-08T11:04:55.489Z] ====== als (apache-spark) [default], iteration 7 started ====== [2026-02-08T11:04:55.489Z] GC before operation: completed in 162.691 ms, heap usage 378.962 MB -> 66.580 MB. [2026-02-08T11:05:29.618Z] ====== als (apache-spark) [default], iteration 7 completed (35134.867 ms) ====== [2026-02-08T11:05:29.618Z] ====== als (apache-spark) [default], iteration 8 started ====== [2026-02-08T11:05:29.618Z] GC before operation: completed in 175.060 ms, heap usage 318.220 MB -> 67.010 MB. [2026-02-08T11:06:03.381Z] ====== als (apache-spark) [default], iteration 8 completed (35436.511 ms) ====== [2026-02-08T11:06:03.381Z] ====== als (apache-spark) [default], iteration 9 started ====== [2026-02-08T11:06:03.381Z] GC before operation: completed in 153.839 ms, heap usage 140.953 MB -> 67.168 MB. [2026-02-08T11:06:37.248Z] ====== als (apache-spark) [default], iteration 9 completed (35352.752 ms) ====== [2026-02-08T11:06:37.248Z] ====== als (apache-spark) [default], iteration 10 started ====== [2026-02-08T11:06:37.248Z] GC before operation: completed in 162.057 ms, heap usage 712.309 MB -> 68.253 MB. [2026-02-08T11:07:18.089Z] ====== als (apache-spark) [default], iteration 10 completed (35332.257 ms) ====== [2026-02-08T11:07:18.089Z] ====== als (apache-spark) [default], iteration 11 started ====== [2026-02-08T11:07:18.089Z] GC before operation: completed in 170.034 ms, heap usage 1.159 GB -> 68.997 MB. [2026-02-08T11:07:51.870Z] ====== als (apache-spark) [default], iteration 11 completed (35317.348 ms) ====== [2026-02-08T11:07:51.870Z] ====== als (apache-spark) [default], iteration 12 started ====== [2026-02-08T11:07:51.870Z] GC before operation: completed in 162.457 ms, heap usage 573.251 MB -> 68.667 MB. [2026-02-08T11:08:25.683Z] ====== als (apache-spark) [default], iteration 12 completed (35268.601 ms) ====== [2026-02-08T11:08:25.683Z] ====== als (apache-spark) [default], iteration 13 started ====== [2026-02-08T11:08:25.683Z] GC before operation: completed in 180.689 ms, heap usage 540.970 MB -> 68.832 MB. [2026-02-08T11:08:59.733Z] ====== als (apache-spark) [default], iteration 13 completed (34740.343 ms) ====== [2026-02-08T11:08:59.733Z] ====== als (apache-spark) [default], iteration 14 started ====== [2026-02-08T11:08:59.733Z] GC before operation: completed in 163.724 ms, heap usage 627.598 MB -> 69.129 MB. [2026-02-08T11:09:40.172Z] ====== als (apache-spark) [default], iteration 14 completed (34959.988 ms) ====== [2026-02-08T11:09:40.172Z] ====== als (apache-spark) [default], iteration 15 started ====== [2026-02-08T11:09:40.172Z] GC before operation: completed in 163.388 ms, heap usage 717.020 MB -> 69.595 MB. [2026-02-08T11:10:14.310Z] ====== als (apache-spark) [default], iteration 15 completed (34355.665 ms) ====== [2026-02-08T11:10:14.310Z] ====== als (apache-spark) [default], iteration 16 started ====== [2026-02-08T11:10:14.310Z] GC before operation: completed in 166.676 ms, heap usage 720.022 MB -> 69.945 MB. [2026-02-08T11:10:47.976Z] ====== als (apache-spark) [default], iteration 16 completed (35262.599 ms) ====== [2026-02-08T11:10:47.976Z] ====== als (apache-spark) [default], iteration 17 started ====== [2026-02-08T11:10:47.976Z] GC before operation: completed in 164.554 ms, heap usage 306.621 MB -> 69.525 MB. [2026-02-08T11:11:21.904Z] ====== als (apache-spark) [default], iteration 17 completed (34908.446 ms) ====== [2026-02-08T11:11:21.904Z] ====== als (apache-spark) [default], iteration 18 started ====== [2026-02-08T11:11:21.904Z] GC before operation: completed in 168.005 ms, heap usage 526.557 MB -> 70.085 MB. [2026-02-08T11:11:55.870Z] ====== als (apache-spark) [default], iteration 18 completed (34992.597 ms) ====== [2026-02-08T11:11:55.870Z] ====== als (apache-spark) [default], iteration 19 started ====== [2026-02-08T11:11:55.870Z] GC before operation: completed in 181.428 ms, heap usage 615.170 MB -> 70.453 MB. [2026-02-08T11:12:36.365Z] ====== als (apache-spark) [default], iteration 19 completed (35031.637 ms) ====== [2026-02-08T11:12:36.365Z] ====== als (apache-spark) [default], iteration 20 started ====== [2026-02-08T11:12:36.365Z] GC before operation: completed in 170.433 ms, heap usage 469.845 MB -> 70.639 MB. [2026-02-08T11:13:10.217Z] ====== als (apache-spark) [default], iteration 20 completed (35119.213 ms) ====== [2026-02-08T11:13:10.217Z] ====== als (apache-spark) [default], iteration 21 started ====== [2026-02-08T11:13:10.217Z] GC before operation: completed in 177.277 ms, heap usage 988.660 MB -> 71.426 MB. [2026-02-08T11:13:43.924Z] ====== als (apache-spark) [default], iteration 21 completed (34814.591 ms) ====== [2026-02-08T11:13:43.924Z] ====== als (apache-spark) [default], iteration 22 started ====== [2026-02-08T11:13:43.924Z] GC before operation: completed in 178.225 ms, heap usage 765.833 MB -> 71.393 MB. [2026-02-08T11:14:18.187Z] ====== als (apache-spark) [default], iteration 22 completed (35072.780 ms) ====== [2026-02-08T11:14:18.187Z] ====== als (apache-spark) [default], iteration 23 started ====== [2026-02-08T11:14:18.187Z] GC before operation: completed in 179.466 ms, heap usage 1.177 GB -> 72.278 MB. [2026-02-08T11:14:58.735Z] ====== als (apache-spark) [default], iteration 23 completed (35198.543 ms) ====== [2026-02-08T11:14:58.735Z] ====== als (apache-spark) [default], iteration 24 started ====== [2026-02-08T11:14:58.735Z] GC before operation: completed in 183.464 ms, heap usage 1.434 GB -> 72.762 MB. [2026-02-08T11:15:32.675Z] ====== als (apache-spark) [default], iteration 24 completed (35452.975 ms) ====== [2026-02-08T11:15:32.675Z] ====== als (apache-spark) [default], iteration 25 started ====== [2026-02-08T11:15:32.675Z] GC before operation: completed in 168.564 ms, heap usage 548.817 MB -> 72.028 MB. [2026-02-08T11:16:06.514Z] ====== als (apache-spark) [default], iteration 25 completed (35049.293 ms) ====== [2026-02-08T11:16:06.514Z] ====== als (apache-spark) [default], iteration 26 started ====== [2026-02-08T11:16:06.514Z] GC before operation: completed in 188.717 ms, heap usage 284.753 MB -> 71.899 MB. [2026-02-08T11:16:40.368Z] ====== als (apache-spark) [default], iteration 26 completed (34507.518 ms) ====== [2026-02-08T11:16:40.368Z] ====== als (apache-spark) [default], iteration 27 started ====== [2026-02-08T11:16:40.368Z] GC before operation: completed in 170.743 ms, heap usage 186.767 MB -> 72.159 MB. [2026-02-08T11:17:21.045Z] ====== als (apache-spark) [default], iteration 27 completed (35013.474 ms) ====== [2026-02-08T11:17:21.045Z] ====== als (apache-spark) [default], iteration 28 started ====== [2026-02-08T11:17:21.045Z] GC before operation: completed in 176.117 ms, heap usage 764.261 MB -> 72.793 MB. [2026-02-08T11:17:55.332Z] ====== als (apache-spark) [default], iteration 28 completed (34932.612 ms) ====== [2026-02-08T11:17:55.332Z] ====== als (apache-spark) [default], iteration 29 started ====== [2026-02-08T11:17:55.332Z] GC before operation: completed in 181.052 ms, heap usage 899.030 MB -> 72.952 MB. [2026-02-08T11:18:29.125Z] ====== als (apache-spark) [default], iteration 29 completed (35067.154 ms) ====== [2026-02-08T11:18:29.125Z] ----------------------------------- [2026-02-08T11:18:29.125Z] renaissance-als_0_PASSED [2026-02-08T11:18:29.125Z] ----------------------------------- [2026-02-08T11:18:29.125Z] [2026-02-08T11:18:29.125Z] TEST TEARDOWN: [2026-02-08T11:18:29.125Z] Nothing to be done for teardown. [2026-02-08T11:18:29.125Z] renaissance-als_0 Finish Time: Sun Feb 8 11:18:27 2026 Epoch Time (ms): 1770549507502