Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

panic on estimate gas and eth_call #1858

Closed
arnaubennassar opened this issue Mar 17, 2023 · 5 comments · Fixed by #1917
Closed

panic on estimate gas and eth_call #1858

arnaubennassar opened this issue Mar 17, 2023 · 5 comments · Fixed by #1917
Assignees
@tclemos
Labels
blue-berry bug Something isn't working rpc

Comments

@arnaubennassar
Copy link
Member 

Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2979074,"caller":"state/helper.go:109","msg":"174 1000000000 30000000 0xC737FB62BC0E5a4B4B0609B529308302B446B600 0 36 1","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2979453,"caller":"state/state.go:291","msg":"EstimateGas[processBatchRequest.OldBatchNum]: 52","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.297956,"caller":"state/state.go:293","msg":"EstimateGas[processBatchRequest.From]: 0xf5b17C19B0C15956f6Ae4c8B0785363B24707e76","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2979693,"caller":"state/state.go:294","msg":"EstimateGas[processBatchRequest.OldStateRoot]: 0xbed585f79af62d5459cb617debceda99f659ce060053df9c942d6901387b4a20","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2979836,"caller":"state/state.go:295","msg":"EstimateGas[processBatchRequest.globalExitRoot]: 0xdbbeb412be795ee927c2ed4a9d0288364b18281df97e4ea3e9cc10741af92edb","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2979987,"caller":"state/state.go:296","msg":"EstimateGas[processBatchRequest.OldAccInputHash]: 0x0000000000000000000000000000000000000000000000000000000000000000","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2980092,"caller":"state/state.go:297","msg":"EstimateGas[processBatchRequest.EthTimestamp]: 1679020065","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.298016,"caller":"state/state.go:298","msg":"EstimateGas[processBatchRequest.Coinbase]: 0x85dA99c8a7C2C95964c8EfD687E95E632Fc533D6","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2980235,"caller":"state/state.go:299","msg":"EstimateGas[processBatchRequest.UpdateMerkleTree]: 0","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2980304,"caller":"state/state.go:300","msg":"EstimateGas[processBatchRequest.ChainId]: 1","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2980428,"caller":"state/state.go:301","msg":"EstimateGas[processBatchRequest.ForkId]: 2","pid":102130,"version":"v0.0.3-RC19"}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: {"level":"debug","ts":1679020067.2988417,"caller":"jsonrpc/handler.go:89","msg":"Current open connections 0","pid":102130,"version":"v0.0.3-RC19","method":"eth_estimateGas","requestId":394}
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: 2023/03/17 02:27:47 http: panic serving 10.10.64.96:44668: runtime error: invalid memory address or nil pointer dereference
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: goroutine 2113 [running]:
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: net/http.(*conn).serve.func1()
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:1850 +0xbf
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: panic({0x1411100, 0x24a7f10})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/runtime/panic.go:890 +0x262
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/state.(*State).EstimateGas.func1(0x1c9c380, 0x0)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/state/state.go:305 +0xd23
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/state.(*State).EstimateGas(0xc0001ba100, 0xc0015163c0, {0xf5, 0xb1, 0x7c, 0x19, 0xb0, 0xc1, 0x59, 0x56, ...}, ...)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/state/state.go:343 +0x97a
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).EstimateGas.func1({0x1958528, 0xc000040070}, {0x1962080, 0xc000ccff98})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/jsonrpc/endpoints_eth.go:116 +0x224
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*dbTxManager).NewDbTxScope(0x3?, {0x196dbb0?, 0xc0001ba100?}, 0xc000b16bd0)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/jsonrpc/dbtxmanager.go:20 +0x82
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).EstimateGas(0x4?, 0xc0006001e0?, 0x2?)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/jsonrpc/endpoints_eth.go:100 +0x5d
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: reflect.Value.call({0xc00033a080?, 0xc0000125b0?, 0x55224c?}, {0x15e5276, 0x4}, {0xc0012caf50, 0x3, 0x542485?})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/reflect/value.go:584 +0x8c5
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: reflect.Value.Call({0xc00033a080?, 0xc0000125b0?, 0xf0?}, {0xc0012caf50?, 0xc000ccff38?, 0xf?})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/reflect/value.go:368 +0xbc
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Handler).Handle(0x122?, {{{0xc000c9a9c8, 0x3}, {0x13860e0, 0xc000c9aa10}, {0xc000c9aa40, 0xf}, {0xc00092c1e0, 0xe3, 0xf0}}, ...})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/jsonrpc/handler.go:141 +0xc4b
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handleSingleRequest(0xc0001e6690, 0xc000e1a800, {0x19571f0, 0xc000533260}, {0xc000dcbc00?, 0xe?, 0x40b3880000000000?})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/jsonrpc/server.go:273 +0x1fb
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handle(0xc0001ba000?, {0x19571f0, 0xc000533260}, 0xc000e1a800)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /opt/zkevm-node/jsonrpc/server.go:248 +0x5af
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: net/http.HandlerFunc.ServeHTTP(0xc000c9a945?, {0x19571f0?, 0xc000533260?}, 0xc0002fe2c0?)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:2109 +0x2f
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: github.com/didip/tollbooth/v6.LimitHandler.func1({0x19571f0, 0xc000533260}, 0xc0fd11e8d1636301?)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /root/go/pkg/mod/github.com/didip/tollbooth/v6@v6.1.2/tollbooth.go:311 +0x22c
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: net/http.HandlerFunc.ServeHTTP(0xc000533260?, {0x19571f0?, 0xc000533260?}, 0x15f2786?)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:2109 +0x2f
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: net/http.(*ServeMux).ServeHTTP(0x0?, {0x19571f0, 0xc000533260}, 0xc000e1a800)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:2487 +0x149
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: net/http.serverHandler.ServeHTTP({0x19515e0?}, {0x19571f0, 0xc000533260}, 0xc000e1a800)
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:2947 +0x30c
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: net/http.(*conn).serve(0xc000318aa0, {0x1958598, 0xc000723b00})
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:1991 +0x607
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]: created by net/http.(*Server).Serve
Mar 17 02:27:47 rpc-001.devnet03.zkevm.polygon.private zkevm-node[102130]:         /usr/local/go/src/net/http/server.go:3102 +0x4db
@arnaubennassar arnaubennassar changed the title panic on estimate gas panic on estimate gas and eth_call Mar 17, 2023
@arnaubennassar
Copy link
Member Author 

Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4519188,"caller":"state/helper.go:109","msg":"0 0 30000000 0xe2194B52dFfB1E88eE269A73091f5DF72dC690c6 0 36 1","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4519434,"caller":"state/helper.go:113","msg":"Forced nonce: 0","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4519806,"caller":"state/state.go:1299","msg":"internalProcessUnsignedTransaction[processBatchRequest.OldBatchNum]: 144","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4519956,"caller":"state/state.go:1300","msg":"internalProcessUnsignedTransaction[processBatchRequest.From]: 0x1111111111111111111111111111111111111111","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.452007,"caller":"state/state.go:1301","msg":"internalProcessUnsignedTransaction[processBatchRequest.OldStateRoot]: 0xfa6fbcf8f676265eeab9687bdf6d1a729ca1cbe3439fb9450fa78231b9dca7ac","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4520183,"caller":"state/state.go:1302","msg":"internalProcessUnsignedTransaction[processBatchRequest.globalExitRoot]: 0x0000000000000000000000000000000000000000000000000000000000000000","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.452029,"caller":"state/state.go:1303","msg":"internalProcessUnsignedTransaction[processBatchRequest.OldAccInputHash]: 0xb83318100a5904a923fe172b0f573789ad690c0087a0ef2f82ea4489215958e1","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4520402,"caller":"state/state.go:1304","msg":"internalProcessUnsignedTransaction[processBatchRequest.EthTimestamp]: 1679025030","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4520514,"caller":"state/state.go:1305","msg":"internalProcessUnsignedTransaction[processBatchRequest.Coinbase]: 0x85dA99c8a7C2C95964c8EfD687E95E632Fc533D6","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4520626,"caller":"state/state.go:1306","msg":"internalProcessUnsignedTransaction[processBatchRequest.UpdateMerkleTree]: 0","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4520738,"caller":"state/state.go:1307","msg":"internalProcessUnsignedTransaction[processBatchRequest.ChainId]: 1","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4520848,"caller":"state/state.go:1308","msg":"internalProcessUnsignedTransaction[processBatchRequest.ForkId]: 2","pid":121437,"version":"v0.0.3-RC19"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"error","ts":1679025230.452919,"caller":"state/state.go:1313","msg":"error processing unsigned transaction  rpc error: code = ResourceExhausted desc = %!(EXTRA string=\n/opt/zkevm-node/log/log.go:140 github.com/0xPolygonHermez/zkevm-node/log.appendStackTraceMaybeArgs()\n/opt/zkevm-node/log/log.go:249 github.com/0xPolygonHermez/zkevm-node/log.Errorf()\n/opt/zkevm-node/state/state.go:1313 github.com/0xPolygonHermez/zkevm-node/state.(*State).internalProcessUnsignedTransaction()\n/opt/zkevm-node/state/state.go:1225 github.com/0xPolygonHermez/zkevm-node/state.(*State).ProcessUnsignedTransaction()\n/opt/zkevm-node/jsonrpc/endpoints_eth.go:77 github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).Call.func1()\n/opt/zkevm-node/jsonrpc/dbtxmanager.go:20 github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*dbTxManager).NewDbTxScope()\n/opt/zkevm-node/jsonrpc/endpoints_eth.go:55 github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).Call()\n/usr/local/go/src/reflect/value.go:584 reflect.Value.call()\n/usr/local/go/src/reflect/value.go:368 reflect.Value.Call()\n/opt/zkevm-node/jsonrpc/handler.go:141 github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Handler).Handle()\n/opt/zkevm-node/jsonrpc/server.go:300 github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handleBatchRequest()\n/opt/zkevm-node/jsonrpc/server.go:250 github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handle()\n/usr/local/go/src/net/http/server.go:2109 net/http.HandlerFunc.ServeHTTP()\n/root/go/pkg/mod/github.com/didip/tollbooth/v6@v6.1.2/tollbooth.go:311 github.com/didip/tollbooth/v6.LimitHandler.func1()\n/usr/local/go/src/net/http/server.go:2109 net/http.HandlerFunc.ServeHTTP()\n/usr/local/go/src/net/http/server.go:2487 net/http.(*ServeMux).ServeHTTP()\n/usr/local/go/src/net/http/server.go:2947 net/http.serverHandler.ServeHTTP()\n/usr/local/go/src/net/http/server.go:1991 net/http.(*conn).serve()\n)","pid":121437,"version":"v0.0.3-RC19","stacktrace":"github.com/0xPolygonHermez/zkevm-node/state.(*State).internalProcessUnsignedTransaction\n\t/opt/zkevm-node/state/state.go:1313\ngithub.com/0xPolygonHermez/zkevm-node/state.(*State).ProcessUnsignedTransaction\n\t/opt/zkevm-node/state/state.go:1225\ngithub.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).Call.func1\n\t/opt/zkevm-node/jsonrpc/endpoints_eth.go:77\ngithub.com/0xPolygonHermez/zkevm-node/jsonrpc.(*dbTxManager).NewDbTxScope\n\t/opt/zkevm-node/jsonrpc/dbtxmanager.go:20\ngithub.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).Call\n\t/opt/zkevm-node/jsonrpc/endpoints_eth.go:55\nreflect.Value.call\n\t/usr/local/go/src/reflect/value.go:584\nreflect.Value.Call\n\t/usr/local/go/src/reflect/value.go:368\ngithub.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Handler).Handle\n\t/opt/zkevm-node/jsonrpc/handler.go:141\ngithub.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handleBatchRequest\n\t/opt/zkevm-node/jsonrpc/server.go:300\ngithub.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handle\n\t/opt/zkevm-node/jsonrpc/server.go:250\nnet/http.HandlerFunc.ServeHTTP\n\t/usr/local/go/src/net/http/server.go:2109\ngithub.com/didip/tollbooth/v6.LimitHandler.func1\n\t/root/go/pkg/mod/github.com/didip/tollbooth/v6@v6.1.2/tollbooth.go:311\nnet/http.HandlerFunc.ServeHTTP\n\t/usr/local/go/src/net/http/server.go:2109\nnet/http.(*ServeMux).ServeHTTP\n\t/usr/local/go/src/net/http/server.go:2487\nnet/http.serverHandler.ServeHTTP\n\t/usr/local/go/src/net/http/server.go:2947\nnet/http.(*conn).serve\n\t/usr/local/go/src/net/http/server.go:1991"}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4530187,"caller":"jsonrpc/handler.go:89","msg":"Current open connections 0","pid":121437,"version":"v0.0.3-RC19","method":"eth_call","requestId":0}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: 2023/03/17 03:53:50 http: panic serving 10.10.74.42:56566: runtime error: invalid memory address or nil pointer dereference
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: goroutine 195 [running]:
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: net/http.(*conn).serve.func1()
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:1850 +0xbf
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: panic({0x1411100, 0x24a7f10})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/runtime/panic.go:890 +0x262
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/state.(*State).ProcessUnsignedTransaction(0x3c?, {0x1958528, 0xc000040070}, 0xc00047ccc0?, {0x11, 0x11, 0x11, 0x11, 0x11, 0x11, ...}, ...)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/state/state.go:1229 +0xfb
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).Call.func1({0x1958528, 0xc000040070}, {0x1962080, 0xc000a6eb70})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/jsonrpc/endpoints_eth.go:77 +0x29e
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*dbTxManager).NewDbTxScope(0x3?, {0x196dbb0?, 0xc000218900?}, 0xc000368bb8)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/jsonrpc/dbtxmanager.go:20 +0x82
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*EthEndpoints).Call(0x4?, 0xc0007cc560?, 0x2?)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/jsonrpc/endpoints_eth.go:55 +0x5d
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: reflect.Value.call({0xc000386100?, 0xc00012c630?, 0x55224c?}, {0x15e5276, 0x4}, {0xc0009d2690, 0x3, 0x542485?})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/reflect/value.go:584 +0x8c5
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: reflect.Value.Call({0xc000386100?, 0xc00012c630?, 0xa0?}, {0xc0009d2690?, 0xc000a6eb28?, 0x8?})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/reflect/value.go:368 +0xbc
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Handler).Handle(0x24d2f80?, {{{0xc000a3e8a8, 0x3}, {0x13860e0, 0x2317c00}, {0xc000a3e8c0, 0x8}, {0xc000202140, 0x92, 0xa0}}, ...})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/jsonrpc/handler.go:141 +0xc4b
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handleBatchRequest(0xc00046e1e0, 0xc0003be600, {0x19571f0, 0xc000454460}, {0xc000403600?, 0xe?, 0x40b3880000000000?})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/jsonrpc/server.go:300 +0x2db
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/0xPolygonHermez/zkevm-node/jsonrpc.(*Server).handle(0xc000218500?, {0x19571f0, 0xc000454460}, 0xc0003be600)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /opt/zkevm-node/jsonrpc/server.go:250 +0x5e8
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: net/http.HandlerFunc.ServeHTTP(0xc000a3e845?, {0x19571f0?, 0xc000454460?}, 0xc000231f40?)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:2109 +0x2f
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: github.com/didip/tollbooth/v6.LimitHandler.func1({0x19571f0, 0xc000454460}, 0xc0fd16f39906554c?)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /root/go/pkg/mod/github.com/didip/tollbooth/v6@v6.1.2/tollbooth.go:311 +0x22c
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: net/http.HandlerFunc.ServeHTTP(0xc000454460?, {0x19571f0?, 0xc000454460?}, 0x15f0338?)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:2109 +0x2f
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: net/http.(*ServeMux).ServeHTTP(0x0?, {0x19571f0, 0xc000454460}, 0xc0003be600)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:2487 +0x149
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: net/http.serverHandler.ServeHTTP({0x19515e0?}, {0x19571f0, 0xc000454460}, 0xc0003be600)
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:2947 +0x30c
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: net/http.(*conn).serve(0xc000224a00, {0x1958598, 0xc00011b5c0})
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:1991 +0x607
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: created by net/http.(*Server).Serve
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]:         /usr/local/go/src/net/http/server.go:3102 +0x4db
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4571068,"caller":"jsonrpc/handler.go:91","msg":"Current open connections 1","pid":121437,"version":"v0.0.3-RC19","method":"eth_call","requestId":0}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.4571338,"caller":"jsonrpc/handler.go:92","msg":"request params [{\"data\":\"0xc87b56dd0000000000000000000000000000000000000000000000000000000000000147\",\"to\":\"0xe2194b52dffb1e88ee269a73091f5df72dc690c6\"},\"latest\"]","pid":121437,"version":"v0.0.3-RC19","method":"eth_call","requestId":0}
Mar 17 03:53:50 rpc-001.devnet03.zkevm.polygon.private zkevm-node[121437]: {"level":"debug","ts":1679025230.5103457,"caller":"state/helper.go:109","msg":"0 0 30000000 0xe2194B52dFfB1E88eE269A73091f5DF72dC690c6 0 36 1","pid":121437,"version":"v0.0.3-RC19"}

@arnaubennassar arnaubennassar added bug Something isn't working rpc labels Mar 17, 2023
@tclemos
Copy link
Contributor

tclemos commented Mar 17, 2023 •
edited
Loading

I tried to reproduce this in a local environment without success, probably it's something related to the data on-chain and I'll have to test it in a fully synchronized env.

@tclemos tclemos self-assigned this Mar 17, 2023
@praetoriansentry
Copy link

I see these errors somewhat regularly in my environment.

In this case, we might be able to check the err and return before trying to access processBatchResponse:

zkevm-node/state/state.go

Lines 304 to 306 in 743b904

processBatchResponse, err := s.executorClient.ProcessBatch(ctx, processBatchRequest)
gasUsed = processBatchResponse.Responses[0].GasUsed
log.Debugf("executor time: %vms", time.Since(txExecutionOnExecutorTime).Milliseconds())

The issue is mostly the same here. We check err and set result.Err but then don't return and end up panicking trying to access response.Responses[0]

zkevm-node/state/state.go

Lines 1225 to 1229 in 743b904

response, err := s.internalProcessUnsignedTransaction(ctx, tx, senderAddress, l2BlockNumber, noZKEVMCounters, dbTx)
if err != nil {
result.Err = err
}
if response.Responses[0] != nil {

@tclemos
Copy link
Contributor

tclemos commented Mar 19, 2023

@ToniRamirezM do you know if there is a reason why we try to access the responses even when an error is detected in these cases?

@ToniRamirezM
Copy link
Contributor

We should return after line 1227. I will create a PR with the fix.

@ToniRamirezM ToniRamirezM mentioned this issue Mar 23, 2023
Merged
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@tclemos tclemos

Labels
blue-berry bug Something isn't working rpc
Projects
None yet
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

fix missing return on ProcessUnsignedTransaction 0xPolygonHermez/zkevm-node
4 participants
@praetoriansentry @tclemos @arnaubennassar @ToniRamirezM