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: 9, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 84.406 sec
------------- Standard Error -----------------
java.util.logging.ErrorManager: 0: Unable to delete log files older than [90] days
java.util.logging.ErrorManager: 0: Unable to delete log files older than [90] days
java.util.logging.ErrorManager: 0: Unable to delete log files older than [90] days
java.util.logging.ErrorManager: 0: Unable to delete log files older than [90] days
05-Aug-2020 19:11:08.499 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testBug55438NonBlockingReadWriteEmptyRead]
05-Aug-2020 19:11:08.866 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:08.867 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:08.875 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:09.487 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-1"]
05-Aug-2020 19:11:09.543 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:09.544 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:09.858 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-1-41463"]
05-Aug-2020 19:11:10.067 INFO [http-apr-127.0.0.1-auto-1-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadWriteListener.onAllDataRead onAllDataRead
05-Aug-2020 19:11:10.073 INFO [http-apr-127.0.0.1-auto-1-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadWriteListener$1.onWritePossible Writing []
05-Aug-2020 19:11:10.089 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-1-41463"]
05-Aug-2020 19:11:10.091 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:11:10.124 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-1-41463"]
05-Aug-2020 19:11:10.179 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-1-41463"]
05-Aug-2020 19:11:10.202 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingRead]
05-Aug-2020 19:11:10.222 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:10.230 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:10.231 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:10.236 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-2"]
05-Aug-2020 19:11:10.238 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:10.238 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:10.256 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-2-34621"]
05-Aug-2020 19:11:10.279 INFO [http-apr-127.0.0.1-auto-2-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
05-Aug-2020 19:11:10.773 INFO [http-apr-127.0.0.1-auto-2-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
05-Aug-2020 19:11:11.271 INFO [http-apr-127.0.0.1-auto-2-exec-2] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
05-Aug-2020 19:11:11.771 INFO [http-apr-127.0.0.1-auto-2-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable WANTMORE
05-Aug-2020 19:11:12.272 INFO [http-apr-127.0.0.1-auto-2-exec-5] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable FINISHED
05-Aug-2020 19:11:12.272 INFO [http-apr-127.0.0.1-auto-2-exec-5] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead totalData=40
05-Aug-2020 19:11:12.273 INFO [http-apr-127.0.0.1-auto-2-exec-5] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBReadServlet$1.onComplete onComplete
05-Aug-2020 19:11:12.286 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-2-34621"]
05-Aug-2020 19:11:12.292 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:11:12.297 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-2-34621"]
05-Aug-2020 19:11:12.353 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-2-34621"]
05-Aug-2020 19:11:12.361 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingWriteWithKeepAlive]
05-Aug-2020 19:11:12.372 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:12.373 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:12.373 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:12.375 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-3"]
05-Aug-2020 19:11:12.376 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:12.376 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:12.387 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-3-34697"]
05-Aug-2020 19:11:12.429 INFO [http-apr-127.0.0.1-auto-3-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead totalData=0
05-Aug-2020 19:11:12.431 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:12.437 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 656192 bytes, pause 500ms
05-Aug-2020 19:11:12.442 INFO [http-apr-127.0.0.1-auto-3-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 12 ms. Bytes before=0 after=1048576
05-Aug-2020 19:11:12.478 INFO [http-apr-127.0.0.1-auto-3-exec-2] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 5 ms. Bytes before=1048576 after=2097152
05-Aug-2020 19:11:12.488 INFO [http-apr-127.0.0.1-auto-3-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 5 ms. Bytes before=2097152 after=3145728
05-Aug-2020 19:11:12.529 INFO [http-apr-127.0.0.1-auto-3-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 5 ms. Bytes before=3145728 after=4194304
05-Aug-2020 19:11:12.537 INFO [http-apr-127.0.0.1-auto-3-exec-5] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 5 ms. Bytes before=4194304 after=5242880
05-Aug-2020 19:11:12.563 INFO [http-apr-127.0.0.1-auto-3-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=5242880 after=6291456
05-Aug-2020 19:11:12.603 INFO [http-apr-127.0.0.1-auto-3-exec-7] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=6291456 after=7340032
05-Aug-2020 19:11:12.608 INFO [http-apr-127.0.0.1-auto-3-exec-8] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=7340032 after=8388608
05-Aug-2020 19:11:12.691 INFO [http-apr-127.0.0.1-auto-3-exec-9] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=8388608 after=9437184
05-Aug-2020 19:11:12.938 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:12.942 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:12.947 INFO [http-apr-127.0.0.1-auto-3-exec-10] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 5 ms. Bytes before=9437184 after=10485760
05-Aug-2020 19:11:13.443 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:13.447 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:13.448 INFO [http-apr-127.0.0.1-auto-3-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 0 ms. Bytes before=10485760 after=10485760
05-Aug-2020 19:11:13.448 INFO [http-apr-127.0.0.1-auto-3-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onComplete onComplete
05-Aug-2020 19:11:13.948 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:13.950 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:14.451 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:14.458 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:14.959 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:14.962 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:15.462 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:15.465 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:15.965 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:15.968 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:16.468 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:16.471 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:16.971 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:16.979 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:17.479 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:17.482 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:17.982 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:17.984 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:18.485 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:18.488 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:18.989 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:18.991 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:19.491 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:19.494 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:11:19.994 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:11:20.044 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Client read 10486333 bytes
05-Aug-2020 19:11:20.045 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.045 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 108, End: 204909
05-Aug-2020 19:11:20.045 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqponml0zyxwvutsrqponml1
05-Aug-2020 19:11:20.046 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.046 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 204917, End: 409718
05-Aug-2020 19:11:20.046 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpo3200zyxwvutsrqpo3201
05-Aug-2020 19:11:20.046 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.047 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 409726, End: 614527
05-Aug-2020 19:11:20.047 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpo6400zyxwvutsrqpo6401
05-Aug-2020 19:11:20.047 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.048 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 614535, End: 819336
05-Aug-2020 19:11:20.048 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpo9600zyxwvutsrqpo9601
05-Aug-2020 19:11:20.048 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.048 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 819344, End: 1024145
05-Aug-2020 19:11:20.049 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpoC800zyxwvutsrqpoC801
05-Aug-2020 19:11:20.049 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.049 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1024153, End: 1228954
05-Aug-2020 19:11:20.050 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpoFA00zyxwvutsrqpoFA01
05-Aug-2020 19:11:20.050 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.050 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1228962, End: 1433763
05-Aug-2020 19:11:20.050 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp12C00zyxwvutsrqp12C01
05-Aug-2020 19:11:20.051 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.051 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1433771, End: 1638572
05-Aug-2020 19:11:20.051 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp15E00zyxwvutsrqp15E01
05-Aug-2020 19:11:20.052 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.052 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1638580, End: 1843381
05-Aug-2020 19:11:20.052 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp19000zyxwvutsrqp19001
05-Aug-2020 19:11:20.052 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.053 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1843389, End: 2048190
05-Aug-2020 19:11:20.053 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp1C200zyxwvutsrqp1C201
05-Aug-2020 19:11:20.053 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.054 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2048198, End: 2252999
05-Aug-2020 19:11:20.054 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp1F400zyxwvutsrqp1F401
05-Aug-2020 19:11:20.054 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.054 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2253007, End: 2457808
05-Aug-2020 19:11:20.055 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp22600zyxwvutsrqp22601
05-Aug-2020 19:11:20.055 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.055 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2457816, End: 2662617
05-Aug-2020 19:11:20.056 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp25800zyxwvutsrqp25801
05-Aug-2020 19:11:20.056 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.056 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2662625, End: 2867426
05-Aug-2020 19:11:20.057 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp28A00zyxwvutsrqp28A01
05-Aug-2020 19:11:20.057 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.057 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2867434, End: 3072235
05-Aug-2020 19:11:20.057 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp2BC00zyxwvutsrqp2BC01

Continuation...

05-Aug-2020 19:11:20.058 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.058 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3072243, End: 3277044
05-Aug-2020 19:11:20.058 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp2EE00zyxwvutsrqp2EE01
05-Aug-2020 19:11:20.059 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.059 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3277052, End: 3481853
05-Aug-2020 19:11:20.059 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp32000zyxwvutsrqp32001
05-Aug-2020 19:11:20.059 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.060 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3481861, End: 3686662
05-Aug-2020 19:11:20.060 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp35200zyxwvutsrqp35201
05-Aug-2020 19:11:20.060 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.061 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3686670, End: 3891471
05-Aug-2020 19:11:20.061 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp38400zyxwvutsrqp38401
05-Aug-2020 19:11:20.061 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.061 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3891479, End: 4096280
05-Aug-2020 19:11:20.062 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp3B600zyxwvutsrqp3B601
05-Aug-2020 19:11:20.062 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.062 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4096288, End: 4301089
05-Aug-2020 19:11:20.063 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp3E800zyxwvutsrqp3E801
05-Aug-2020 19:11:20.063 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.063 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4301097, End: 4505898
05-Aug-2020 19:11:20.064 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp41A00zyxwvutsrqp41A01
05-Aug-2020 19:11:20.064 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.064 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4505906, End: 4710707
05-Aug-2020 19:11:20.064 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp44C00zyxwvutsrqp44C01
05-Aug-2020 19:11:20.065 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.065 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4710715, End: 4915516
05-Aug-2020 19:11:20.065 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp47E00zyxwvutsrqp47E01
05-Aug-2020 19:11:20.066 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.066 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4915524, End: 5120325
05-Aug-2020 19:11:20.066 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp4B000zyxwvutsrqp4B001
05-Aug-2020 19:11:20.066 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.067 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5120333, End: 5325134
05-Aug-2020 19:11:20.067 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp4E200zyxwvutsrqp4E201
05-Aug-2020 19:11:20.067 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.068 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5325142, End: 5529943
05-Aug-2020 19:11:20.068 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp51400zyxwvutsrqp51401
05-Aug-2020 19:11:20.068 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.068 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5529951, End: 5734752
05-Aug-2020 19:11:20.069 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp54600zyxwvutsrqp54601
05-Aug-2020 19:11:20.069 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.069 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5734760, End: 5939561
05-Aug-2020 19:11:20.070 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp57800zyxwvutsrqp57801
05-Aug-2020 19:11:20.070 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.070 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5939569, End: 6144370
05-Aug-2020 19:11:20.075 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp5AA00zyxwvutsrqp5AA01
05-Aug-2020 19:11:20.076 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.080 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6144378, End: 6349179
05-Aug-2020 19:11:20.080 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp5DC00zyxwvutsrqp5DC01
05-Aug-2020 19:11:20.081 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.081 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6349187, End: 6553988
05-Aug-2020 19:11:20.082 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp60E00zyxwvutsrqp60E01
05-Aug-2020 19:11:20.082 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.083 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6553996, End: 6758797
05-Aug-2020 19:11:20.084 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp64000zyxwvutsrqp64001
05-Aug-2020 19:11:20.084 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.088 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6758805, End: 6963606
05-Aug-2020 19:11:20.089 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp67200zyxwvutsrqp67201
05-Aug-2020 19:11:20.089 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.090 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6963614, End: 7168415
05-Aug-2020 19:11:20.090 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp6A400zyxwvutsrqp6A401
05-Aug-2020 19:11:20.091 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.091 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7168423, End: 7373224
05-Aug-2020 19:11:20.092 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp6D600zyxwvutsrqp6D601
05-Aug-2020 19:11:20.092 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.093 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7373232, End: 7578033
05-Aug-2020 19:11:20.093 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp70800zyxwvutsrqp70801
05-Aug-2020 19:11:20.094 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.095 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7578041, End: 7782842
05-Aug-2020 19:11:20.095 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp73A00zyxwvutsrqp73A01
05-Aug-2020 19:11:20.095 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.096 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7782850, End: 7987651
05-Aug-2020 19:11:20.097 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp76C00zyxwvutsrqp76C01
05-Aug-2020 19:11:20.097 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.098 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7987659, End: 8192460
05-Aug-2020 19:11:20.098 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp79E00zyxwvutsrqp79E01
05-Aug-2020 19:11:20.098 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.099 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8192468, End: 8397269
05-Aug-2020 19:11:20.100 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp7D000zyxwvutsrqp7D001
05-Aug-2020 19:11:20.100 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.101 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8397277, End: 8602078
05-Aug-2020 19:11:20.101 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp80200zyxwvutsrqp80201
05-Aug-2020 19:11:20.103 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.103 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8602086, End: 8806887
05-Aug-2020 19:11:20.104 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp83400zyxwvutsrqp83401
05-Aug-2020 19:11:20.104 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.105 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8806895, End: 9011696
05-Aug-2020 19:11:20.106 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp86600zyxwvutsrqp86601
05-Aug-2020 19:11:20.106 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.107 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9011704, End: 9216505
05-Aug-2020 19:11:20.107 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp89800zyxwvutsrqp89801
05-Aug-2020 19:11:20.108 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.108 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9216513, End: 9421314
05-Aug-2020 19:11:20.109 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp8CA00zyxwvutsrqp8CA01
05-Aug-2020 19:11:20.109 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.110 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9421322, End: 9626123
05-Aug-2020 19:11:20.110 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp8FC00zyxwvutsrqp8FC01
05-Aug-2020 19:11:20.111 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.112 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9626131, End: 9830932
05-Aug-2020 19:11:20.112 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp92E00zyxwvutsrqp92E01
05-Aug-2020 19:11:20.112 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.113 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9830940, End: 10035741
05-Aug-2020 19:11:20.114 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp96000zyxwvutsrqp96001
05-Aug-2020 19:11:20.114 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.115 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10035749, End: 10240550
05-Aug-2020 19:11:20.115 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp99200zyxwvutsrqp99201
05-Aug-2020 19:11:20.116 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:11:20.116 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10240558, End: 10445359
05-Aug-2020 19:11:20.117 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp9C400zyxwvutsrqp9C401
05-Aug-2020 19:11:20.117 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [a000]
05-Aug-2020 19:11:20.117 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10445366, End: 10486327
05-Aug-2020 19:11:20.118 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp9F600zyxwvutsrqp9F601
05-Aug-2020 19:11:20.118 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [0]
05-Aug-2020 19:11:20.119 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10486331, End: 10486332
05-Aug-2020 19:11:20.119 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal 

05-Aug-2020 19:11:20.120 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-3-34697"]
05-Aug-2020 19:11:20.121 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:11:20.126 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-3-34697"]
05-Aug-2020 19:11:20.185 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-3-34697"]
05-Aug-2020 19:11:20.191 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingReadWithDispatch]
05-Aug-2020 19:11:20.196 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:20.197 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:20.197 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:20.199 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-4"]
05-Aug-2020 19:11:20.200 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:20.201 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:20.211 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-4-34165"]
05-Aug-2020 19:11:22.257 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-4-34165"]
05-Aug-2020 19:11:22.264 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:11:22.268 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-4-34165"]
05-Aug-2020 19:11:22.328 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-4-34165"]
05-Aug-2020 19:11:22.333 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingWriteError]
05-Aug-2020 19:11:22.336 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:22.336 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:22.337 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:22.338 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-5"]
05-Aug-2020 19:11:22.339 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:22.340 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:22.351 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-5-36011"]
05-Aug-2020 19:11:22.362 INFO [http-apr-127.0.0.1-auto-5-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead totalData=0
05-Aug-2020 19:11:22.367 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [9] ms
05-Aug-2020 19:11:22.367 INFO [http-apr-127.0.0.1-auto-5-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=0 after=1048576

Continuation...

05-Aug-2020 19:11:22.367 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.367 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.368 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.368 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.368 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.368 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.370 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.370 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.371 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.371 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.371 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.371 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.372 INFO [http-apr-127.0.0.1-auto-5-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=1048576 after=2097152
05-Aug-2020 19:11:22.374 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [3] ms
05-Aug-2020 19:11:22.375 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.375 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.375 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.376 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [1] ms
05-Aug-2020 19:11:22.376 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.376 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.376 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.380 INFO [http-apr-127.0.0.1-auto-5-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 5 ms. Bytes before=2097152 after=3145728
05-Aug-2020 19:11:22.384 INFO [http-apr-127.0.0.1-auto-5-exec-5] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=3145728 after=4194304
05-Aug-2020 19:11:22.423 INFO [http-apr-127.0.0.1-auto-5-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 4 ms. Bytes before=4194304 after=5242880
05-Aug-2020 19:11:22.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [1] ms
05-Aug-2020 19:11:22.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [0] ms
05-Aug-2020 19:11:22.881 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read [8192] bytes in [1] ms
05-Aug-2020 19:11:22.891 INFO [http-apr-127.0.0.1-auto-5-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onError ReadListener.onError totalData=0
java.io.IOException: Unexpected error [104] writing data to the APR/native socket [139,952,515,989,392] with wrapper [org.apache.tomcat.util.net.AprEndpoint$AprSocketWrapper@49538ddf:139952515989392].
	at org.apache.tomcat.util.net.AprEndpoint$AprSocketWrapper.doWriteInternal(AprEndpoint.java:2334)
	at org.apache.tomcat.util.net.AprEndpoint$AprSocketWrapper.doWrite(AprEndpoint.java:2261)
	at org.apache.tomcat.util.net.SocketWrapperBase.doWrite(SocketWrapperBase.java:734)
	at org.apache.tomcat.util.net.SocketWrapperBase.flushNonBlocking(SocketWrapperBase.java:705)
	at org.apache.tomcat.util.net.SocketWrapperBase.flush(SocketWrapperBase.java:679)
	at org.apache.coyote.http11.Http11OutputBuffer.flushBuffer(Http11OutputBuffer.java:480)
	at org.apache.coyote.http11.Http11Processor.flushBufferedWrite(Http11Processor.java:1067)
	at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:202)
	at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:59)
	at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:845)
	at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.doRun(AprEndpoint.java:1997)
	at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
	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)
05-Aug-2020 19:11:22.892 INFO [http-apr-127.0.0.1-auto-5-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onError WriteListener.onError
java.io.IOException: Unexpected error [104] writing data to the APR/native socket [139,952,515,989,392] with wrapper [org.apache.tomcat.util.net.AprEndpoint$AprSocketWrapper@49538ddf:139952515989392].
	at org.apache.tomcat.util.net.AprEndpoint$AprSocketWrapper.doWriteInternal(AprEndpoint.java:2334)
	at org.apache.tomcat.util.net.AprEndpoint$AprSocketWrapper.doWrite(AprEndpoint.java:2261)
	at org.apache.tomcat.util.net.SocketWrapperBase.doWrite(SocketWrapperBase.java:734)
	at org.apache.tomcat.util.net.SocketWrapperBase.flushNonBlocking(SocketWrapperBase.java:705)
	at org.apache.tomcat.util.net.SocketWrapperBase.flush(SocketWrapperBase.java:679)
	at org.apache.coyote.http11.Http11OutputBuffer.flushBuffer(Http11OutputBuffer.java:480)
	at org.apache.coyote.http11.Http11Processor.flushBufferedWrite(Http11Processor.java:1067)
	at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:202)
	at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:59)
	at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:845)
	at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.doRun(AprEndpoint.java:1997)
	at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
	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)
05-Aug-2020 19:11:22.893 INFO [http-apr-127.0.0.1-auto-5-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onError AsyncListener.onError
05-Aug-2020 19:11:22.896 INFO [http-apr-127.0.0.1-auto-5-exec-6] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onComplete onComplete
05-Aug-2020 19:11:22.899 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteError Client read 327680 bytes
05-Aug-2020 19:11:22.903 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-5-36011"]
05-Aug-2020 19:11:22.905 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:11:22.919 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-5-36011"]
05-Aug-2020 19:11:22.974 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-5-36011"]
05-Aug-2020 19:11:22.979 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingReadIgnoreIsReady]
05-Aug-2020 19:11:22.982 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:22.982 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:22.982 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:22.984 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-6"]
05-Aug-2020 19:11:22.986 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:22.989 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:22.999 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-6-38923"]
05-Aug-2020 19:11:23.017 INFO [http-apr-127.0.0.1-auto-6-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onError ReadListener.onError totalData=0
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:213)
	at org.apache.catalina.connector.CoyoteInputStream.read(CoyoteInputStream.java:116)
	at org.apache.catalina.connector.CoyoteInputStream.read(CoyoteInputStream.java:110)
	at org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onDataAvailable(TestNonBlockingAPI.java:629)
	at org.apache.catalina.connector.CoyoteAdapter.asyncDispatch(CoyoteAdapter.java:206)
	at org.apache.coyote.AbstractProcessor.dispatch(AbstractProcessor.java:238)
	at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:52)
	at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:845)
	at org.apache.tomcat.util.net.AprEndpoint$SocketWithOptionsProcessor.run(AprEndpoint.java:1967)
	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)
05-Aug-2020 19:11:23.021 SEVERE [http-apr-127.0.0.1-auto-6-exec-1] org.apache.coyote.AbstractProtocol$ConnectionHandler.process Error reading request, ignored
	java.lang.IllegalStateException: Calling [asyncPostProcess()] is not valid for a request with Async state [ERROR]
		at org.apache.coyote.AsyncStateMachine.asyncPostProcess(AsyncStateMachine.java:290)
		at org.apache.coyote.AbstractProcessor.asyncPostProcess(AbstractProcessor.java:192)
		at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:81)
		at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:845)
		at org.apache.tomcat.util.net.AprEndpoint$SocketWithOptionsProcessor.run(AprEndpoint.java:1967)
		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)
05-Aug-2020 19:11:24.515 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-6-38923"]
05-Aug-2020 19:11:24.522 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:11:26.534 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-6-38923"]
05-Aug-2020 19:11:26.590 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-6-38923"]
05-Aug-2020 19:11:26.600 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingReadAsync]
05-Aug-2020 19:11:26.603 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:11:26.603 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:11:26.603 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:11:26.605 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-7"]
05-Aug-2020 19:11:26.606 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:11:26.606 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:11:26.622 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-7-40481"]
05-Aug-2020 19:12:21.944 INFO [Thread-141717] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead totalData=16000000
05-Aug-2020 19:12:21.956 INFO [Thread-141717] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestAsyncReadListener.onAllDataRead isReadyCount=141614 notReadyCount=99 containerThreadCount=100 nonContainerThreadCount=141614
05-Aug-2020 19:12:21.956 INFO [Thread-141717] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBReadServlet$1.onComplete onComplete
05-Aug-2020 19:12:21.959 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-7-40481"]
05-Aug-2020 19:12:21.965 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:12:21.970 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-7-40481"]
05-Aug-2020 19:12:22.026 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-7-40481"]
05-Aug-2020 19:12:22.030 INFO [main] org.apache.catalina.startup.LoggingBaseTest.setUp Starting test case [testNonBlockingWrite]
05-Aug-2020 19:12:22.033 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.25] using APR version [1.7.0].
05-Aug-2020 19:12:22.033 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
05-Aug-2020 19:12:22.034 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 3.0.0-alpha6-dev ]
05-Aug-2020 19:12:22.035 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-127.0.0.1-auto-8"]
05-Aug-2020 19:12:22.036 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Tomcat]
05-Aug-2020 19:12:22.037 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/10.0.0-M8-dev]
05-Aug-2020 19:12:22.050 INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-127.0.0.1-auto-8-38957"]
05-Aug-2020 19:12:22.092 INFO [http-apr-127.0.0.1-auto-8-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestReadListener.onAllDataRead onAllDataRead totalData=0
05-Aug-2020 19:12:22.094 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:22.104 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 661152 bytes, pause 500ms
05-Aug-2020 19:12:22.106 INFO [http-apr-127.0.0.1-auto-8-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 13 ms. Bytes before=0 after=1048576
05-Aug-2020 19:12:22.123 INFO [http-apr-127.0.0.1-auto-8-exec-2] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 12 ms. Bytes before=1048576 after=2097152
05-Aug-2020 19:12:22.127 INFO [http-apr-127.0.0.1-auto-8-exec-3] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=2097152 after=3145728
05-Aug-2020 19:12:22.194 INFO [http-apr-127.0.0.1-auto-8-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=3145728 after=4194304

Continuation...

05-Aug-2020 19:12:22.198 INFO [http-apr-127.0.0.1-auto-8-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=4194304 after=5242880
05-Aug-2020 19:12:22.201 INFO [http-apr-127.0.0.1-auto-8-exec-4] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=5242880 after=6291456
05-Aug-2020 19:12:22.270 INFO [http-apr-127.0.0.1-auto-8-exec-7] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=6291456 after=7340032
05-Aug-2020 19:12:22.273 INFO [http-apr-127.0.0.1-auto-8-exec-8] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 2 ms. Bytes before=7340032 after=8388608
05-Aug-2020 19:12:22.314 INFO [http-apr-127.0.0.1-auto-8-exec-9] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=8388608 after=9437184
05-Aug-2020 19:12:22.605 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:22.609 INFO [http-apr-127.0.0.1-auto-8-exec-10] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 3 ms. Bytes before=9437184 after=10485760
05-Aug-2020 19:12:22.622 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:23.122 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:23.125 INFO [http-apr-127.0.0.1-auto-8-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$TestWriteListener.onWritePossible Write took: 0 ms. Bytes before=10485760 after=10485760
05-Aug-2020 19:12:23.126 INFO [http-apr-127.0.0.1-auto-8-exec-1] org.apache.catalina.nonblocking.TestNonBlockingAPI$NBWriteServlet$1.onComplete onComplete
05-Aug-2020 19:12:23.125 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:23.627 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:23.635 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:24.136 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:24.139 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:24.640 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:24.643 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:25.143 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:25.153 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:25.654 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:25.656 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:26.157 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:26.159 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:26.660 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:26.662 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:27.163 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:27.166 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:27.666 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:27.668 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:28.169 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:28.192 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:28.693 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:28.696 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:29.197 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:29.199 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Read 663552 bytes, pause 500ms
05-Aug-2020 19:12:29.700 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Reading data
05-Aug-2020 19:12:29.876 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Client read 10486333 bytes
05-Aug-2020 19:12:29.876 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.876 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 108, End: 204909
05-Aug-2020 19:12:29.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqponml0zyxwvutsrqponml1
05-Aug-2020 19:12:29.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.877 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 204917, End: 409718
05-Aug-2020 19:12:29.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpo3200zyxwvutsrqpo3201
05-Aug-2020 19:12:29.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 409726, End: 614527
05-Aug-2020 19:12:29.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpo6400zyxwvutsrqpo6401
05-Aug-2020 19:12:29.878 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 614535, End: 819336
05-Aug-2020 19:12:29.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpo9600zyxwvutsrqpo9601
05-Aug-2020 19:12:29.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.879 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 819344, End: 1024145
05-Aug-2020 19:12:29.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpoC800zyxwvutsrqpoC801
05-Aug-2020 19:12:29.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1024153, End: 1228954
05-Aug-2020 19:12:29.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqpoFA00zyxwvutsrqpoFA01
05-Aug-2020 19:12:29.880 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.881 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1228962, End: 1433763
05-Aug-2020 19:12:29.881 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp12C00zyxwvutsrqp12C01
05-Aug-2020 19:12:29.881 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.881 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1433771, End: 1638572
05-Aug-2020 19:12:29.882 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp15E00zyxwvutsrqp15E01
05-Aug-2020 19:12:29.882 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.882 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1638580, End: 1843381
05-Aug-2020 19:12:29.882 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp19000zyxwvutsrqp19001
05-Aug-2020 19:12:29.883 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.883 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 1843389, End: 2048190
05-Aug-2020 19:12:29.883 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp1C200zyxwvutsrqp1C201
05-Aug-2020 19:12:29.883 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.884 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2048198, End: 2252999
05-Aug-2020 19:12:29.884 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp1F400zyxwvutsrqp1F401
05-Aug-2020 19:12:29.884 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.884 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2253007, End: 2457808
05-Aug-2020 19:12:29.885 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp22600zyxwvutsrqp22601
05-Aug-2020 19:12:29.885 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.885 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2457816, End: 2662617
05-Aug-2020 19:12:29.885 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp25800zyxwvutsrqp25801
05-Aug-2020 19:12:29.885 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.886 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2662625, End: 2867426
05-Aug-2020 19:12:29.886 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp28A00zyxwvutsrqp28A01
05-Aug-2020 19:12:29.886 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.886 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 2867434, End: 3072235
05-Aug-2020 19:12:29.890 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp2BC00zyxwvutsrqp2BC01
05-Aug-2020 19:12:29.890 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.890 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3072243, End: 3277044
05-Aug-2020 19:12:29.891 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp2EE00zyxwvutsrqp2EE01
05-Aug-2020 19:12:29.891 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.891 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3277052, End: 3481853
05-Aug-2020 19:12:29.891 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp32000zyxwvutsrqp32001
05-Aug-2020 19:12:29.891 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.892 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3481861, End: 3686662
05-Aug-2020 19:12:29.892 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp35200zyxwvutsrqp35201
05-Aug-2020 19:12:29.892 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.892 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3686670, End: 3891471
05-Aug-2020 19:12:29.893 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp38400zyxwvutsrqp38401
05-Aug-2020 19:12:29.893 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.893 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 3891479, End: 4096280
05-Aug-2020 19:12:29.893 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp3B600zyxwvutsrqp3B601
05-Aug-2020 19:12:29.893 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.894 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4096288, End: 4301089
05-Aug-2020 19:12:29.894 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp3E800zyxwvutsrqp3E801
05-Aug-2020 19:12:29.894 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.894 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4301097, End: 4505898
05-Aug-2020 19:12:29.895 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp41A00zyxwvutsrqp41A01
05-Aug-2020 19:12:29.895 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.895 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4505906, End: 4710707
05-Aug-2020 19:12:29.895 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp44C00zyxwvutsrqp44C01
05-Aug-2020 19:12:29.895 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.896 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4710715, End: 4915516
05-Aug-2020 19:12:29.896 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp47E00zyxwvutsrqp47E01
05-Aug-2020 19:12:29.896 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.896 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 4915524, End: 5120325
05-Aug-2020 19:12:29.897 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp4B000zyxwvutsrqp4B001
05-Aug-2020 19:12:29.897 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.897 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5120333, End: 5325134
05-Aug-2020 19:12:29.897 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp4E200zyxwvutsrqp4E201
05-Aug-2020 19:12:29.897 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.898 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5325142, End: 5529943
05-Aug-2020 19:12:29.898 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp51400zyxwvutsrqp51401
05-Aug-2020 19:12:29.898 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.898 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5529951, End: 5734752
05-Aug-2020 19:12:29.899 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp54600zyxwvutsrqp54601
05-Aug-2020 19:12:29.899 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.899 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5734760, End: 5939561
05-Aug-2020 19:12:29.899 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp57800zyxwvutsrqp57801
05-Aug-2020 19:12:29.900 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.900 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 5939569, End: 6144370
05-Aug-2020 19:12:29.900 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp5AA00zyxwvutsrqp5AA01
05-Aug-2020 19:12:29.900 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.901 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6144378, End: 6349179
05-Aug-2020 19:12:29.902 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp5DC00zyxwvutsrqp5DC01
05-Aug-2020 19:12:29.902 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.904 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6349187, End: 6553988
05-Aug-2020 19:12:29.904 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp60E00zyxwvutsrqp60E01
05-Aug-2020 19:12:29.904 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.905 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6553996, End: 6758797
05-Aug-2020 19:12:29.905 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp64000zyxwvutsrqp64001
05-Aug-2020 19:12:29.905 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.905 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6758805, End: 6963606

Continuation...

05-Aug-2020 19:12:29.906 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp67200zyxwvutsrqp67201
05-Aug-2020 19:12:29.907 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.907 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 6963614, End: 7168415
05-Aug-2020 19:12:29.907 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp6A400zyxwvutsrqp6A401
05-Aug-2020 19:12:29.908 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.919 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7168423, End: 7373224
05-Aug-2020 19:12:29.919 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp6D600zyxwvutsrqp6D601
05-Aug-2020 19:12:29.919 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.920 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7373232, End: 7578033
05-Aug-2020 19:12:29.920 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp70800zyxwvutsrqp70801
05-Aug-2020 19:12:29.920 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.920 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7578041, End: 7782842
05-Aug-2020 19:12:29.921 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp73A00zyxwvutsrqp73A01
05-Aug-2020 19:12:29.921 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.921 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7782850, End: 7987651
05-Aug-2020 19:12:29.921 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp76C00zyxwvutsrqp76C01
05-Aug-2020 19:12:29.922 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.922 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 7987659, End: 8192460
05-Aug-2020 19:12:29.922 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp79E00zyxwvutsrqp79E01
05-Aug-2020 19:12:29.922 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.923 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8192468, End: 8397269
05-Aug-2020 19:12:29.923 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp7D000zyxwvutsrqp7D001
05-Aug-2020 19:12:29.923 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.924 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8397277, End: 8602078
05-Aug-2020 19:12:29.924 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp80200zyxwvutsrqp80201
05-Aug-2020 19:12:29.924 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.924 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8602086, End: 8806887
05-Aug-2020 19:12:29.925 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp83400zyxwvutsrqp83401
05-Aug-2020 19:12:29.925 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.925 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 8806895, End: 9011696
05-Aug-2020 19:12:29.925 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp86600zyxwvutsrqp86601
05-Aug-2020 19:12:29.926 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.926 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9011704, End: 9216505
05-Aug-2020 19:12:29.926 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp89800zyxwvutsrqp89801
05-Aug-2020 19:12:29.926 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.927 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9216513, End: 9421314
05-Aug-2020 19:12:29.927 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp8CA00zyxwvutsrqp8CA01
05-Aug-2020 19:12:29.927 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.927 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9421322, End: 9626123
05-Aug-2020 19:12:29.928 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp8FC00zyxwvutsrqp8FC01
05-Aug-2020 19:12:29.928 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.928 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9626131, End: 9830932
05-Aug-2020 19:12:29.929 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp92E00zyxwvutsrqp92E01
05-Aug-2020 19:12:29.929 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.929 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 9830940, End: 10035741
05-Aug-2020 19:12:29.929 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp96000zyxwvutsrqp96001
05-Aug-2020 19:12:29.930 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.930 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10035749, End: 10240550
05-Aug-2020 19:12:29.930 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp99200zyxwvutsrqp99201
05-Aug-2020 19:12:29.930 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [32000]
05-Aug-2020 19:12:29.931 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10240558, End: 10445359
05-Aug-2020 19:12:29.931 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp9C400zyxwvutsrqp9C401
05-Aug-2020 19:12:29.931 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [a000]
05-Aug-2020 19:12:29.931 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10445366, End: 10486327
05-Aug-2020 19:12:29.931 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal zyxwvutsrqp9F600zyxwvutsrqp9F601
05-Aug-2020 19:12:29.932 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal [0]
05-Aug-2020 19:12:29.932 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal Start : 10486331, End: 10486332
05-Aug-2020 19:12:29.932 INFO [main] org.apache.catalina.nonblocking.TestNonBlockingAPI.testNonBlockingWriteInternal 

05-Aug-2020 19:12:29.932 INFO [main] org.apache.coyote.AbstractProtocol.pause Pausing ProtocolHandler ["http-apr-127.0.0.1-auto-8-38957"]
05-Aug-2020 19:12:29.939 INFO [main] org.apache.catalina.core.StandardService.stopInternal Stopping service [Tomcat]
05-Aug-2020 19:12:29.943 INFO [main] org.apache.coyote.AbstractProtocol.stop Stopping ProtocolHandler ["http-apr-127.0.0.1-auto-8-38957"]
05-Aug-2020 19:12:29.998 INFO [main] org.apache.coyote.AbstractProtocol.destroy Destroying ProtocolHandler ["http-apr-127.0.0.1-auto-8-38957"]
------------- ---------------- ---------------

Testcase: testBug55438NonBlockingReadWriteEmptyRead took 4.506 sec
Testcase: testDelayedNBWrite took 0 sec
	SKIPPED
Testcase: testNonBlockingRead took 2.159 sec
Testcase: testNonBlockingWriteWithKeepAlive took 7.83 sec
Testcase: testNonBlockingReadWithDispatch took 2.142 sec
Testcase: testNonBlockingWriteError took 0.646 sec
Testcase: testNonBlockingReadIgnoreIsReady took 3.62 sec
Testcase: testNonBlockingReadAsync took 55.429 sec
Testcase: testNonBlockingWrite took 7.971 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, 05 Aug 2020 12:00:05 ().Python Logo