[2025-11-11T23:58:02.779Z] Running test jdk_net_0 ... [2025-11-11T23:58:02.779Z] =============================================== [2025-11-11T23:58:02.779Z] jdk_net_0 Start Time: Tue Nov 11 23:58:02 2025 Epoch Time (ms): 1762905482669 [2025-11-11T23:58:02.779Z] variation: Mode150 [2025-11-11T23:58:02.779Z] JVM_OPTIONS: -XX:+UseCompressedOops [2025-11-11T23:58:02.779Z] { \ [2025-11-11T23:58:02.779Z] echo ""; echo "TEST SETUP:"; \ [2025-11-11T23:58:02.779Z] echo "Nothing to be done for setup."; \ [2025-11-11T23:58:02.779Z] mkdir -p "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/jdk_net_0"; \ [2025-11-11T23:58:02.779Z] cd "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/jdk_net_0"; \ [2025-11-11T23:58:02.779Z] echo ""; echo "TESTING:"; \ [2025-11-11T23:58:02.779Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2025-11-11T23:58:02.779Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -k:'!headful' -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true" \ [2025-11-11T23:58:02.779Z] -w ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/jdk_net_0"/work" \ [2025-11-11T23:58:02.779Z] -r ""/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/jdk_net_0"/report" \ [2025-11-11T23:58:02.779Z] -jdk:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image" \ [2025-11-11T23:58:02.779Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2025-11-11T23:58:02.779Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk21.txt" \ [2025-11-11T23:58:02.779Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/excludes/alpine/ProblemList_openjdk21_alpine.txt" \ [2025-11-11T23:58:02.779Z] -exclude:"/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk21.txt" \ [2025-11-11T23:58:02.779Z] "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_net"; \ [2025-11-11T23:58:02.779Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_net_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_net_0""_FAILED"; echo "-----------------------------------"; fi; \ [2025-11-11T23:58:02.779Z] echo ""; echo "TEST TEARDOWN:"; \ [2025-11-11T23:58:02.779Z] echo "Nothing to be done for teardown."; \ [2025-11-11T23:58:02.779Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/TestTargetResult"; [2025-11-11T23:58:02.779Z] [2025-11-11T23:58:02.779Z] TEST SETUP: [2025-11-11T23:58:02.779Z] Nothing to be done for setup. [2025-11-11T23:58:03.766Z] [2025-11-11T23:58:03.766Z] TESTING: [2025-11-11T23:58:03.766Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/jdk_net_0/work" not found: creating [2025-11-11T23:58:03.766Z] Directory "/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/../TKG/output_176288228576/jdk_net_0/report" not found: creating [2025-11-11T23:58:15.833Z] XML output with verification to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work [2025-11-12T00:04:53.911Z] -------------------------------------------------- [2025-11-12T00:04:53.911Z] TEST: com/sun/net/httpserver/ServerStopTerminationTest.java [2025-11-12T00:04:53.911Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image [2025-11-12T00:04:53.911Z] [2025-11-12T00:04:53.911Z] ACTION: build -- Passed. Build successful [2025-11-12T00:04:53.911Z] REASON: Named class compiled on demand [2025-11-12T00:04:53.911Z] TIME: 3.145 seconds [2025-11-12T00:04:53.911Z] messages: [2025-11-12T00:04:53.911Z] command: build ServerStopTerminationTest [2025-11-12T00:04:53.911Z] reason: Named class compiled on demand [2025-11-12T00:04:53.911Z] started: Wed Nov 12 00:03:54 GMT 2025 [2025-11-12T00:04:53.911Z] Test directory: [2025-11-12T00:04:53.911Z] compile: ServerStopTerminationTest [2025-11-12T00:04:53.911Z] finished: Wed Nov 12 00:03:57 GMT 2025 [2025-11-12T00:04:53.911Z] elapsed time (seconds): 3.145 [2025-11-12T00:04:53.911Z] [2025-11-12T00:04:53.911Z] ACTION: compile -- Passed. Compilation successful [2025-11-12T00:04:53.911Z] REASON: .class file out of date or does not exist [2025-11-12T00:04:53.911Z] TIME: 3.145 seconds [2025-11-12T00:04:53.911Z] messages: [2025-11-12T00:04:53.911Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver/ServerStopTerminationTest.java [2025-11-12T00:04:53.911Z] reason: .class file out of date or does not exist [2025-11-12T00:04:53.911Z] started: Wed Nov 12 00:03:54 GMT 2025 [2025-11-12T00:04:53.911Z] Additional options from @modules: --add-modules jdk.httpserver,java.logging [2025-11-12T00:04:53.911Z] Mode: agentvm [2025-11-12T00:04:53.911Z] Agent id: 3 [2025-11-12T00:04:53.911Z] finished: Wed Nov 12 00:03:57 GMT 2025 [2025-11-12T00:04:53.911Z] elapsed time (seconds): 3.145 [2025-11-12T00:04:53.911Z] configuration: [2025-11-12T00:04:53.911Z] Boot Layer (javac runtime environment) [2025-11-12T00:04:53.911Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-11-12T00:04:53.911Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-11-12T00:04:53.911Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/patches/java.base [2025-11-12T00:04:53.911Z] [2025-11-12T00:04:53.911Z] javac compilation environment [2025-11-12T00:04:53.911Z] add modules: jdk.httpserver java.logging [2025-11-12T00:04:53.911Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver [2025-11-12T00:04:53.911Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/lib [2025-11-12T00:04:53.911Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver [2025-11-12T00:04:53.911Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d [2025-11-12T00:04:53.911Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib [2025-11-12T00:04:53.911Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar [2025-11-12T00:04:53.911Z] [2025-11-12T00:04:53.911Z] rerun: [2025-11-12T00:04:53.911Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/scratch/0 && \ [2025-11-12T00:04:53.911Z] DISPLAY=:0 \ [2025-11-12T00:04:53.911Z] HOME=/home/jenkins \ [2025-11-12T00:04:53.911Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-11-12T00:04:53.911Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/javac \ [2025-11-12T00:04:53.911Z] -J-ea \ [2025-11-12T00:04:53.911Z] -J-esa \ [2025-11-12T00:04:53.911Z] -J-Xmx512m \ [2025-11-12T00:04:53.911Z] -J-XX:+UseCompressedOops \ [2025-11-12T00:04:53.911Z] -J-Djava.awt.headless=true \ [2025-11-12T00:04:53.911Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \ [2025-11-12T00:04:53.911Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \ [2025-11-12T00:04:53.911Z] -J-Dtest.compiler.opts= \ [2025-11-12T00:04:53.911Z] -J-Dtest.java.opts= \ [2025-11-12T00:04:53.911Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:04:53.911Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:04:53.911Z] -J-Dtest.timeout.factor=8.0 \ [2025-11-12T00:04:53.911Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-11-12T00:04:53.911Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-11-12T00:04:53.911Z] -J-Dtest.name=com/sun/net/httpserver/ServerStopTerminationTest.java \ [2025-11-12T00:04:53.911Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver/ServerStopTerminationTest.java \ [2025-11-12T00:04:53.911Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver \ [2025-11-12T00:04:53.911Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-11-12T00:04:53.911Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d \ [2025-11-12T00:04:53.911Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib \ [2025-11-12T00:04:53.911Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib \ [2025-11-12T00:04:53.911Z] -J-Dtest.modules='jdk.httpserver java.logging' \ [2025-11-12T00:04:53.911Z] --add-modules jdk.httpserver,java.logging \ [2025-11-12T00:04:53.911Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d \ [2025-11-12T00:04:53.911Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-11-12T00:04:53.911Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver/ServerStopTerminationTest.java [2025-11-12T00:04:53.911Z] [2025-11-12T00:04:53.911Z] ACTION: junit -- Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure [2025-11-12T00:04:53.911Z] REASON: User specified action: run junit/othervm -Djdk.internal.httpclient.debug=err ServerStopTerminationTest [2025-11-12T00:04:53.911Z] TIME: 55.271 seconds [2025-11-12T00:04:53.911Z] messages: [2025-11-12T00:04:53.911Z] command: junit -Djdk.internal.httpclient.debug=err ServerStopTerminationTest [2025-11-12T00:04:53.911Z] reason: User specified action: run junit/othervm -Djdk.internal.httpclient.debug=err ServerStopTerminationTest [2025-11-12T00:04:53.911Z] started: Wed Nov 12 00:03:57 GMT 2025 [2025-11-12T00:04:53.911Z] Mode: othervm [/othervm specified] [2025-11-12T00:04:53.911Z] Additional options from @modules: --add-modules jdk.httpserver,java.logging [2025-11-12T00:04:53.911Z] finished: Wed Nov 12 00:04:53 GMT 2025 [2025-11-12T00:04:53.911Z] elapsed time (seconds): 55.271 [2025-11-12T00:04:53.911Z] configuration: [2025-11-12T00:04:53.911Z] Boot Layer [2025-11-12T00:04:53.911Z] add modules: jdk.httpserver java.logging [2025-11-12T00:04:53.911Z] [2025-11-12T00:04:53.911Z] STDOUT: [2025-11-12T00:04:53.911Z] {noActiveExchanges}: Shutting down the server with no exchanges [2025-11-12T00:04:53.911Z] {shouldAllowRepeatedStop}: Shutting down the server the first time [2025-11-12T00:04:53.911Z] {shouldAllowRepeatedStop}: Shutting down the server the second time [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelay}: Exchange started [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelay}: Complete Exchange triggered [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelay}: Shutdown triggered with the delay of 1 [2025-11-12T00:04:53.911Z] request completed (null, java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes) [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelay}: Shutdown complete [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelayCustomHandler}: Changing the server to the server with a custom executor [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelayCustomHandler}: Custom setup complete [2025-11-12T00:04:53.911Z] {lambda$shouldCompeteAfterDelayCustomHandler$2}: Custom executor started, sleeping [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelayCustomHandler}: Exchange (Executor) started [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelayCustomHandler}: Shutdown triggered with the delay of 1 [2025-11-12T00:04:53.911Z] {shouldCompeteAfterDelayCustomHandler}: Shutdown complete [2025-11-12T00:04:53.911Z] request completed (null, java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes) [2025-11-12T00:04:53.911Z] {shouldAwaitActiveExchange}: Exchange started [2025-11-12T00:04:53.911Z] {shouldAwaitActiveExchange}: Complete Exchange triggered [2025-11-12T00:04:53.911Z] {shouldAwaitActiveExchange}: Shutdown triggered with the delay of 40 [2025-11-12T00:04:53.911Z] {shouldAwaitActiveExchange}: Shutdown complete [2025-11-12T00:04:53.911Z] request completed ((POST http://127.0.0.1:35767) 200, null) [2025-11-12T00:04:53.911Z] STDERR: [2025-11-12T00:04:53.911Z] STARTED ServerStopTerminationTest::noActiveExchanges 'noActiveExchanges()' [2025-11-12T00:04:53.911Z] Nov 12, 2025 12:04:02 AM sun.net.httpserver.ServerImpl <init> [2025-11-12T00:04:53.911Z] FINE: HttpServer created http null [2025-11-12T00:04:53.911Z] Nov 12, 2025 12:04:02 AM sun.net.httpserver.ServerImpl createContext [2025-11-12T00:04:53.911Z] FINE: context created: / [2025-11-12T00:04:53.911Z] DEBUG: [MainThread] [734ms] HttpClientImpl(1) proxySelector is sun.net.spi.DefaultProxySelector@712be755 (user-supplied=false) [2025-11-12T00:04:53.911Z] DEBUG: [HttpClient-1-SelectorManager] [41s 148ms] HttpClientImpl(1) SelectorManager shutting down [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-1-SelectorManager] [41s 165ms] Http2ClientImpl stopping [2025-11-12T00:04:53.912Z] org.opentest4j.AssertionFailedError: Expected HttpServer.stop to terminate immediately with no active exchanges [2025-11-12T00:04:53.912Z] at org.junit.jupiter.api.AssertionUtils.fail(AssertionUtils.java:38) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.api.Assertions.fail(Assertions.java:135) [2025-11-12T00:04:53.912Z] at ServerStopTerminationTest.noActiveExchanges(ServerStopTerminationTest.java:258) [2025-11-12T00:04:53.912Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:04:53.912Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:04:53.912Z] at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:86) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138) [2025-11-12T00:04:53.912Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:04:53.912Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:04:53.912Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) [2025-11-12T00:04:53.912Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86) [2025-11-12T00:04:53.912Z] at org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86) [2025-11-12T00:04:53.912Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142) [2025-11-12T00:04:53.912Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:04:53.912Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:61) [2025-11-12T00:04:53.912Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:04:53.912Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:04:53.912Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-11-12T00:04:53.912Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:04:53.912Z] FAILED ServerStopTerminationTest::noActiveExchanges 'noActiveExchanges()' [2025-11-12T00:04:53.912Z] STARTED ServerStopTerminationTest::shouldAllowRepeatedStop 'shouldAllowRepeatedStop()' [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:44 AM sun.net.httpserver.ServerImpl <init> [2025-11-12T00:04:53.912Z] FINE: HttpServer created http null [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:44 AM sun.net.httpserver.ServerImpl createContext [2025-11-12T00:04:53.912Z] FINE: context created: / [2025-11-12T00:04:53.912Z] DEBUG: [MainThread] [41s 390ms] HttpClientImpl(2) proxySelector is sun.net.spi.DefaultProxySelector@712be755 (user-supplied=false) [2025-11-12T00:04:53.912Z] SUCCESSFUL ServerStopTerminationTest::shouldAllowRepeatedStop 'shouldAllowRepeatedStop()' [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-2-SelectorManager] [42s 625ms] HttpClientImpl(2) SelectorManager shutting down [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-2-SelectorManager] [42s 626ms] Http2ClientImpl stopping [2025-11-12T00:04:53.912Z] STARTED ServerStopTerminationTest::shouldCompeteAfterDelay 'shouldCompeteAfterDelay()' [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:45 AM sun.net.httpserver.ServerImpl <init> [2025-11-12T00:04:53.912Z] FINE: HttpServer created http null [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:45 AM sun.net.httpserver.ServerImpl createContext [2025-11-12T00:04:53.912Z] FINE: context created: / [2025-11-12T00:04:53.912Z] DEBUG: [MainThread] [42s 666ms] HttpClientImpl(3) proxySelector is sun.net.spi.DefaultProxySelector@712be755 (user-supplied=false) [2025-11-12T00:04:53.912Z] DEBUG: [MainThread] [42s 701ms] HttpClientImpl(3) ClientImpl (async) send http://127.0.0.1:38069 POST [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 818ms] Exchange establishing exchange for http://127.0.0.1:38069 POST, [2025-11-12T00:04:53.912Z] proxy=null [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 879ms] Http2ClientImpl not found in connection pool [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 880ms] ExchangeImpl get: Trying to get HTTP/2 connection [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 880ms] ExchangeImpl handling HTTP/2 connection creation result [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 880ms] ExchangeImpl new Http1Exchange, try to upgrade [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 909ms] PlainHttpConnection(?) Initial receive buffer size is: 65536 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [42s 912ms] PlainHttpConnection(?) Initial send buffer size is: 8192 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 124ms] Exchange checkFor407: all clear [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 125ms] Http1Exchange Sending headers only [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 263ms] Http1AsyncReceiver(SocketTube(1)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@28434568 queue.isEmpty: true [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 473ms] Http1AsyncReceiver(SocketTube(1)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@28434568, demand=1, canRequestMore=true, queue.isEmpty=true [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 480ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 565ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 566ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 578ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 579ms] Http1Exchange response created in advance [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 580ms] Http1Exchange initiating connect async [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 593ms] PlainHttpConnection(SocketTube(1)) registering connect event [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 599ms] SelectorAttachment Registering jdk.internal.net.http.PlainHttpConnection$ConnectEvent@6046c6bd for 8 (true) [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 682ms] PlainHttpConnection(SocketTube(1)) ConnectEvent: finishing connect [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 685ms] PlainHttpConnection(SocketTube(1)) ConnectEvent: connect finished: true, cancelled: false, Local addr: /127.0.0.1:46636 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 705ms] PlainHttpConnection(SocketTube(1)) finishConnect, setting connected=true [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 725ms] Http1Exchange SocketTube(1) connecting flows [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 726ms] SocketTube(1) connecting flows [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 745ms] SocketTube(1) read publisher got subscriber [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 747ms] SocketTube(1) registering subscribe event [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 747ms] SocketTube(1) leaving read.subscribe: Reading: [ops=0, demand=0, stopped=false], Writing: [ops=0, demand=0] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 748ms] Http1Publisher(SocketTube(1)) got subscriber: SocketTube(1) [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 748ms] SocketTube(1) subscribed for writing [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 753ms] SocketTube(1) write: registering startSubscription event [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 753ms] Http1Exchange requestAction.headers [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 766ms] SocketTube(1) subscribe event raised [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 777ms] Http1Exchange setting outgoing with headers [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 778ms] SocketTube(1) handling pending subscription for jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber@5209b79e [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 778ms] SocketTube(1) read demand reset to 0 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 778ms] SocketTube(1) calling onSubscribe [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 778ms] Http1AsyncReceiver(SocketTube(1)) Received onSubscribed from upstream [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 778ms] SocketTube(1) onSubscribe called [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 778ms] SocketTube(1) pending subscriber subscribed [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 779ms] SocketTube(1) write: starting subscription [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 779ms] SocketTube(1) write: offloading requestMore [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 782ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 782ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 782ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: requesting one more from upstream [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 782ms] SocketTube(1) got some demand for reading [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 782ms] SocketTube(1) resuming read event [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 785ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=215 cap=215]], throwable=null] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 786ms] Http1Publisher(SocketTube(1)) WriteTask [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 788ms] SocketTube(1) leaving request(1): Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=0] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [43s 801ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@5349158 for 1 (true) [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 807ms] SocketTube(1) write: requesting more... [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 808ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-1] [43s 808ms] SocketTube(1) leaving requestMore: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 867ms] Http1Publisher(SocketTube(1)) hasOutgoing = true, demand = 0 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 868ms] Http1Exchange initiating completion of headersSentCF [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 872ms] Http1Publisher(SocketTube(1)) outgoing: DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=215 cap=215]], throwable=null] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 874ms] Http1Publisher(SocketTube(1)) onNext with 215 bytes [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 895ms] SocketTube(1) trying to write: 215 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 911ms] SocketTube(1) wrote: 215 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 921ms] SocketTube(1) write: requesting more... [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 928ms] Http1Publisher(SocketTube(1)) subscription request(1), demand=1 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 929ms] SocketTube(1) leaving requestMore: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 929ms] SocketTube(1) leaving w.onNext Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 929ms] Http1Publisher(SocketTube(1)) WriteTask [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 929ms] Http1Publisher(SocketTube(1)) hasOutgoing = false, demand = 1 [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 932ms] Exchange checkFor407: all clear [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 932ms] Exchange sendRequestBody [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 932ms] Http1Exchange sendBodyAsync [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 933ms] Http1Exchange bodySubscriber is null [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 933ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 933ms] Http1Publisher(SocketTube(1)) WriteTask [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 933ms] Http1Publisher(SocketTube(1)) hasOutgoing = true, demand = 1 [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:47 AM sun.net.httpserver.ServerImpl$Exchange run [2025-11-12T00:04:53.912Z] FINER: exchange started [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 935ms] Http1Exchange initiating completion of bodySentCF [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 951ms] Http1Publisher(SocketTube(1)) outgoing: DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 951ms] Http1Publisher(SocketTube(1)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@7eb3b28d [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 957ms] Http1Exchange sendBodyAsync completed successfully [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 958ms] Http1Exchange reading headers [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 987ms] Http1Response(id=1, PlainHttpConnection(SocketTube(1))) Reading Headers: (remaining: 0) READING_HEADERS [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 987ms] Http1Response(id=1, PlainHttpConnection(SocketTube(1))) First time around [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-Worker-0] [43s 987ms] Http1Response(id=1, PlainHttpConnection(SocketTube(1))) headersReader is not yet completed [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:47 AM sun.net.httpserver.ServerImpl$Exchange run [2025-11-12T00:04:53.912Z] FINE: Exchange request line: POST / HTTP/1.1 [2025-11-12T00:04:53.912Z] Nov 12, 2025 12:04:48 AM sun.net.httpserver.HttpConnection close [2025-11-12T00:04:53.912Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:38069 remote=/127.0.0.1:46636] [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [45s 251ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@5349158 for 0 (false) [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [45s 252ms] SocketTube(1) got read EOF [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [45s 252ms] SocketTube(1) pausing read event [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [45s 253ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@5349158 for 0 (false) [2025-11-12T00:04:53.912Z] DEBUG: [HttpClient-3-SelectorManager] [45s 253ms] SocketTube(1) completing subscriber [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 253ms] Http1AsyncReceiver(SocketTube(1)) onError: java.io.EOFException: EOF reached while reading [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 290ms] Http1AsyncReceiver(SocketTube(1)) recorded jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] delegate: jdk.internal.net.http.Http1Response$HeadersReader@28434568 [2025-11-12T00:04:53.913Z] queue.isEmpty: true [2025-11-12T00:04:53.913Z] stopRequested: false jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver.onReadError(Http1AsyncReceiver.java:494) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber.onComplete(Http1AsyncReceiver.java:601) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadSubscription.signalCompletion(SocketTube.java:648) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription.read(SocketTube.java:853) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$SocketFlowTask.run(SocketTube.java:181) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SchedulableTask.run(SequentialScheduler.java:207) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:280) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:233) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription.signalReadable(SocketTube.java:782) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent.signalEvent(SocketTube.java:965) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$SocketFlowEvent.handle(SocketTube.java:253) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$SelectorManager.handleEvent(HttpClientImpl.java:1477) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$SelectorManager.lambda$run$3(HttpClientImpl.java:1422) [2025-11-12T00:04:53.913Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$SelectorManager.run(HttpClientImpl.java:1422) [2025-11-12T00:04:53.913Z] Caused by: java.io.EOFException: EOF reached while reading [2025-11-12T00:04:53.913Z] ... 14 more [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 300ms] SocketTube(1) Stopping read scheduler [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 300ms] SocketTube(1) leaving read() loop after EOF: Reading: [ops=0, demand=0, stopped=true], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 300ms] SocketTube(1) Read scheduler stopped [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 301ms] Http1AsyncReceiver(SocketTube(1)) downstream subscription demand is 1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 301ms] Http1AsyncReceiver(SocketTube(1)) checkRequestMore: canRequestMore=false, hasDemand=true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 301ms] Http1AsyncReceiver(SocketTube(1)) Http1TubeSubscriber: no need to request more [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 305ms] Http1AsyncReceiver(SocketTube(1)) flushing jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] delegate: jdk.internal.net.http.Http1Response$HeadersReader@28434568 queue.isEmpty: true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 310ms] Http1Response(id=1, PlainHttpConnection(SocketTube(1))) onReadError: cf is not yet completed [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 312ms] Http1Exchange getResponseAsync completed java.util.concurrent.CompletionException: jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 327ms] HttpClientImpl(3) ClientImpl (async) elapsed 2612 millis for POST to http://127.0.0.1:38069 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 331ms] Http1Response(id=1, PlainHttpConnection(SocketTube(1))) closing connection: cause is jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 334ms] PlainHttpConnection(SocketTube(1)) Closing channel: channel registered with selector, key.interestOps=0, sa.interestOps=0 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 337ms] SocketTube(1) signal read error: java.io.IOException: connection closed locally [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 337ms] SocketTube(1) got read error: java.io.IOException: connection closed locally [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-Worker-0] [45s 338ms] Http1Exchange asyncReceiver finished (failed=jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished) [2025-11-12T00:04:53.913Z] Nov 12, 2025 12:04:48 AM sun.net.httpserver.ServerImpl$Exchange run [2025-11-12T00:04:53.913Z] FINER: ServerImpl.Exchange [2025-11-12T00:04:53.913Z] java.io.IOException: stream is closed [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.Request$WriteStream.write(Request.java:410) [2025-11-12T00:04:53.913Z] at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125) [2025-11-12T00:04:53.913Z] at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252) [2025-11-12T00:04:53.913Z] at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.ExchangeImpl.sendResponseHeaders(ExchangeImpl.java:281) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.HttpExchangeImpl.sendResponseHeaders(HttpExchangeImpl.java:85) [2025-11-12T00:04:53.913Z] at ServerStopTerminationTest.lambda$setup$0(ServerStopTerminationTest.java:91) [2025-11-12T00:04:53.913Z] at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.AuthFilter.doFilter(AuthFilter.java:82) [2025-11-12T00:04:53.913Z] at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:101) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange$LinkHandler.handle(ServerImpl.java:871) [2025-11-12T00:04:53.913Z] at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:847) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.ServerImpl$DefaultExecutor.execute(ServerImpl.java:203) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.ServerImpl$Dispatcher.handle(ServerImpl.java:566) [2025-11-12T00:04:53.913Z] at jdk.httpserver/sun.net.httpserver.ServerImpl$Dispatcher.run(ServerImpl.java:531) [2025-11-12T00:04:53.913Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:04:53.913Z] [2025-11-12T00:04:53.913Z] SUCCESSFUL ServerStopTerminationTest::shouldCompeteAfterDelay 'shouldCompeteAfterDelay()' [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 894ms] HttpClientImpl(3) SelectorManager shutting down [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-3-SelectorManager] [45s 894ms] Http2ClientImpl stopping [2025-11-12T00:04:53.913Z] STARTED ServerStopTerminationTest::shouldCompeteAfterDelayCustomHandler 'shouldCompeteAfterDelayCustomHandler()' [2025-11-12T00:04:53.913Z] Nov 12, 2025 12:04:49 AM sun.net.httpserver.ServerImpl <init> [2025-11-12T00:04:53.913Z] FINE: HttpServer created http null [2025-11-12T00:04:53.913Z] Nov 12, 2025 12:04:49 AM sun.net.httpserver.ServerImpl createContext [2025-11-12T00:04:53.913Z] FINE: context created: / [2025-11-12T00:04:53.913Z] DEBUG: [MainThread] [45s 945ms] HttpClientImpl(4) proxySelector is sun.net.spi.DefaultProxySelector@712be755 (user-supplied=false) [2025-11-12T00:04:53.913Z] Nov 12, 2025 12:04:49 AM sun.net.httpserver.ServerImpl <init> [2025-11-12T00:04:53.913Z] FINE: HttpServer created http localhost/127.0.0.1:0 [2025-11-12T00:04:53.913Z] Nov 12, 2025 12:04:49 AM sun.net.httpserver.ServerImpl createContext [2025-11-12T00:04:53.913Z] FINE: context created: / [2025-11-12T00:04:53.913Z] DEBUG: [MainThread] [46s 43ms] HttpClientImpl(4) ClientImpl (async) send http://127.0.0.1:44427 POST [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 71ms] Exchange establishing exchange for http://127.0.0.1:44427 POST, [2025-11-12T00:04:53.913Z] proxy=null [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 71ms] Http2ClientImpl not found in connection pool [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 71ms] ExchangeImpl get: Trying to get HTTP/2 connection [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 72ms] ExchangeImpl handling HTTP/2 connection creation result [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 72ms] ExchangeImpl new Http1Exchange, try to upgrade [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 72ms] PlainHttpConnection(?) Initial receive buffer size is: 65536 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 72ms] PlainHttpConnection(?) Initial send buffer size is: 8192 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Exchange checkFor407: all clear [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1Exchange Sending headers only [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1AsyncReceiver(SocketTube(2)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@17543090 queue.isEmpty: true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1AsyncReceiver(SocketTube(2)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@17543090, demand=1, canRequestMore=true, queue.isEmpty=true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1AsyncReceiver(SocketTube(2)) downstream subscription demand is 1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1AsyncReceiver(SocketTube(2)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1AsyncReceiver(SocketTube(2)) downstream subscription demand is 1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1AsyncReceiver(SocketTube(2)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1Exchange response created in advance [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 73ms] Http1Exchange initiating connect async [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 79ms] PlainHttpConnection(SocketTube(2)) registering connect event [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 91ms] SelectorAttachment Registering jdk.internal.net.http.PlainHttpConnection$ConnectEvent@34b7e518 for 8 (true) [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 92ms] PlainHttpConnection(SocketTube(2)) ConnectEvent: finishing connect [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 93ms] PlainHttpConnection(SocketTube(2)) ConnectEvent: connect finished: true, cancelled: false, Local addr: /127.0.0.1:45866 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 108ms] PlainHttpConnection(SocketTube(2)) finishConnect, setting connected=true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] Http1Exchange SocketTube(2) connecting flows [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] SocketTube(2) connecting flows [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] SocketTube(2) read publisher got subscriber [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] SocketTube(2) registering subscribe event [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] SocketTube(2) leaving read.subscribe: Reading: [ops=0, demand=0, stopped=false], Writing: [ops=0, demand=0] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] Http1Publisher(SocketTube(2)) got subscriber: SocketTube(2) [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] SocketTube(2) subscribed for writing [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] SocketTube(2) write: registering startSubscription event [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] Http1Exchange requestAction.headers [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] Http1Exchange setting outgoing with headers [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 109ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=215 cap=215]], throwable=null] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 110ms] Http1Publisher(SocketTube(2)) WriteTask [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 110ms] Http1Publisher(SocketTube(2)) hasOutgoing = true, demand = 0 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 116ms] SocketTube(2) subscribe event raised [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) handling pending subscription for jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber@3e4f8e68 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) read demand reset to 0 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) calling onSubscribe [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] Http1AsyncReceiver(SocketTube(2)) Received onSubscribed from upstream [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) onSubscribe called [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) pending subscriber subscribed [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) write: starting subscription [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 117ms] SocketTube(2) write: offloading requestMore [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 128ms] Http1AsyncReceiver(SocketTube(2)) downstream subscription demand is 1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 128ms] Http1AsyncReceiver(SocketTube(2)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 129ms] Http1AsyncReceiver(SocketTube(2)) Http1TubeSubscriber: requesting one more from upstream [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 129ms] SocketTube(2) got some demand for reading [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 129ms] SocketTube(2) resuming read event [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-0] [46s 129ms] SocketTube(2) leaving request(1): Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=0] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 146ms] SocketTube(2) write: requesting more... [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [46s 146ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@7059b291 for 1 (true) [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 146ms] Http1Publisher(SocketTube(2)) subscription request(1), demand=1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 155ms] Http1Publisher(SocketTube(2)) WriteTask [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 155ms] Http1Publisher(SocketTube(2)) hasOutgoing = true, demand = 1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 155ms] Http1Exchange initiating completion of headersSentCF [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 155ms] Exchange checkFor407: all clear [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 155ms] Exchange sendRequestBody [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] Http1Exchange sendBodyAsync [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] Http1Exchange bodySubscriber is null [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] Http1Publisher(SocketTube(2)) outgoing: DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=215 cap=215]], throwable=null] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] Http1Publisher(SocketTube(2)) onNext with 215 bytes [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] SocketTube(2) trying to write: 215 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 156ms] SocketTube(2) wrote: 215 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] SocketTube(2) write: requesting more... [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Publisher(SocketTube(2)) subscription request(1), demand=1 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] SocketTube(2) leaving requestMore: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] SocketTube(2) leaving w.onNext Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Exchange initiating completion of bodySentCF [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Exchange sendBodyAsync completed successfully [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Exchange reading headers [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Response(id=2, PlainHttpConnection(SocketTube(2))) Reading Headers: (remaining: 0) READING_HEADERS [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Response(id=2, PlainHttpConnection(SocketTube(2))) First time around [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Response(id=2, PlainHttpConnection(SocketTube(2))) headersReader is not yet completed [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Publisher(SocketTube(2)) outgoing: DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] Http1Publisher(SocketTube(2)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@6af3bc20 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-Worker-1] [46s 157ms] SocketTube(2) leaving requestMore: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 254ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@7059b291 for 0 (false) [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 274ms] SocketTube(2) signal read error: java.net.SocketException: Connection reset [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 275ms] SocketTube(2) got read error: java.net.SocketException: Connection reset [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 275ms] SocketTube(2) pausing read event [2025-11-12T00:04:53.913Z] SUCCESSFUL ServerStopTerminationTest::shouldCompeteAfterDelayCustomHandler 'shouldCompeteAfterDelayCustomHandler()' [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 293ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@7059b291 for 0 (false) [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 298ms] SocketTube(2) Sending error java.net.SocketException: Connection reset to subscriber jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber@3e4f8e68 [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 299ms] SocketTube(2) forwarding error to subscriber: java.net.SocketException: Connection reset [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 299ms] Http1AsyncReceiver(SocketTube(2)) onError: java.net.SocketException: Connection reset [2025-11-12T00:04:53.913Z] DEBUG: [HttpClient-4-SelectorManager] [47s 300ms] Http1AsyncReceiver(SocketTube(2)) recorded jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] delegate: jdk.internal.net.http.Http1Response$HeadersReader@17543090 [2025-11-12T00:04:53.913Z] queue.isEmpty: true [2025-11-12T00:04:53.913Z] stopRequested: false jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver.onReadError(Http1AsyncReceiver.java:494) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber.onError(Http1AsyncReceiver.java:595) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadSubscription.signalCompletion(SocketTube.java:645) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription.read(SocketTube.java:829) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$SocketFlowTask.run(SocketTube.java:181) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SchedulableTask.run(SequentialScheduler.java:207) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:280) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:233) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription.signalReadable(SocketTube.java:782) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent.signalEvent(SocketTube.java:965) [2025-11-12T00:04:53.913Z] at java.net.http/jdk.internal.net.http.SocketTube$SocketFlowEvent.handle(SocketTube.java:253) [2025-11-12T00:04:53.914Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$SelectorManager.handleEvent(HttpClientImpl.java:1477) [2025-11-12T00:04:53.914Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$SelectorManager.lambda$run$3(HttpClientImpl.java:1422) [2025-11-12T00:04:53.914Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:04:53.914Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$SelectorManager.run(HttpClientImpl.java:1422) [2025-11-12T00:04:53.914Z] Caused by: java.net.SocketException: Connection reset [2025-11-12T00:04:53.914Z] at java.base/sun.nio.ch.SocketChannelImpl.throwConnectionReset(SocketChannelImpl.java:401) [2025-11-12T00:04:53.914Z] at java.base/sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:434) [2025-11-12T00:04:53.914Z] at java.net.http/jdk.internal.net.http.SocketTube.readAvailable(SocketTube.java:1178) [2025-11-12T00:04:53.914Z] at java.net.http/jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription.read(SocketTube.java:841) [2025-11-12T00:04:53.914Z] ... 11 more [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-SelectorManager] [47s 348ms] SocketTube(2) Stopping read scheduler [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-SelectorManager] [47s 348ms] SocketTube(2) leaving read() loop with error: Reading: [ops=0, demand=0, stopped=true], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-SelectorManager] [47s 348ms] SocketTube(2) Read scheduler stopped [2025-11-12T00:04:53.914Z] STARTED ServerStopTerminationTest::shouldAwaitActiveExchange 'shouldAwaitActiveExchange()' [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 359ms] Http1AsyncReceiver(SocketTube(2)) downstream subscription demand is 1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] Http1AsyncReceiver(SocketTube(2)) checkRequestMore: canRequestMore=false, hasDemand=true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] Http1AsyncReceiver(SocketTube(2)) Http1TubeSubscriber: no need to request more [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] Http1AsyncReceiver(SocketTube(2)) flushing jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.914Z] delegate: jdk.internal.net.http.Http1Response$HeadersReader@17543090 queue.isEmpty: true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] Http1Response(id=2, PlainHttpConnection(SocketTube(2))) onReadError: cf is not yet completed [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] Http1Exchange getResponseAsync completed java.util.concurrent.CompletionException: jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] HttpClientImpl(4) ClientImpl (async) elapsed 1317 millis for POST to http://127.0.0.1:44427 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] Http1Response(id=2, PlainHttpConnection(SocketTube(2))) closing connection: cause is jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 360ms] PlainHttpConnection(SocketTube(2)) Closing channel: channel registered with selector, key.interestOps=0, sa.interestOps=0 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 361ms] SocketTube(2) signal read error: java.io.IOException: connection closed locally [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-Worker-1] [47s 361ms] Http1Exchange asyncReceiver finished (failed=jdk.internal.net.http.common.ConnectionExpiredException: subscription is finished) [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-SelectorManager] [47s 362ms] HttpClientImpl(4) SelectorManager shutting down [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-4-SelectorManager] [47s 363ms] Http2ClientImpl stopping [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:50 AM sun.net.httpserver.ServerImpl <init> [2025-11-12T00:04:53.914Z] FINE: HttpServer created http null [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:50 AM sun.net.httpserver.ServerImpl createContext [2025-11-12T00:04:53.914Z] FINE: context created: / [2025-11-12T00:04:53.914Z] DEBUG: [MainThread] [47s 487ms] HttpClientImpl(5) proxySelector is sun.net.spi.DefaultProxySelector@712be755 (user-supplied=false) [2025-11-12T00:04:53.914Z] DEBUG: [MainThread] [47s 561ms] HttpClientImpl(5) ClientImpl (async) send http://127.0.0.1:35767 POST [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 582ms] Exchange establishing exchange for http://127.0.0.1:35767 POST, [2025-11-12T00:04:53.914Z] proxy=null [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 582ms] Http2ClientImpl not found in connection pool [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 582ms] ExchangeImpl get: Trying to get HTTP/2 connection [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 582ms] ExchangeImpl handling HTTP/2 connection creation result [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 582ms] ExchangeImpl new Http1Exchange, try to upgrade [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 583ms] PlainHttpConnection(?) Initial receive buffer size is: 65536 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 583ms] PlainHttpConnection(?) Initial send buffer size is: 8192 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Exchange checkFor407: all clear [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1Exchange Sending headers only [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1AsyncReceiver(SocketTube(3)) Subscribed pending jdk.internal.net.http.Http1Response$HeadersReader@103b007d queue.isEmpty: true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1AsyncReceiver(SocketTube(3)) delegate is now jdk.internal.net.http.Http1Response$HeadersReader@103b007d, demand=1, canRequestMore=true, queue.isEmpty=true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1AsyncReceiver(SocketTube(3)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1AsyncReceiver(SocketTube(3)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1Exchange response created in advance [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 584ms] Http1Exchange initiating connect async [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 585ms] PlainHttpConnection(SocketTube(3)) registering connect event [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 586ms] SelectorAttachment Registering jdk.internal.net.http.PlainHttpConnection$ConnectEvent@87b1a05 for 8 (true) [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 609ms] PlainHttpConnection(SocketTube(3)) ConnectEvent: finishing connect [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 610ms] PlainHttpConnection(SocketTube(3)) ConnectEvent: connect finished: true, cancelled: false, Local addr: /127.0.0.1:34810 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 635ms] PlainHttpConnection(SocketTube(3)) finishConnect, setting connected=true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 636ms] Http1Exchange SocketTube(3) connecting flows [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 636ms] SocketTube(3) connecting flows [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 646ms] SocketTube(3) read publisher got subscriber [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 647ms] SocketTube(3) registering subscribe event [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] SocketTube(3) subscribe event raised [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] SocketTube(3) handling pending subscription for jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber@4781ef41 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] SocketTube(3) read demand reset to 0 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] SocketTube(3) calling onSubscribe [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] Http1AsyncReceiver(SocketTube(3)) Received onSubscribed from upstream [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] SocketTube(3) onSubscribe called [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 650ms] SocketTube(3) pending subscriber subscribed [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 651ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 651ms] Http1AsyncReceiver(SocketTube(3)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 651ms] Http1AsyncReceiver(SocketTube(3)) Http1TubeSubscriber: requesting one more from upstream [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 651ms] SocketTube(3) got some demand for reading [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 651ms] SocketTube(3) resuming read event [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 652ms] SocketTube(3) leaving request(1): Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=0] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 654ms] SocketTube(3) leaving read.subscribe: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=0] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 664ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 1 (true) [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 670ms] Http1Publisher(SocketTube(3)) got subscriber: SocketTube(3) [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 670ms] SocketTube(3) subscribed for writing [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 670ms] SocketTube(3) write: registering startSubscription event [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 671ms] Http1Exchange requestAction.headers [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 672ms] Http1Exchange setting outgoing with headers [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 672ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=215 cap=215]], throwable=null] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 672ms] Http1Publisher(SocketTube(3)) WriteTask [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-1] [47s 672ms] Http1Publisher(SocketTube(3)) hasOutgoing = true, demand = 0 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 682ms] SocketTube(3) write: starting subscription [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [47s 682ms] SocketTube(3) write: offloading requestMore [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 693ms] SocketTube(3) write: requesting more... [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 693ms] Http1Publisher(SocketTube(3)) subscription request(1), demand=1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 693ms] Http1Publisher(SocketTube(3)) WriteTask [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 693ms] Http1Publisher(SocketTube(3)) hasOutgoing = true, demand = 1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 693ms] Http1Exchange initiating completion of headersSentCF [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 697ms] Exchange checkFor407: all clear [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 697ms] Exchange sendRequestBody [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 697ms] Http1Exchange sendBodyAsync [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 697ms] Http1Exchange bodySubscriber is null [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] Http1Exchange appending to outgoing DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] Http1Publisher(SocketTube(3)) outgoing: DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=215 cap=215]], throwable=null] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] Http1Publisher(SocketTube(3)) onNext with 215 bytes [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] SocketTube(3) trying to write: 215 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] SocketTube(3) wrote: 215 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] SocketTube(3) write: requesting more... [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] Http1Publisher(SocketTube(3)) subscription request(1), demand=1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] SocketTube(3) leaving requestMore: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] SocketTube(3) leaving w.onNext Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] Http1Exchange initiating completion of bodySentCF [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 698ms] Http1Exchange sendBodyAsync completed successfully [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] Http1Exchange reading headers [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Reading Headers: (remaining: 0) READING_HEADERS [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) First time around [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) headersReader is not yet completed [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] Http1Publisher(SocketTube(3)) outgoing: DataPair [data=[java.nio.HeapByteBuffer[pos=0 lim=0 cap=0]], throwable=null] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] Http1Publisher(SocketTube(3)) completed, stopping jdk.internal.net.http.common.SequentialScheduler@140496a2 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [47s 699ms] SocketTube(3) leaving requestMore: Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:50 AM sun.net.httpserver.ServerImpl$Exchange run [2025-11-12T00:04:53.914Z] FINER: exchange started [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:50 AM sun.net.httpserver.ServerImpl$Exchange run [2025-11-12T00:04:53.914Z] FINE: Exchange request line: POST / HTTP/1.1 [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:51 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2025-11-12T00:04:53.914Z] FINER: Sent headers: noContentToSend=false [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 790ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 0 (false) [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:51 AM sun.net.httpserver.ServerImpl logReply [2025-11-12T00:04:53.914Z] FINE: POST / HTTP/1.1 [200 OK] () [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:51 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2025-11-12T00:04:53.914Z] FINER: Write Finished [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 836ms] SocketTube(3) read bytes: 84 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 837ms] Http1AsyncReceiver(SocketTube(3)) Putting 84 bytes into the queue [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 838ms] SocketTube(3) resuming read event [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 838ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 1 (false) [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 843ms] Http1AsyncReceiver(SocketTube(3)) Got 84 bytes for delegate jdk.internal.net.http.Http1Response$HeadersReader@103b007d [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 843ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 1 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 844ms] Http1AsyncReceiver(SocketTube(3)) Forwarding 84 bytes to delegate jdk.internal.net.http.Http1Response$HeadersReader@103b007d [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 854ms] SocketTube(3) leaving read() loop after onNext: Reading: [ops=1, demand=0, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 870ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 0 (false) [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 871ms] SocketTube(3) no more demand for reading [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-SelectorManager] [48s 871ms] SocketTube(3) leaving read() loop with no demand Reading: [ops=0, demand=0, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 872ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Sending 84/84 bytes to header parser [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 873ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Parsing headers completed. bytes=84 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 884ms] Http1AsyncReceiver(SocketTube(3)) Unsubscribed jdk.internal.net.http.Http1Response$HeadersReader@103b007d [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 885ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Reading Headers: creating Response object; state is now READING_BODY [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 885ms] Http1Exchange getResponseAsync completed successfully [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [48s 940ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) readBody: return2Cache: true [2025-11-12T00:04:53.914Z] Nov 12, 2025 12:04:52 AM sun.net.httpserver.HttpConnection close [2025-11-12T00:04:53.914Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:35767 remote=/127.0.0.1:34810] [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [49s 51ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Operation started: incrementing ref count for jdk.internal.net.http.HttpClientImpl@1efcfdd2(5) [2025-11-12T00:04:53.914Z] SUCCESSFUL ServerStopTerminationTest::shouldAwaitActiveExchange 'shouldAwaitActiveExchange()' [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [49s 77ms] Http1AsyncReceiver(SocketTube(3)) Subscribed pending jdk.internal.net.http.Http1Response$BodyReader@302739ed/parser=jdk.internal.net.http.ResponseContent$ChunkedBodyParser@12622b3b queue.isEmpty: false [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [49s 179ms] Http1AsyncReceiver(SocketTube(3)) Delegate done: 0 [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [49s 189ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser onSubscribe: jdk.internal.net.http.Http1Exchange$Http1ResponseBodySubscriber [2025-11-12T00:04:53.914Z] DEBUG: [HttpClient-5-Worker-0] [49s 190ms] HttpClientImpl(5) body subscriber registered: 1 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 191ms] Http1AsyncReceiver(SocketTube(3)) delegate is now jdk.internal.net.http.Http1Response$BodyReader@302739ed/parser=jdk.internal.net.http.ResponseContent$ChunkedBodyParser@12622b3b, demand=9223372036854775807, canRequestMore=false, queue.isEmpty=false [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 191ms] Http1AsyncReceiver(SocketTube(3)) Got 0 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@302739ed/parser=jdk.internal.net.http.ResponseContent$ChunkedBodyParser@12622b3b [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 191ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 9223372036854775807 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 191ms] Http1AsyncReceiver(SocketTube(3)) Forwarding 0 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@302739ed/parser=jdk.internal.net.http.ResponseContent$ChunkedBodyParser@12622b3b [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 191ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Sending 0/84 bytes to body parser [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 192ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser Trying to read chunk len (remaining in buffer:0) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 202ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 9223372036854775807 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] Http1AsyncReceiver(SocketTube(3)) checkRequestMore: canRequestMore=true, hasDemand=true [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] Http1AsyncReceiver(SocketTube(3)) Http1TubeSubscriber: requesting one more from upstream [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] SocketTube(3) got some demand for reading [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] SocketTube(3) resuming read event [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] SocketTube(3) leaving request(1): Reading: [ops=1, demand=1, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 9223372036854775807 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] Http1AsyncReceiver(SocketTube(3)) checkRequestMore: canRequestMore=false, hasDemand=true [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 213ms] Http1AsyncReceiver(SocketTube(3)) Http1TubeSubscriber: no need to request more [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 216ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 1 (true) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 217ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 0 (false) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 217ms] SocketTube(3) read bytes: 5 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 218ms] Http1AsyncReceiver(SocketTube(3)) Putting 5 bytes into the queue [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 218ms] SocketTube(3) resuming read event [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 218ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 1 (false) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 246ms] SocketTube(3) leaving read() loop after onNext: Reading: [ops=1, demand=0, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 218ms] Http1AsyncReceiver(SocketTube(3)) Got 5 bytes for delegate jdk.internal.net.http.Http1Response$BodyReader@302739ed/parser=jdk.internal.net.http.ResponseContent$ChunkedBodyParser@12622b3b [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 261ms] Http1AsyncReceiver(SocketTube(3)) downstream subscription demand is 9223372036854775807 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 261ms] Http1AsyncReceiver(SocketTube(3)) Forwarding 5 bytes to delegate jdk.internal.net.http.Http1Response$BodyReader@302739ed/parser=jdk.internal.net.http.ResponseContent$ChunkedBodyParser@12622b3b [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 261ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Sending 5/5 bytes to body parser [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 261ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser Trying to read chunk len (remaining in buffer:5) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 262ms] SelectorAttachment Registering jdk.internal.net.http.SocketTube$InternalReadPublisher$ReadEvent@17fa6e86 for 0 (false) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 267ms] SocketTube(3) no more demand for reading [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 267ms] SocketTube(3) leaving read() loop with no demand Reading: [ops=0, demand=0, stopped=false], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 273ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser Got chunk len 0 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 274ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser Trying to consume bytes: 2 (remaining in buffer: 2) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 274ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser No more chunks: 0 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 274ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser done! [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 274ms] Http1AsyncReceiver(SocketTube(3)) cleared [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 274ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) SocketTube(3): return to HTTP/1.1 pool [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 275ms] PlainHttpConnection(SocketTube(3)) Closing channel: channel registered with selector, key.interestOps=0, sa.interestOps=0 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 291ms] SocketTube(3) signal read error: java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 291ms] SocketTube(3) got read error: java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 291ms] SocketTube(3) pausing read event [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 295ms] SocketTube(3) Sending error java.io.IOException: connection closed locally to subscriber jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber@4781ef41 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 295ms] SocketTube(3) forwarding error to subscriber: java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 295ms] Http1AsyncReceiver(SocketTube(3)) onError: java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 295ms] Http1AsyncReceiver(SocketTube(3)) recorded java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] delegate: null [2025-11-12T00:04:53.915Z] queue.isEmpty: false [2025-11-12T00:04:53.915Z] stopRequested: false java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] java.io.IOException: connection closed locally [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.SocketTube.signalClosed(SocketTube.java:159) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.PlainHttpConnection.close(PlainHttpConnection.java:428) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.PlainHttpConnection.close(PlainHttpConnection.java:406) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.HttpConnection.checkOpen(HttpConnection.java:202) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.HttpConnection.closeOrReturnToCache(HttpConnection.java:408) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.Http1Response.onFinished(Http1Response.java:436) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.ResponseContent$ChunkedBodyParser.accept(ResponseContent.java:219) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.ResponseContent$ChunkedBodyParser.accept(ResponseContent.java:131) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.Http1Response$BodyReader.handle(Http1Response.java:707) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.Http1Response$BodyReader.handle(Http1Response.java:635) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.Http1Response$Receiver.accept(Http1Response.java:527) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.Http1Response$BodyReader.tryAsyncReceive(Http1Response.java:665) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver.flush(Http1AsyncReceiver.java:233) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$LockingRestartableTask.run(SequentialScheduler.java:182) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$CompleteRestartableTask.run(SequentialScheduler.java:149) [2025-11-12T00:04:53.915Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SchedulableTask.run(SequentialScheduler.java:207) [2025-11-12T00:04:53.915Z] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144) [2025-11-12T00:04:53.915Z] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642) [2025-11-12T00:04:53.915Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 296ms] SocketTube(3) Stopping read scheduler [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 296ms] SocketTube(3) leaving read() loop with error: Reading: [ops=0, demand=0, stopped=true], Writing: [ops=0, demand=1] [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 296ms] SocketTube(3) Read scheduler stopped [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 313ms] HttpClientImpl(5) body subscriber unregistered: 0 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 314ms] HttpClientImpl(5) ClientImpl (async) elapsed 1793 millis for POST to http://127.0.0.1:35767 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 314ms] PlainHttpConnection(SocketTube(3))/ResponseContent/ChunkedBodyParser subscriber completed [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 314ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Finished reading body: READING_BODY [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 315ms] Http1Response(id=3, PlainHttpConnection(SocketTube(3))) Operation finished: decrementing ref count for jdk.internal.net.http.HttpClientImpl@1efcfdd2(5) [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-Worker-0] [49s 315ms] Http1AsyncReceiver(SocketTube(3)) Delegate done: 0 [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 330ms] HttpClientImpl(5) SelectorManager shutting down [2025-11-12T00:04:53.915Z] DEBUG: [HttpClient-5-SelectorManager] [49s 331ms] Http2ClientImpl stopping [2025-11-12T00:04:53.915Z] JavaTest Message: JUnit Platform Failure(s): 1 [2025-11-12T00:04:53.915Z] [2025-11-12T00:04:53.915Z] [ JUnit Containers: found 4, started 4, succeeded 4, failed 0, aborted 0, skipped 0] [2025-11-12T00:04:53.915Z] [ JUnit Tests: found 5, started 5, succeeded 4, failed 1, aborted 0, skipped 0] [2025-11-12T00:04:53.915Z] [2025-11-12T00:04:53.915Z] java.lang.Exception: JUnit test failure [2025-11-12T00:04:53.915Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:149) [2025-11-12T00:04:53.915Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:04:53.915Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:61) [2025-11-12T00:04:53.915Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:04:53.915Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:04:53.915Z] at com.sun.javatest.regtest.agent.MainWrapper$MainTask.run(MainWrapper.java:138) [2025-11-12T00:04:53.915Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:04:53.915Z] [2025-11-12T00:04:53.915Z] JavaTest Message: Test threw exception: java.lang.Exception: JUnit test failure [2025-11-12T00:04:53.915Z] JavaTest Message: shutting down test [2025-11-12T00:04:53.915Z] [2025-11-12T00:04:53.915Z] STATUS:Failed.`main' threw exception: java.lang.Exception: JUnit test failure [2025-11-12T00:04:53.915Z] rerun: [2025-11-12T00:04:53.915Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/scratch/0 && \ [2025-11-12T00:04:53.915Z] DISPLAY=:0 \ [2025-11-12T00:04:53.915Z] HOME=/home/jenkins \ [2025-11-12T00:04:53.915Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-11-12T00:04:53.915Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-11-12T00:04:53.915Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/java \ [2025-11-12T00:04:53.915Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \ [2025-11-12T00:04:53.915Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \ [2025-11-12T00:04:53.915Z] -Dtest.compiler.opts= \ [2025-11-12T00:04:53.915Z] -Dtest.java.opts= \ [2025-11-12T00:04:53.915Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:04:53.915Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:04:53.915Z] -Dtest.timeout.factor=8.0 \ [2025-11-12T00:04:53.915Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-11-12T00:04:53.915Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-11-12T00:04:53.915Z] -Dtest.name=com/sun/net/httpserver/ServerStopTerminationTest.java \ [2025-11-12T00:04:53.915Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver/ServerStopTerminationTest.java \ [2025-11-12T00:04:53.915Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver \ [2025-11-12T00:04:53.915Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2025-11-12T00:04:53.915Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d \ [2025-11-12T00:04:53.915Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib \ [2025-11-12T00:04:53.915Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/com/sun/net/httpserver/ServerStopTerminationTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/com/sun/net/httpserver:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/1/test/lib \ [2025-11-12T00:04:53.915Z] -Dtest.modules='jdk.httpserver java.logging' \ [2025-11-12T00:04:53.915Z] --add-modules jdk.httpserver,java.logging \ [2025-11-12T00:04:53.915Z] -ea \ [2025-11-12T00:04:53.915Z] -esa \ [2025-11-12T00:04:53.915Z] -Xmx512m \ [2025-11-12T00:04:53.915Z] -XX:+UseCompressedOops \ [2025-11-12T00:04:53.915Z] -Djava.awt.headless=true \ [2025-11-12T00:04:53.915Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-11-12T00:04:53.915Z] -Djdk.internal.httpclient.debug=err \ [2025-11-12T00:04:53.915Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/com/sun/net/httpserver/ServerStopTerminationTest.d/junit.0.jta com/sun/net/httpserver/ServerStopTerminationTest.java ServerStopTerminationTest [2025-11-12T00:04:53.915Z] [2025-11-12T00:04:53.915Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure [2025-11-12T00:04:53.915Z] -------------------------------------------------- [2025-11-12T00:34:55.430Z] TEST: java/net/CookieStoreTest.java [2025-11-12T00:34:55.430Z] TEST JDK: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] ACTION: build -- Passed. Build successful [2025-11-12T00:34:55.430Z] REASON: Named class compiled on demand [2025-11-12T00:34:55.430Z] TIME: 0.117 seconds [2025-11-12T00:34:55.430Z] messages: [2025-11-12T00:34:55.430Z] command: build CookieStoreTest [2025-11-12T00:34:55.430Z] reason: Named class compiled on demand [2025-11-12T00:34:55.430Z] started: Wed Nov 12 00:34:39 GMT 2025 [2025-11-12T00:34:55.430Z] Test directory: [2025-11-12T00:34:55.430Z] compile: CookieStoreTest [2025-11-12T00:34:55.430Z] finished: Wed Nov 12 00:34:40 GMT 2025 [2025-11-12T00:34:55.430Z] elapsed time (seconds): 0.117 [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] ACTION: compile -- Passed. Compilation successful [2025-11-12T00:34:55.430Z] REASON: .class file out of date or does not exist [2025-11-12T00:34:55.430Z] TIME: 0.117 seconds [2025-11-12T00:34:55.430Z] messages: [2025-11-12T00:34:55.430Z] command: compile /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/CookieStoreTest.java [2025-11-12T00:34:55.430Z] reason: .class file out of date or does not exist [2025-11-12T00:34:55.430Z] started: Wed Nov 12 00:34:39 GMT 2025 [2025-11-12T00:34:55.430Z] Mode: agentvm [2025-11-12T00:34:55.430Z] Agent id: 1 [2025-11-12T00:34:55.430Z] finished: Wed Nov 12 00:34:40 GMT 2025 [2025-11-12T00:34:55.430Z] elapsed time (seconds): 0.117 [2025-11-12T00:34:55.430Z] configuration: [2025-11-12T00:34:55.430Z] Boot Layer (javac runtime environment) [2025-11-12T00:34:55.430Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-11-12T00:34:55.430Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/patches/java.base [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] javac compilation environment [2025-11-12T00:34:55.430Z] source path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net [2025-11-12T00:34:55.430Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] rerun: [2025-11-12T00:34:55.430Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/scratch/1 && \ [2025-11-12T00:34:55.430Z] DISPLAY=:0 \ [2025-11-12T00:34:55.430Z] HOME=/home/jenkins \ [2025-11-12T00:34:55.430Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/javac \ [2025-11-12T00:34:55.430Z] -J-ea \ [2025-11-12T00:34:55.430Z] -J-esa \ [2025-11-12T00:34:55.430Z] -J-Xmx512m \ [2025-11-12T00:34:55.430Z] -J-XX:+UseCompressedOops \ [2025-11-12T00:34:55.430Z] -J-Djava.awt.headless=true \ [2025-11-12T00:34:55.430Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \ [2025-11-12T00:34:55.430Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \ [2025-11-12T00:34:55.430Z] -J-Dtest.compiler.opts= \ [2025-11-12T00:34:55.430Z] -J-Dtest.java.opts= \ [2025-11-12T00:34:55.430Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:34:55.430Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:34:55.430Z] -J-Dtest.timeout.factor=8.0 \ [2025-11-12T00:34:55.430Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-11-12T00:34:55.430Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-11-12T00:34:55.430Z] -J-Dtest.name=java/net/CookieStoreTest.java \ [2025-11-12T00:34:55.430Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/CookieStoreTest.java \ [2025-11-12T00:34:55.430Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d \ [2025-11-12T00:34:55.430Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d \ [2025-11-12T00:34:55.430Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -d /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d \ [2025-11-12T00:34:55.430Z] -sourcepath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/CookieStoreTest.java [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] ACTION: junit -- Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure [2025-11-12T00:34:55.430Z] REASON: User specified action: run junit CookieStoreTest [2025-11-12T00:34:55.430Z] TIME: 1.485 seconds [2025-11-12T00:34:55.430Z] messages: [2025-11-12T00:34:55.430Z] command: junit CookieStoreTest [2025-11-12T00:34:55.430Z] reason: User specified action: run junit CookieStoreTest [2025-11-12T00:34:55.430Z] started: Wed Nov 12 00:34:40 GMT 2025 [2025-11-12T00:34:55.430Z] Mode: agentvm [2025-11-12T00:34:55.430Z] Agent id: 39 [2025-11-12T00:34:55.430Z] finished: Wed Nov 12 00:34:41 GMT 2025 [2025-11-12T00:34:55.430Z] elapsed time (seconds): 1.485 [2025-11-12T00:34:55.430Z] configuration: [2025-11-12T00:34:55.430Z] Boot Layer [2025-11-12T00:34:55.430Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/testng-7.3.0.jar [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/guice-5.1.0.jar [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jcommander-1.82.jar [2025-11-12T00:34:55.430Z] patch: java.base /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/patches/java.base [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] Test Layer [2025-11-12T00:34:55.430Z] class path: /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net [2025-11-12T00:34:55.430Z] [2025-11-12T00:34:55.430Z] rerun: [2025-11-12T00:34:55.430Z] cd /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/scratch/1 && \ [2025-11-12T00:34:55.430Z] DISPLAY=:0 \ [2025-11-12T00:34:55.430Z] HOME=/home/jenkins \ [2025-11-12T00:34:55.430Z] PATH=/bin:/usr/bin:/usr/sbin \ [2025-11-12T00:34:55.430Z] /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image/bin/java \ [2025-11-12T00:34:55.430Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops -Djava.awt.headless=true' \ [2025-11-12T00:34:55.430Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops -J-Djava.awt.headless=true' \ [2025-11-12T00:34:55.430Z] -Dtest.compiler.opts= \ [2025-11-12T00:34:55.430Z] -Dtest.java.opts= \ [2025-11-12T00:34:55.430Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:34:55.430Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/j2sdk-image \ [2025-11-12T00:34:55.430Z] -Dtest.timeout.factor=8.0 \ [2025-11-12T00:34:55.430Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2025-11-12T00:34:55.430Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2025-11-12T00:34:55.430Z] -Dtest.name=java/net/CookieStoreTest.java \ [2025-11-12T00:34:55.430Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/CookieStoreTest.java \ [2025-11-12T00:34:55.430Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d \ [2025-11-12T00:34:55.430Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d \ [2025-11-12T00:34:55.430Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net \ [2025-11-12T00:34:55.430Z] -classpath /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work/classes/0/java/net/CookieStoreTest.d:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/junit-platform-console-standalone-1.9.2.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2025-11-12T00:34:55.430Z] com.sun.javatest.regtest.agent.JUnitRunner java/net/CookieStoreTest.java CookieStoreTest [2025-11-12T00:34:55.430Z] STDERR: [2025-11-12T00:34:55.430Z] STARTED CookieStoreTest::testImmutableGetCookies '[1] java.net.InMemoryCookieStore@5c2060d4, true' [2025-11-12T00:34:55.430Z] SUCCESSFUL CookieStoreTest::testImmutableGetCookies '[1] java.net.InMemoryCookieStore@5c2060d4, true' [2025-11-12T00:34:55.430Z] STARTED CookieStoreTest::testImmutableGetCookies '[2] java.net.InMemoryCookieStore@43d0d1c7, false' [2025-11-12T00:34:55.430Z] SUCCESSFUL CookieStoreTest::testImmutableGetCookies '[2] java.net.InMemoryCookieStore@43d0d1c7, false' [2025-11-12T00:34:55.430Z] STARTED CookieStoreTest::testImmutableGetURIs '[1] java.net.InMemoryCookieStore@4cf97abc, true' [2025-11-12T00:34:55.430Z] org.opentest4j.AssertionFailedError: Expected java.lang.UnsupportedOperationException to be thrown, but nothing was thrown. [2025-11-12T00:34:55.430Z] at org.junit.jupiter.api.AssertionFailureBuilder.build(AssertionFailureBuilder.java:152) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:73) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:35) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.api.Assertions.assertThrows(Assertions.java:3083) [2025-11-12T00:34:55.430Z] at CookieStoreTest.assertImmutableList(CookieStoreTest.java:105) [2025-11-12T00:34:55.430Z] at CookieStoreTest.testImmutableGetURIs(CookieStoreTest.java:72) [2025-11-12T00:34:55.430Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.430Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.430Z] at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestTemplateMethod(TimeoutExtension.java:94) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138) [2025-11-12T00:34:55.430Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.430Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:226) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:204) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:142) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.lambda$execute$2(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:179) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:762) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Spliterators.java:1024) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:44) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86) [2025-11-12T00:34:55.431Z] at org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86) [2025-11-12T00:34:55.431Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142) [2025-11-12T00:34:55.431Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:34:55.431Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.431Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.431Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2025-11-12T00:34:55.431Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:34:55.431Z] FAILED CookieStoreTest::testImmutableGetURIs '[1] java.net.InMemoryCookieStore@4cf97abc, true' [2025-11-12T00:34:55.431Z] STARTED CookieStoreTest::testImmutableGetURIs '[2] java.net.InMemoryCookieStore@580eaf98, false' [2025-11-12T00:34:55.431Z] org.opentest4j.AssertionFailedError: Expected java.lang.UnsupportedOperationException to be thrown, but nothing was thrown. [2025-11-12T00:34:55.431Z] at org.junit.jupiter.api.AssertionFailureBuilder.build(AssertionFailureBuilder.java:152) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:73) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:35) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.api.Assertions.assertThrows(Assertions.java:3083) [2025-11-12T00:34:55.431Z] at CookieStoreTest.assertImmutableList(CookieStoreTest.java:105) [2025-11-12T00:34:55.431Z] at CookieStoreTest.testImmutableGetURIs(CookieStoreTest.java:72) [2025-11-12T00:34:55.431Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.431Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.431Z] at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestTemplateMethod(TimeoutExtension.java:94) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:226) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:204) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:142) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.lambda$execute$2(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:179) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:762) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Spliterators.java:1024) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.431Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.431Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:44) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.431Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.431Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86) [2025-11-12T00:34:55.432Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142) [2025-11-12T00:34:55.432Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:34:55.432Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.432Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.432Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2025-11-12T00:34:55.432Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:34:55.432Z] FAILED CookieStoreTest::testImmutableGetURIs '[2] java.net.InMemoryCookieStore@580eaf98, false' [2025-11-12T00:34:55.432Z] STARTED CookieStoreTest::testImmutableGetCookiesForURI '[1] java.net.InMemoryCookieStore@12b033b3, true' [2025-11-12T00:34:55.432Z] org.opentest4j.AssertionFailedError: Expected java.lang.UnsupportedOperationException to be thrown, but nothing was thrown. [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.AssertionFailureBuilder.build(AssertionFailureBuilder.java:152) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:73) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:35) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.Assertions.assertThrows(Assertions.java:3083) [2025-11-12T00:34:55.432Z] at CookieStoreTest.assertImmutableList(CookieStoreTest.java:105) [2025-11-12T00:34:55.432Z] at CookieStoreTest.testImmutableGetCookiesForURI(CookieStoreTest.java:96) [2025-11-12T00:34:55.432Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.432Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.432Z] at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestTemplateMethod(TimeoutExtension.java:94) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:226) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:204) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:142) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.lambda$execute$2(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:179) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:762) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Spliterators.java:1024) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.432Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.432Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.432Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:44) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.432Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.432Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) [2025-11-12T00:34:55.432Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86) [2025-11-12T00:34:55.432Z] at org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86) [2025-11-12T00:34:55.432Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142) [2025-11-12T00:34:55.432Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:34:55.432Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.432Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.432Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2025-11-12T00:34:55.432Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:34:55.432Z] FAILED CookieStoreTest::testImmutableGetCookiesForURI '[1] java.net.InMemoryCookieStore@12b033b3, true' [2025-11-12T00:34:55.432Z] STARTED CookieStoreTest::testImmutableGetCookiesForURI '[2] java.net.InMemoryCookieStore@6f0459a0, false' [2025-11-12T00:34:55.432Z] org.opentest4j.AssertionFailedError: Expected java.lang.UnsupportedOperationException to be thrown, but nothing was thrown. [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.AssertionFailureBuilder.build(AssertionFailureBuilder.java:152) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:73) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.AssertThrows.assertThrows(AssertThrows.java:35) [2025-11-12T00:34:55.432Z] at org.junit.jupiter.api.Assertions.assertThrows(Assertions.java:3083) [2025-11-12T00:34:55.432Z] at CookieStoreTest.assertImmutableList(CookieStoreTest.java:105) [2025-11-12T00:34:55.434Z] at CookieStoreTest.testImmutableGetCookiesForURI(CookieStoreTest.java:96) [2025-11-12T00:34:55.434Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.434Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.434Z] at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:727) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:131) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:156) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:147) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestTemplateMethod(TimeoutExtension.java:94) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(InterceptingExecutableInvoker.java:103) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.lambda$invoke$0(InterceptingExecutableInvoker.java:93) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:106) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:64) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:45) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:37) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:92) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.execution.InterceptingExecutableInvoker.invoke(InterceptingExecutableInvoker.java:86) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$7(TestMethodTestDescriptor.java:217) [2025-11-12T00:34:55.434Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:213) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:138) [2025-11-12T00:34:55.434Z] at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:68) [2025-11-12T00:34:55.434Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.434Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.434Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.434Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:226) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask$DefaultDynamicTestExecutor.execute(NodeTestTask.java:204) [2025-11-12T00:34:55.435Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:142) [2025-11-12T00:34:55.435Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.lambda$execute$2(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:179) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:762) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Spliterators.java:1024) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:197) [2025-11-12T00:34:55.435Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline$7$1.accept(ReferencePipeline.java:276) [2025-11-12T00:34:55.435Z] at java.base/java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1708) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:509) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:499) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) [2025-11-12T00:34:55.435Z] at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:596) [2025-11-12T00:34:55.435Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:110) [2025-11-12T00:34:55.435Z] at org.junit.jupiter.engine.descriptor.TestTemplateTestDescriptor.execute(TestTemplateTestDescriptor.java:44) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:151) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.435Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.435Z] at java.base/java.util.ArrayList.forEach(ArrayList.java:1596) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:41) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$6(NodeTestTask.java:155) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:141) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:137) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$9(NodeTestTask.java:139) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:138) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:95) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:35) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57) [2025-11-12T00:34:55.435Z] at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:54) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:147) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:127) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:90) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.lambda$execute$0(EngineExecutionOrchestrator.java:55) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.withInterceptedStreams(EngineExecutionOrchestrator.java:102) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.EngineExecutionOrchestrator.execute(EngineExecutionOrchestrator.java:54) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:114) [2025-11-12T00:34:55.435Z] at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:86) [2025-11-12T00:34:55.436Z] at org.junit.platform.launcher.core.DefaultLauncherSession$DelegatingLauncher.execute(DefaultLauncherSession.java:86) [2025-11-12T00:34:55.436Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:142) [2025-11-12T00:34:55.436Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:34:55.436Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.436Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.436Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2025-11-12T00:34:55.436Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:34:55.436Z] FAILED CookieStoreTest::testImmutableGetCookiesForURI '[2] java.net.InMemoryCookieStore@6f0459a0, false' [2025-11-12T00:34:55.436Z] JavaTest Message: JUnit Platform Failure(s): 4 [2025-11-12T00:34:55.436Z] [2025-11-12T00:34:55.436Z] [ JUnit Containers: found 7, started 7, succeeded 7, failed 0, aborted 0, skipped 0] [2025-11-12T00:34:55.436Z] [ JUnit Tests: found 6, started 6, succeeded 2, failed 4, aborted 0, skipped 0] [2025-11-12T00:34:55.436Z] [2025-11-12T00:34:55.436Z] java.lang.Exception: JUnit test failure [2025-11-12T00:34:55.436Z] at com.sun.javatest.regtest.agent.JUnitRunner.runWithJUnitPlatform(JUnitRunner.java:149) [2025-11-12T00:34:55.436Z] at com.sun.javatest.regtest.agent.JUnitRunner.main(JUnitRunner.java:95) [2025-11-12T00:34:55.436Z] at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:103) [2025-11-12T00:34:55.436Z] at java.base/java.lang.reflect.Method.invoke(Method.java:580) [2025-11-12T00:34:55.436Z] at com.sun.javatest.regtest.agent.MainActionHelper$AgentVMRunnable.run(MainActionHelper.java:333) [2025-11-12T00:34:55.436Z] at java.base/java.lang.Thread.run(Thread.java:1583) [2025-11-12T00:34:55.436Z] [2025-11-12T00:34:55.436Z] JavaTest Message: Test threw exception: java.lang.Exception [2025-11-12T00:34:55.436Z] JavaTest Message: shutting down test [2025-11-12T00:34:55.436Z] [2025-11-12T00:34:55.436Z] [2025-11-12T00:34:55.436Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.lang.Exception: JUnit test failure [2025-11-12T00:34:55.436Z] -------------------------------------------------- [2025-11-12T00:38:07.988Z] Test results: passed: 885; failed: 2 [2025-11-12T00:38:11.098Z] Report written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/report/html/report.html [2025-11-12T00:38:11.098Z] Results written to /home/jenkins/workspace/Test_openjdk21_hs_extended.openjdk_aarch64_alpine-linux/aqa-tests/TKG/output_176288228576/jdk_net_0/work [2025-11-12T00:38:11.098Z] Error: Some tests failed or other problems occurred. [2025-11-12T00:38:12.076Z] ----------------------------------- [2025-11-12T00:38:12.076Z] jdk_net_0_FAILED [2025-11-12T00:38:12.076Z] ----------------------------------- [2025-11-12T00:38:12.076Z] [2025-11-12T00:38:12.076Z] TEST TEARDOWN: [2025-11-12T00:38:12.076Z] Nothing to be done for teardown. [2025-11-12T00:38:12.076Z] jdk_net_0 Finish Time: Wed Nov 12 00:38:11 2025 Epoch Time (ms): 1762907891191