[2025-08-01T23:05:48.108Z] Running test renaissance-finagle-http_0 ... [2025-08-01T23:05:48.109Z] =============================================== [2025-08-01T23:05:48.109Z] renaissance-finagle-http_0 Start Time: Fri Aug 1 23:05:48 2025 Epoch Time (ms): 1754089548043 [2025-08-01T23:05:48.441Z] variation: NoOptions [2025-08-01T23:05:48.441Z] JVM_OPTIONS: [2025-08-01T23:05:48.441Z] { \ [2025-08-01T23:05:48.441Z] echo ""; echo "TEST SETUP:"; \ [2025-08-01T23:05:48.441Z] echo "Nothing to be done for setup."; \ [2025-08-01T23:05:48.441Z] mkdir -p "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17540883567694\\renaissance-finagle-http_0"; \ [2025-08-01T23:05:48.441Z] cd "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17540883567694\\renaissance-finagle-http_0"; \ [2025-08-01T23:05:48.441Z] echo ""; echo "TESTING:"; \ [2025-08-01T23:05:48.441Z] "c:/jenkins/workspace/Test_openjdk11_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_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests///..//jvmtest\\perf\\renaissance\\renaissance.jar" --json ""C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17540883567694\\renaissance-finagle-http_0"\\finagle-http.json" finagle-http; \ [2025-08-01T23:05:48.441Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "renaissance-finagle-http_0""_PASSED"; echo "-----------------------------------"; cd C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/; rm -f -r "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17540883567694\\renaissance-finagle-http_0"; else echo "-----------------------------------"; echo "renaissance-finagle-http_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-08-01T23:05:48.441Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-08-01T23:05:48.441Z] echo "Nothing to be done for teardown."; \ [2025-08-01T23:05:48.441Z] } 2>&1 | tee -a "C:/jenkins/workspace/Test_openjdk11_hs_extended.perf_x86-64_windows/aqa-tests/\\TKG\\output_17540883567694\\TestTargetResult"; [2025-08-01T23:05:49.051Z] [2025-08-01T23:05:49.051Z] TEST SETUP: [2025-08-01T23:05:49.051Z] Nothing to be done for setup. [2025-08-01T23:05:49.051Z] [2025-08-01T23:05:49.051Z] TESTING: [2025-08-01T23:05:58.667Z] finagle-http on :65224 spawning 2 client and default number of server workers. [2025-08-01T23:05:58.667Z] ====== finagle-http (web) [default], iteration 0 started ====== [2025-08-01T23:05:58.667Z] GC before operation: completed in 48.530 ms, heap usage 55.598 MB -> 10.271 MB. [2025-08-01T23:06:19.947Z] ====== finagle-http (web) [default], iteration 0 completed (20279.272 ms) ====== [2025-08-01T23:06:19.947Z] ====== finagle-http (web) [default], iteration 1 started ====== [2025-08-01T23:06:19.947Z] GC before operation: completed in 124.428 ms, heap usage 23.397 MB -> 13.006 MB. [2025-08-01T23:06:29.787Z] ====== finagle-http (web) [default], iteration 1 completed (9978.735 ms) ====== [2025-08-01T23:06:29.787Z] ====== finagle-http (web) [default], iteration 2 started ====== [2025-08-01T23:06:29.787Z] GC before operation: completed in 115.406 ms, heap usage 37.900 MB -> 13.905 MB. [2025-08-01T23:06:34.636Z] ====== finagle-http (web) [default], iteration 2 completed (6283.587 ms) ====== [2025-08-01T23:06:34.636Z] ====== finagle-http (web) [default], iteration 3 started ====== [2025-08-01T23:06:35.290Z] GC before operation: completed in 57.624 ms, heap usage 17.150 MB -> 13.631 MB. [2025-08-01T23:06:40.287Z] ====== finagle-http (web) [default], iteration 3 completed (5842.166 ms) ====== [2025-08-01T23:06:40.287Z] ====== finagle-http (web) [default], iteration 4 started ====== [2025-08-01T23:06:41.621Z] GC before operation: completed in 100.223 ms, heap usage 16.694 MB -> 13.724 MB. [2025-08-01T23:06:46.553Z] ====== finagle-http (web) [default], iteration 4 completed (5571.376 ms) ====== [2025-08-01T23:06:46.553Z] ====== finagle-http (web) [default], iteration 5 started ====== [2025-08-01T23:06:46.553Z] GC before operation: completed in 76.989 ms, heap usage 29.340 MB -> 13.724 MB. [2025-08-01T23:06:54.419Z] ====== finagle-http (web) [default], iteration 5 completed (5489.504 ms) ====== [2025-08-01T23:06:54.419Z] ====== finagle-http (web) [default], iteration 6 started ====== [2025-08-01T23:06:54.419Z] GC before operation: completed in 135.138 ms, heap usage 28.883 MB -> 13.725 MB. [2025-08-01T23:06:58.138Z] ====== finagle-http (web) [default], iteration 6 completed (5556.760 ms) ====== [2025-08-01T23:06:58.138Z] ====== finagle-http (web) [default], iteration 7 started ====== [2025-08-01T23:06:58.138Z] GC before operation: completed in 88.027 ms, heap usage 29.068 MB -> 13.716 MB. [2025-08-01T23:07:02.994Z] ====== finagle-http (web) [default], iteration 7 completed (5633.838 ms) ====== [2025-08-01T23:07:02.994Z] ====== finagle-http (web) [default], iteration 8 started ====== [2025-08-01T23:07:02.994Z] GC before operation: completed in 91.117 ms, heap usage 29.542 MB -> 13.729 MB. [2025-08-01T23:07:09.484Z] ====== finagle-http (web) [default], iteration 8 completed (5509.478 ms) ====== [2025-08-01T23:07:09.484Z] ====== finagle-http (web) [default], iteration 9 started ====== [2025-08-01T23:07:09.484Z] GC before operation: completed in 93.759 ms, heap usage 28.523 MB -> 13.724 MB. [2025-08-01T23:07:15.203Z] ====== finagle-http (web) [default], iteration 9 completed (5626.583 ms) ====== [2025-08-01T23:07:15.203Z] ====== finagle-http (web) [default], iteration 10 started ====== [2025-08-01T23:07:15.203Z] GC before operation: completed in 84.733 ms, heap usage 29.021 MB -> 13.723 MB. [2025-08-01T23:07:20.793Z] ====== finagle-http (web) [default], iteration 10 completed (5501.058 ms) ====== [2025-08-01T23:07:20.793Z] ====== finagle-http (web) [default], iteration 11 started ====== [2025-08-01T23:07:21.764Z] GC before operation: completed in 80.507 ms, heap usage 28.767 MB -> 13.732 MB. [2025-08-01T23:07:25.616Z] ====== finagle-http (web) [default], iteration 11 completed (5632.286 ms) ====== [2025-08-01T23:07:25.971Z] [2025-08-01T23:07:25.620+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-08-01T23:07:25.971Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk11_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17540883567694\renaissance-finagle-http_0\harness-230549-7246357955251039611: harness-230549-7246357955251039611\twitter-finagle\lib\caffeine-3.1.8.jar: The process cannot access the file because it is being used by another process. [2025-08-01T23:07:25.971Z] [2025-08-01T23:07:25.971Z] [2025-08-01T23:07:25.631+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-08-01T23:07:25.971Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk11_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17540883567694\renaissance-finagle-http_0\launcher-230548-2583206108202796912: launcher-230548-2583206108202796912\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-08-01T23:07:25.971Z] [2025-08-01T23:07:25.971Z] [2025-08-01T23:07:25.620+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-08-01T23:07:25.971Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk11_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17540883567694\renaissance-finagle-http_0\harness-230549-7246357955251039611: harness-230549-7246357955251039611\twitter-finagle\lib\caffeine-3.1.8.jar: The process cannot access the file because it is being used by another process. [2025-08-01T23:07:25.971Z] [2025-08-01T23:07:25.971Z] [2025-08-01T23:07:25.631+0000] org.renaissance.core (org.renaissance.core.DirUtils lambda$createScratchDirectory$1) [2025-08-01T23:07:25.971Z] WARNING: Error deleting scratch directory C:\jenkins\workspace\Test_openjdk11_hs_extended.perf_x86-64_windows\aqa-tests\TKG\output_17540883567694\renaissance-finagle-http_0\launcher-230548-2583206108202796912: launcher-230548-2583206108202796912\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-08-01T23:07:25.971Z] [2025-08-01T23:07:26.309Z] ----------------------------------- [2025-08-01T23:07:26.309Z] renaissance-finagle-http_0_PASSED [2025-08-01T23:07:26.309Z] ----------------------------------- [2025-08-01T23:07:26.309Z] [2025-08-01T23:07:26.309Z] TEST TEARDOWN: [2025-08-01T23:07:26.309Z] Nothing to be done for teardown. [2025-08-01T23:07:26.309Z] renaissance-finagle-http_0 Finish Time: Fri Aug 1 23:07:26 2025 Epoch Time (ms): 1754089646218