| Run | | | Workspace | | | Log | | | Issues | | | Fixes | | | Pre-reqs | | | Stats | | | XRef | | | Maven Repository Proxy Log | |
||
Testsuite: org.apache.tomcat.websocket.TestWebSocketFrameClientSSL Tests run: 6, Failures: 0, Errors: 0, Skipped: 2, Time elapsed: 16.51 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 ------------- ---------------- --------------- ------------- Standard Error ----------------- 31-Mar-2023 13:16:09.516 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032[JSSE]] 31-Mar-2023 13:16:10.171 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1"] 31-Mar-2023 13:16:10.349 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-main/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-main/test/org/apache/tomcat/util/net/ca.jks] 31-Mar-2023 13:16:10.371 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 31-Mar-2023 13:16:10.372 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/11.0.0-M5-dev] 31-Mar-2023 13:16:10.476 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-42201"] 31-Mar-2023 13:16:16.362 WARNING [https-jsse-nio2-127.0.0.1-auto-1-exec-5] 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:1351) 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:1149) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:636) 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 31-Mar-2023 13:16:16.394 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-42201"] 31-Mar-2023 13:16:16.395 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 31-Mar-2023 13:16:16.403 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-42201"] 31-Mar-2023 13:16:16.404 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-1-42201"] 31-Mar-2023 13:16:16.408 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpoint[JSSE]] 31-Mar-2023 13:16:16.409 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2"] 31-Mar-2023 13:16:16.413 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-main/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-main/test/org/apache/tomcat/util/net/ca.jks] 31-Mar-2023 13:16:16.414 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 31-Mar-2023 13:16:16.414 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/11.0.0-M5-dev] 31-Mar-2023 13:16:16.418 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-33551"] 31-Mar-2023 13:16:19.320 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-33551"] 31-Mar-2023 13:16:19.400 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 31-Mar-2023 13:16:19.402 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-33551"] 31-Mar-2023 13:16:19.405 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-2-33551"] 31-Mar-2023 13:16:19.409 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032[OpenSSL]] 31-Mar-2023 13:16:19.416 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [2.0.3-dev] using APR version [1.7.4-dev]. 31-Mar-2023 13:16:19.419 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.2.0-dev ] 31-Mar-2023 13:16:19.419 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-3"] 31-Mar-2023 13:16:19.444 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-openssl-nio2-127.0.0.1-auto-3], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-main/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-main/test/org/apache/tomcat/util/net/ca.jks] 31-Mar-2023 13:16:19.445 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 31-Mar-2023 13:16:19.445 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/11.0.0-M5-dev] 31-Mar-2023 13:16:19.466 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-3-37537"] 31-Mar-2023 13:16:24.547 WARNING [https-openssl-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:1351) 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:1149) at org.apache.tomcat.util.threads.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:636) 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 31-Mar-2023 13:16:24.601 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-3-37537"] 31-Mar-2023 13:16:24.601 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 31-Mar-2023 13:16:24.603 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-3-37537"] 31-Mar-2023 13:16:24.604 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-3-37537"] 31-Mar-2023 13:16:24.606 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpoint[OpenSSL]] 31-Mar-2023 13:16:24.607 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [2.0.3-dev] using APR version [1.7.4-dev]. 31-Mar-2023 13:16:24.607 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.2.0-dev ] 31-Mar-2023 13:16:24.608 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-4"] 31-Mar-2023 13:16:24.612 INFO [main] org.apache.tomcat.util.net.AbstractEndpoint.logCertificate Connector [https-openssl-nio2-127.0.0.1-auto-4], TLS virtual host [_default_], certificate type [UNDEFINED] configured from [/srv/gump/public/workspace/tomcat-main/test/org/apache/tomcat/util/net/localhost-rsa.jks] using alias [tomcat] and with trust store [/srv/gump/public/workspace/tomcat-main/test/org/apache/tomcat/util/net/ca.jks] 31-Mar-2023 13:16:24.612 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat] 31-Mar-2023 13:16:24.612 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/11.0.0-M5-dev] 31-Mar-2023 13:16:24.616 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-4-40263"] 31-Mar-2023 13:16:25.667 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-4-40263"] 31-Mar-2023 13:16:25.668 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat] 31-Mar-2023 13:16:25.670 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-4-40263"] 31-Mar-2023 13:16:25.670 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-openssl-nio2-127.0.0.1-auto-4-40263"] 31-Mar-2023 13:16:25.672 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug56032[OpenSSL-Panama]] 31-Mar-2023 13:16:25.674 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-5"] 31-Mar-2023 13:16:25.676 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testConnectToServerEndpoint[OpenSSL-Panama]] 31-Mar-2023 13:16:25.676 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["https-jsse-nio2-127.0.0.1-auto-6"] ------------- ---------------- --------------- Testcase: testBug56032[JSSE] took 6.996 sec Testcase: testConnectToServerEndpoint[JSSE] took 3 sec Testcase: testBug56032[OpenSSL] took 5.197 sec Testcase: testConnectToServerEndpoint[OpenSSL] took 1.066 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.001 sec SKIPPED: got: <java.lang.ClassNotFoundException: org.apache.tomcat.util.net.openssl.panama.OpenSSLImplementation>, expected: null Testcase: testConnectToServerEndpoint[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: Fri, 31 Mar 2023 12:00:04 ().