Testsuite: org.apache.catalina.core.TestAsyncContextImpl Tests run: 70, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 67.069 sec ------------- Standard Error ----------------- 07-Jan-2025 08:06:02.756 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorWithThreadSingleThenComplete] 07-Jan-2025 08:06:04.372 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-1"] 07-Jan-2025 08:06:04.426 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:04.427 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:04.798 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-1-39891"] 07-Jan-2025 08:06:05.597 SEVERE [http-nio-127.0.0.1-auto-1-exec-2] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:05.601 SEVERE [http-nio-127.0.0.1-auto-1-exec-2] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:05.658 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-1-39891"] 07-Jan-2025 08:06:05.665 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:05.711 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-1-39891"] 07-Jan-2025 08:06:05.729 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-1-39891"] 07-Jan-2025 08:06:05.748 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorSingleThenComplete] 07-Jan-2025 08:06:05.763 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-2"] 07-Jan-2025 08:06:05.764 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:05.764 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:05.776 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-2-46227"] 07-Jan-2025 08:06:06.309 SEVERE [http-nio-127.0.0.1-auto-2-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:06.315 SEVERE [http-nio-127.0.0.1-auto-2-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:06.324 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-2-46227"] 07-Jan-2025 08:06:06.332 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:06.345 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-2-46227"] 07-Jan-2025 08:06:06.369 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-2-46227"] 07-Jan-2025 08:06:06.377 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutListenerCompleteNonAsyncDispatch] 07-Jan-2025 08:06:06.387 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-3"] 07-Jan-2025 08:06:06.394 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:06.394 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:06.417 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-3-34563"] 07-Jan-2025 08:06:07.439 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-3-34563"] 07-Jan-2025 08:06:07.441 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:07.449 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-3-34563"] 07-Jan-2025 08:06:07.460 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-3-34563"] 07-Jan-2025 08:06:07.464 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutListenerNoCompleteAsyncDispatch] 07-Jan-2025 08:06:07.467 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-4"] 07-Jan-2025 08:06:07.468 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:07.469 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:07.479 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-4-44751"] 07-Jan-2025 08:06:11.489 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-4-44751"] 07-Jan-2025 08:06:11.490 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:11.494 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-4-44751"] 07-Jan-2025 08:06:11.497 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-4-44751"] 07-Jan-2025 08:06:11.499 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testCanceledPostNoChunking] 07-Jan-2025 08:06:11.504 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-5"] 07-Jan-2025 08:06:11.507 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:11.507 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:11.517 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-5-39493"] org.apache.catalina.connector.ClientAbortException: java.io.EOFException at org.apache.catalina.connector.InputBuffer.realReadBytes(InputBuffer.java:312) at org.apache.catalina.connector.InputBuffer.checkByteBufferEof(InputBuffer.java:615) at org.apache.catalina.connector.InputBuffer.readByte(InputBuffer.java:348) at org.apache.catalina.connector.CoyoteInputStream.read(CoyoteInputStream.java:85) at org.apache.catalina.core.TestAsyncContextImpl$PostServletThread.run(TestAsyncContextImpl.java:3205) Caused by: java.io.EOFException at org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.fillReadBuffer(NioEndpoint.java:1322) at org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.read(NioEndpoint.java:1233) at org.apache.coyote.http11.Http11InputBuffer.fill(Http11InputBuffer.java:796) at org.apache.coyote.http11.Http11InputBuffer.access$400(Http11InputBuffer.java:41) at org.apache.coyote.http11.Http11InputBuffer$SocketInputBuffer.doRead(Http11InputBuffer.java:1202) at org.apache.coyote.http11.filters.IdentityInputFilter.doRead(IdentityInputFilter.java:96) at org.apache.coyote.http11.Http11InputBuffer.doRead(Http11InputBuffer.java:244) at org.apache.coyote.Request.doRead(Request.java:626) at org.apache.catalina.connector.InputBuffer.realReadBytes(InputBuffer.java:303) ... 4 more 07-Jan-2025 08:06:11.530 SEVERE [http-nio-127.0.0.1-auto-5-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Error reading request, ignored java.lang.IllegalStateException: Calling [asyncPostProcess()] is not valid for a request with Async state [MUST_ERROR] at org.apache.coyote.AsyncStateMachine.asyncPostProcess(AsyncStateMachine.java:302) at org.apache.coyote.AbstractProcessor.asyncPostProcess(AbstractProcessor.java:196) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:83) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:11.530 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-5-39493"] 07-Jan-2025 08:06:11.531 INFO [http-nio-127.0.0.1-auto-5-exec-1] org.apache.catalina.connector.CoyoteAdapter.checkRecycled Encountered a non-recycled request and recycled it forcedly. org.apache.catalina.connector.CoyoteAdapter$RecycleRequiredException at org.apache.catalina.connector.CoyoteAdapter.checkRecycled(CoyoteAdapter.java:524) at org.apache.coyote.http11.Http11Processor.recycle(Http11Processor.java:1444) at org.apache.coyote.AbstractProtocol$ConnectionHandler.release(AbstractProtocol.java:1140) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:1101) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:11.532 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:13.554 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-5-39493"] 07-Jan-2025 08:06:13.563 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-5-39493"] 07-Jan-2025 08:06:13.566 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorWithThreadMultiple] 07-Jan-2025 08:06:13.569 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-6"] 07-Jan-2025 08:06:13.569 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:13.570 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:13.575 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-6-39885"] 07-Jan-2025 08:06:14.095 SEVERE [http-nio-127.0.0.1-auto-6-exec-5] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:14.098 SEVERE [http-nio-127.0.0.1-auto-6-exec-5] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:14.104 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-6-39885"] 07-Jan-2025 08:06:14.106 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:14.113 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-6-39885"] 07-Jan-2025 08:06:14.118 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-6-39885"] 07-Jan-2025 08:06:14.120 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorMultiple] 07-Jan-2025 08:06:14.123 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-7"] 07-Jan-2025 08:06:14.128 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:14.128 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:14.134 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-7-41949"] 07-Jan-2025 08:06:14.644 SEVERE [http-nio-127.0.0.1-auto-7-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:14.649 SEVERE [http-nio-127.0.0.1-auto-7-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:14.706 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-7-41949"] 07-Jan-2025 08:06:14.710 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:14.715 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-7-41949"] 07-Jan-2025 08:06:14.720 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-7-41949"] 07-Jan-2025 08:06:14.724 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchMultiple] 07-Jan-2025 08:06:14.733 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-8"] 07-Jan-2025 08:06:14.734 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:14.734 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:14.744 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-8-39373"] 07-Jan-2025 08:06:14.763 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-8-39373"] 07-Jan-2025 08:06:14.766 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:14.772 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-8-39373"] 07-Jan-2025 08:06:14.776 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-8-39373"] 07-Jan-2025 08:06:14.778 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchFromOtherContainerThread] 07-Jan-2025 08:06:14.783 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-9"] 07-Jan-2025 08:06:14.783 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:14.784 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:14.793 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-9-43553"] 07-Jan-2025 08:06:14.909 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-9-43553"] 07-Jan-2025 08:06:14.915 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:14.924 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-9-43553"] 07-Jan-2025 08:06:14.935 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-9-43553"] 07-Jan-2025 08:06:14.938 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug49528] 07-Jan-2025 08:06:14.942 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-10"] 07-Jan-2025 08:06:14.943 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:14.943 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:14.950 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-10-39751"] 07-Jan-2025 08:06:15.991 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-10-39751"] 07-Jan-2025 08:06:15.993 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:15.996 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-10-39751"] 07-Jan-2025 08:06:15.999 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-10-39751"] 07-Jan-2025 08:06:16.003 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug49567] 07-Jan-2025 08:06:16.007 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-11"] 07-Jan-2025 08:06:16.009 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:16.010 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:16.018 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-11-45485"] 07-Jan-2025 08:06:17.037 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-11-45485"] 07-Jan-2025 08:06:17.038 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:17.040 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-11-45485"] 07-Jan-2025 08:06:17.043 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-11-45485"] 07-Jan-2025 08:06:17.044 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug50352] 07-Jan-2025 08:06:17.046 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-12"] 07-Jan-2025 08:06:17.046 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:17.047 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:17.051 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-12-35071"] 07-Jan-2025 08:06:20.061 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-12-35071"] 07-Jan-2025 08:06:20.067 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:20.084 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-12-35071"] 07-Jan-2025 08:06:20.097 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-12-35071"] 07-Jan-2025 08:06:20.107 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug50753] 07-Jan-2025 08:06:20.111 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-13"] 07-Jan-2025 08:06:20.112 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:20.114 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:20.133 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-13-39887"] 07-Jan-2025 08:06:25.271 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-13-39887"] 07-Jan-2025 08:06:25.276 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:25.279 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-13-39887"] 07-Jan-2025 08:06:25.300 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-13-39887"] 07-Jan-2025 08:06:25.311 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug53337] 07-Jan-2025 08:06:25.324 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-14"] 07-Jan-2025 08:06:25.327 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:25.327 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:25.367 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-14-34961"] 07-Jan-2025 08:06:25.419 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-14-34961"] 07-Jan-2025 08:06:25.422 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:25.427 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-14-34961"] 07-Jan-2025 08:06:25.440 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-14-34961"] 07-Jan-2025 08:06:25.450 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug53843] 07-Jan-2025 08:06:25.462 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-15"] 07-Jan-2025 08:06:25.463 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:25.463 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:25.498 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-15-39683"] 07-Jan-2025 08:06:28.547 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-15-39683"] 07-Jan-2025 08:06:28.551 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:28.559 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-15-39683"] 07-Jan-2025 08:06:28.569 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-15-39683"] 07-Jan-2025 08:06:28.570 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug54178] 07-Jan-2025 08:06:28.581 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-16"] 07-Jan-2025 08:06:28.582 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:28.582 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:28.598 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-16-42747"] 07-Jan-2025 08:06:28.639 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-16-42747"] 07-Jan-2025 08:06:28.643 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:28.649 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-16-42747"] 07-Jan-2025 08:06:28.653 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-16-42747"] 07-Jan-2025 08:06:28.658 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug61185] 07-Jan-2025 08:06:28.661 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-17"] 07-Jan-2025 08:06:28.665 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:28.665 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:28.674 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-17-35051"] 07-Jan-2025 08:06:28.706 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-17-35051"] 07-Jan-2025 08:06:28.712 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:28.721 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-17-35051"] 07-Jan-2025 08:06:28.735 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-17-35051"] 07-Jan-2025 08:06:28.737 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug63816] 07-Jan-2025 08:06:28.747 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-18"] 07-Jan-2025 08:06:28.755 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:28.755 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:28.769 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-18-42257"] 07-Jan-2025 08:06:28.787 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-18-42257"] 07-Jan-2025 08:06:28.791 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:28.793 WARNING [main] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesThreads The web application [ROOT] appears to have started a thread named [Thread-10] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread: 07-Jan-2025 08:06:28.794 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-18-42257"] 07-Jan-2025 08:06:28.807 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-18-42257"] 07-Jan-2025 08:06:28.809 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testEmptyDispatch] 07-Jan-2025 08:06:28.812 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-19"] 07-Jan-2025 08:06:28.813 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:28.813 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:28.825 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-19-44957"] 07-Jan-2025 08:06:28.900 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-19-44957"] 07-Jan-2025 08:06:28.910 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:28.922 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-19-44957"] 07-Jan-2025 08:06:28.934 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-19-44957"] 07-Jan-2025 08:06:28.936 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchWithCustomRequestResponse] 07-Jan-2025 08:06:28.941 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-20"] 07-Jan-2025 08:06:28.945 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:28.945 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:28.968 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-20-44353"] 07-Jan-2025 08:06:29.011 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-20-44353"] 07-Jan-2025 08:06:29.016 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:29.024 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-20-44353"] 07-Jan-2025 08:06:29.029 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-20-44353"] 07-Jan-2025 08:06:29.031 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutListenerNoCompleteNoDispatch] 07-Jan-2025 08:06:29.045 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-21"] 07-Jan-2025 08:06:29.046 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:29.046 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:29.062 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-21-45981"] 07-Jan-2025 08:06:30.092 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-21-45981"] 07-Jan-2025 08:06:30.100 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:30.112 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-21-45981"] 07-Jan-2025 08:06:30.131 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-21-45981"] 07-Jan-2025 08:06:30.133 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutErrorDispatchNonAsync] 07-Jan-2025 08:06:30.141 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-22"] 07-Jan-2025 08:06:30.147 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:30.148 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:30.189 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-22-44153"] 07-Jan-2025 08:06:31.327 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-22-44153"] 07-Jan-2025 08:06:31.328 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:31.356 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-22-44153"] 07-Jan-2025 08:06:31.371 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-22-44153"] 07-Jan-2025 08:06:31.382 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testListeners] 07-Jan-2025 08:06:31.398 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-23"] 07-Jan-2025 08:06:31.399 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:31.399 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:31.424 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-23-38109"] 07-Jan-2025 08:06:32.437 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-23-38109"] 07-Jan-2025 08:06:32.437 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:32.442 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-23-38109"] 07-Jan-2025 08:06:32.454 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-23-38109"] 07-Jan-2025 08:06:32.461 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutDispatchCustomErrorPage] 07-Jan-2025 08:06:32.464 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-24"] 07-Jan-2025 08:06:32.464 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:32.464 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:32.488 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-24-33375"] 07-Jan-2025 08:06:38.529 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-24-33375"] 07-Jan-2025 08:06:38.531 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:38.534 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-24-33375"] 07-Jan-2025 08:06:38.543 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-24-33375"] 07-Jan-2025 08:06:38.548 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncContextListenerClearing] 07-Jan-2025 08:06:38.553 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-25"] 07-Jan-2025 08:06:38.553 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:38.553 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:38.567 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-25-35951"] 07-Jan-2025 08:06:38.582 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-25-35951"] 07-Jan-2025 08:06:38.585 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:38.588 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-25-35951"] 07-Jan-2025 08:06:38.590 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-25-35951"] 07-Jan-2025 08:06:38.593 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncStartNoComplete] 07-Jan-2025 08:06:38.597 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-26"] 07-Jan-2025 08:06:38.600 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:38.600 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:38.610 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-26-44843"] 07-Jan-2025 08:06:42.639 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-26-44843"] 07-Jan-2025 08:06:42.640 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:42.653 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-26-44843"] 07-Jan-2025 08:06:42.666 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-26-44843"] 07-Jan-2025 08:06:42.669 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testGetResponseISE] 07-Jan-2025 08:06:42.674 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-27"] 07-Jan-2025 08:06:42.675 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:42.675 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:42.687 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-27-45459"] 07-Jan-2025 08:06:42.714 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-27-45459"] 07-Jan-2025 08:06:42.714 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:42.722 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-27-45459"] 07-Jan-2025 08:06:42.729 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-27-45459"] 07-Jan-2025 08:06:42.730 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug51197a] 07-Jan-2025 08:06:42.734 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-28"] 07-Jan-2025 08:06:42.736 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:42.737 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:42.748 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-28-32891"] 07-Jan-2025 08:06:44.299 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-28-32891"] 07-Jan-2025 08:06:44.301 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:44.307 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-28-32891"] 07-Jan-2025 08:06:44.311 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-28-32891"] 07-Jan-2025 08:06:44.313 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug51197b] 07-Jan-2025 08:06:44.315 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-29"] 07-Jan-2025 08:06:44.316 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:44.317 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:44.330 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-29-34249"] 07-Jan-2025 08:06:45.845 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-29-34249"] 07-Jan-2025 08:06:45.849 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:45.854 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-29-34249"] 07-Jan-2025 08:06:45.864 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-29-34249"] 07-Jan-2025 08:06:45.865 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug51197c] 07-Jan-2025 08:06:45.879 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-30"] 07-Jan-2025 08:06:45.880 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:45.882 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:45.900 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-30-46469"] 07-Jan-2025 08:06:47.436 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-30-46469"] 07-Jan-2025 08:06:47.438 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:47.446 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-30-46469"] 07-Jan-2025 08:06:47.465 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-30-46469"] 07-Jan-2025 08:06:47.466 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug51197d] 07-Jan-2025 08:06:47.475 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-31"] 07-Jan-2025 08:06:47.475 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:47.475 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:47.496 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-31-36553"] 07-Jan-2025 08:06:49.038 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-31-36553"] 07-Jan-2025 08:06:49.039 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:49.051 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-31-36553"] 07-Jan-2025 08:06:49.064 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-31-36553"] 07-Jan-2025 08:06:49.066 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug59219a] 07-Jan-2025 08:06:49.068 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-32"] 07-Jan-2025 08:06:49.068 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:49.068 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:49.088 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-32-35381"] 07-Jan-2025 08:06:49.105 SEVERE [http-nio-127.0.0.1-auto-32-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [async] in context with path [] threw exception [null] with root cause javax.servlet.ServletException at org.apache.catalina.core.TestAsyncContextImpl$Bug59219Servlet.doGet(TestAsyncContextImpl.java:1963) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:168) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:346) at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:396) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:49.112 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-32-35381"] 07-Jan-2025 08:06:49.117 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:49.119 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-32-35381"] 07-Jan-2025 08:06:49.131 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-32-35381"] 07-Jan-2025 08:06:49.132 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug59219b] 07-Jan-2025 08:06:49.141 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-33"] 07-Jan-2025 08:06:49.141 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:49.142 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:49.164 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-33-45487"] 07-Jan-2025 08:06:49.191 SEVERE [http-nio-127.0.0.1-auto-33-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [async] threw exception javax.servlet.ServletException at org.apache.catalina.core.TestAsyncContextImpl$Bug59219Servlet.doGet(TestAsyncContextImpl.java:1963) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:49.194 SEVERE [http-nio-127.0.0.1-auto-33-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [async] in context with path [] threw exception [null] with root cause javax.servlet.ServletException at org.apache.catalina.core.TestAsyncContextImpl$Bug59219Servlet.doGet(TestAsyncContextImpl.java:1963) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:49.197 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-33-45487"] 07-Jan-2025 08:06:49.198 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:49.207 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-33-45487"] 07-Jan-2025 08:06:49.215 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-33-45487"] 07-Jan-2025 08:06:49.216 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testCanceledPostChunked] 07-Jan-2025 08:06:49.221 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-34"] 07-Jan-2025 08:06:49.222 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:49.222 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:49.233 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-34-45325"] org.apache.catalina.connector.ClientAbortException: java.io.EOFException at org.apache.catalina.connector.InputBuffer.realReadBytes(InputBuffer.java:312) at org.apache.catalina.connector.InputBuffer.checkByteBufferEof(InputBuffer.java:615) at org.apache.catalina.connector.InputBuffer.readByte(InputBuffer.java:348) at org.apache.catalina.connector.CoyoteInputStream.read(CoyoteInputStream.java:85) at org.apache.catalina.core.TestAsyncContextImpl$PostServletThread.run(TestAsyncContextImpl.java:3205) Caused by: java.io.EOFException at org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.fillReadBuffer(NioEndpoint.java:1322) at org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.read(NioEndpoint.java:1233) at org.apache.coyote.http11.Http11InputBuffer.fill(Http11InputBuffer.java:796) at org.apache.coyote.http11.Http11InputBuffer.access$400(Http11InputBuffer.java:41) at org.apache.coyote.http11.Http11InputBuffer$SocketInputBuffer.doRead(Http11InputBuffer.java:1202) at org.apache.coyote.http11.filters.ChunkedInputFilter.readBytes(ChunkedInputFilter.java:265) at org.apache.coyote.http11.filters.ChunkedInputFilter.fill(ChunkedInputFilter.java:306) at org.apache.coyote.http11.filters.ChunkedInputFilter.parseChunkHeader(ChunkedInputFilter.java:336) at org.apache.coyote.http11.filters.ChunkedInputFilter.doRead(ChunkedInputFilter.java:135) at org.apache.coyote.http11.Http11InputBuffer.doRead(Http11InputBuffer.java:244) at org.apache.coyote.Request.doRead(Request.java:626) at org.apache.catalina.connector.InputBuffer.realReadBytes(InputBuffer.java:303) ... 4 more 07-Jan-2025 08:06:49.271 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-34-45325"] 07-Jan-2025 08:06:49.271 SEVERE [http-nio-127.0.0.1-auto-34-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Error reading request, ignored java.lang.IllegalStateException: Calling [asyncPostProcess()] is not valid for a request with Async state [MUST_ERROR] at org.apache.coyote.AsyncStateMachine.asyncPostProcess(AsyncStateMachine.java:302) at org.apache.coyote.AbstractProcessor.asyncPostProcess(AbstractProcessor.java:196) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:83) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:49.272 INFO [http-nio-127.0.0.1-auto-34-exec-1] org.apache.catalina.connector.CoyoteAdapter.checkRecycled Encountered a non-recycled request and recycled it forcedly. org.apache.catalina.connector.CoyoteAdapter$RecycleRequiredException at org.apache.catalina.connector.CoyoteAdapter.checkRecycled(CoyoteAdapter.java:524) at org.apache.coyote.http11.Http11Processor.recycle(Http11Processor.java:1444) at org.apache.coyote.AbstractProtocol$ConnectionHandler.release(AbstractProtocol.java:1140) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:1101) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:49.274 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:51.302 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-34-45325"] 07-Jan-2025 08:06:51.311 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-34-45325"] 07-Jan-2025 08:06:51.312 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncDispatchUrlWithSpaces] 07-Jan-2025 08:06:51.315 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-35"] 07-Jan-2025 08:06:51.316 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:51.316 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:51.327 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-35-40471"] 07-Jan-2025 08:06:51.353 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-35-40471"] 07-Jan-2025 08:06:51.354 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:51.357 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-35-40471"] 07-Jan-2025 08:06:51.362 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-35-40471"] 07-Jan-2025 08:06:51.363 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncStartWithComplete] 07-Jan-2025 08:06:51.373 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-36"] 07-Jan-2025 08:06:51.374 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:51.374 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:51.387 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-36-34069"] 07-Jan-2025 08:06:51.425 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-36-34069"] 07-Jan-2025 08:06:51.427 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:51.434 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-36-34069"] 07-Jan-2025 08:06:51.440 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-36-34069"] 07-Jan-2025 08:06:51.442 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchWithThreadDouble] 07-Jan-2025 08:06:51.449 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-37"] 07-Jan-2025 08:06:51.455 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:51.455 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:51.473 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-37-41741"] 07-Jan-2025 08:06:51.520 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-37-41741"] 07-Jan-2025 08:06:51.526 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:51.530 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-37-41741"] 07-Jan-2025 08:06:51.538 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-37-41741"] 07-Jan-2025 08:06:51.540 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testEmptyDispatchWithCustomRequestResponse] 07-Jan-2025 08:06:51.545 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-38"] 07-Jan-2025 08:06:51.545 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:51.546 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:51.552 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-38-46545"] 07-Jan-2025 08:06:51.617 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-38-46545"] 07-Jan-2025 08:06:51.619 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:51.624 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-38-46545"] 07-Jan-2025 08:06:51.632 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-38-46545"] 07-Jan-2025 08:06:51.634 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchWithThreadSingle] 07-Jan-2025 08:06:51.646 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-39"] 07-Jan-2025 08:06:51.652 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:51.652 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:51.666 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-39-38939"] 07-Jan-2025 08:06:51.704 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-39-38939"] 07-Jan-2025 08:06:51.713 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:51.715 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-39-38939"] 07-Jan-2025 08:06:51.722 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-39-38939"] 07-Jan-2025 08:06:51.724 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutListenerCompleteNoDispatch] 07-Jan-2025 08:06:51.728 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-40"] 07-Jan-2025 08:06:51.729 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:51.729 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:51.741 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-40-34125"] 07-Jan-2025 08:06:52.778 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-40-34125"] 07-Jan-2025 08:06:52.778 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:52.782 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-40-34125"] 07-Jan-2025 08:06:52.789 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-40-34125"] 07-Jan-2025 08:06:52.791 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutErrorDispatchAsyncComplete] 07-Jan-2025 08:06:52.792 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-41"] 07-Jan-2025 08:06:52.792 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:52.792 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:52.797 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-41-44679"] 07-Jan-2025 08:06:53.814 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-41-44679"] 07-Jan-2025 08:06:53.819 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:53.824 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-41-44679"] 07-Jan-2025 08:06:53.849 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-41-44679"] 07-Jan-2025 08:06:53.851 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorWithThreadDouble] 07-Jan-2025 08:06:53.857 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-42"] 07-Jan-2025 08:06:53.857 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:53.857 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:53.873 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-42-34215"] 07-Jan-2025 08:06:54.400 SEVERE [http-nio-127.0.0.1-auto-42-exec-3] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:54.402 SEVERE [http-nio-127.0.0.1-auto-42-exec-3] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:54.407 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-42-34215"] 07-Jan-2025 08:06:54.419 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:54.422 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-42-34215"] 07-Jan-2025 08:06:54.430 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-42-34215"] 07-Jan-2025 08:06:54.432 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncIoEnd00] 07-Jan-2025 08:06:54.442 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-43"] 07-Jan-2025 08:06:54.443 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:54.443 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:54.448 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-43-40465"] 07-Jan-2025 08:06:54.464 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Processing socket [org.apache.tomcat.util.net.NioChannel@13123467:java.nio.channels.SocketChannel[connected local=/127.0.0.1:40465 remote=/127.0.0.1:46394]] with status [OPEN_READ] 07-Jan-2025 08:06:54.464 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@13123467:java.nio.channels.SocketChannel[connected local=/127.0.0.1:40465 remote=/127.0.0.1:46394]] 07-Jan-2025 08:06:54.464 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Popped processor [null] from cache 07-Jan-2025 08:06:54.465 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.register Register [org.apache.coyote.http11.Http11Processor@1dd5d875] as [Tomcat:type=RequestProcessor,worker="http-nio-127.0.0.1-auto-43-40465",name=HttpRequest1] 07-Jan-2025 08:06:54.465 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Created new processor [org.apache.coyote.http11.Http11Processor@1dd5d875] 07-Jan-2025 08:06:54.465 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [0] 07-Jan-2025 08:06:54.465 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Received [GET /asyncIoEndServlet HTTP/1.1 Cache-Control: no-cache Pragma: no-cache User-Agent: Java/23.0.1 Host: localhost:40465 Accept: */* Connection: keep-alive ] 07-Jan-2025 08:06:54.466 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [DISPATCHED] to [STARTING] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@2494eb6d:org.apache.tomcat.util.net.NioChannel@13123467:java.nio.channels.SocketChannel[connected local=/127.0.0.1:40465 remote=/127.0.0.1:46394]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTING] to [STARTED] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@2494eb6d:org.apache.tomcat.util.net.NioChannel@13123467:java.nio.channels.SocketChannel[connected local=/127.0.0.1:40465 remote=/127.0.0.1:46394]], State after async post processing: [LONG] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProcessorLight.process Processing dispatch type: [NON_BLOCKING_WRITE] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTED] to [READ_WRITE_OP] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [READ_WRITE_OP] to [DISPATCHING] 07-Jan-2025 08:06:54.468 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [DISPATCHING] to [DISPATCHED] 07-Jan-2025 08:06:54.469 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@2494eb6d:org.apache.tomcat.util.net.NioChannel@13123467:java.nio.channels.SocketChannel[connected local=/127.0.0.1:40465 remote=/127.0.0.1:46394]], Status in: [OPEN_WRITE], State out: [OPEN] 07-Jan-2025 08:06:54.469 FINER [http-nio-127.0.0.1-auto-43-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [163] 07-Jan-2025 08:06:54.470 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-43-40465"] 07-Jan-2025 08:06:54.472 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:54.475 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-43-40465"] 07-Jan-2025 08:06:54.477 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-43-40465"] 07-Jan-2025 08:06:54.478 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncIoEnd01] 07-Jan-2025 08:06:54.485 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-44"] 07-Jan-2025 08:06:54.485 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:54.486 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:54.491 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-44-45863"] 07-Jan-2025 08:06:54.502 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Processing socket [org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]] with status [OPEN_READ] 07-Jan-2025 08:06:54.502 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]] 07-Jan-2025 08:06:54.505 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Popped processor [null] from cache 07-Jan-2025 08:06:54.505 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.register Register [org.apache.coyote.http11.Http11Processor@5920a3ac] as [Tomcat:type=RequestProcessor,worker="http-nio-127.0.0.1-auto-44-45863",name=HttpRequest1] 07-Jan-2025 08:06:54.505 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Created new processor [org.apache.coyote.http11.Http11Processor@5920a3ac] 07-Jan-2025 08:06:54.505 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [0] 07-Jan-2025 08:06:54.505 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Received [GET /asyncIoEndServlet HTTP/1.1 Cache-Control: no-cache Pragma: no-cache User-Agent: Java/23.0.1 Host: localhost:45863 Accept: */* Connection: keep-alive ] 07-Jan-2025 08:06:54.506 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [DISPATCHED] to [STARTING] 07-Jan-2025 08:06:54.506 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5d1f2c50:org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.506 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTING] to [STARTED] 07-Jan-2025 08:06:54.506 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5d1f2c50:org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]], State after async post processing: [LONG] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessorLight.process Processing dispatch type: [NON_BLOCKING_WRITE] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTED] to [READ_WRITE_OP] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [READ_WRITE_OP] to [COMPLETING] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5d1f2c50:org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]], Status in: [OPEN_WRITE], State out: [LONG] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5d1f2c50:org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [COMPLETING] to [DISPATCHED] 07-Jan-2025 08:06:54.507 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5d1f2c50:org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]], State after async post processing: [ASYNC_END] 07-Jan-2025 08:06:54.508 FINER [http-nio-127.0.0.1-auto-44-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5d1f2c50:org.apache.tomcat.util.net.NioChannel@57e74720:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45863 remote=/127.0.0.1:59614]], Status in: [OPEN_READ], State out: [OPEN] 07-Jan-2025 08:06:54.511 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-44-45863"] 07-Jan-2025 08:06:54.514 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:54.516 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-44-45863"] 07-Jan-2025 08:06:54.526 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-44-45863"] 07-Jan-2025 08:06:54.528 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncIoEnd02] 07-Jan-2025 08:06:54.532 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-45"] 07-Jan-2025 08:06:54.532 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:54.532 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:54.546 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-45-45171"] 07-Jan-2025 08:06:54.568 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Processing socket [org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]] with status [OPEN_READ] 07-Jan-2025 08:06:54.569 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]] 07-Jan-2025 08:06:54.569 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Popped processor [null] from cache 07-Jan-2025 08:06:54.569 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.register Register [org.apache.coyote.http11.Http11Processor@5b9e3b8d] as [Tomcat:type=RequestProcessor,worker="http-nio-127.0.0.1-auto-45-45171",name=HttpRequest1] 07-Jan-2025 08:06:54.569 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Created new processor [org.apache.coyote.http11.Http11Processor@5b9e3b8d] 07-Jan-2025 08:06:54.569 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [0] 07-Jan-2025 08:06:54.569 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Received [GET /asyncIoEndServlet HTTP/1.1 Cache-Control: no-cache Pragma: no-cache User-Agent: Java/23.0.1 Host: localhost:45171 Accept: */* Connection: keep-alive ] 07-Jan-2025 08:06:54.570 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [DISPATCHED] to [STARTING] 07-Jan-2025 08:06:54.573 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.574 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTING] to [STARTED] 07-Jan-2025 08:06:54.574 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], State after async post processing: [LONG] 07-Jan-2025 08:06:54.574 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProcessorLight.process Processing dispatch type: [NON_BLOCKING_WRITE] 07-Jan-2025 08:06:54.574 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTED] to [READ_WRITE_OP] 07-Jan-2025 08:06:54.582 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], Status in: [OPEN_WRITE], State out: [LONG] 07-Jan-2025 08:06:54.582 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.582 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [READ_WRITE_OP] to [STARTED] 07-Jan-2025 08:06:54.582 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], State after async post processing: [LONG] 07-Jan-2025 08:06:54.582 FINER [http-nio-127.0.0.1-auto-45-exec-1] org.apache.coyote.AbstractProtocol.addWaitingProcessor Adding processor [org.apache.coyote.http11.Http11Processor@5b9e3b8d] to waiting processors 07-Jan-2025 08:06:54.582 FINER [Thread-17] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTED] to [DISPATCHING] 07-Jan-2025 08:06:54.583 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Processing socket [org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]] with status [OPEN_READ] 07-Jan-2025 08:06:54.583 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Found processor [org.apache.coyote.http11.Http11Processor@5b9e3b8d] for socket [org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]] 07-Jan-2025 08:06:54.583 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AbstractProtocol.removeWaitingProcessor abstractProtocol.waitingProcessor.remove 07-Jan-2025 08:06:54.583 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [DISPATCHING] to [DISPATCHED] 07-Jan-2025 08:06:54.584 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], Status in: [OPEN_READ], State out: [OPEN] 07-Jan-2025 08:06:54.584 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [163] 07-Jan-2025 08:06:54.584 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.http11.Http11InputBuffer.fill Received [] 07-Jan-2025 08:06:54.584 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@5fa1a426:org.apache.tomcat.util.net.NioChannel@5559cf56:java.nio.channels.SocketChannel[connected local=/127.0.0.1:45171 remote=/127.0.0.1:55974]], Status in: [OPEN_READ], State out: [OPEN] 07-Jan-2025 08:06:54.584 FINER [http-nio-127.0.0.1-auto-45-exec-2] org.apache.coyote.AbstractProtocol$ConnectionHandler.release Pushed Processor [org.apache.coyote.http11.Http11Processor@5b9e3b8d] 07-Jan-2025 08:06:54.589 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-45-45171"] 07-Jan-2025 08:06:54.599 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:54.602 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-45-45171"] 07-Jan-2025 08:06:54.618 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-45-45171"] 07-Jan-2025 08:06:54.620 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncIoEnd03] 07-Jan-2025 08:06:54.626 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-46"] 07-Jan-2025 08:06:54.627 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:54.632 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:54.650 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-46-44161"] 07-Jan-2025 08:06:54.668 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Processing socket [org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]] with status [OPEN_READ] 07-Jan-2025 08:06:54.669 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]] 07-Jan-2025 08:06:54.669 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Popped processor [null] from cache 07-Jan-2025 08:06:54.669 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.register Register [org.apache.coyote.http11.Http11Processor@4a463a34] as [Tomcat:type=RequestProcessor,worker="http-nio-127.0.0.1-auto-46-44161",name=HttpRequest1] 07-Jan-2025 08:06:54.669 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Created new processor [org.apache.coyote.http11.Http11Processor@4a463a34] 07-Jan-2025 08:06:54.669 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [0] 07-Jan-2025 08:06:54.669 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Received [GET /asyncIoEndServlet HTTP/1.1 Cache-Control: no-cache Pragma: no-cache User-Agent: Java/23.0.1 Host: localhost:44161 Accept: */* Connection: keep-alive ] 07-Jan-2025 08:06:54.670 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [DISPATCHED] to [STARTING] 07-Jan-2025 08:06:54.676 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.676 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTING] to [STARTED] 07-Jan-2025 08:06:54.677 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], State after async post processing: [LONG] 07-Jan-2025 08:06:54.677 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Processing dispatch type: [NON_BLOCKING_WRITE] 07-Jan-2025 08:06:54.677 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [STARTED] to [READ_WRITE_OP] 07-Jan-2025 08:06:54.678 FINER [Thread-18] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [READ_WRITE_OP] to [COMPLETE_PENDING] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_WRITE], State out: [LONG] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [COMPLETE_PENDING] to [COMPLETING] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], State after async post processing: [ASYNC_END] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_READ], State out: [LONG] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AsyncStateMachine.updateState Changing async state from [COMPLETING] to [DISPATCHED] 07-Jan-2025 08:06:54.679 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], State after async post processing: [ASYNC_END] 07-Jan-2025 08:06:54.680 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessor.dispatch Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_READ], State out: [OPEN] 07-Jan-2025 08:06:54.680 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Before fill(): parsingHeader: [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position(): [0], byteBuffer.limit(): [0], end: [163] 07-Jan-2025 08:06:54.680 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.http11.Http11InputBuffer.fill Received [] 07-Jan-2025 08:06:54.680 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProcessorLight.process Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4e79b7a4:org.apache.tomcat.util.net.NioChannel@4481dcd4:java.nio.channels.SocketChannel[connected local=/127.0.0.1:44161 remote=/127.0.0.1:54746]], Status in: [OPEN_READ], State out: [OPEN] 07-Jan-2025 08:06:54.681 FINER [http-nio-127.0.0.1-auto-46-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.release Pushed Processor [org.apache.coyote.http11.Http11Processor@4a463a34] 07-Jan-2025 08:06:54.681 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-46-44161"] 07-Jan-2025 08:06:54.682 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:54.685 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-46-44161"] 07-Jan-2025 08:06:54.690 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-46-44161"] 07-Jan-2025 08:06:54.692 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testErrorHandling] 07-Jan-2025 08:06:54.696 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-47"] 07-Jan-2025 08:06:54.696 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:54.697 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:54.711 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-47-44791"] 07-Jan-2025 08:06:55.234 SEVERE [http-nio-127.0.0.1-auto-47-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [error] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:168) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:346) at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:396) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:63) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:56.740 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-47-44791"] 07-Jan-2025 08:06:56.742 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:56.748 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-47-44791"] 07-Jan-2025 08:06:56.758 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-47-44791"] 07-Jan-2025 08:06:56.760 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchDouble] 07-Jan-2025 08:06:56.763 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-48"] 07-Jan-2025 08:06:56.763 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:56.763 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:56.768 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-48-33623"] 07-Jan-2025 08:06:56.792 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-48-33623"] 07-Jan-2025 08:06:56.796 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:56.805 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-48-33623"] 07-Jan-2025 08:06:56.819 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-48-33623"] 07-Jan-2025 08:06:56.824 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorDouble] 07-Jan-2025 08:06:56.829 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-49"] 07-Jan-2025 08:06:56.831 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:56.831 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:56.849 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-49-40445"] 07-Jan-2025 08:06:57.382 SEVERE [http-nio-127.0.0.1-auto-49-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:57.383 SEVERE [http-nio-127.0.0.1-auto-49-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:57.388 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-49-40445"] 07-Jan-2025 08:06:57.393 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:57.398 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-49-40445"] 07-Jan-2025 08:06:57.401 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-49-40445"] 07-Jan-2025 08:06:57.403 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testCommitOnComplete] 07-Jan-2025 08:06:57.409 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-50"] 07-Jan-2025 08:06:57.409 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:57.410 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:57.415 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-50-36901"] 07-Jan-2025 08:06:58.929 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-50-36901"] 07-Jan-2025 08:06:58.933 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:58.939 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-50-36901"] 07-Jan-2025 08:06:58.943 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-50-36901"] 07-Jan-2025 08:06:58.944 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorWithThreadDoubleThenComplete] 07-Jan-2025 08:06:58.949 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-51"] 07-Jan-2025 08:06:58.950 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:58.950 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:58.963 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-51-32887"] 07-Jan-2025 08:06:59.502 SEVERE [http-nio-127.0.0.1-auto-51-exec-3] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:59.503 SEVERE [http-nio-127.0.0.1-auto-51-exec-3] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:06:59.505 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-51-32887"] 07-Jan-2025 08:06:59.506 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:06:59.513 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-51-32887"] 07-Jan-2025 08:06:59.517 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-51-32887"] 07-Jan-2025 08:06:59.519 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorWithThreadSingle] 07-Jan-2025 08:06:59.524 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-52"] 07-Jan-2025 08:06:59.524 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:06:59.525 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:06:59.538 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-52-44485"] 07-Jan-2025 08:07:00.064 SEVERE [http-nio-127.0.0.1-auto-52-exec-2] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:00.065 SEVERE [http-nio-127.0.0.1-auto-52-exec-2] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:00.068 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-52-44485"] 07-Jan-2025 08:07:00.070 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:00.074 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-52-44485"] 07-Jan-2025 08:07:00.091 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-52-44485"] 07-Jan-2025 08:07:00.096 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorDoubleThenComplete] 07-Jan-2025 08:07:00.100 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-53"] 07-Jan-2025 08:07:00.101 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:00.101 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:00.106 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-53-45435"] 07-Jan-2025 08:07:00.630 SEVERE [http-nio-127.0.0.1-auto-53-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:00.633 SEVERE [http-nio-127.0.0.1-auto-53-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:00.637 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-53-45435"] 07-Jan-2025 08:07:00.642 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:00.646 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-53-45435"] 07-Jan-2025 08:07:00.649 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-53-45435"] 07-Jan-2025 08:07:00.652 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchSingle] 07-Jan-2025 08:07:00.655 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-54"] 07-Jan-2025 08:07:00.656 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:00.656 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:00.668 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-54-33851"] 07-Jan-2025 08:07:00.692 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-54-33851"] 07-Jan-2025 08:07:00.697 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:00.702 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-54-33851"] 07-Jan-2025 08:07:00.708 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-54-33851"] 07-Jan-2025 08:07:00.710 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorSingle] 07-Jan-2025 08:07:00.714 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-55"] 07-Jan-2025 08:07:00.714 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:00.716 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:00.721 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-55-41059"] 07-Jan-2025 08:07:01.257 SEVERE [http-nio-127.0.0.1-auto-55-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:01.260 SEVERE [http-nio-127.0.0.1-auto-55-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:01.263 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-55-41059"] 07-Jan-2025 08:07:01.268 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:01.272 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-55-41059"] 07-Jan-2025 08:07:01.280 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-55-41059"] 07-Jan-2025 08:07:01.283 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutNoListener] 07-Jan-2025 08:07:01.287 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-56"] 07-Jan-2025 08:07:01.287 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:01.287 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:01.298 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-56-34537"] 07-Jan-2025 08:07:02.325 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-56-34537"] 07-Jan-2025 08:07:02.331 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:02.333 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-56-34537"] 07-Jan-2025 08:07:02.345 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-56-34537"] 07-Jan-2025 08:07:02.347 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchWithThreadMultiple] 07-Jan-2025 08:07:02.350 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-57"] 07-Jan-2025 08:07:02.351 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:02.351 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:02.362 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-57-35261"] 07-Jan-2025 08:07:02.491 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-57-35261"] 07-Jan-2025 08:07:02.492 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:02.494 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-57-35261"] 07-Jan-2025 08:07:02.501 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-57-35261"] 07-Jan-2025 08:07:02.503 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testGetRequestISE] 07-Jan-2025 08:07:02.507 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-58"] 07-Jan-2025 08:07:02.508 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:02.508 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:02.513 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-58-35877"] 07-Jan-2025 08:07:02.526 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-58-35877"] 07-Jan-2025 08:07:02.528 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:02.535 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-58-35877"] 07-Jan-2025 08:07:02.538 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-58-35877"] 07-Jan-2025 08:07:02.539 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutErrorDispatchAsyncDispatch] 07-Jan-2025 08:07:02.541 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-59"] 07-Jan-2025 08:07:02.541 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:02.541 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:02.546 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-59-45207"] 07-Jan-2025 08:07:03.576 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-59-45207"] 07-Jan-2025 08:07:03.579 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:03.581 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-59-45207"] 07-Jan-2025 08:07:03.590 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-59-45207"] 07-Jan-2025 08:07:03.593 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncRequestURI_24] 07-Jan-2025 08:07:03.600 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-60"] 07-Jan-2025 08:07:03.602 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:03.602 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:03.612 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-60-41051"] 07-Jan-2025 08:07:03.653 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-60-41051"] 07-Jan-2025 08:07:03.655 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:03.659 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-60-41051"] 07-Jan-2025 08:07:03.663 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-60-41051"] 07-Jan-2025 08:07:03.665 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncRequestURI_25] 07-Jan-2025 08:07:03.669 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-61"] 07-Jan-2025 08:07:03.669 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:03.669 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:03.678 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-61-37689"] 07-Jan-2025 08:07:03.711 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-61-37689"] 07-Jan-2025 08:07:03.713 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:03.719 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-61-37689"] 07-Jan-2025 08:07:03.721 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-61-37689"] 07-Jan-2025 08:07:03.726 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutErrorDispatchNone] 07-Jan-2025 08:07:03.733 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-62"] 07-Jan-2025 08:07:03.734 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:03.734 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:03.740 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-62-35933"] 07-Jan-2025 08:07:04.758 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-62-35933"] 07-Jan-2025 08:07:04.766 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:04.771 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-62-35933"] 07-Jan-2025 08:07:04.786 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-62-35933"] 07-Jan-2025 08:07:04.788 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testForbiddenDispatching] 07-Jan-2025 08:07:04.793 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-63"] 07-Jan-2025 08:07:04.797 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:04.797 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:04.810 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-63-41025"] 07-Jan-2025 08:07:04.834 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-63-41025"] 07-Jan-2025 08:07:04.837 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:04.844 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-63-41025"] 07-Jan-2025 08:07:04.854 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-63-41025"] 07-Jan-2025 08:07:04.863 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testAsyncListenerSupplyRequestResponse] 07-Jan-2025 08:07:04.979 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-64"] 07-Jan-2025 08:07:04.982 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorWithThreadMultipleThenComplete] 07-Jan-2025 08:07:04.985 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-65"] 07-Jan-2025 08:07:04.985 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:04.985 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:05.000 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-65-36029"] 07-Jan-2025 08:07:05.544 SEVERE [http-nio-127.0.0.1-auto-65-exec-6] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:05.546 SEVERE [http-nio-127.0.0.1-auto-65-exec-6] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:05.551 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-65-36029"] 07-Jan-2025 08:07:05.554 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:05.557 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-65-36029"] 07-Jan-2025 08:07:05.561 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-65-36029"] 07-Jan-2025 08:07:05.563 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutListenerNoCompleteNonAsyncDispatch] 07-Jan-2025 08:07:05.567 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-66"] 07-Jan-2025 08:07:05.567 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:05.567 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:05.578 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-66-41003"] 07-Jan-2025 08:07:06.601 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-66-41003"] 07-Jan-2025 08:07:06.604 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:06.611 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-66-41003"] 07-Jan-2025 08:07:06.623 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-66-41003"] 07-Jan-2025 08:07:06.625 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutErrorDispatchAsyncStart] 07-Jan-2025 08:07:06.626 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-67"] 07-Jan-2025 08:07:06.627 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:06.627 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:06.631 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-67-35533"] 07-Jan-2025 08:07:07.659 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-67-35533"] 07-Jan-2025 08:07:07.663 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:07.666 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-67-35533"] 07-Jan-2025 08:07:07.669 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-67-35533"] 07-Jan-2025 08:07:07.676 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testForwardDispatchUrlWithSpaces] 07-Jan-2025 08:07:07.681 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-68"] 07-Jan-2025 08:07:07.681 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:07.682 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:07.686 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-68-39899"] 07-Jan-2025 08:07:07.690 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-68-39899"] 07-Jan-2025 08:07:07.691 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:07.693 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-68-39899"] 07-Jan-2025 08:07:07.695 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-68-39899"] 07-Jan-2025 08:07:07.697 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testTimeoutListenerCompleteAsyncDispatch] 07-Jan-2025 08:07:07.698 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-69"] 07-Jan-2025 08:07:07.699 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:07.699 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:07.703 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-69-43591"] 07-Jan-2025 08:07:08.716 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-69-43591"] 07-Jan-2025 08:07:08.716 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:08.728 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-69-43591"] 07-Jan-2025 08:07:08.739 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-69-43591"] 07-Jan-2025 08:07:08.741 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testDispatchErrorMultipleThenComplete] 07-Jan-2025 08:07:08.747 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-127.0.0.1-auto-70"] 07-Jan-2025 08:07:08.748 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 07-Jan-2025 08:07:08.748 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/9.0.99-dev] 07-Jan-2025 08:07:08.765 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-127.0.0.1-auto-70-33133"] 07-Jan-2025 08:07:09.298 SEVERE [http-nio-127.0.0.1-auto-70-exec-1] org.apache.catalina.core.ApplicationDispatcher.invoke Servlet.service() for servlet [error] threw exception javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:09.299 SEVERE [http-nio-127.0.0.1-auto-70-exec-1] org.apache.catalina.core.StandardWrapperValve.invoke Servlet.service() for servlet [dispatch] in context with path [] threw exception [Oops.] with root cause javax.servlet.ServletException: Oops. at org.apache.catalina.core.TestAsyncContextImpl$ErrorServlet.doGet(TestAsyncContextImpl.java:1108) at javax.servlet.http.HttpServlet.service(HttpServlet.java:529) at javax.servlet.http.HttpServlet.service(HttpServlet.java:623) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:199) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:144) at org.apache.catalina.core.ApplicationDispatcher.invoke(ApplicationDispatcher.java:642) at org.apache.catalina.core.ApplicationDispatcher.doDispatch(ApplicationDispatcher.java:570) at org.apache.catalina.core.ApplicationDispatcher.dispatch(ApplicationDispatcher.java:539) at org.apache.catalina.core.AsyncContextImpl$AsyncRunnable.run(AsyncContextImpl.java:600) at org.apache.catalina.core.AsyncContextImpl.doInternalDispatch(AsyncContextImpl.java:343) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:166) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:90) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:482) at org.apache.catalina.valves.TesterAccessLogValve.invoke(TesterAccessLogValve.java:64) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:130) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:93) at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:660) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:241) at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:242) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:937) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1793) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1190) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:63) at java.base/java.lang.Thread.run(Thread.java:1575) 07-Jan-2025 08:07:09.300 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-nio-127.0.0.1-auto-70-33133"] 07-Jan-2025 08:07:09.302 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 07-Jan-2025 08:07:09.307 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-nio-127.0.0.1-auto-70-33133"] 07-Jan-2025 08:07:09.312 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-nio-127.0.0.1-auto-70-33133"] ------------- ---------------- --------------- Testcase: testDispatchErrorWithThreadSingleThenComplete took 3.352 sec Testcase: testDispatchErrorSingleThenComplete took 0.624 sec Testcase: testTimeoutListenerCompleteNonAsyncDispatch took 1.092 sec Testcase: testTimeoutListenerNoCompleteAsyncDispatch took 4.036 sec Testcase: testCanceledPostNoChunking took 2.066 sec Testcase: testDispatchErrorWithThreadMultiple took 0.554 sec Testcase: testDispatchErrorMultiple took 0.602 sec Testcase: testDispatchMultiple took 0.054 sec Testcase: testDispatchFromOtherContainerThread took 0.159 sec Testcase: testBug49528 took 1.065 sec Testcase: testBug49567 took 1.041 sec Testcase: testBug50352 took 3.055 sec Testcase: testBug50753 took 5.201 sec Testcase: testBug53337 took 0.135 sec Testcase: testBug53843 took 3.129 sec Testcase: testBug54178 took 0.084 sec Testcase: testBug61185 took 0.082 sec Testcase: testBug63816 took 0.072 sec Testcase: testEmptyDispatch took 0.126 sec Testcase: testDispatchWithCustomRequestResponse took 0.095 sec Testcase: testTimeoutListenerNoCompleteNoDispatch took 1.102 sec Testcase: testTimeoutErrorDispatchNonAsync took 1.241 sec Testcase: testListeners took 1.082 sec Testcase: testTimeoutDispatchCustomErrorPage took 6.089 sec Testcase: testAsyncContextListenerClearing took 0.048 sec Testcase: testAsyncStartNoComplete took 4.077 sec Testcase: testGetResponseISE took 0.061 sec Testcase: testBug51197a took 1.582 sec Testcase: testBug51197b took 1.553 sec Testcase: testBug51197c took 1.601 sec Testcase: testBug51197d took 1.599 sec Testcase: testBug59219a took 0.067 sec Testcase: testBug59219b took 0.084 sec Testcase: testCanceledPostChunked took 2.095 sec Testcase: testAsyncDispatchUrlWithSpaces took 0.051 sec Testcase: testAsyncStartWithComplete took 0.078 sec Testcase: testDispatchWithThreadDouble took 0.099 sec Testcase: testEmptyDispatchWithCustomRequestResponse took 0.093 sec Testcase: testDispatchWithThreadSingle took 0.089 sec Testcase: testTimeoutListenerCompleteNoDispatch took 1.067 sec Testcase: testTimeoutErrorDispatchAsyncComplete took 1.06 sec Testcase: testDispatchErrorWithThreadDouble took 0.58 sec Testcase: testAsyncIoEnd00 took 0.047 sec Testcase: testAsyncIoEnd01 took 0.049 sec Testcase: testAsyncIoEnd02 took 0.091 sec Testcase: testAsyncIoEnd03 took 0.072 sec Testcase: testErrorHandling took 2.068 sec Testcase: testDispatchDouble took 0.063 sec Testcase: testDispatchErrorDouble took 0.58 sec Testcase: testCommitOnComplete took 1.542 sec Testcase: testDispatchErrorWithThreadDoubleThenComplete took 0.574 sec Testcase: testDispatchErrorWithThreadSingle took 0.576 sec Testcase: testDispatchErrorDoubleThenComplete took 0.555 sec Testcase: testDispatchSingle took 0.059 sec Testcase: testDispatchErrorSingle took 0.572 sec Testcase: testTimeoutNoListener took 1.063 sec Testcase: testDispatchWithThreadMultiple took 0.156 sec Testcase: testGetRequestISE took 0.037 sec Testcase: testTimeoutErrorDispatchAsyncDispatch took 1.051 sec Testcase: testAsyncRequestURI_24 took 0.071 sec Testcase: testAsyncRequestURI_25 took 0.061 sec Testcase: testTimeoutErrorDispatchNone took 1.061 sec Testcase: testForbiddenDispatching took 0.067 sec Testcase: testAsyncListenerSupplyRequestResponse took 0.119 sec Testcase: testDispatchErrorWithThreadMultipleThenComplete took 0.581 sec Testcase: testTimeoutListenerNoCompleteNonAsyncDispatch took 1.061 sec Testcase: testTimeoutErrorDispatchAsyncStart took 1.052 sec Testcase: testForwardDispatchUrlWithSpaces took 0.02 sec Testcase: testTimeoutListenerCompleteAsyncDispatch took 1.044 sec Testcase: testDispatchErrorMultipleThenComplete took 0.573 sec