| Run | | | Workspace | | | Log | | | Issues | | | Fixes | | | Pre-reqs | | | Stats | | | XRef | | | Maven Repository Proxy Log | |
||
Testsuite: org.apache.tomcat.websocket.TestWebSocketFrameClientSSL Tests run: 12, Failures: 0, Errors: 0, Skipped: 4, Time elapsed: 29.246 sec ------------- Standard Output --------------- Waiting for server to report an error Received Hello, now sending data Waiting for connection to be closed Sent Hello message, waiting for data Received Hello, now sending data Waiting for server to report an error Waiting for connection to be closed Received Hello, now sending data Sent Hello message, waiting for data Received Hello, now sending data Waiting for server to report an error Waiting for connection to be closed Received Hello, now sending data Sent Hello message, waiting for data Received Hello, now sending data Waiting for server to report an error Waiting for connection to be closed Received Hello, now sending data Sent Hello message, waiting for data Received Hello, now sending data ------------- ---------------- --------------- ------------- Standard Error ----------------- 29-Mar-2023 14:31:35.462 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032[JSSE]] 29-Mar-2023 14:31:36.050 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1"] 29-Mar-2023 14:31:36.397 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-jsse-nio2-127.0.0.1-auto-1], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:36.409 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:36.410 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:36.624 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-41037"] 29-Mar-2023 14:31:42.501 WARNING [https-jsse-nio2-127.0.0.1-auto-1-exec-6] org.apache.tomcat.websocket.WsSession.doClose Failed to flush batched messages on session close java.io.IOException: java.lang.IllegalStateException: Writing not allowed due to timeout or cancellation at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:321) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:256) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.flushBatch(WsRemoteEndpointImplBase.java:124) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.setBatchingAllowed(WsRemoteEndpointImplBase.java:111) at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:578) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:319) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:249) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendString(WsRemoteEndpointImplBase.java:191) at org.apache.tomcat.websocket.WsRemoteEndpointBasic.sendText(WsRemoteEndpointBasic.java:36) at org.apache.tomcat.websocket.TesterFirehoseServer$Writer.doRun(TesterFirehoseServer.java:166) at org.apache.tomcat.websocket.TesterFirehoseServer$Endpoint.onMessage(TesterFirehoseServer.java:120) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:568) at org.apache.tomcat.websocket.pojo.PojoMessageHandlerWholeBase.onMessage(PojoMessageHandlerWholeBase.java:102) at org.apache.tomcat.websocket.WsFrameBase.sendMessageText(WsFrameBase.java:390) at org.apache.tomcat.websocket.server.WsFrameServer.sendMessageText(WsFrameServer.java:129) at org.apache.tomcat.websocket.WsFrameBase.processDataText(WsFrameBase.java:484) at org.apache.tomcat.websocket.WsFrameBase.processData(WsFrameBase.java:284) at org.apache.tomcat.websocket.WsFrameBase.processInputBuffer(WsFrameBase.java:130) at org.apache.tomcat.websocket.server.WsFrameServer.onDataAvailable(WsFrameServer.java:84) at org.apache.tomcat.websocket.server.WsFrameServer.doOnDataAvailable(WsFrameServer.java:183) at org.apache.tomcat.websocket.server.WsFrameServer.notifyDataAvailable(WsFrameServer.java:163) at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:151) at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:60) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:894) at org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1664) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.net.AbstractEndpoint.processSocket(AbstractEndpoint.java:1219) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:630) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:608) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:1006) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:934) at java.base/sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:129) at java.base/sun.nio.ch.Invoker$2.run(Invoker.java:221) at java.base/sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:113) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: java.lang.IllegalStateException: Writing not allowed due to timeout or cancellation at java.base/sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:350) at java.base/sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:399) at org.apache.tomcat.util.net.SecureNio2Channel.write(SecureNio2Channel.java:1242) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$Nio2OperationState.run(Nio2Endpoint.java:1087) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$Nio2OperationState.start(Nio2Endpoint.java:1032) at org.apache.tomcat.util.net.SocketWrapperBase.vectoredOperation(SocketWrapperBase.java:1440) at org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:1366) at org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:1337) at org.apache.tomcat.websocket.server.WsRemoteEndpointImplServer.doWrite(WsRemoteEndpointImplServer.java:91) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.writeMessagePart(WsRemoteEndpointImplBase.java:441) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:308) ... 41 more 29-Mar-2023 14:31:42.548 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-41037"] 29-Mar-2023 14:31:42.552 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:31:42.583 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-41037"] 29-Mar-2023 14:31:42.588 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-41037"] 29-Mar-2023 14:31:42.604 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpoint[JSSE]] 29-Mar-2023 14:31:42.605 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2"] 29-Mar-2023 14:31:42.643 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-jsse-nio2-127.0.0.1-auto-2], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:42.644 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:42.644 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:42.664 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-44699"] 29-Mar-2023 14:31:45.269 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-44699"] 29-Mar-2023 14:31:45.270 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:31:45.272 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-44699"] 29-Mar-2023 14:31:45.272 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-44699"] 29-Mar-2023 14:31:45.281 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032Legacy[JSSE]] 29-Mar-2023 14:31:45.282 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-3"] 29-Mar-2023 14:31:45.430 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-jsse-nio2-127.0.0.1-auto-3], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:45.430 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:45.430 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:45.436 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-3-43663"] 29-Mar-2023 14:31:50.520 WARNING [https-jsse-nio2-127.0.0.1-auto-3-exec-7] org.apache.tomcat.websocket.WsSession.doClose Failed to flush batched messages on session close java.io.IOException: java.net.SocketTimeoutException at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:321) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:256) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.flushBatch(WsRemoteEndpointImplBase.java:124) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.setBatchingAllowed(WsRemoteEndpointImplBase.java:111) at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:578) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:319) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:249) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendString(WsRemoteEndpointImplBase.java:191) at org.apache.tomcat.websocket.WsRemoteEndpointBasic.sendText(WsRemoteEndpointBasic.java:36) at org.apache.tomcat.websocket.TesterFirehoseServer$Writer.doRun(TesterFirehoseServer.java:166) at org.apache.tomcat.websocket.TesterFirehoseServer$Endpoint.onMessage(TesterFirehoseServer.java:120) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:568) at org.apache.tomcat.websocket.pojo.PojoMessageHandlerWholeBase.onMessage(PojoMessageHandlerWholeBase.java:102) at org.apache.tomcat.websocket.WsFrameBase.sendMessageText(WsFrameBase.java:390) at org.apache.tomcat.websocket.server.WsFrameServer.sendMessageText(WsFrameServer.java:129) at org.apache.tomcat.websocket.WsFrameBase.processDataText(WsFrameBase.java:484) at org.apache.tomcat.websocket.WsFrameBase.processData(WsFrameBase.java:284) at org.apache.tomcat.websocket.WsFrameBase.processInputBuffer(WsFrameBase.java:130) at org.apache.tomcat.websocket.server.WsFrameServer.onDataAvailable(WsFrameServer.java:84) at org.apache.tomcat.websocket.server.WsFrameServer.doOnDataAvailable(WsFrameServer.java:183) at org.apache.tomcat.websocket.server.WsFrameServer.notifyDataAvailable(WsFrameServer.java:163) at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:151) at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:60) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:894) at org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1664) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.net.AbstractEndpoint.processSocket(AbstractEndpoint.java:1219) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:630) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:608) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:1006) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:934) at java.base/sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:129) at java.base/sun.nio.ch.Invoker$2.run(Invoker.java:221) at java.base/sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:113) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: java.net.SocketTimeoutException at org.apache.tomcat.util.net.SocketWrapperBase$VectoredIOCompletionHandler.failed(SocketWrapperBase.java:1124) at org.apache.tomcat.util.net.SocketWrapperBase$VectoredIOCompletionHandler.failed(SocketWrapperBase.java:1066) at org.apache.tomcat.util.net.SecureNio2Channel$4.failed(SecureNio2Channel.java:1260) at java.base/sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:131) ... 6 more 29-Mar-2023 14:31:50.596 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-3-43663"] 29-Mar-2023 14:31:50.596 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:31:50.599 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-3-43663"] 29-Mar-2023 14:31:50.600 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-3-43663"] 29-Mar-2023 14:31:50.603 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpointLegacy[JSSE]] 29-Mar-2023 14:31:50.605 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-4"] 29-Mar-2023 14:31:50.609 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-jsse-nio2-127.0.0.1-auto-4], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:50.609 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:50.609 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:50.613 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-4-42295"] 29-Mar-2023 14:31:51.834 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-4-42295"] 29-Mar-2023 14:31:51.835 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:31:51.837 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-4-42295"] 29-Mar-2023 14:31:51.837 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-4-42295"] 29-Mar-2023 14:31:51.840 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032[OpenSSL]] 29-Mar-2023 14:31:51.843 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [2.0.3-dev] using APR version [1.7.3]. 29-Mar-2023 14:31:51.845 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.2.0-dev ] 29-Mar-2023 14:31:51.846 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-5"] 29-Mar-2023 14:31:51.858 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-openssl-nio2-127.0.0.1-auto-5], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:51.858 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:51.858 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:51.862 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-5-39643"] 29-Mar-2023 14:31:56.943 WARNING [https-openssl-nio2-127.0.0.1-auto-5-exec-6] org.apache.tomcat.websocket.WsSession.doClose Failed to flush batched messages on session close java.io.IOException: java.lang.IllegalStateException: Writing not allowed due to timeout or cancellation at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:321) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:256) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.flushBatch(WsRemoteEndpointImplBase.java:124) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.setBatchingAllowed(WsRemoteEndpointImplBase.java:111) at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:578)
Continuation...
at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:319) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:249) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendString(WsRemoteEndpointImplBase.java:191) at org.apache.tomcat.websocket.WsRemoteEndpointBasic.sendText(WsRemoteEndpointBasic.java:36) at org.apache.tomcat.websocket.TesterFirehoseServer$Writer.doRun(TesterFirehoseServer.java:166) at org.apache.tomcat.websocket.TesterFirehoseServer$Endpoint.onMessage(TesterFirehoseServer.java:120) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:568) at org.apache.tomcat.websocket.pojo.PojoMessageHandlerWholeBase.onMessage(PojoMessageHandlerWholeBase.java:102) at org.apache.tomcat.websocket.WsFrameBase.sendMessageText(WsFrameBase.java:390) at org.apache.tomcat.websocket.server.WsFrameServer.sendMessageText(WsFrameServer.java:129) at org.apache.tomcat.websocket.WsFrameBase.processDataText(WsFrameBase.java:484) at org.apache.tomcat.websocket.WsFrameBase.processData(WsFrameBase.java:284) at org.apache.tomcat.websocket.WsFrameBase.processInputBuffer(WsFrameBase.java:130) at org.apache.tomcat.websocket.server.WsFrameServer.onDataAvailable(WsFrameServer.java:84) at org.apache.tomcat.websocket.server.WsFrameServer.doOnDataAvailable(WsFrameServer.java:183) at org.apache.tomcat.websocket.server.WsFrameServer.notifyDataAvailable(WsFrameServer.java:163) at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:151) at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:60) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:894) at org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1664) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.net.AbstractEndpoint.processSocket(AbstractEndpoint.java:1219) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:630) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:608) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:1006) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:934) at java.base/sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:129) at java.base/sun.nio.ch.Invoker$2.run(Invoker.java:221) at java.base/sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:113) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: java.lang.IllegalStateException: Writing not allowed due to timeout or cancellation at java.base/sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:350) at java.base/sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:399) at org.apache.tomcat.util.net.SecureNio2Channel.write(SecureNio2Channel.java:1242) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$Nio2OperationState.run(Nio2Endpoint.java:1087) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$Nio2OperationState.start(Nio2Endpoint.java:1032) at org.apache.tomcat.util.net.SocketWrapperBase.vectoredOperation(SocketWrapperBase.java:1440) at org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:1366) at org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:1337) at org.apache.tomcat.websocket.server.WsRemoteEndpointImplServer.doWrite(WsRemoteEndpointImplServer.java:91) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.writeMessagePart(WsRemoteEndpointImplBase.java:441) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:308) ... 41 more 29-Mar-2023 14:31:56.989 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-5-39643"] 29-Mar-2023 14:31:56.990 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:31:56.992 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-5-39643"] 29-Mar-2023 14:31:56.993 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-5-39643"] 29-Mar-2023 14:31:56.995 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpoint[OpenSSL]] 29-Mar-2023 14:31:56.996 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [2.0.3-dev] using APR version [1.7.3]. 29-Mar-2023 14:31:56.996 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.2.0-dev ] 29-Mar-2023 14:31:56.997 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-6"] 29-Mar-2023 14:31:57.003 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-openssl-nio2-127.0.0.1-auto-6], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:57.003 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:57.003 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:57.008 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-6-43687"] 29-Mar-2023 14:31:58.192 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-6-43687"] 29-Mar-2023 14:31:58.194 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:31:58.201 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-6-43687"] 29-Mar-2023 14:31:58.202 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-6-43687"] 29-Mar-2023 14:31:58.205 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032Legacy[OpenSSL]] 29-Mar-2023 14:31:58.206 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [2.0.3-dev] using APR version [1.7.3]. 29-Mar-2023 14:31:58.206 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.2.0-dev ] 29-Mar-2023 14:31:58.207 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-7"] 29-Mar-2023 14:31:58.218 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-openssl-nio2-127.0.0.1-auto-7], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:31:58.219 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:31:58.219 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:31:58.224 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-7-45945"] 29-Mar-2023 14:32:03.305 WARNING [https-openssl-nio2-127.0.0.1-auto-7-exec-7] org.apache.tomcat.websocket.WsSession.doClose Failed to flush batched messages on session close java.io.IOException: java.lang.IllegalStateException: Writing not allowed due to timeout or cancellation at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:321) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:256) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.flushBatch(WsRemoteEndpointImplBase.java:124) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.setBatchingAllowed(WsRemoteEndpointImplBase.java:111) at org.apache.tomcat.websocket.WsSession.doClose(WsSession.java:578) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:319) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:249) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendString(WsRemoteEndpointImplBase.java:191) at org.apache.tomcat.websocket.WsRemoteEndpointBasic.sendText(WsRemoteEndpointBasic.java:36) at org.apache.tomcat.websocket.TesterFirehoseServer$Writer.doRun(TesterFirehoseServer.java:166) at org.apache.tomcat.websocket.TesterFirehoseServer$Endpoint.onMessage(TesterFirehoseServer.java:120) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:568) at org.apache.tomcat.websocket.pojo.PojoMessageHandlerWholeBase.onMessage(PojoMessageHandlerWholeBase.java:102) at org.apache.tomcat.websocket.WsFrameBase.sendMessageText(WsFrameBase.java:390) at org.apache.tomcat.websocket.server.WsFrameServer.sendMessageText(WsFrameServer.java:129) at org.apache.tomcat.websocket.WsFrameBase.processDataText(WsFrameBase.java:484) at org.apache.tomcat.websocket.WsFrameBase.processData(WsFrameBase.java:284) at org.apache.tomcat.websocket.WsFrameBase.processInputBuffer(WsFrameBase.java:130) at org.apache.tomcat.websocket.server.WsFrameServer.onDataAvailable(WsFrameServer.java:84) at org.apache.tomcat.websocket.server.WsFrameServer.doOnDataAvailable(WsFrameServer.java:183) at org.apache.tomcat.websocket.server.WsFrameServer.notifyDataAvailable(WsFrameServer.java:163) at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:151) at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:60) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:57) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:894) at org.apache.tomcat.util.net.Nio2Endpoint$SocketProcessor.doRun(Nio2Endpoint.java:1664) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:52) at org.apache.tomcat.util.net.AbstractEndpoint.processSocket(AbstractEndpoint.java:1219) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:630) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$2.completed(Nio2Endpoint.java:608) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:1006) at org.apache.tomcat.util.net.SecureNio2Channel$1.completed(SecureNio2Channel.java:934) at java.base/sun.nio.ch.Invoker.invokeUnchecked(Invoker.java:129) at java.base/sun.nio.ch.Invoker$2.run(Invoker.java:221) at java.base/sun.nio.ch.AsynchronousChannelGroupImpl$1.run(AsynchronousChannelGroupImpl.java:113) at org.apache.tomcat.util.threads.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1191) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:659) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: java.lang.IllegalStateException: Writing not allowed due to timeout or cancellation at java.base/sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:350) at java.base/sun.nio.ch.AsynchronousSocketChannelImpl.write(AsynchronousSocketChannelImpl.java:399) at org.apache.tomcat.util.net.SecureNio2Channel.write(SecureNio2Channel.java:1242) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$Nio2OperationState.run(Nio2Endpoint.java:1087) at org.apache.tomcat.util.net.Nio2Endpoint$Nio2SocketWrapper$Nio2OperationState.start(Nio2Endpoint.java:1032) at org.apache.tomcat.util.net.SocketWrapperBase.vectoredOperation(SocketWrapperBase.java:1440) at org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:1366) at org.apache.tomcat.util.net.SocketWrapperBase.write(SocketWrapperBase.java:1337) at org.apache.tomcat.websocket.server.WsRemoteEndpointImplServer.doWrite(WsRemoteEndpointImplServer.java:91) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.writeMessagePart(WsRemoteEndpointImplBase.java:441) at org.apache.tomcat.websocket.WsRemoteEndpointImplBase.sendMessageBlock(WsRemoteEndpointImplBase.java:308) ... 41 more 29-Mar-2023 14:32:03.352 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-7-45945"] 29-Mar-2023 14:32:03.353 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:32:03.354 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-7-45945"] 29-Mar-2023 14:32:03.355 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-7-45945"] 29-Mar-2023 14:32:03.357 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpointLegacy[OpenSSL]] 29-Mar-2023 14:32:03.358 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [2.0.3-dev] using APR version [1.7.3]. 29-Mar-2023 14:32:03.358 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.2.0-dev ] 29-Mar-2023 14:32:03.359 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-8"] 29-Mar-2023 14:32:03.415 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-openssl-nio2-127.0.0.1-auto-8], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-10.1.x/test/org/apache/tomcat/util/net/ca.jks] 29-Mar-2023 14:32:03.416 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 29-Mar-2023 14:32:03.417 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.1.8-dev] 29-Mar-2023 14:32:03.423 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-8-37963"] 29-Mar-2023 14:32:04.581 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-8-37963"] 29-Mar-2023 14:32:04.582 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 29-Mar-2023 14:32:04.583 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-8-37963"] 29-Mar-2023 14:32:04.584 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-8-37963"] 29-Mar-2023 14:32:04.586 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032[OpenSSL-Panama]] 29-Mar-2023 14:32:04.587 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-9"] 29-Mar-2023 14:32:04.590 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpoint[OpenSSL-Panama]] 29-Mar-2023 14:32:04.590 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-10"] 29-Mar-2023 14:32:04.591 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032Legacy[OpenSSL-Panama]] 29-Mar-2023 14:32:04.592 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-11"] 29-Mar-2023 14:32:04.594 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpointLegacy[OpenSSL-Panama]] 29-Mar-2023 14:32:04.595 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-12"] ------------- ---------------- --------------- Testcase: testBug56032[JSSE] took 7.214 sec Testcase: testConnectToServerEndpoint[JSSE] took 2.677 sec Testcase: testBug56032Legacy[JSSE] took 5.322 sec Testcase: testConnectToServerEndpointLegacy[JSSE] took 1.237 sec Testcase: testBug56032[OpenSSL] took 5.155 sec Testcase: testConnectToServerEndpoint[OpenSSL] took 1.21 sec Testcase: testBug56032Legacy[OpenSSL] took 5.152 sec Testcase: testConnectToServerEndpointLegacy[OpenSSL] took 1.228 sec Testcase: testBug56032[OpenSSL-Panama] took 0.003 sec SKIPPED: got: <java.lang.ClassNotFoundException: org.apache.tomcat.util.net.openssl.panama.OpenSSLImplementation>, expected: null Testcase: testBug56032[OpenSSL-Panama] took 0.003 sec Testcase: testConnectToServerEndpoint[OpenSSL-Panama] took 0.002 sec SKIPPED: got: <java.lang.ClassNotFoundException: org.apache.tomcat.util.net.openssl.panama.OpenSSLImplementation>, expected: null Testcase: testConnectToServerEndpoint[OpenSSL-Panama] took 0.002 sec Testcase: testBug56032Legacy[OpenSSL-Panama] took 0.001 sec SKIPPED: got: <java.lang.ClassNotFoundException: org.apache.tomcat.util.net.openssl.panama.OpenSSLImplementation>, expected: null Testcase: testBug56032Legacy[OpenSSL-Panama] took 0.001 sec Testcase: testConnectToServerEndpointLegacy[OpenSSL-Panama] took 0.001 sec SKIPPED: got: <java.lang.ClassNotFoundException: org.apache.tomcat.util.net.openssl.panama.OpenSSLImplementation>, expected: null Testcase: testConnectToServerEndpointLegacy[OpenSSL-Panama] took 0.001 sec
Apache Gump, Gump, Apache, the Apache feather logo, and the Apache Gump project logos are trademarks of The Apache Software Foundation.
Last Updated: Wed, 29 Mar 2023 12:00:06 ().