[2025-06-18T22:20:12.325Z] Running test renaissance-finagle-http_0 ... [2025-06-18T22:20:12.635Z] =============================================== [2025-06-18T22:20:12.635Z] renaissance-finagle-http_0 Start Time: Wed Jun 18 22:20:12 2025 Epoch Time (ms): 1750285212518 [2025-06-18T22:20:12.940Z] variation: NoOptions [2025-06-18T22:20:12.940Z] JVM_OPTIONS: [2025-06-18T22:20:12.940Z] { \ [2025-06-18T22:20:12.940Z] echo ""; echo "TEST SETUP:"; \ [2025-06-18T22:20:12.940Z] echo "Nothing to be done for setup."; \ [2025-06-18T22:20:12.940Z] mkdir -p "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17502851224747\\renaissance-finagle-http_0"; \ [2025-06-18T22:20:12.940Z] cd "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17502851224747\\renaissance-finagle-http_0"; \ [2025-06-18T22:20:12.940Z] echo ""; echo "TESTING:"; \ [2025-06-18T22:20:12.940Z] "c:/jenkins/workspace/Test_openjdk21_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:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17502851224747\\renaissance-finagle-http_0"\\finagle-http.json" finagle-http; \ [2025-06-18T22:20:12.940Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17502851224747\\renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-06-18T22:20:12.940Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-06-18T22:20:12.940Z] echo "Nothing to be done for teardown."; \ [2025-06-18T22:20:12.940Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk21_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17502851224747\\TestTargetResult"; [2025-06-18T22:20:13.267Z] [2025-06-18T22:20:13.267Z] TEST SETUP: [2025-06-18T22:20:13.267Z] Nothing to be done for setup. [2025-06-18T22:20:13.267Z] [2025-06-18T22:20:13.267Z] TESTING: [2025-06-18T22:20:22.119Z] finagle-http on :58734 spawning 2 client and default number of server workers. [2025-06-18T22:20:22.119Z] ====== finagle-http (web) [default], iteration 0 started ====== [2025-06-18T22:20:22.441Z] GC before operation: completed in 203.304 ms, heap usage 23.143 MB -> 11.105 MB. [2025-06-18T22:20:43.086Z] ====== finagle-http (web) [default], iteration 0 completed (19258.384 ms) ====== [2025-06-18T22:20:43.086Z] ====== finagle-http (web) [default], iteration 1 started ====== [2025-06-18T22:20:43.086Z] GC before operation: completed in 78.786 ms, heap usage 27.019 MB -> 13.653 MB. [2025-06-18T22:20:53.112Z] ====== finagle-http (web) [default], iteration 1 completed (10266.927 ms) ====== [2025-06-18T22:20:53.112Z] ====== finagle-http (web) [default], iteration 2 started ====== [2025-06-18T22:20:53.112Z] GC before operation: completed in 67.025 ms, heap usage 58.833 MB -> 14.313 MB. [2025-06-18T22:20:57.707Z] ====== finagle-http (web) [default], iteration 2 completed (5343.735 ms) ====== [2025-06-18T22:20:57.707Z] ====== finagle-http (web) [default], iteration 3 started ====== [2025-06-18T22:20:58.398Z] GC before operation: completed in 81.797 ms, heap usage 32.140 MB -> 14.365 MB. [2025-06-18T22:21:03.309Z] ====== finagle-http (web) [default], iteration 3 completed (5008.664 ms) ====== [2025-06-18T22:21:03.309Z] ====== finagle-http (web) [default], iteration 4 started ====== [2025-06-18T22:21:03.309Z] GC before operation: completed in 81.522 ms, heap usage 51.517 MB -> 14.356 MB. [2025-06-18T22:21:06.991Z] ====== finagle-http (web) [default], iteration 4 completed (4621.146 ms) ====== [2025-06-18T22:21:06.991Z] ====== finagle-http (web) [default], iteration 5 started ====== [2025-06-18T22:21:08.022Z] GC before operation: completed in 93.772 ms, heap usage 17.743 MB -> 14.432 MB. [2025-06-18T22:21:11.701Z] ====== finagle-http (web) [default], iteration 5 completed (4632.187 ms) ====== [2025-06-18T22:21:11.701Z] ====== finagle-http (web) [default], iteration 6 started ====== [2025-06-18T22:21:12.714Z] GC before operation: completed in 80.040 ms, heap usage 17.073 MB -> 14.430 MB. [2025-06-18T22:21:17.700Z] ====== finagle-http (web) [default], iteration 6 completed (4864.994 ms) ====== [2025-06-18T22:21:17.700Z] ====== finagle-http (web) [default], iteration 7 started ====== [2025-06-18T22:21:17.700Z] GC before operation: completed in 69.815 ms, heap usage 35.409 MB -> 14.438 MB. [2025-06-18T22:21:21.420Z] ====== finagle-http (web) [default], iteration 7 completed (4620.086 ms) ====== [2025-06-18T22:21:21.420Z] ====== finagle-http (web) [default], iteration 8 started ====== [2025-06-18T22:21:21.730Z] GC before operation: completed in 86.697 ms, heap usage 19.357 MB -> 14.437 MB. [2025-06-18T22:21:27.094Z] ====== finagle-http (web) [default], iteration 8 completed (4644.977 ms) ====== [2025-06-18T22:21:27.095Z] ====== finagle-http (web) [default], iteration 9 started ====== [2025-06-18T22:21:27.095Z] GC before operation: completed in 59.930 ms, heap usage 19.417 MB -> 14.440 MB. [2025-06-18T22:21:31.808Z] ====== finagle-http (web) [default], iteration 9 completed (4611.804 ms) ====== [2025-06-18T22:21:31.808Z] ====== finagle-http (web) [default], iteration 10 started ====== [2025-06-18T22:21:31.808Z] GC before operation: completed in 85.143 ms, heap usage 18.280 MB -> 14.431 MB. [2025-06-18T22:21:36.622Z] ====== finagle-http (web) [default], iteration 10 completed (4705.561 ms) ====== [2025-06-18T22:21:36.622Z] ====== finagle-http (web) [default], iteration 11 started ====== [2025-06-18T22:21:36.622Z] GC before operation: completed in 141.011 ms, heap usage 18.070 MB -> 14.441 MB. [2025-06-18T22:21:40.735Z] ====== finagle-http (web) [default], iteration 11 completed (4902.694 ms) ====== [2025-06-18T22:21:40.735Z] [2025-06-18T22:21:40.626+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-06-18T22:21:40.735Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk21_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17502851224747\renaissance-finagle-http_0\harness-222013-6921652738939067575: harness-222013-6921652738939067575\twitter-finagle\lib\caffeine-3.1.8.jar: The process cannot access the file because it is being used by another process [2025-06-18T22:21:40.735Z] [2025-06-18T22:21:40.634+0000] [2025-06-18T22:21:40.626+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-06-18T22:21:40.735Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk21_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17502851224747\renaissance-finagle-http_0\harness-222013-6921652738939067575: harness-222013-6921652738939067575\twitter-finagle\lib\caffeine-3.1.8.jar: The process cannot access the file because it is being used by another process [2025-06-18T22:21:40.735Z] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-06-18T22:21:40.735Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk21_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17502851224747\renaissance-finagle-http_0\launcher-222013-8737714494261508808: launcher-222013-8737714494261508808\renaissance-harness_3\lib\renaissance-harness_3-0.16.0.jar: The process cannot access the file because it is being used by another process [2025-06-18T22:21:41.060Z] ----------------------------------- [2025-06-18T22:21:41.060Z] renaissance-finagle-http_0_PASSED [2025-06-18T22:21:41.060Z] ----------------------------------- [2025-06-18T22:21:41.382Z] [2025-06-18T22:21:41.382Z] TEST TEARDOWN: [2025-06-18T22:21:41.382Z] Nothing to be done for teardown. [2025-06-18T22:21:41.382Z] renaissance-finagle-http_0 Finish Time: Wed Jun 18 22:21:41 2025 Epoch Time (ms): 1750285301204