[2024-11-22T03:12:02.355Z] Running test jdk_net_0 ... [2024-11-22T03:12:02.355Z] =============================================== [2024-11-22T03:12:02.355Z] jdk_net_0 Start Time: Fri Nov 22 03:12:00 2024 Epoch Time (ms): 1732245120876 [2024-11-22T03:12:02.355Z] variation: Mode150 [2024-11-22T03:12:02.355Z] JVM_OPTIONS: -XX:+UseCompressedOops [2024-11-22T03:12:02.355Z] { \ [2024-11-22T03:12:02.355Z] echo ""; echo "TEST SETUP:"; \ [2024-11-22T03:12:02.355Z] echo "Nothing to be done for setup."; \ [2024-11-22T03:12:02.355Z] mkdir -p "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/jdk_net_0"; \ [2024-11-22T03:12:02.355Z] cd "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/jdk_net_0"; \ [2024-11-22T03:12:02.355Z] echo ""; echo "TESTING:"; \ [2024-11-22T03:12:02.355Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image/bin/java" -Xmx512m -jar "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../../jvmtest/openjdk/jtreg/lib/jtreg.jar" \ [2024-11-22T03:12:02.355Z] -agentvm -a -ea -esa -v:fail,error,time,nopass -retain:fail,error,*.dmp,javacore.*,heapdump.*,*.trc -ignore:quiet -timeoutFactor:8 -xml:verify -concurrency:3 -nativepath:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native" -vmoptions:"-Xmx512m -XX:+UseCompressedOops " \ [2024-11-22T03:12:02.355Z] -w ""/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/jdk_net_0"/work" \ [2024-11-22T03:12:02.355Z] -r ""/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/jdk_net_0"/report" \ [2024-11-22T03:12:02.355Z] -jdk:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image" \ [2024-11-22T03:12:02.355Z] -exclude:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk/ProblemList.txt" \ [2024-11-22T03:12:02.355Z] -exclude:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../../jvmtest/openjdk/excludes/ProblemList_openjdk11.txt" \ [2024-11-22T03:12:02.355Z] \ [2024-11-22T03:12:02.355Z] -exclude:"/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../openjdk/excludes/vendors/eclipse/ProblemList_openjdk11.txt" \ [2024-11-22T03:12:02.355Z] "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../openjdk/openjdk-jdk/test/jdk:jdk_net"; \ [2024-11-22T03:12:02.355Z] if [ $? -eq 0 ]; then echo "-----------------------------------"; echo "jdk_net_0""_PASSED"; echo "-----------------------------------"; cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/..; else echo "-----------------------------------"; echo "jdk_net_0""_FAILED"; echo "-----------------------------------"; fi; \ [2024-11-22T03:12:02.355Z] echo ""; echo "TEST TEARDOWN:"; \ [2024-11-22T03:12:02.355Z] echo "Nothing to be done for teardown."; \ [2024-11-22T03:12:02.355Z] } 2>&1 | tee -a "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/TestTargetResult"; [2024-11-22T03:12:02.355Z] [2024-11-22T03:12:02.355Z] TEST SETUP: [2024-11-22T03:12:02.355Z] Nothing to be done for setup. [2024-11-22T03:12:02.355Z] [2024-11-22T03:12:02.355Z] TESTING: [2024-11-22T03:12:08.795Z] Directory "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/jdk_net_0/work" not found: creating [2024-11-22T03:12:08.795Z] Directory "/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/../TKG/output_17322403247973/jdk_net_0/report" not found: creating [2024-11-22T03:12:51.609Z] XML output with verification to /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work [2024-11-22T04:04:43.541Z] -------------------------------------------------- [2024-11-22T04:04:43.541Z] TEST: java/net/httpclient/ManyRequests2.java [2024-11-22T04:04:43.541Z] TEST JDK: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image [2024-11-22T04:04:43.541Z] [2024-11-22T04:04:43.541Z] ACTION: build -- Passed. All files up to date [2024-11-22T04:04:43.541Z] REASON: User specified action: run build jdk.test.lib.net.SimpleSSLContext [2024-11-22T04:04:43.541Z] TIME: 0.0 seconds [2024-11-22T04:04:43.541Z] messages: [2024-11-22T04:04:43.541Z] command: build jdk.test.lib.net.SimpleSSLContext [2024-11-22T04:04:43.541Z] reason: User specified action: run build jdk.test.lib.net.SimpleSSLContext [2024-11-22T04:04:43.541Z] started: Fri Nov 22 04:03:44 UTC 2024 [2024-11-22T04:04:43.541Z] finished: Fri Nov 22 04:03:44 UTC 2024 [2024-11-22T04:04:43.541Z] elapsed time (seconds): 0.0 [2024-11-22T04:04:43.541Z] [2024-11-22T04:04:43.541Z] ACTION: compile -- Passed. Compilation successful [2024-11-22T04:04:43.541Z] REASON: User specified action: run compile ../../../com/sun/net/httpserver/LogFilter.java [2024-11-22T04:04:43.541Z] TIME: 0.818 seconds [2024-11-22T04:04:43.541Z] messages: [2024-11-22T04:04:43.541Z] command: compile /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/../../../com/sun/net/httpserver/LogFilter.java [2024-11-22T04:04:43.541Z] reason: User specified action: run compile ../../../com/sun/net/httpserver/LogFilter.java [2024-11-22T04:04:43.541Z] started: Fri Nov 22 04:03:44 UTC 2024 [2024-11-22T04:04:43.541Z] Additional options from @modules: --add-modules java.net.http,java.logging,jdk.httpserver [2024-11-22T04:04:43.541Z] Mode: agentvm [2024-11-22T04:04:43.541Z] Agent id: 3 [2024-11-22T04:04:43.541Z] finished: Fri Nov 22 04:03:45 UTC 2024 [2024-11-22T04:04:43.541Z] elapsed time (seconds): 0.818 [2024-11-22T04:04:43.541Z] configuration: [2024-11-22T04:04:43.541Z] Boot Layer (javac runtime environment) [2024-11-22T04:04:43.541Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-11-22T04:04:43.541Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-11-22T04:04:43.541Z] patch: java.base /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/patches/java.base [2024-11-22T04:04:43.541Z] [2024-11-22T04:04:43.541Z] javac compilation environment [2024-11-22T04:04:43.541Z] add modules: java.net.http java.logging jdk.httpserver [2024-11-22T04:04:43.541Z] source path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.541Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-11-22T04:04:43.541Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.541Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d [2024-11-22T04:04:43.541Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib [2024-11-22T04:04:43.541Z] [2024-11-22T04:04:43.541Z] rerun: [2024-11-22T04:04:43.541Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/scratch/2 && \ [2024-11-22T04:04:43.541Z] DISPLAY=:0 \ [2024-11-22T04:04:43.541Z] HOME=/home/jenkins \ [2024-11-22T04:04:43.541Z] LANG=C.UTF-8 \ [2024-11-22T04:04:43.541Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-11-22T04:04:43.541Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image/bin/javac \ [2024-11-22T04:04:43.541Z] -J-ea \ [2024-11-22T04:04:43.541Z] -J-esa \ [2024-11-22T04:04:43.542Z] -J-Xmx512m \ [2024-11-22T04:04:43.542Z] -J-XX:+UseCompressedOops \ [2024-11-22T04:04:43.542Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-11-22T04:04:43.542Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-11-22T04:04:43.542Z] -J-Dtest.compiler.opts= \ [2024-11-22T04:04:43.542Z] -J-Dtest.java.opts= \ [2024-11-22T04:04:43.542Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.542Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.542Z] -J-Dtest.timeout.factor=8.0 \ [2024-11-22T04:04:43.542Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-11-22T04:04:43.542Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-11-22T04:04:43.542Z] -J-Dtest.name=java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.542Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.542Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient \ [2024-11-22T04:04:43.542Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.542Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.542Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.542Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.542Z] -J-Dtest.modules='java.net.http java.logging jdk.httpserver' \ [2024-11-22T04:04:43.542Z] --add-modules java.net.http,java.logging,jdk.httpserver \ [2024-11-22T04:04:43.542Z] -d /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.542Z] -sourcepath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.542Z] -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/../../../com/sun/net/httpserver/LogFilter.java [2024-11-22T04:04:43.542Z] [2024-11-22T04:04:43.542Z] ACTION: compile -- Passed. Compilation successful [2024-11-22T04:04:43.542Z] REASON: User specified action: run compile ../../../com/sun/net/httpserver/EchoHandler.java [2024-11-22T04:04:43.542Z] TIME: 0.286 seconds [2024-11-22T04:04:43.542Z] messages: [2024-11-22T04:04:43.542Z] command: compile /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/../../../com/sun/net/httpserver/EchoHandler.java [2024-11-22T04:04:43.542Z] reason: User specified action: run compile ../../../com/sun/net/httpserver/EchoHandler.java [2024-11-22T04:04:43.542Z] started: Fri Nov 22 04:03:45 UTC 2024 [2024-11-22T04:04:43.542Z] Additional options from @modules: --add-modules java.net.http,java.logging,jdk.httpserver [2024-11-22T04:04:43.542Z] Mode: agentvm [2024-11-22T04:04:43.542Z] Agent id: 3 [2024-11-22T04:04:43.542Z] finished: Fri Nov 22 04:03:45 UTC 2024 [2024-11-22T04:04:43.542Z] elapsed time (seconds): 0.286 [2024-11-22T04:04:43.542Z] configuration: [2024-11-22T04:04:43.542Z] Boot Layer (javac runtime environment) [2024-11-22T04:04:43.542Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-11-22T04:04:43.542Z] patch: java.base /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/patches/java.base [2024-11-22T04:04:43.542Z] [2024-11-22T04:04:43.542Z] javac compilation environment [2024-11-22T04:04:43.542Z] add modules: java.net.http java.logging jdk.httpserver [2024-11-22T04:04:43.542Z] source path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-11-22T04:04:43.542Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib [2024-11-22T04:04:43.542Z] [2024-11-22T04:04:43.542Z] rerun: [2024-11-22T04:04:43.542Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/scratch/2 && \ [2024-11-22T04:04:43.542Z] DISPLAY=:0 \ [2024-11-22T04:04:43.542Z] HOME=/home/jenkins \ [2024-11-22T04:04:43.542Z] LANG=C.UTF-8 \ [2024-11-22T04:04:43.542Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image/bin/javac \ [2024-11-22T04:04:43.542Z] -J-ea \ [2024-11-22T04:04:43.542Z] -J-esa \ [2024-11-22T04:04:43.542Z] -J-Xmx512m \ [2024-11-22T04:04:43.542Z] -J-XX:+UseCompressedOops \ [2024-11-22T04:04:43.542Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-11-22T04:04:43.542Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-11-22T04:04:43.542Z] -J-Dtest.compiler.opts= \ [2024-11-22T04:04:43.542Z] -J-Dtest.java.opts= \ [2024-11-22T04:04:43.542Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.542Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.542Z] -J-Dtest.timeout.factor=8.0 \ [2024-11-22T04:04:43.542Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-11-22T04:04:43.542Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-11-22T04:04:43.542Z] -J-Dtest.name=java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.542Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.542Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient \ [2024-11-22T04:04:43.542Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.542Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.542Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.542Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.542Z] -J-Dtest.modules='java.net.http java.logging jdk.httpserver' \ [2024-11-22T04:04:43.542Z] --add-modules java.net.http,java.logging,jdk.httpserver \ [2024-11-22T04:04:43.542Z] -d /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.542Z] -sourcepath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.542Z] -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/../../../com/sun/net/httpserver/EchoHandler.java [2024-11-22T04:04:43.542Z] [2024-11-22T04:04:43.542Z] ACTION: compile -- Passed. Compilation successful [2024-11-22T04:04:43.542Z] REASON: User specified action: run compile ../../../com/sun/net/httpserver/FileServerHandler.java [2024-11-22T04:04:43.542Z] TIME: 0.589 seconds [2024-11-22T04:04:43.542Z] messages: [2024-11-22T04:04:43.542Z] command: compile /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/../../../com/sun/net/httpserver/FileServerHandler.java [2024-11-22T04:04:43.542Z] reason: User specified action: run compile ../../../com/sun/net/httpserver/FileServerHandler.java [2024-11-22T04:04:43.542Z] started: Fri Nov 22 04:03:45 UTC 2024 [2024-11-22T04:04:43.542Z] Additional options from @modules: --add-modules java.net.http,java.logging,jdk.httpserver [2024-11-22T04:04:43.542Z] Mode: agentvm [2024-11-22T04:04:43.542Z] Agent id: 3 [2024-11-22T04:04:43.542Z] finished: Fri Nov 22 04:03:46 UTC 2024 [2024-11-22T04:04:43.542Z] elapsed time (seconds): 0.589 [2024-11-22T04:04:43.542Z] configuration: [2024-11-22T04:04:43.542Z] Boot Layer (javac runtime environment) [2024-11-22T04:04:43.542Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-11-22T04:04:43.542Z] patch: java.base /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/patches/java.base [2024-11-22T04:04:43.542Z] [2024-11-22T04:04:43.542Z] javac compilation environment [2024-11-22T04:04:43.542Z] add modules: java.net.http java.logging jdk.httpserver [2024-11-22T04:04:43.542Z] source path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-11-22T04:04:43.542Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d [2024-11-22T04:04:43.542Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib [2024-11-22T04:04:43.542Z] [2024-11-22T04:04:43.542Z] rerun: [2024-11-22T04:04:43.543Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/scratch/2 && \ [2024-11-22T04:04:43.543Z] DISPLAY=:0 \ [2024-11-22T04:04:43.543Z] HOME=/home/jenkins \ [2024-11-22T04:04:43.543Z] LANG=C.UTF-8 \ [2024-11-22T04:04:43.543Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-11-22T04:04:43.543Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image/bin/javac \ [2024-11-22T04:04:43.543Z] -J-ea \ [2024-11-22T04:04:43.543Z] -J-esa \ [2024-11-22T04:04:43.543Z] -J-Xmx512m \ [2024-11-22T04:04:43.543Z] -J-XX:+UseCompressedOops \ [2024-11-22T04:04:43.543Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-11-22T04:04:43.543Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-11-22T04:04:43.543Z] -J-Dtest.compiler.opts= \ [2024-11-22T04:04:43.543Z] -J-Dtest.java.opts= \ [2024-11-22T04:04:43.543Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.543Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.543Z] -J-Dtest.timeout.factor=8.0 \ [2024-11-22T04:04:43.543Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-11-22T04:04:43.543Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-11-22T04:04:43.543Z] -J-Dtest.name=java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.543Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.543Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient \ [2024-11-22T04:04:43.543Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.543Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.543Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.543Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.543Z] -J-Dtest.modules='java.net.http java.logging jdk.httpserver' \ [2024-11-22T04:04:43.543Z] --add-modules java.net.http,java.logging,jdk.httpserver \ [2024-11-22T04:04:43.543Z] -d /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.543Z] -sourcepath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.543Z] -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/../../../com/sun/net/httpserver/FileServerHandler.java [2024-11-22T04:04:43.543Z] [2024-11-22T04:04:43.543Z] ACTION: build -- Passed. Build successful [2024-11-22T04:04:43.543Z] REASON: User specified action: run build ManyRequests ManyRequests2 [2024-11-22T04:04:43.543Z] TIME: 2.847 seconds [2024-11-22T04:04:43.543Z] messages: [2024-11-22T04:04:43.543Z] command: build ManyRequests ManyRequests2 [2024-11-22T04:04:43.543Z] reason: User specified action: run build ManyRequests ManyRequests2 [2024-11-22T04:04:43.543Z] started: Fri Nov 22 04:03:46 UTC 2024 [2024-11-22T04:04:43.543Z] Test directory: [2024-11-22T04:04:43.543Z] compile: ManyRequests, ManyRequests2 [2024-11-22T04:04:43.543Z] finished: Fri Nov 22 04:03:49 UTC 2024 [2024-11-22T04:04:43.543Z] elapsed time (seconds): 2.847 [2024-11-22T04:04:43.543Z] [2024-11-22T04:04:43.543Z] ACTION: compile -- Passed. Compilation successful [2024-11-22T04:04:43.543Z] REASON: .class file out of date or does not exist [2024-11-22T04:04:43.543Z] TIME: 2.846 seconds [2024-11-22T04:04:43.543Z] messages: [2024-11-22T04:04:43.543Z] command: compile /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests.java /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java [2024-11-22T04:04:43.543Z] reason: .class file out of date or does not exist [2024-11-22T04:04:43.543Z] started: Fri Nov 22 04:03:46 UTC 2024 [2024-11-22T04:04:43.543Z] Additional options from @modules: --add-modules java.net.http,java.logging,jdk.httpserver [2024-11-22T04:04:43.543Z] Mode: agentvm [2024-11-22T04:04:43.543Z] Agent id: 3 [2024-11-22T04:04:43.543Z] finished: Fri Nov 22 04:03:49 UTC 2024 [2024-11-22T04:04:43.543Z] elapsed time (seconds): 2.846 [2024-11-22T04:04:43.543Z] configuration: [2024-11-22T04:04:43.543Z] Boot Layer (javac runtime environment) [2024-11-22T04:04:43.543Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar [2024-11-22T04:04:43.543Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar [2024-11-22T04:04:43.543Z] patch: java.base /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/patches/java.base [2024-11-22T04:04:43.543Z] [2024-11-22T04:04:43.543Z] javac compilation environment [2024-11-22T04:04:43.543Z] add modules: java.net.http java.logging jdk.httpserver [2024-11-22T04:04:43.543Z] source path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.543Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib [2024-11-22T04:04:43.543Z] class path: /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient [2024-11-22T04:04:43.543Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d [2024-11-22T04:04:43.543Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib [2024-11-22T04:04:43.543Z] [2024-11-22T04:04:43.543Z] rerun: [2024-11-22T04:04:43.543Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/scratch/2 && \ [2024-11-22T04:04:43.543Z] DISPLAY=:0 \ [2024-11-22T04:04:43.543Z] HOME=/home/jenkins \ [2024-11-22T04:04:43.543Z] LANG=C.UTF-8 \ [2024-11-22T04:04:43.543Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-11-22T04:04:43.543Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image/bin/javac \ [2024-11-22T04:04:43.543Z] -J-ea \ [2024-11-22T04:04:43.543Z] -J-esa \ [2024-11-22T04:04:43.543Z] -J-Xmx512m \ [2024-11-22T04:04:43.543Z] -J-XX:+UseCompressedOops \ [2024-11-22T04:04:43.543Z] -J-Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-11-22T04:04:43.543Z] -J-Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-11-22T04:04:43.543Z] -J-Dtest.compiler.opts= \ [2024-11-22T04:04:43.543Z] -J-Dtest.java.opts= \ [2024-11-22T04:04:43.543Z] -J-Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.543Z] -J-Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.543Z] -J-Dtest.timeout.factor=8.0 \ [2024-11-22T04:04:43.543Z] -J-Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-11-22T04:04:43.543Z] -J-Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-11-22T04:04:43.543Z] -J-Dtest.name=java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.543Z] -J-Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.543Z] -J-Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient \ [2024-11-22T04:04:43.543Z] -J-Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.543Z] -J-Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.543Z] -J-Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.543Z] -J-Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.543Z] -J-Dtest.modules='java.net.http java.logging jdk.httpserver' \ [2024-11-22T04:04:43.543Z] --add-modules java.net.http,java.logging,jdk.httpserver \ [2024-11-22T04:04:43.543Z] -d /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.543Z] -sourcepath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.543Z] -classpath /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests.java /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java [2024-11-22T04:04:43.543Z] [2024-11-22T04:04:43.543Z] ACTION: build -- Passed. All files up to date [2024-11-22T04:04:43.543Z] REASON: Named class compiled on demand [2024-11-22T04:04:43.543Z] TIME: 0.001 seconds [2024-11-22T04:04:43.543Z] messages: [2024-11-22T04:04:43.543Z] command: build ManyRequests2 [2024-11-22T04:04:43.544Z] reason: Named class compiled on demand [2024-11-22T04:04:43.544Z] started: Fri Nov 22 04:03:49 UTC 2024 [2024-11-22T04:04:43.544Z] finished: Fri Nov 22 04:03:49 UTC 2024 [2024-11-22T04:04:43.544Z] elapsed time (seconds): 0.001 [2024-11-22T04:04:43.544Z] [2024-11-22T04:04:43.544Z] ACTION: main -- Failed. Execution failed: `main' threw exception: java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.544Z] REASON: User specified action: run main/othervm/timeout=40 -Dtest.XFixed=true -Djdk.httpclient.HttpClient.log=channel ManyRequests2 [2024-11-22T04:04:43.544Z] TIME: 52.319 seconds [2024-11-22T04:04:43.544Z] messages: [2024-11-22T04:04:43.544Z] command: main -Dtest.XFixed=true -Djdk.httpclient.HttpClient.log=channel ManyRequests2 [2024-11-22T04:04:43.544Z] reason: User specified action: run main/othervm/timeout=40 -Dtest.XFixed=true -Djdk.httpclient.HttpClient.log=channel ManyRequests2 [2024-11-22T04:04:43.544Z] started: Fri Nov 22 04:03:49 UTC 2024 [2024-11-22T04:04:43.544Z] Mode: othervm [/othervm specified] [2024-11-22T04:04:43.544Z] Additional options from @modules: --add-modules java.net.http,java.logging,jdk.httpserver [2024-11-22T04:04:43.544Z] finished: Fri Nov 22 04:04:41 UTC 2024 [2024-11-22T04:04:43.544Z] elapsed time (seconds): 52.319 [2024-11-22T04:04:43.544Z] configuration: [2024-11-22T04:04:43.544Z] Boot Layer [2024-11-22T04:04:43.544Z] add modules: java.net.http java.logging jdk.httpserver [2024-11-22T04:04:43.544Z] [2024-11-22T04:04:43.544Z] STDOUT: [2024-11-22T04:04:43.544Z] Seed from RandomFactory = -2673085866570983379L [2024-11-22T04:04:43.544Z] Sending 20 requests; delay=false, chunks=0, XFixed=true [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x1 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x2 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x3 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x4 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x5 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x6 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x7 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x8 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x9 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x10 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x11 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x12 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x13 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x14 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x15 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x16 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x17 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x18 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x19 [2024-11-22T04:04:43.544Z] Client: sendAsync: https://localhost:34131/foo/x20 [2024-11-22T04:04:43.544Z] Server: received /foo/x5 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x5 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x5 [2024-11-22T04:04:43.544Z] 16s, 223ms: Result (1) from /foo/x5 [2024-11-22T04:04:43.544Z] Server: received /foo/x4 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x4 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x4 [2024-11-22T04:04:43.544Z] 17s, 754ms: Result (2) from /foo/x4 [2024-11-22T04:04:43.544Z] Server: received /foo/x15 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x15 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x15 [2024-11-22T04:04:43.544Z] 18s, 532ms: Result (3) from /foo/x15 [2024-11-22T04:04:43.544Z] Server: received /foo/x16 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x16 [2024-11-22T04:04:43.544Z] 19s, 278ms: Result (4) from /foo/x16 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x16 [2024-11-22T04:04:43.544Z] Server: received /foo/x18 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x18 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x18 [2024-11-22T04:04:43.544Z] 22s, 212ms: Result (5) from /foo/x18 [2024-11-22T04:04:43.544Z] Server: received /foo/x20 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x20 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x20 [2024-11-22T04:04:43.544Z] 22s, 519ms: Result (6) from /foo/x20 [2024-11-22T04:04:43.544Z] Server: received /foo/x3 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x3 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x3 [2024-11-22T04:04:43.544Z] 23s, 787ms: Result (7) from /foo/x3 [2024-11-22T04:04:43.544Z] Server: received /foo/x17 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x17 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x17 [2024-11-22T04:04:43.544Z] 25s, 739ms: Result (8) from /foo/x17 [2024-11-22T04:04:43.544Z] Server: received /foo/x19 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x19 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x19 [2024-11-22T04:04:43.544Z] 26s, 702ms: Result (9) from /foo/x19 [2024-11-22T04:04:43.544Z] Server: received /foo/x6 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x6 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x6 [2024-11-22T04:04:43.544Z] 27s, 537ms: Result (10) from /foo/x6 [2024-11-22T04:04:43.544Z] Server: received /foo/x14 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x14 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x14 [2024-11-22T04:04:43.544Z] 28s, 762ms: Result (11) from /foo/x14 [2024-11-22T04:04:43.544Z] Server: received /foo/x1 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x1 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x1 [2024-11-22T04:04:43.544Z] 29s, 741ms: Result (12) from /foo/x1 [2024-11-22T04:04:43.544Z] Server: received /foo/x13 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x13 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x13 [2024-11-22T04:04:43.544Z] 31s, 847ms: Result (13) from /foo/x13 [2024-11-22T04:04:43.544Z] Server: received /foo/x7 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x7 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x7 [2024-11-22T04:04:43.544Z] 33s, 243ms: Result (14) from /foo/x7 [2024-11-22T04:04:43.544Z] Server: received /foo/x2 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x2 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x2 [2024-11-22T04:04:43.544Z] 34s, 472ms: Result (15) from /foo/x2 [2024-11-22T04:04:43.544Z] Server: received /foo/x10 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x10 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x10 [2024-11-22T04:04:43.544Z] 36s, 346ms: Result (16) from /foo/x10 [2024-11-22T04:04:43.544Z] Server: received /foo/x8 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x8 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x8 [2024-11-22T04:04:43.544Z] 38s, 381ms: Result (17) from /foo/x8 [2024-11-22T04:04:43.544Z] Server: received /foo/x12 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x12 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x12 [2024-11-22T04:04:43.544Z] 39s, 123ms: Result (18) from /foo/x12 [2024-11-22T04:04:43.544Z] Server: received /foo/x11 [2024-11-22T04:04:43.544Z] Server: close outbound: /foo/x11 [2024-11-22T04:04:43.544Z] Server: close inbound: /foo/x11 [2024-11-22T04:04:43.544Z] 40s, 671ms: Result (20) from /foo/x11 [2024-11-22T04:04:43.544Z] 39s, 531ms: Result (19) from /foo/x9 [2024-11-22T04:04:43.544Z] failed: java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.544Z] Caused by: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.544Z] Caused by: javax.net.ssl.SSLHandshakeException: Remote host terminated the handshake [2024-11-22T04:04:43.544Z] STDERR: [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:03:52 AM ManyRequests main [2024-11-22T04:04:43.544Z] INFO: TEST [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:03:57 AM sun.net.httpserver.ServerImpl <init> [2024-11-22T04:04:43.544Z] FINE: HttpServer created https localhost/127.0.0.1:0 [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:03:58 AM sun.net.httpserver.ServerImpl createContext [2024-11-22T04:04:43.544Z] FINE: context created: /foo [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:03:58 AM jdk.internal.net.http.HttpClientImpl$SelectorManager run [2024-11-22T04:04:43.544Z] INFO: CHANNEL: HttpClient-1-SelectorManager: starting [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33922 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33922 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33932 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33932 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33894 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33894 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33948 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:04 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33948 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33946 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33946 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33808 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33808 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33950 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33950 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33886 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33886 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33888 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33888 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:05 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.544Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33850 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.544Z] Nov 22, 2024 4:04:06 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33850 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:06 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33962 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:06 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33962 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:06 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:06 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33864 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:06 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33864 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:06 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33834 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33834 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33914 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33914 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33818 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33818 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33782 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33782 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33792 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33792 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33936 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33936 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33904 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33904 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription handleSubscribeEvent [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start reading from java.nio.channels.SocketChannel[connected local=/127.0.0.1:33874 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:07 AM jdk.internal.net.http.SocketTube$InternalWriteSubscriber startSubscription [2024-11-22T04:04:43.545Z] INFO: CHANNEL: Start requesting bytes for writing to channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33874 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:12 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x5 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:12 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x5 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:13 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:14 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x5 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:14 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.545Z] FINER: Write Finished [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:14 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x4 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x4 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x4 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x15 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x15 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x15 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:16 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:17 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x16 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:17 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x16 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:17 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:17 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x16 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:17 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:19 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x18 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x18 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x18 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x20 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x20 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x20 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:20 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:21 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x3 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:22 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x3 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:22 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:22 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x3 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:22 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:23 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x17 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:23 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x17 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:23 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:23 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.545Z] FINE: POST /foo/x17 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:23 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINER: exchange started [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:24 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.545Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x19 POST [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:24 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.545Z] FINE: Exchange request line: POST /foo/x19 HTTP/1.1 [2024-11-22T04:04:43.545Z] Nov 22, 2024 4:04:24 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.545Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:24 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.546Z] FINE: POST /foo/x19 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:24 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.546Z] FINER: exchange started [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:25 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.546Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x6 POST [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:25 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.546Z] FINE: Exchange request line: POST /foo/x6 HTTP/1.1 [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:25 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.546Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:25 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.546Z] FINE: POST /foo/x6 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:25 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.546Z] FINER: exchange started [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:26 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.546Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x14 POST [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:26 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.546Z] FINE: Exchange request line: POST /foo/x14 HTTP/1.1 [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:26 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.546Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.546Z] Nov 22, 2024 4:04:26 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.547Z] FINE: POST /foo/x14 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:26 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINER: exchange started [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:27 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.547Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x1 POST [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:27 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINE: Exchange request line: POST /foo/x1 HTTP/1.1 [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:27 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.547Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:27 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.547Z] FINE: POST /foo/x1 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:27 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINER: exchange started [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:29 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.547Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x13 POST [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:29 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINE: Exchange request line: POST /foo/x13 HTTP/1.1 [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:29 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.547Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:29 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.547Z] FINE: POST /foo/x13 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:29 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINER: exchange started [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:30 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.547Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x7 POST [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:31 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINE: Exchange request line: POST /foo/x7 HTTP/1.1 [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:31 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.547Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:31 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.547Z] FINE: POST /foo/x7 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:31 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINER: exchange started [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:32 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.547Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x2 POST [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:32 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINE: Exchange request line: POST /foo/x2 HTTP/1.1 [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:32 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.547Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:32 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.547Z] FINE: POST /foo/x2 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:32 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINER: exchange started [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:34 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.547Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x10 POST [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:34 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.547Z] FINE: Exchange request line: POST /foo/x10 HTTP/1.1 [2024-11-22T04:04:43.547Z] Nov 22, 2024 4:04:34 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.547Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:34 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.548Z] FINE: POST /foo/x10 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:34 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.548Z] FINER: exchange started [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:35 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.548Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x8 POST [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:35 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.548Z] FINE: Exchange request line: POST /foo/x8 HTTP/1.1 [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:35 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.548Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:35 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.548Z] FINE: POST /foo/x8 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:35 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.548Z] FINER: exchange started [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:36 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.548Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x12 POST [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:36 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.548Z] FINE: Exchange request line: POST /foo/x12 HTTP/1.1 [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:36 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.548Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:36 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.548Z] FINE: POST /foo/x12 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:36 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.548Z] FINER: exchange started [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:37 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33864 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:37 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33864 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:37 AM sun.net.httpserver.ServerImpl$IdleTimeoutTask closeConnections [2024-11-22T04:04:43.548Z] FINER: Closed idle connection java.nio.channels.SocketChannel[closed] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:37 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.548Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x9 POST [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM jdk.internal.net.http.Http1AsyncReceiver checkForErrors [2024-11-22T04:04:43.548Z] INFO: CHANNEL: HTTP/1 read subscriber stopped for: https://localhost:34131/foo/x9 POST [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe [2024-11-22T04:04:43.548Z] INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:34131/foo/x11 POST [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Exchange run [2024-11-22T04:04:43.548Z] FINE: Exchange request line: POST /foo/x11 HTTP/1.1 [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders [2024-11-22T04:04:43.548Z] FINER: Sent headers: noContentToSend=false [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl logReply [2024-11-22T04:04:43.548Z] FINE: POST /foo/x11 HTTP/1.1 [200 OK] () [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:38 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent [2024-11-22T04:04:43.548Z] FINER: Write Finished [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33950] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33932] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33874] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33886] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33914] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33936] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33886 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33886 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33950 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33950 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33874 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33874 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33932 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33932 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33808] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33792] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33888] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: java.nio.channels.CancelledKeyException [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33914 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33914 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33792 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33792 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.548Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33936 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:39 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.548Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33782] [2024-11-22T04:04:43.548Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33936 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33808 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33808 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: java.nio.channels.CancelledKeyException [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.nio.channels.ClosedChannelException [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: java.nio.channels.CancelledKeyException [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33888 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33888 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: java.nio.channels.CancelledKeyException [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33782 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33782 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33894] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33894 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33948] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[closed] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33818] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33904] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33962] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33818 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33834] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33818 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33948 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33948 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33850] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33904 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33904 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33962 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33922] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33962 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM sun.net.httpserver.HttpConnection close [2024-11-22T04:04:43.549Z] FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:34131 remote=localhost/127.0.0.1:33946] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33834 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33834 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: java.nio.channels.CancelledKeyException [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33850 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33850 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.549Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33922 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.549Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33922 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: java.nio.channels.CancelledKeyException [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.550Z] java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.CompletableFuture.encodeRelay(CompletableFuture.java:367) [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.CompletableFuture.completeRelay(CompletableFuture.java:376) [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.CompletableFuture$UniCompose.tryFire(CompletableFuture.java:1074) [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506) [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.CompletableFuture.completeExceptionally(CompletableFuture.java:2094) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1Response.onReadError(Http1Response.java:553) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1Response$HeadersReader.onReadError(Http1Response.java:674) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver.checkForErrors(Http1AsyncReceiver.java:297) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver.flush(Http1AsyncReceiver.java:263) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SynchronizedRestartableTask.run(SequentialScheduler.java:175) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$CompleteRestartableTask.run(SequentialScheduler.java:147) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SchedulableTask.run(SequentialScheduler.java:198) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.HttpClientImpl$DelegatingExecutor.execute(HttpClientImpl.java:154) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:273) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:242) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver.onReadError(Http1AsyncReceiver.java:506) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber.onError(Http1AsyncReceiver.java:585) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SSLTube$DelegateWrapper.onError(SSLTube.java:249) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SSLTube$SSLSubscriberWrapper.complete(SSLTube.java:433) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SSLTube$SSLSubscriberWrapper.onErrorImpl(SSLTube.java:503) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SSLTube$SSLSubscriberWrapper.onComplete(SSLTube.java:559) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SubscriberWrapper.checkCompletion(SubscriberWrapper.java:443) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SubscriberWrapper$DownstreamPusher.run1(SubscriberWrapper.java:322) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SubscriberWrapper$DownstreamPusher.run(SubscriberWrapper.java:261) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SynchronizedRestartableTask.run(SequentialScheduler.java:175) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$CompleteRestartableTask.run(SequentialScheduler.java:147) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SchedulableTask.run(SequentialScheduler.java:198) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:271) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler.runOrSchedule(SequentialScheduler.java:224) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SubscriberWrapper.outgoing(SubscriberWrapper.java:234) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SSLFlowDelegate$Reader.processData(SSLFlowDelegate.java:468) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SSLFlowDelegate$Reader$ReaderDownstreamPusher.run(SSLFlowDelegate.java:264) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SynchronizedRestartableTask.run(SequentialScheduler.java:175) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$CompleteRestartableTask.run(SequentialScheduler.java:147) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.SequentialScheduler$SchedulableTask.run(SequentialScheduler.java:198) [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) [2024-11-22T04:04:43.550Z] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) [2024-11-22T04:04:43.550Z] at java.base/java.lang.Thread.run(Thread.java:829) [2024-11-22T04:04:43.550Z] Caused by: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.common.Utils.wrapWithExtraDetail(Utils.java:327) [2024-11-22T04:04:43.550Z] at java.net.http/jdk.internal.net.http.Http1Response$HeadersReader.onReadError(Http1Response.java:673) [2024-11-22T04:04:43.550Z] ... 31 more [2024-11-22T04:04:43.550Z] Caused by: javax.net.ssl.SSLHandshakeException: Remote host terminated the handshake [2024-11-22T04:04:43.550Z] ... 18 more [2024-11-22T04:04:43.550Z] [2024-11-22T04:04:43.550Z] JavaTest Message: Test threw exception: java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.550Z] JavaTest Message: shutting down test [2024-11-22T04:04:43.550Z] [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.550Z] INFO: CHANNEL: EOF read from channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:33946 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[connected local=/127.0.0.1:33946 remote=localhost/127.0.0.1:34131] [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.550Z] STATUS:Failed.`main' threw exception: java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube signalClosed [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed]) [2024-11-22T04:04:43.550Z] Nov 22, 2024 4:04:40 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError [2024-11-22T04:04:43.550Z] INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally [2024-11-22T04:04:43.550Z] rerun: [2024-11-22T04:04:43.550Z] cd /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/scratch/2 && \ [2024-11-22T04:04:43.550Z] DISPLAY=:0 \ [2024-11-22T04:04:43.550Z] HOME=/home/jenkins \ [2024-11-22T04:04:43.550Z] LANG=C.UTF-8 \ [2024-11-22T04:04:43.550Z] PATH=/bin:/usr/bin:/usr/sbin \ [2024-11-22T04:04:43.550Z] CLASSPATH=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/javatest.jar:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jvmtest/openjdk/jtreg/lib/jtreg.jar \ [2024-11-22T04:04:43.550Z] /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image/bin/java \ [2024-11-22T04:04:43.550Z] -Dtest.vm.opts='-ea -esa -Xmx512m -XX:+UseCompressedOops' \ [2024-11-22T04:04:43.550Z] -Dtest.tool.vm.opts='-J-ea -J-esa -J-Xmx512m -J-XX:+UseCompressedOops' \ [2024-11-22T04:04:43.550Z] -Dtest.compiler.opts= \ [2024-11-22T04:04:43.550Z] -Dtest.java.opts= \ [2024-11-22T04:04:43.550Z] -Dtest.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.550Z] -Dcompile.jdk=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/j2sdk-image \ [2024-11-22T04:04:43.550Z] -Dtest.timeout.factor=8.0 \ [2024-11-22T04:04:43.550Z] -Dtest.nativepath=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-11-22T04:04:43.550Z] -Dtest.root=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk \ [2024-11-22T04:04:43.550Z] -Dtest.name=java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.550Z] -Dtest.file=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient/ManyRequests2.java \ [2024-11-22T04:04:43.550Z] -Dtest.src=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient \ [2024-11-22T04:04:43.550Z] -Dtest.src.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/lib \ [2024-11-22T04:04:43.550Z] -Dtest.classes=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d \ [2024-11-22T04:04:43.550Z] -Dtest.class.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.550Z] -Dtest.class.path.prefix=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/java/net/httpclient/ManyRequests2.d:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/openjdk/openjdk-jdk/test/jdk/java/net/httpclient:/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/classes/0/test/lib \ [2024-11-22T04:04:43.550Z] -Dtest.modules='java.net.http java.logging jdk.httpserver' \ [2024-11-22T04:04:43.550Z] --add-modules java.net.http,java.logging,jdk.httpserver \ [2024-11-22T04:04:43.550Z] -ea \ [2024-11-22T04:04:43.550Z] -esa \ [2024-11-22T04:04:43.550Z] -Xmx512m \ [2024-11-22T04:04:43.550Z] -XX:+UseCompressedOops \ [2024-11-22T04:04:43.550Z] -Djava.library.path=/home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/jdkbinary/openjdk-test-image/jdk/jtreg/native \ [2024-11-22T04:04:43.550Z] -Dtest.XFixed=true \ [2024-11-22T04:04:43.550Z] -Djdk.httpclient.HttpClient.log=channel \ [2024-11-22T04:04:43.550Z] com.sun.javatest.regtest.agent.MainWrapper /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work/java/net/httpclient/ManyRequests2.d/main.0.jta [2024-11-22T04:04:43.550Z] [2024-11-22T04:04:43.550Z] TEST RESULT: Failed. Execution failed: `main' threw exception: java.util.concurrent.CompletionException: java.io.IOException: HTTP/1.1 header parser received no bytes [2024-11-22T04:04:43.550Z] -------------------------------------------------- [2024-11-22T04:48:25.174Z] Test results: passed: 719; failed: 1 [2024-11-22T04:48:38.717Z] Report written to /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/report/html/report.html [2024-11-22T04:48:38.717Z] Results written to /home/jenkins/workspace/Test_openjdk11_hs_extended.openjdk_s390x_linux_testList_5/aqa-tests/TKG/output_17322403247973/jdk_net_0/work [2024-11-22T04:48:38.717Z] Error: Some tests failed or other problems occurred. [2024-11-22T04:48:38.717Z] ----------------------------------- [2024-11-22T04:48:38.717Z] jdk_net_0_FAILED [2024-11-22T04:48:38.717Z] ----------------------------------- [2024-11-22T04:48:38.717Z] [2024-11-22T04:48:38.717Z] TEST TEARDOWN: [2024-11-22T04:48:38.717Z] Nothing to be done for teardown. [2024-11-22T04:48:38.717Z] jdk_net_0 Finish Time: Fri Nov 22 04:48:38 2024 Epoch Time (ms): 1732250918266