Uploaded image for project: 'JDK'
  1. JDK
  2. JDK-8327968

java/net/httpclient/ManyRequests.java fails with jtreg timeout

    XMLWordPrintable

Details

    • Bug
    • Resolution: Unresolved
    • P4
    • None
    • 23
    • core-libs
    • x86_64
    • windows

    Description

      The test appears to complete OK

      Server: close outbound: /foo/x48
      Server: close inbound: /foo/x48
      Server: close outbound: /foo/x50
      Server: close inbound: /foo/x50
      Server: close outbound: /foo/x46
      Server: close inbound: /foo/x46
      159ms: Result (48) from /foo/x50
      159ms: Result (49) from /foo/x48
      159ms: Result (50) from /foo/x46
      OK

      But "under the hood" the test gets itself in a "knot" with HttpClient/HttpServer SSL exchange failing and appears to continuously fail thereafter until jtreg timeout activates.

      This may be dues to the termination/shutdown sequences


      log extract ... there are a multitude of http server exchange failures

      ----------messages:(9/541)----------
      command: main -Djdk.tracePinnedThreads=full -Djdk.httpclient.HttpClient.log=ssl,channel ManyRequests
      reason: User specified action: run main/othervm/timeout=40 -Djdk.tracePinnedThreads=full -Djdk.httpclient.HttpClient.log=ssl,channel ManyRequests
      started: Tue Mar 12 08:43:33 UTC 2024
      Mode: othervm [/othervm specified]
      Additional options from @modules: --add-modules java.net.http,java.logging,jdk.httpserver
      Timeout information:
      --- Timeout information end.
      finished: Tue Mar 12 08:46:41 UTC 2024
      elapsed time (seconds): 187.803
      ----------configuration:(3/72)----------
      Boot Layer
        add modules: java.net.http java.logging jdk.httpserver

      ----------System.out:(513/19768)----------
      Seed from RandomFactory = 8893814701183628058L
      Running on: Windows Server 2016
      Sending 50 requests; delay=false, chunks=0, XFixed=false
      Client: sendAsync: https://localhost:55489/foo/x1
      Client: sendAsync: https://localhost:55489/foo/x2
      Client: sendAsync: https://localhost:55489/foo/x3
      Client: sendAsync: https://localhost:55489/foo/x4
      Client: sendAsync: https://localhost:55489/foo/x5
      Client: sendAsync: https://localhost:55489/foo/x6
      Client: sendAsync: https://localhost:55489/foo/x7
      Client: sendAsync: https://localhost:55489/foo/x8
      Client: sendAsync: https://localhost:55489/foo/x9
      Client: sendAsync: https://localhost:55489/foo/x10
      Client: sendAsync: https://localhost:55489/foo/x11
      Client: sendAsync: https://localhost:55489/foo/x12
      Client: sendAsync: https://localhost:55489/foo/x13
      Client: sendAsync: https://localhost:55489/foo/x14
      Client: sendAsync: https://localhost:55489/foo/x15
      Client: sendAsync: https://localhost:55489/foo/x16
      Client: sendAsync: https://localhost:55489/foo/x17
      Client: sendAsync: https://localhost:55489/foo/x18
      Client: sendAsync: https://localhost:55489/foo/x19
      Client: sendAsync: https://localhost:55489/foo/x20
      Client: sendAsync: https://localhost:55489/foo/x21
      Client: sendAsync: https://localhost:55489/foo/x22
      Client: sendAsync: https://localhost:55489/foo/x23

      . . .

      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x27 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x6 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x12 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x36 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x30 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x34 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x32 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x2 POST
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.PlainHttpConnection close
      INFO: CHANNEL: Closing channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55507 remote=localhost/127.0.0.1:55489]
      Mar 12, 2024 8:45:42 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: connection closed for reading
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.recvAndUnwrap(SSLStreams.java:335)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.doHandshake(SSLStreams.java:481)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.recvData(SSLStreams.java:419)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:528)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:600)
      at jdk.httpserver/sun.net.httpserver.Request.readLine(Request.java:79)
      at jdk.httpserver/sun.net.httpserver.Request.<init>(Request.java:52)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:692)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:45:37 AM jdk.internal.net.http.Http2Connection lambda$checkSSLConfig$4
      INFO: SSL: No ALPN negotiated
      Mar 12, 2024 8:45:42 AM jdk.internal.net.http.Http1AsyncReceiver$Http1TubeSubscriber onSubscribe
      INFO: CHANNEL: HTTP/1 read subscriber got subscription from https://localhost:55489/foo/x25 POST


      . . .

      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: An established connection was aborted by the software in your host machine
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:54)
      at java.base/sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:137)
      at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:102)
      at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:58)
      at java.base/sun.nio.ch.SocketChannelImpl.implWrite(SocketChannelImpl.java:566)
      at java.base/sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:618)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSendX(SSLStreams.java:299)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSend(SSLStreams.java:273)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.sendData(SSLStreams.java:380)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$OutputStream.write(SSLStreams.java:642)
      at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125)
      at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252)
      at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240)
      at jdk.httpserver/sun.net.httpserver.ExchangeImpl.sendResponseHeaders(ExchangeImpl.java:281)
      at jdk.httpserver/sun.net.httpserver.HttpsExchangeImpl.sendResponseHeaders(HttpsExchangeImpl.java:85)
      at EchoHandler.handle(EchoHandler.java:53)
      at ManyRequests$TestEchoHandler.handle(ManyRequests.java:147)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.AuthFilter.doFilter(AuthFilter.java:82)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:101)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange$LinkHandler.handle(ServerImpl.java:871)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:845)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:08 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55514]
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x15 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x16 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x1 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x25 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: An established connection was aborted by the software in your host machine
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:54)
      at java.base/sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:137)
      at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:102)
      at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:58)
      at java.base/sun.nio.ch.SocketChannelImpl.implWrite(SocketChannelImpl.java:566)
      at java.base/sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:618)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSendX(SSLStreams.java:299)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSend(SSLStreams.java:273)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.sendData(SSLStreams.java:380)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$OutputStream.write(SSLStreams.java:642)
      at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125)
      at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252)
      at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240)
      at jdk.httpserver/sun.net.httpserver.ExchangeImpl.sendResponseHeaders(ExchangeImpl.java:281)
      at jdk.httpserver/sun.net.httpserver.HttpsExchangeImpl.sendResponseHeaders(HttpsExchangeImpl.java:85)
      at EchoHandler.handle(EchoHandler.java:53)
      at ManyRequests$TestEchoHandler.handle(ManyRequests.java:147)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.AuthFilter.doFilter(AuthFilter.java:82)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:101)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange$LinkHandler.handle(ServerImpl.java:871)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:845)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:08 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55516]
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x7 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x4 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x12 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x2 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x19 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x5 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders
      FINER: Sent headers: noContentToSend=false
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x35 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: An established connection was aborted by the software in your host machine
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:54)
      at java.base/sun.nio.ch.IOUtil.writeFromNativeBuffer(IOUtil.java:137)
      at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:102)
      at java.base/sun.nio.ch.IOUtil.write(IOUtil.java:58)
      at java.base/sun.nio.ch.SocketChannelImpl.implWrite(SocketChannelImpl.java:566)
      at java.base/sun.nio.ch.SocketChannelImpl.write(SocketChannelImpl.java:618)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSendX(SSLStreams.java:299)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSend(SSLStreams.java:273)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.sendData(SSLStreams.java:380)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$OutputStream.write(SSLStreams.java:642)
      at java.base/java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:125)
      at java.base/java.io.BufferedOutputStream.implFlush(BufferedOutputStream.java:252)
      at java.base/java.io.BufferedOutputStream.flush(BufferedOutputStream.java:240)
      at jdk.httpserver/sun.net.httpserver.ExchangeImpl.sendResponseHeaders(ExchangeImpl.java:281)
      at jdk.httpserver/sun.net.httpserver.HttpsExchangeImpl.sendResponseHeaders(HttpsExchangeImpl.java:85)
      at EchoHandler.handle(EchoHandler.java:53)
      at ManyRequests$TestEchoHandler.handle(ManyRequests.java:147)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.AuthFilter.doFilter(AuthFilter.java:82)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:101)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange$LinkHandler.handle(ServerImpl.java:871)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:845)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:08 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55517]
      Mar 12, 2024 8:46:08 AM sun.net.httpserver.ExchangeImpl sendResponseHeaders

      . . .

      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x48 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x50 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl logReply
      FINE: POST /foo/x46 HTTP/1.1 [200 OK] ()
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent
      FINER: Write Finished
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent
      FINER: Write Finished
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Dispatcher handleEvent
      FINER: Write Finished
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.HttpClientImpl$SelectorManager run
      INFO: CHANNEL: HttpClient-1-SelectorManager: stopping
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.PlainHttpConnection close
      INFO: CHANNEL: Closing channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55531 remote=localhost/127.0.0.1:55489]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube signalClosed
      INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed])
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: exchange started
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError
      INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Raising error with subscriber for java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[closed]
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: connection closed for reading
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.recvAndUnwrap(SSLStreams.java:335)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.recvData(SSLStreams.java:407)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:528)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:600)
      at jdk.httpserver/sun.net.httpserver.Request.readLine(Request.java:79)
      at jdk.httpserver/sun.net.httpserver.Request.<init>(Request.java:52)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:692)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.PlainHttpConnection close
      INFO: CHANNEL: Closing channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55590 remote=localhost/127.0.0.1:55489]
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55531]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube signalClosed
      INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed])
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError
      INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Raising error with subscriber for java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[closed]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.PlainHttpConnection close
      INFO: CHANNEL: Closing channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55540 remote=localhost/127.0.0.1:55489]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube signalClosed
      INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed])
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: exchange started
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError
      INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Raising error with subscriber for java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[closed]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.PlainHttpConnection close
      INFO: CHANNEL: Closing channel: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55620 remote=localhost/127.0.0.1:55489]
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: exchange started
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: connection closed for reading
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.recvAndUnwrap(SSLStreams.java:335)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.recvData(SSLStreams.java:407)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:528)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:600)
      at jdk.httpserver/sun.net.httpserver.Request.readLine(Request.java:79)
      at jdk.httpserver/sun.net.httpserver.Request.<init>(Request.java:52)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:692)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: connection closed for reading
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.recvAndUnwrap(SSLStreams.java:335)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.recvData(SSLStreams.java:407)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:528)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:600)
      at jdk.httpserver/sun.net.httpserver.Request.readLine(Request.java:79)
      at jdk.httpserver/sun.net.httpserver.Request.<init>(Request.java:52)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:692)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube signalClosed
      INFO: CHANNEL: Connection close signalled: connection closed locally (java.nio.channels.SocketChannel[closed])
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: exchange started
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.ServerImpl$Exchange run
      FINER: ServerImpl.Exchange
      java.io.IOException: connection closed for reading
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.recvAndUnwrap(SSLStreams.java:335)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.recvData(SSLStreams.java:407)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:528)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$InputStream.read(SSLStreams.java:600)
      at jdk.httpserver/sun.net.httpserver.Request.readLine(Request.java:79)
      at jdk.httpserver/sun.net.httpserver.Request.<init>(Request.java:52)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:692)
      at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1144)
      at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:642)
      at java.base/java.lang.Thread.run(Thread.java:1575)

      Mar 12, 2024 8:46:15 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55620]
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55540]
      Mar 12, 2024 8:46:15 AM sun.net.httpserver.HttpConnection close
      FINER: Closing connection: java.nio.channels.SocketChannel[connected local=/127.0.0.1:55489 remote=127.0.0.1/127.0.0.1:55590]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription signalError
      INFO: CHANNEL: Read error signalled on channel java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Raising error with subscriber for java.nio.channels.SocketChannel[closed]: java.io.IOException: connection closed locally
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.SocketTube$InternalReadPublisher$InternalReadSubscription read
      INFO: CHANNEL: Stopped reading from channel java.nio.channels.SocketChannel[closed]
      Mar 12, 2024 8:46:15 AM jdk.internal.net.http.PlainHttpConnection close

      Attachments

        Issue Links

          Activity

            People

              jpai Jaikiran Pai
              msheppar Mark Sheppard
              Votes:
              0 Vote for this issue
              Watchers:
              4 Start watching this issue

              Dates

                Created:
                Updated: