https://bz.apache.org/bugzilla/show_bug.cgi?id=62899

--- Comment #2 from Dapeng Zhang <zdap...@google.com> ---
Thank you for the confirmation. I'm not able to reproduce it when turning on
logging in this simple test case either. I can reproduce it in my own project
(which is very complex) though even when turning on logging. I can show you the
logs that I saw. Hope that could help a bit.

Nov 08, 2018 11:20:32 AM io.grpc.servlet.ServletAdapter$GrpcReadListener
onDataAvailable
FINEST: [io.grpc.servlet.ServletAdapter-7] inbound data: length = 4,096, bytes
=
00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000...00000000000000000000000000000000
Nov 08, 2018 11:20:32 AM io.grpc.servlet.ServletAdapter$GrpcReadListener
onDataAvailable
FINEST: [io.grpc.servlet.ServletAdapter-7] inbound data: length = 4,095, bytes
=
00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000...00000000000000000000000000000000
Nov 08, 2018 11:20:32 AM org.apache.tomcat.util.net.SocketWrapperBase
populateReadBuffer
FINE: Socket:
[org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@3cc365d2:org.apache.tomcat.util.net.NioChannel@33ef3bbf:java.nio.channels.SocketChannel[connected
local=/127.0.0.1:38401 remote=/127.0.0.1:46436]], Read from buffer: [8183]
Nov 08, 2018 11:20:32 AM org.apache.coyote.http2.StreamStateMachine stateChange
FINE: Connection [0], Stream [3], State changed from [OPEN] to
[HALF_CLOSED_REMOTE]
Nov 08, 2018 11:20:32 AM org.apache.coyote.http2.Stream$StreamInputBuffer
onDataAvailable
FINE: Data added to inBuffer when read thread is waiting. Signalling that
thread to continue
Nov 08, 2018 11:20:32 AM io.grpc.servlet.ServletAdapter$GrpcReadListener
onDataAvailable
FINEST: [io.grpc.servlet.ServletAdapter-7] thread =
Thread[http-nio-auto-1-exec-4,5,FailOnTimeoutGroup]
Nov 08, 2018 11:20:32 AM org.apache.coyote.http2.Http2UpgradeHandler
upgradeDispatch
FINE: Exit, Connection [0], SocketState [UPGRADED]
Nov 08, 2018 11:20:32 AM io.grpc.servlet.ServletAdapter$GrpcReadListener
onDataAvailable
FINEST: [io.grpc.servlet.ServletAdapter-7] EXIT
Nov 08, 2018 11:20:32 AM org.apache.coyote.AbstractProcessorLight process
FINE: Socket:
[org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@3cc365d2:org.apache.tomcat.util.net.NioChannel@33ef3bbf:java.nio.channels.SocketChannel[connected
local=/127.0.0.1:38401 remote=/127.0.0.1:46436]], Status in: [OPEN_READ], State
out: [UPGRADED]
Nov 08, 2018 11:20:32 AM org.apache.coyote.AbstractProcessorLight process
FINE: Socket:
[org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@3cc365d2:org.apache.tomcat.util.net.NioChannel@33ef3bbf:java.nio.channels.SocketChannel[connected
local=/127.0.0.1:38401 remote=/127.0.0.1:46436]], Status in: [OPEN_READ], State
out: [LONG]
Nov 08, 2018 11:20:32 AM org.apache.coyote.AbstractProcessorLight process
FINE: Socket:
[org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@3cc365d2:org.apache.tomcat.util.net.NioChannel@33ef3bbf:java.nio.channels.SocketChannel[connected
local=/127.0.0.1:38401 remote=/127.0.0.1:46436]], State after async post
processing: [LONG]
Nov 08, 2018 11:20:33 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704833217;
nextExpiration=1541704833216; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:33 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704833258;
nextExpiration=1541704832769; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:34 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704834219;
nextExpiration=1541704834217; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:34 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704834260;
nextExpiration=1541704834258; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:35 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704835220;
nextExpiration=1541704835219; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:35 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704835261;
nextExpiration=1541704835260; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:36 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704836221;
nextExpiration=1541704836220; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:36 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704836263;
nextExpiration=1541704836261; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:37 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704837223;
nextExpiration=1541704837221; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:37 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704837264;
nextExpiration=1541704837263; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:38 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704838224;
nextExpiration=1541704838223; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:38 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704838265;
nextExpiration=1541704838264; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:39 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704839225;
nextExpiration=1541704839224; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:39 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704839267;
nextExpiration=1541704839265; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:40 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704840227;
nextExpiration=1541704840225; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:40 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704840268;
nextExpiration=1541704840267; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:41 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704841228;
nextExpiration=1541704841227; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:41 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704841269;
nextExpiration=1541704841268; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:42 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704842229;
nextExpiration=1541704842228; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:42 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704842271;
nextExpiration=1541704842269; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:43 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704843231;
nextExpiration=1541704843229; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:43 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704843272;
nextExpiration=1541704843271; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:44 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704844232;
nextExpiration=1541704844231; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:44 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704844273;
nextExpiration=1541704844272; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:45 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704845233;
nextExpiration=1541704845232; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:45 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=1; now=1541704845275;
nextExpiration=1541704845273; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:46 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout
FINER: timeout completed: keys processed=0; now=1541704846234;
nextExpiration=1541704846233; keyCount=0; hasEvents=false; eval=false
Nov 08, 2018 11:20:46 AM org.apache.tomcat.util.net.NioEndpoint$Poller timeout

-- 
You are receiving this mail because:
You are the assignee for the bug.
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@tomcat.apache.org
For additional commands, e-mail: dev-h...@tomcat.apache.org

Reply via email to