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

java/net/httpclient/CancelRequestTest.java fails "test CancelRequestTest.testGetSendAsync("https://localhost:46509/https1/x/same/interrupt", true, true)"

XMLWordPrintable

    • b08
    • aarch64
    • linux
    • Verified

      The following test failed in the JDK21 CI:

      java/net/httpclient/CancelRequestTest.java

      Here's a snippet from the log file:

      [1 s, 303 ms, 231796 ns] testGetSendAsync(https://localhost:46509/https1/x/same/interrupt/get, true, true)
      response: jdk.internal.net.http.common.MinimalFuture@671dc8b1[Not completed, 1 dependents] (id=830)
      cf1: jdk.internal.net.http.common.MinimalFuture@6bf6d795[Not completed, 1 dependents] (id=832)
      cf2: jdk.internal.net.http.common.MinimalFuture@9fd74fb[Not completed] (id=833)
      client delay: 61
      Server wrote 12 bytes
      HTTPSlowHandler received request to /https1/x/same/interrupt/get
      java.util.concurrent.CompletionException: java.util.concurrent.CancellationException: Request cancelled
      response after cancel: jdk.internal.net.http.common.MinimalFuture@671dc8b1[Completed exceptionally: java.util.concurrent.CompletionException: java.util.concurrent.CancellationException: Request cancelled] (id=830)
      cf1 after cancel: jdk.internal.net.http.common.MinimalFuture@6bf6d795[Completed exceptionally: java.util.concurrent.CompletionException: java.util.concurrent.CancellationException: Request cancelled] (id=832)
      cf2 after cancel: jdk.internal.net.http.common.MinimalFuture@9fd74fb[Completed exceptionally: java.util.concurrent.CompletionException: java.util.concurrent.CancellationException: Request cancelled] (id=833)
      Got expected exception: java.util.concurrent.ExecutionException: java.util.concurrent.CancellationException: Request cancelled
      Got expected exception: java.util.concurrent.ExecutionException: java.util.concurrent.CancellationException: Request cancelled
      CancellationException cause: java.util.concurrent.ExecutionException: java.util.concurrent.CancellationException: Request cancelled
      Got expected exception: java.util.concurrent.CancellationException: Request cancelled
      cause: java.io.IOException: Request cancelled
      Waiting for HTTP operations to terminate...
      gracedelay: 200 ms, iterations: 20, wait/iteration: 10ms
      Server wrote 12 bytes
      Server wrote 12 bytes
      HTTPSlowHandler: unexpected exception: java.io.IOException: Broken pipe
      HTTPSlowHandler reply sent: /http1/x/same/interrupt/get
      WARNING: exception caught in HttpTestHandler::handle java.io.IOException: Broken pipe
      java.io.IOException: Broken pipe
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:62)
      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.write(SocketChannelImpl.java:542)
      at jdk.httpserver/sun.net.httpserver.Request$WriteStream.write(Request.java:390)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.writeChunk(ChunkedOutputStream.java:125)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.flush(ChunkedOutputStream.java:159)
      at jdk.httpserver/sun.net.httpserver.PlaceholderOutputStream.flush(ExchangeImpl.java:469)
      at CancelRequestTest$HTTPSlowHandler.handle(CancelRequestTest.java:660)
      at HttpServerAdapters$HttpTestHandler.doHandle(HttpServerAdapters.java:382)
      at HttpServerAdapters$HttpTestHandler.lambda$toHttpHandler$0(HttpServerAdapters.java:375)
      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:868)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:835)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$DefaultExecutor.execute(ServerImpl.java:204)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Dispatcher.handle(ServerImpl.java:567)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Dispatcher.run(ServerImpl.java:533)
      at java.base/java.lang.Thread.run(Thread.java:1623)
      Suppressed: java.io.IOException: Broken pipe
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:62)
      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.write(SocketChannelImpl.java:542)
      at jdk.httpserver/sun.net.httpserver.Request$WriteStream.write(Request.java:390)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.writeChunk(ChunkedOutputStream.java:125)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.flush(ChunkedOutputStream.java:159)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.close(ChunkedOutputStream.java:134)
      at jdk.httpserver/sun.net.httpserver.PlaceholderOutputStream.close(ExchangeImpl.java:474)
      at CancelRequestTest$HTTPSlowHandler.handle(CancelRequestTest.java:651)
      ... 12 more
      Server wrote 12 bytes
      HTTPSlowHandler: unexpected exception: java.io.IOException: Broken pipe
      HTTPSlowHandler reply sent: /https1/x/same/interrupt/get
      WARNING: exception caught in HttpTestHandler::handle java.io.IOException: Broken pipe
      java.io.IOException: Broken pipe
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:62)
      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.write(SocketChannelImpl.java:542)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSendX(SSLStreams.java:296)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSend(SSLStreams.java:269)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.sendData(SSLStreams.java:377)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$OutputStream.write(SSLStreams.java:639)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.writeChunk(ChunkedOutputStream.java:125)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.flush(ChunkedOutputStream.java:159)
      at jdk.httpserver/sun.net.httpserver.PlaceholderOutputStream.flush(ExchangeImpl.java:469)
      at CancelRequestTest$HTTPSlowHandler.handle(CancelRequestTest.java:660)
      at HttpServerAdapters$HttpTestHandler.doHandle(HttpServerAdapters.java:382)
      at HttpServerAdapters$HttpTestHandler.lambda$toHttpHandler$0(HttpServerAdapters.java:375)
      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:868)
      at jdk.httpserver/com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:98)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:833)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$DefaultExecutor.execute(ServerImpl.java:204)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Dispatcher.handle(ServerImpl.java:567)
      at jdk.httpserver/sun.net.httpserver.ServerImpl$Dispatcher.run(ServerImpl.java:533)
      at java.base/java.lang.Thread.run(Thread.java:1623)
      Suppressed: java.io.IOException: Broken pipe
      at java.base/sun.nio.ch.SocketDispatcher.write0(Native Method)
      at java.base/sun.nio.ch.SocketDispatcher.write(SocketDispatcher.java:62)
      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.write(SocketChannelImpl.java:542)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSendX(SSLStreams.java:296)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$EngineWrapper.wrapAndSend(SSLStreams.java:269)
      at jdk.httpserver/sun.net.httpserver.SSLStreams.sendData(SSLStreams.java:377)
      at jdk.httpserver/sun.net.httpserver.SSLStreams$OutputStream.write(SSLStreams.java:639)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.writeChunk(ChunkedOutputStream.java:125)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.flush(ChunkedOutputStream.java:159)
      at jdk.httpserver/sun.net.httpserver.ChunkedOutputStream.close(ChunkedOutputStream.java:134)
      at jdk.httpserver/sun.net.httpserver.PlaceholderOutputStream.close(ExchangeImpl.java:474)
      at CancelRequestTest$HTTPSlowHandler.handle(CancelRequestTest.java:651)
      ... 12 more
      WARNING: tracker for HttpClientImpl(13) has outstanding operations:
      Pending HTTP Requests: 0
      Pending HTTP/1.1 operations: 0
      Pending HTTP/2 streams: 0
      Pending WebSocket operations: 0
      Pending TCP connections: 0
      Pending Subscribers: 1
      Total pending operations: 0
      Facade referenced: true
      Selector alive: true
      AssertionError: Found some subscribers for testGetSendAsync(https://localhost:46509/https1/x/same/interrupt/get)
      step [0] in HttpClientImpl(13) after 20 iterations and 494 ms, waited 200 ms
      test CancelRequestTest.testGetSendAsync("https://localhost:46509/https1/x/same/interrupt", true, true): failure

      <snip>

      =========================

      [1 s, 905 ms, 508531 ns] Created 4 servers and 13 clients
      Failed tests:
      testGetSendAsync[https://localhost:46509/https1/x/same/interrupt, true, true]: java.lang.AssertionError: WARNING: tracker for HttpClientImpl(13) has outstanding operations:
      Pending HTTP Requests: 0
      Pending HTTP/1.1 operations: 0
      Pending HTTP/2 streams: 0
      Pending WebSocket operations: 0
      Pending TCP connections: 0
      Pending Subscribers: 1
      Total pending operations: 0
      Facade referenced: true
      Selector alive: true
      java.lang.AssertionError: WARNING: tracker for HttpClientImpl(13) has outstanding operations:
      Pending HTTP Requests: 0
      Pending HTTP/1.1 operations: 0
      Pending HTTP/2 streams: 0
      Pending WebSocket operations: 0
      Pending TCP connections: 0
      Pending Subscribers: 1
      Total pending operations: 0
      Facade referenced: true
      Selector alive: true
      at ReferenceTracker.check(ReferenceTracker.java:243)
      at CancelRequestTest.testGetSendAsync(CancelRequestTest.java:384)
      at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
      at java.base/java.lang.reflect.Method.invoke(Method.java:578)
      at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:132)
      at org.testng.internal.TestInvoker.invokeMethod(TestInvoker.java:599)
      at org.testng.internal.TestInvoker.invokeTestMethod(TestInvoker.java:174)
      at org.testng.internal.MethodRunner.runInSequence(MethodRunner.java:46)
      at org.testng.internal.TestInvoker$MethodInvocationAgent.invoke(TestInvoker.java:822)
      at org.testng.internal.TestInvoker.invokeTestMethods(TestInvoker.java:147)
      at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:146)
      at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:128)
      at java.base/java.util.ArrayList.forEach(ArrayList.java:1511)
      at org.testng.TestRunner.privateRun(TestRunner.java:764)
      at org.testng.TestRunner.run(TestRunner.java:585)
      at org.testng.SuiteRunner.runTest(SuiteRunner.java:384)
      at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:378)
      at org.testng.SuiteRunner.privateRun(SuiteRunner.java:337)
      at org.testng.SuiteRunner.run(SuiteRunner.java:286)
      at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:53)
      at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:96)
      at org.testng.TestNG.runSuitesSequentially(TestNG.java:1218)
      at org.testng.TestNG.runSuitesLocally(TestNG.java:1140)
      at org.testng.TestNG.runSuites(TestNG.java:1069)
      at org.testng.TestNG.run(TestNG.java:1037)
      at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:93)
      at com.sun.javatest.regtest.agent.TestNGRunner.main(TestNGRunner.java:53)
      at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104)
      at java.base/java.lang.reflect.Method.invoke(Method.java:578)
      at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:125)
      at java.base/java.lang.Thread.run(Thread.java:1623)

      =========================

      config CancelRequestTest.printFailedTests(org.testng.TestRunner@dd3e330): success
      Waiting for HTTP operations to terminate...
      gracedelay: 500 ms, iterations: 50, wait/iteration: 10ms
      No outstanding HTTP operations remaining after 1/50 iterations and 10/500 ms, (wait/iteration 10 ms)
      PASSED: No outstanding operations or unreleased resources found in 13 clients in 26 ms
      Http1TestServer: stop
      Http1TestServer: stop
      Http2TestServerImpl: stop
      Http2TestServerImpl: stop
      config CancelRequestTest.teardown(): success

      ===============================================
      java/net/httpclient/CancelRequestTest.java
      Total tests run: 56, Passes: 5, Failures: 1, Skips: 50
      ===============================================

      ----------System.err:(4828/508046)----------

            dfuchs Daniel Fuchs
            dcubed Daniel Daugherty
            Votes:
            0 Vote for this issue
            Watchers:
            4 Start watching this issue

              Created:
              Updated:
              Resolved: