Run| Workspace| Log| Issues| Fixes| Pre-reqs| Stats| XRef| Maven Repository Proxy Log Gump Logo

Details

File Contents

Testsuite: org.apache.catalina.nonblocking.TestNonBlockingAPI
Tests run: 7, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 22.268 sec
------------- Standard Error -----------------
26-Apr-2018 08:51:43.397 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug55438NonBlockingReadWriteEmptyRead]
26-Apr-2018 08:51:43.519 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.17 using APR version 1.6.4.
26-Apr-2018 08:51:43.520 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
26-Apr-2018 08:51:43.523 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2p-dev  xx XXX xxxx)
26-Apr-2018 08:51:43.806 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-1"]
26-Apr-2018 08:51:43.826 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat
26-Apr-2018 08:51:43.826 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.52-dev
26-Apr-2018 08:51:43.965 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-1-35884"]
26-Apr-2018 08:51:44.109 INFO [http-apr-127.0.0.1-auto-1-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadWriteListener.onAllDataRead onAllDataRead
26-Apr-2018 08:51:44.110 INFO [http-apr-127.0.0.1-auto-1-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadWriteListener$1.onWritePossible Writing []
26-Apr-2018 08:51:44.118 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-1-35884"]
26-Apr-2018 08:51:44.168 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service Tomcat
26-Apr-2018 08:51:44.178 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-1-35884"]
26-Apr-2018 08:51:47.122 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-1-35884"]
26-Apr-2018 08:51:47.143 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingReadWithDispathch]
26-Apr-2018 08:51:47.146 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.17 using APR version 1.6.4.
26-Apr-2018 08:51:47.147 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
26-Apr-2018 08:51:47.148 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2p-dev  xx XXX xxxx)
26-Apr-2018 08:51:47.149 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-2"]
26-Apr-2018 08:51:47.150 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat
26-Apr-2018 08:51:47.151 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.52-dev
26-Apr-2018 08:51:47.174 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-2-40458"]
26-Apr-2018 08:51:49.201 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-2-40458"]
26-Apr-2018 08:51:49.252 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service Tomcat
26-Apr-2018 08:51:49.260 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-2-40458"]
26-Apr-2018 08:51:49.318 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-2-40458"]
26-Apr-2018 08:51:49.327 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingRead]
26-Apr-2018 08:51:49.331 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.17 using APR version 1.6.4.
26-Apr-2018 08:51:49.331 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
26-Apr-2018 08:51:49.333 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2p-dev  xx XXX xxxx)
26-Apr-2018 08:51:49.334 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-3"]
26-Apr-2018 08:51:49.335 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat
26-Apr-2018 08:51:49.335 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.52-dev
26-Apr-2018 08:51:49.352 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-3-55157"]
26-Apr-2018 08:51:49.399 INFO [http-apr-127.0.0.1-auto-3-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
26-Apr-2018 08:51:49.896 INFO [http-apr-127.0.0.1-auto-3-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
26-Apr-2018 08:51:50.395 INFO [http-apr-127.0.0.1-auto-3-exec-7] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
26-Apr-2018 08:51:50.896 INFO [http-apr-127.0.0.1-auto-3-exec-8] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
26-Apr-2018 08:51:51.396 INFO [http-apr-127.0.0.1-auto-3-exec-9] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable FINISHED
26-Apr-2018 08:51:51.396 INFO [http-apr-127.0.0.1-auto-3-exec-9] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead
26-Apr-2018 08:51:51.397 INFO [http-apr-127.0.0.1-auto-3-exec-9] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBReadServlet$1.onComplete onComplete
26-Apr-2018 08:51:51.400 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-3-55157"]
26-Apr-2018 08:51:51.401 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service Tomcat
26-Apr-2018 08:51:51.404 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-3-55157"]
26-Apr-2018 08:51:54.404 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-3-55157"]
26-Apr-2018 08:51:54.414 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingWriteError]
26-Apr-2018 08:51:54.425 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.17 using APR version 1.6.4.
26-Apr-2018 08:51:54.425 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
26-Apr-2018 08:51:54.426 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2p-dev  xx XXX xxxx)
26-Apr-2018 08:51:54.430 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-4"]
26-Apr-2018 08:51:54.431 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat
26-Apr-2018 08:51:54.431 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.52-dev
26-Apr-2018 08:51:54.452 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-4-59905"]
26-Apr-2018 08:51:54.467 INFO [http-apr-127.0.0.1-auto-4-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead
26-Apr-2018 08:51:54.468 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [7] ms
26-Apr-2018 08:51:54.468 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [808] bytes in [0] ms
26-Apr-2018 08:51:54.469 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.469 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [808] bytes in [0] ms
26-Apr-2018 08:51:54.469 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.470 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.470 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.470 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.470 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.470 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.472 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.472 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.472 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.472 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.472 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.472 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.475 INFO [http-apr-127.0.0.1-auto-4-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 8 ms. Bytes before=0 after=1048576
26-Apr-2018 08:51:54.478 INFO [http-apr-127.0.0.1-auto-4-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 2 ms. Bytes before=1048576 after=2097152
26-Apr-2018 08:51:54.516 INFO [http-apr-127.0.0.1-auto-4-exec-7] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=2097152 after=3145728
26-Apr-2018 08:51:54.521 INFO [http-apr-127.0.0.1-auto-4-exec-8] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=3145728 after=4194304
26-Apr-2018 08:51:54.973 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.974 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.974 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.974 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.975 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.975 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.975 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.975 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.976 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.976 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.976 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.976 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.977 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.977 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.977 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.978 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.978 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.978 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.978 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
26-Apr-2018 08:51:54.979 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [1] ms
26-Apr-2018 08:51:54.983 INFO [http-apr-127.0.0.1-auto-4-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onError ReadListener.onError
java.io.IOException: APR error: -104
	at org.apache.coyote.http11.InternalAprOutputBuffer.writeToSocket(InternalAprOutputBuffer.java:292)
	at org.apache.coyote.http11.InternalAprOutputBuffer.writeToSocket(InternalAprOutputBuffer.java:245)
	at org.apache.coyote.http11.InternalAprOutputBuffer.flushBuffer(InternalAprOutputBuffer.java:214)
	at org.apache.coyote.http11.AbstractHttp11Processor.asyncDispatch(AbstractHttp11Processor.java:1711)
	at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:666)
	at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.doRun(AprEndpoint.java:2527)
	at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:2516)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
	at java.lang.Thread.run(Thread.java:748)
26-Apr-2018 08:51:54.985 INFO [http-apr-127.0.0.1-auto-4-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onError WriteListener.onError
java.io.IOException: APR error: -104
	at org.apache.coyote.http11.InternalAprOutputBuffer.writeToSocket(InternalAprOutputBuffer.java:292)
	at org.apache.coyote.http11.InternalAprOutputBuffer.writeToSocket(InternalAprOutputBuffer.java:245)
	at org.apache.coyote.http11.InternalAprOutputBuffer.flushBuffer(InternalAprOutputBuffer.java:214)
	at org.apache.coyote.http11.AbstractHttp11Processor.asyncDispatch(AbstractHttp11Processor.java:1711)
	at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:666)
	at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.doRun(AprEndpoint.java:2527)
	at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:2516)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
	at java.lang.Thread.run(Thread.java:748)
26-Apr-2018 08:51:54.986 INFO [http-apr-127.0.0.1-auto-4-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onError AsyncListener.onError
26-Apr-2018 08:51:54.993 INFO [http-apr-127.0.0.1-auto-4-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onComplete onComplete
26-Apr-2018 08:51:55.004 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read 329296 bytes
26-Apr-2018 08:51:55.005 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-4-59905"]
26-Apr-2018 08:51:55.006 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service Tomcat
26-Apr-2018 08:51:55.016 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-4-59905"]
26-Apr-2018 08:51:55.082 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-4-59905"]
26-Apr-2018 08:51:55.091 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingReadIgnoreIsReady]
26-Apr-2018 08:51:55.094 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.17 using APR version 1.6.4.
26-Apr-2018 08:51:55.094 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
26-Apr-2018 08:51:55.095 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2p-dev  xx XXX xxxx)
26-Apr-2018 08:51:55.096 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-5"]
26-Apr-2018 08:51:55.097 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat
26-Apr-2018 08:51:55.097 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.52-dev
26-Apr-2018 08:51:55.125 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-5-41759"]
26-Apr-2018 08:51:55.139 INFO [http-apr-127.0.0.1-auto-5-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onError ReadListener.onError

Continuation...

java.lang.IllegalStateException: In non-blocking mode you may not read from the ServletInputStream until the previous read has completed and isReady() returns true
	at org.apache.catalina.connector.CoyoteInputStream.checkNonBlockingRead(CoyoteInputStream.java:255)
	at org.apache.catalina.connector.CoyoteInputStream.read(CoyoteInputStream.java:130)
	at org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable(TestNonBlockingAPI.java:583)
	at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:342)
	at org.apache.coyote.http11.AbstractHttp11Processor.asyncDispatch(AbstractHttp11Processor.java:1754)
	at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:655)
	at org.apache.tomcat.util.net.AprEndpoint$SocketWithOptionsProcessor.run(AprEndpoint.java:2464)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
	at java.lang.Thread.run(Thread.java:748)
java.io.IOException: Error writing request body to server
	at sun.net.www.protocol.http.HttpURLConnection$StreamingOutputStream.checkError(HttpURLConnection.java:3536)
	at sun.net.www.protocol.http.HttpURLConnection$StreamingOutputStream.write(HttpURLConnection.java:3519)
	at sun.net.www.protocol.http.HttpURLConnection$StreamingOutputStream.write(HttpURLConnection.java:3514)
	at org.apache.catalina.startup.TomcatBaseTest.postUrl(TomcatBaseTest.java:771)
	at org.apache.catalina.nonblocking.TestNonBlockingAPI.doTestNonBlockingRead(TestNonBlockingAPI.java:125)
	at org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingReadIgnoreIsReady(TestNonBlockingAPI.java:107)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:59)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:61)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
	at org.junit.internal.runners.statements.ExpectException.evaluate(ExpectException.java:19)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:61)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:346)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:311)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:76)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:309)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:63)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:289)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:393)
	at junit.framework.JUnit4TestAdapter.run(JUnit4TestAdapter.java:48)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:534)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:1196)
	at org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:1041)
	Suppressed: java.io.IOException: insufficient data written
		at sun.net.www.protocol.http.HttpURLConnection$StreamingOutputStream.close(HttpURLConnection.java:3558)
		at org.apache.catalina.startup.TomcatBaseTest.postUrl(TomcatBaseTest.java:774)
		... 30 more
26-Apr-2018 08:51:56.646 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-5-41759"]
26-Apr-2018 08:51:56.699 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service Tomcat
26-Apr-2018 08:51:56.705 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-5-41759"]
26-Apr-2018 08:51:56.758 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-5-41759"]
26-Apr-2018 08:51:56.765 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingWrite]
26-Apr-2018 08:51:56.766 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.17 using APR version 1.6.4.
26-Apr-2018 08:51:56.766 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
26-Apr-2018 08:51:56.767 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2p-dev  xx XXX xxxx)
26-Apr-2018 08:51:56.768 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-6"]
26-Apr-2018 08:51:56.768 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service Tomcat
26-Apr-2018 08:51:56.768 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.52-dev
26-Apr-2018 08:51:56.782 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-6-35274"]
26-Apr-2018 08:51:56.790 INFO [http-apr-127.0.0.1-auto-6-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead
26-Apr-2018 08:51:56.793 INFO [http-apr-127.0.0.1-auto-6-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=0 after=1048576
26-Apr-2018 08:51:56.795 INFO [http-apr-127.0.0.1-auto-6-exec-2] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=1048576 after=2097152
26-Apr-2018 08:51:56.796 INFO [http-apr-127.0.0.1-auto-6-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=2097152 after=3145728
26-Apr-2018 08:51:56.874 INFO [http-apr-127.0.0.1-auto-6-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=3145728 after=4194304
26-Apr-2018 08:51:56.876 INFO [http-apr-127.0.0.1-auto-6-exec-5] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=4194304 after=5242880
26-Apr-2018 08:51:56.914 INFO [http-apr-127.0.0.1-auto-6-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=5242880 after=6291456
26-Apr-2018 08:51:56.946 INFO [http-apr-127.0.0.1-auto-6-exec-7] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=6291456 after=7340032
26-Apr-2018 08:51:56.948 INFO [http-apr-127.0.0.1-auto-6-exec-8] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 1 ms. Bytes before=7340032 after=8388608
26-Apr-2018 08:51:56.987 INFO [http-apr-127.0.0.1-auto-6-exec-9] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 2 ms. Bytes before=8388608 after=9437184
26-Apr-2018 08:51:57.297 INFO [http-apr-127.0.0.1-auto-6-exec-10] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 2 ms. Bytes before=9437184 after=10485760
26-Apr-2018 08:51:57.800 INFO [http-apr-127.0.0.1-auto-6-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 0 ms. Bytes before=10485760 after=10485760
26-Apr-2018 08:51:57.800 INFO [http-apr-127.0.0.1-auto-6-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onComplete onComplete
26-Apr-2018 08:52:04.376 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Client read 10486362 bytes
26-Apr-2018 08:52:04.377 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.377 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 137, End: 204938
26-Apr-2018 08:52:04.378 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqponml0zyxwvutsrqponml1
26-Apr-2018 08:52:04.378 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.378 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 204946, End: 409747
26-Apr-2018 08:52:04.379 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqpo3200zyxwvutsrqpo3201
26-Apr-2018 08:52:04.379 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.379 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 409755, End: 614556
26-Apr-2018 08:52:04.379 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqpo6400zyxwvutsrqpo6401
26-Apr-2018 08:52:04.379 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.380 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 614564, End: 819365
26-Apr-2018 08:52:04.380 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqpo9600zyxwvutsrqpo9601
26-Apr-2018 08:52:04.380 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.381 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 819373, End: 1024174
26-Apr-2018 08:52:04.381 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqpoC800zyxwvutsrqpoC801
26-Apr-2018 08:52:04.382 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.382 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 1024182, End: 1228983
26-Apr-2018 08:52:04.382 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqpoFA00zyxwvutsrqpoFA01
26-Apr-2018 08:52:04.382 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.383 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 1228991, End: 1433792
26-Apr-2018 08:52:04.383 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp12C00zyxwvutsrqp12C01
26-Apr-2018 08:52:04.383 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.384 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 1433800, End: 1638601
26-Apr-2018 08:52:04.384 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp15E00zyxwvutsrqp15E01
26-Apr-2018 08:52:04.384 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.384 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 1638609, End: 1843410
26-Apr-2018 08:52:04.385 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp19000zyxwvutsrqp19001
26-Apr-2018 08:52:04.385 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.385 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 1843418, End: 2048219
26-Apr-2018 08:52:04.386 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp1C200zyxwvutsrqp1C201
26-Apr-2018 08:52:04.386 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.387 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 2048227, End: 2253028
26-Apr-2018 08:52:04.387 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp1F400zyxwvutsrqp1F401
26-Apr-2018 08:52:04.387 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.388 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 2253036, End: 2457837
26-Apr-2018 08:52:04.388 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp22600zyxwvutsrqp22601
26-Apr-2018 08:52:04.388 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.388 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 2457845, End: 2662646
26-Apr-2018 08:52:04.389 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp25800zyxwvutsrqp25801
26-Apr-2018 08:52:04.389 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.389 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 2662654, End: 2867455
26-Apr-2018 08:52:04.390 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp28A00zyxwvutsrqp28A01
26-Apr-2018 08:52:04.390 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.390 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 2867463, End: 3072264
26-Apr-2018 08:52:04.391 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp2BC00zyxwvutsrqp2BC01
26-Apr-2018 08:52:04.391 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.391 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 3072272, End: 3277073
26-Apr-2018 08:52:04.392 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp2EE00zyxwvutsrqp2EE01
26-Apr-2018 08:52:04.392 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.392 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 3277081, End: 3481882
26-Apr-2018 08:52:04.392 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp32000zyxwvutsrqp32001
26-Apr-2018 08:52:04.393 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.393 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 3481890, End: 3686691
26-Apr-2018 08:52:04.393 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp35200zyxwvutsrqp35201
26-Apr-2018 08:52:04.393 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.394 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 3686699, End: 3891500
26-Apr-2018 08:52:04.394 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp38400zyxwvutsrqp38401
26-Apr-2018 08:52:04.394 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.394 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 3891508, End: 4096309
26-Apr-2018 08:52:04.395 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp3B600zyxwvutsrqp3B601
26-Apr-2018 08:52:04.395 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.396 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 4096317, End: 4301118
26-Apr-2018 08:52:04.396 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp3E800zyxwvutsrqp3E801
26-Apr-2018 08:52:04.396 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.396 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 4301126, End: 4505927
26-Apr-2018 08:52:04.397 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp41A00zyxwvutsrqp41A01
26-Apr-2018 08:52:04.397 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.397 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 4505935, End: 4710736
26-Apr-2018 08:52:04.398 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp44C00zyxwvutsrqp44C01
26-Apr-2018 08:52:04.398 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.398 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 4710744, End: 4915545
26-Apr-2018 08:52:04.398 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp47E00zyxwvutsrqp47E01
26-Apr-2018 08:52:04.398 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.399 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 4915553, End: 5120354
26-Apr-2018 08:52:04.399 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp4B000zyxwvutsrqp4B001
26-Apr-2018 08:52:04.399 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.399 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 5120362, End: 5325163
26-Apr-2018 08:52:04.400 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp4E200zyxwvutsrqp4E201
26-Apr-2018 08:52:04.400 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.401 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 5325171, End: 5529972
26-Apr-2018 08:52:04.401 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp51400zyxwvutsrqp51401
26-Apr-2018 08:52:04.401 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.401 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 5529980, End: 5734781
26-Apr-2018 08:52:04.402 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp54600zyxwvutsrqp54601
26-Apr-2018 08:52:04.402 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]

Continuation...

26-Apr-2018 08:52:04.402 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 5734789, End: 5939590
26-Apr-2018 08:52:04.402 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp57800zyxwvutsrqp57801
26-Apr-2018 08:52:04.402 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.403 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 5939598, End: 6144399
26-Apr-2018 08:52:04.403 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp5AA00zyxwvutsrqp5AA01
26-Apr-2018 08:52:04.403 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.403 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 6144407, End: 6349208
26-Apr-2018 08:52:04.404 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp5DC00zyxwvutsrqp5DC01
26-Apr-2018 08:52:04.404 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.405 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 6349216, End: 6554017
26-Apr-2018 08:52:04.405 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp60E00zyxwvutsrqp60E01
26-Apr-2018 08:52:04.405 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.405 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 6554025, End: 6758826
26-Apr-2018 08:52:04.406 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp64000zyxwvutsrqp64001
26-Apr-2018 08:52:04.406 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.406 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 6758834, End: 6963635
26-Apr-2018 08:52:04.406 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp67200zyxwvutsrqp67201
26-Apr-2018 08:52:04.407 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.407 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 6963643, End: 7168444
26-Apr-2018 08:52:04.408 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp6A400zyxwvutsrqp6A401
26-Apr-2018 08:52:04.408 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.408 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 7168452, End: 7373253
26-Apr-2018 08:52:04.408 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp6D600zyxwvutsrqp6D601
26-Apr-2018 08:52:04.408 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.409 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 7373261, End: 7578062
26-Apr-2018 08:52:04.409 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp70800zyxwvutsrqp70801
26-Apr-2018 08:52:04.409 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.409 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 7578070, End: 7782871
26-Apr-2018 08:52:04.410 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp73A00zyxwvutsrqp73A01
26-Apr-2018 08:52:04.410 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.410 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 7782879, End: 7987680
26-Apr-2018 08:52:04.410 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp76C00zyxwvutsrqp76C01
26-Apr-2018 08:52:04.410 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.411 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 7987688, End: 8192489
26-Apr-2018 08:52:04.412 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp79E00zyxwvutsrqp79E01
26-Apr-2018 08:52:04.412 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.412 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 8192497, End: 8397298
26-Apr-2018 08:52:04.412 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp7D000zyxwvutsrqp7D001
26-Apr-2018 08:52:04.413 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.413 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 8397306, End: 8602107
26-Apr-2018 08:52:04.413 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp80200zyxwvutsrqp80201
26-Apr-2018 08:52:04.413 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.414 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 8602115, End: 8806916
26-Apr-2018 08:52:04.414 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp83400zyxwvutsrqp83401
26-Apr-2018 08:52:04.414 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.414 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 8806924, End: 9011725
26-Apr-2018 08:52:04.415 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp86600zyxwvutsrqp86601
26-Apr-2018 08:52:04.415 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.415 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 9011733, End: 9216534
26-Apr-2018 08:52:04.416 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp89800zyxwvutsrqp89801
26-Apr-2018 08:52:04.416 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.416 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 9216542, End: 9421343
26-Apr-2018 08:52:04.416 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp8CA00zyxwvutsrqp8CA01
26-Apr-2018 08:52:04.416 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.417 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 9421351, End: 9626152
26-Apr-2018 08:52:04.417 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp8FC00zyxwvutsrqp8FC01
26-Apr-2018 08:52:04.417 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.417 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 9626160, End: 9830961
26-Apr-2018 08:52:04.418 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp92E00zyxwvutsrqp92E01
26-Apr-2018 08:52:04.418 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.418 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 9830969, End: 10035770
26-Apr-2018 08:52:04.418 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp96000zyxwvutsrqp96001
26-Apr-2018 08:52:04.419 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.419 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 10035778, End: 10240579
26-Apr-2018 08:52:04.420 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp99200zyxwvutsrqp99201
26-Apr-2018 08:52:04.420 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [32000]
26-Apr-2018 08:52:04.420 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 10240587, End: 10445388
26-Apr-2018 08:52:04.420 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp9C400zyxwvutsrqp9C401
26-Apr-2018 08:52:04.420 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [a000]
26-Apr-2018 08:52:04.421 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 10445395, End: 10486356
26-Apr-2018 08:52:04.421 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite zyxwvutsrqp9F600zyxwvutsrqp9F601
26-Apr-2018 08:52:04.421 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite [0]
26-Apr-2018 08:52:04.421 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite Start : 10486360, End: 10486361
26-Apr-2018 08:52:04.421 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWrite 

26-Apr-2018 08:52:04.421 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-6-35274"]
26-Apr-2018 08:52:04.422 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service Tomcat
26-Apr-2018 08:52:04.426 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-6-35274"]
26-Apr-2018 08:52:04.478 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-6-35274"]
------------- ---------------- ---------------

Testcase: testBug55438NonBlockingReadWriteEmptyRead took 4.904 sec
Testcase: testDelayedNBWrite took 0 sec
	SKIPPED
Testcase: testNonBlockingReadWithDispathch took 2.183 sec
Testcase: testNonBlockingRead took 5.085 sec
Testcase: testNonBlockingWriteError took 0.678 sec
Testcase: testNonBlockingReadIgnoreIsReady took 1.674 sec
Testcase: testNonBlockingWrite took 7.718 sec

Apache Gump, Gump, Apache, the Apache feather logo, and the Apache Gump project logos are trademarks of The Apache Software Foundation.

Last Updated: Thu, 26 Apr 2018 06:00:06 ().Python Logo