REST client breaks on high load

[faboweb]

Summary of Bug

Trying to query all delegators of the cosmos hub. We do about 150 requests to /staking/validators/ADDRESS/delegations. Doing this, the node panics and dies. The nodes are run by Figment a trusted infrastructure provider.

Version

Current cosmos hub binary.

Steps to Reproduce

See above.

Logs:

Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: E[2020-04-30|22:45:34.693] Panic in RPC HTTP handler                    module=rpc-server err="writ
e tcp 127.0.0.1:26657->127.0.0.1:57192: i/o timeout" stack="goroutine 12505392 [running]:\nruntime/debug.Stack(0xc02efad370, 0x10af420, 0xc0060c39a0)\n\t/us
r/local/go/src/runtime/debug/stack.go:24 +0x9d\ngithub.com/tendermint/tendermint/rpc/lib/server.RecoverAndLogHandler.func1.1(0xc05e71fe80, 0x15af520, 0xc007
010160, 0xbfa2f1fd8bc85d6a, 0x12474089ef29, 0x1e006a0, 0xc05249fc00)\n\t/home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/htt
p_server.go:161 +0x486\npanic(0x10af420, 0xc0060c39a0)\n\t/usr/local/go/src/runtime/panic.go:679 +0x1b2\ngithub.com/tendermint/tendermint/rpc/lib/server.Wri
teRPCResponseHTTP(0x15a9ae0, 0xc05e71fe80, 0x11d3e39, 0x3, 0x1591c60, 0xc045563d20, 0xc051380c00, 0x11a7, 0x121a, 0x0)\n\t/home/funduk/go/pkg/mod/github.com
/tendermint/tendermint@v0.32.10/rpc/lib/server/http_server.go:112 +0x281\ngithub.com/tendermint/tendermint/rpc/lib/server.WriteRPCResponseArrayHTTP(0x15a9ae
0, 0xc05e71fe80, 0xc051350f40, 0x1, 0x1)\n\t/home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_server.go:121 +0xca\ngithu
b.com/tendermint/tendermint/rpc/lib/server.makeJSONRPCHandler.func1(0x15a9ae0, 0xc05e71fe80, 0xc05249fc00)\n\t/home/funduk/go/pkg/mod/github.com/tendermint/
tendermint@v0.32.10/rpc/lib/server/handlers.go:190 +0x49a\ngithub.com/tendermint/tendermint/rpc/lib/server.handleInvalidJSONRPCPaths.func1(0x15a9ae0, 0xc05e
71fe80, 0xc05249fc00)\n\t/home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/handlers.go:204 +0x9c\nnet/http.HandlerFunc.ServeH
TTP(0xc00abd4cd0, 0x15a9ae0, 0xc05e71fe80, 0xc05249fc00)\n\t/usr/local/go/src/net/http/server.go:2007 +0x44\nnet/http.(*ServeMux).ServeHTTP(0xc00ac58900, 0x
15a9ae0, 0xc05e71fe80, 0xc05249fc00)\n\t/usr/local/go/src/net/http/server.go:2387 +0x1bd\ngithub.com/tendermint/tendermint/rpc/lib/server.maxBytesHandler.Se
rveHTTP(0x1590640, 0xc00ac58900, 0xf4240, 0x15a9ae0, 0xc05e71fe80, 0xc05249fc00)\n\t/home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/li
b/server/http_server.go:210 +0xcf\ngithub.com/tendermint/tendermint/rpc/lib/server.RecoverAndLogHandler.func1(0x15aa1e0, 0xc007bcad20, 0xc05249fc00)\n\t/hom
e/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_server.go:183 +0x33f\nnet/http.HandlerFunc.ServeHTTP(0xc02ae4c450, 0x15aa1
e0, 0xc007bcad20, 0xc05249fc00)\n\t/usr/local/go/src/net/http/server.go:2007 +0x44\nnet/http.serverHandler.ServeHTTP(0xc00ad68000, 0x15aa1e0, 0xc007bcad20, 
0xc05249fc00)\n\t/usr/local/go/src/net/http/server.go:2802 +0xa4\nnet/http.(*conn).serve(0xc01f709040, 0x15aeb20, 0xc061e9f4c0)\n\t/usr/local/go/src/net/htt
p/server.go:1890 +0x875\ncreated by net/http.(*Server).Serve\n\t/usr/local/go/src/net/http/server.go:2927 +0x38e\n"
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: 2020/04/30 22:45:34 http: superfluous response.WriteHeader call from github.com/tendermint/tendermi
nt/rpc/lib/server.(*ResponseWriterWrapper).WriteHeader (http_server.go:195)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: 2020/04/30 22:45:34 http: panic serving 127.0.0.1:57192: write tcp 127.0.0.1:26657->127.0.0.1:57192
: i/o timeout
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: goroutine 12505392 [running]:
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: net/http.(*conn).serve.func1(0xc01f709040)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:1767 +0x139
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: panic(0x10af420, 0xc0060c39a0)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/runtime/panic.go:679 +0x1b2
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.WriteRPCResponseHTTPError(0x15a9ae0, 0xc05e71fe80, 
0x1f4, 0x11d3e39, 0x3, 0x1591c60, 0x1573dd0, 0x0, 0x0, 0x0, ...)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_serve
r.go:100 +0x285
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.RecoverAndLogHandler.func1.1(0xc05e71fe80, 0x15af52
0, 0xc007010160, 0xbfa2f1fd8bc85d6a, 0x12474089ef29, 0x1e006a0, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_serve
r.go:163 +0x672
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: panic(0x10af420, 0xc0060c39a0)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/runtime/panic.go:679 +0x1b2
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.WriteRPCResponseHTTP(0x15a9ae0, 0xc05e71fe80, 0x11d
3e39, 0x3, 0x1591c60, 0xc045563d20, 0xc051380c00, 0x11a7, 0x121a, 0x0)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_serve
r.go:112 +0x281
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.WriteRPCResponseArrayHTTP(0x15a9ae0, 0xc05e71fe80, 
0xc051350f40, 0x1, 0x1)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_serve
r.go:121 +0xca
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.makeJSONRPCHandler.func1(0x15a9ae0, 0xc05e71fe80, 0
xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/handlers.g
o:190 +0x49a
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.handleInvalidJSONRPCPaths.func1(0x15a9ae0, 0xc05e71
fe80, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/handlers.g
o:204 +0x9c
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: net/http.HandlerFunc.ServeHTTP(0xc00abd4cd0, 0x15a9ae0, 0xc05e71fe80, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:2007 +0x44
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: net/http.(*ServeMux).ServeHTTP(0xc00ac58900, 0x15a9ae0, 0xc05e71fe80, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:2387 +0x1bd
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.maxBytesHandler.ServeHTTP(0x1590640, 0xc00ac58900, 
0xf4240, 0x15a9ae0, 0xc05e71fe80, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_serve
r.go:210 +0xcf
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: github.com/tendermint/tendermint/rpc/lib/server.RecoverAndLogHandler.func1(0x15aa1e0, 0xc007bcad20,
 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /home/funduk/go/pkg/mod/github.com/tendermint/tendermint@v0.32.10/rpc/lib/server/http_serve
r.go:183 +0x33f
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: net/http.HandlerFunc.ServeHTTP(0xc02ae4c450, 0x15aa1e0, 0xc007bcad20, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:2007 +0x44
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: net/http.serverHandler.ServeHTTP(0xc00ad68000, 0x15aa1e0, 0xc007bcad20, 0xc05249fc00)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:2802 +0xa4
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: net/http.(*conn).serve(0xc01f709040, 0x15aeb20, 0xc061e9f4c0)
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:1890 +0x875
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: created by net/http.(*Server).Serve
Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]:         /usr/local/go/src/net/http/server.go:2927 +0x38e

---

For Admin Use

• Not duplicate issue
• Appropriate labels applied
• Appropriate contributors tagged
• Contributor assigned/self-assigned

[alexanderbez]

Thanks @faboweb, but this issue doesn't belong in the SDK from what I can tell:

Apr 30 22:45:34 dh--cosmos3--archive-5 gaiad2_0_8[8010]: 2020/04/30 22:45:34 http: panic serving 127.0.0.1:57192: write tcp 127.0.0.1:26657->127.0.0.1:57192
: i/o timeout

It looks infrastructure-related or something in Tendermint's RPC?

[jgimeno]

This looks related to #6105

[alexanderbez]

I don't think /staking/validators/{address}/delegations is paginated. If not, this could very easily be because of the response > 1MB.

I would say that we should comb through all the staking query endpoints, and verify endpoints that need to be paginated. @jgimeno is something you think you can take a look at?

[jgimeno]

I am trying to understand the flow, to see if there is something I can do.

@faboweb you mention you did around 150 calls, everytime with the same address? Or is a specific address the one that panics?

[faboweb]

No that was requesting the delegations of all validators so the requests would be different every time.