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.

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

Receipt 0 has unexpected block #48

Closed
artjoma opened this issue Sep 1, 2023 · 3 comments
Closed

Receipt 0 has unexpected block #48

artjoma opened this issue Sep 1, 2023 · 3 comments

Comments

@artjoma
Copy link

artjoma commented Sep 1, 2023

op-geth(opbnb) version:

Git Commit: 5804510047588ce5df734f3088c7758a10dafdca
Git Commit Date: 20230815
Upstream Version: 1.11.5-stable
Architecture: amd64
Go Version: go1.19.12
Operating System: linux
GOPATH=
GOROOT=

op-node version: 0.1.2
Erigon as L1: 1.1.9 archive synced node

op-geth:

INFO [09-01|13:10:17.866] IPC endpoint opened                      url=/home/blockchain/op-bnb-testnet/op-geth/datadir/geth.ipc
INFO [09-01|13:10:17.869] Loaded JWT secret file                   path=jwt.txt crc32=0x74412826
INFO [09-01|13:10:17.871] WebSocket enabled                        url=ws://[::]:38545
INFO [09-01|13:10:17.871] HTTP server started                      endpoint=[::]:38545 auth=false prefix= cors=* vhosts=*
INFO [09-01|13:10:17.871] WebSocket enabled                        url=ws://[::]:8551
INFO [09-01|13:10:17.871] HTTP server started                      endpoint=[::]:8551  auth=true  prefix= cors=localhost vhosts=*
INFO [09-01|13:10:17.966] Generated state snapshot                 accounts=2321 slots=2079 storage=391.32KiB dangling=0 elapsed=118.217ms
INFO [09-01|13:10:18.103] Start ok                                 id=0x4842309557c8b50209fce41fadb4cb44
INFO [09-01|13:10:19.575] New local node record                    seq=1,693,573,817,859 id=a4cb6d7d4cc09a5a                   ip=162.19.170.87 udp=30394 tcp=30394
INFO [09-01|13:10:33.383] Looking for peers                        peercount=0 tried=30 static=0
INFO [09-01|13:10:45.336] Looking for peers                        peercount=1 tried=111 static=0
INFO [09-01|13:11:06.019] Looking for peers                        peercount=0 tried=13  static=0
INFO [09-01|13:11:21.027] Looking for peers                        peercount=0 tried=21  static=0
INFO [09-01|13:11:31.161] Looking for peers                        peercount=1 tried=50  static=0
INFO [09-01|13:11:41.700] Looking for peers                        peercount=0 tried=72  static=0
INFO [09-01|13:11:53.213] Looking for peers                        peercount=0 tried=6   static=0
INFO [09-01|13:12:03.217] Looking for peers                        peercount=0 tried=35  static=0
INFO [09-01|13:12:13.514] Looking for peers                        peercount=0 tried=56  static=0
INFO [09-01|13:12:24.608] Looking for peers                        peercount=0 tried=31  static=0
INFO [09-01|13:12:34.794] Looking for peers                        peercount=0 tried=8   static=0
INFO [09-01|13:12:45.035] Looking for peers                        peercount=0 tried=11  static=0
INFO [09-01|13:12:55.407] Looking for peers                        peercount=0 tried=3   static=0
INFO [09-01|13:13:05.429] Looking for peers                        peercount=0 tried=13  static=0
INFO [09-01|13:13:15.831] Looking for peers                        peercount=0 tried=31  static=0

op-node log :

  GNU nano 6.2                                                                                                                                                                                                                                    err.log                                                                                                                                                                                                                                              
t=2023-09-01T13:10:47+0000 lvl=info msg="Initializing Rollup Node"
t=2023-09-01T13:10:47+0000 lvl=info msg="Rollup Config"            l2_chain_id=5611 l2_network="unknown L2" l1_chain_id=97 l1_network="unknown L1" l2_start_time=1,686,878,506 l2_block_hash=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80 l2_block_number=0 l1_block_hash=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7 l1_block_number=30,727,847 regolith_time="@ genesis"
t=2023-09-01T13:10:47+0000 lvl=info msg="loaded new runtime config values!" p2p_seq_address=0x23264E1F3C04efBe84108E666a187D240DDAfcED
t=2023-09-01T13:10:47+0000 lvl=info msg="Peer scoring disabled"
t=2023-09-01T13:10:47+0000 lvl=info msg="started p2p host"                  addrs="[/ip4/162.19.170.87/tcp/9003 /ip4/127.0.0.1/tcp/9003]" peerID=16Uiu2HAmGtC8o3B5nGycPq9msfK7EvLj8Hb3pN5xAAa6YLvy2BEG
t=2023-09-01T13:10:47+0000 lvl=info msg="New local node record"             seq=1,693,573,847,503 id=28fffb0f43c1534d026ac039f1197e3f5aa5cac7a3c66a15e3fc940a850ec137 ip=<nil> udp=9003 tcp=9003
t=2023-09-01T13:10:47+0000 lvl=info msg="started discovery service"         p2p=discv5 enr=enr:-JW4QEPRn4g5iY0BpzEA75MBrLNPCnGRQI79G-0aE9gIueWreUvWI4PkOIgR4N1HtfQUBsit24lriOUqPXECjvN6tE6GAYpQ3hnPgmlkgnY0h29wc3RhY2uD6ysAiXNlY3AyNTZrMaEDPtCfgaS2v9YlQzW950vrGij90-snQGC5Z28Y-IuwrXGDdGNwgiMrg3VkcIIjKw id=28fffb0f43c1534d026ac039f1197e3f5aa5cac7a3c66a15e3fc940a850ec137
t=2023-09-01T13:10:47+0000 lvl=info msg="Admin RPC enabled"
t=2023-09-01T13:10:47+0000 lvl=info msg="Starting JSON-RPC server"
t=2023-09-01T13:10:47+0000 lvl=info msg="starting metrics server"           addr=0.0.0.0 port=7300
t=2023-09-01T13:10:47+0000 lvl=info msg="Starting rollup node"              version=v0.0.0-7dd2c97b-1691118836
t=2023-09-01T13:10:47+0000 lvl=info msg="Starting execution engine driver"
t=2023-09-01T13:10:47+0000 lvl=info msg="Rollup node started"
t=2023-09-01T13:10:47+0000 lvl=info msg="State loop started"
t=2023-09-01T13:10:47+0000 lvl=info msg="pprof server started"              addr=0.0.0.0:6060
t=2023-09-01T13:10:47+0000 lvl=eror msg="error starting pprof"              err="http server failed: listen tcp 0.0.0.0:6060: bind: address already in use"
t=2023-09-01T13:10:47+0000 lvl=info msg="Loaded current L2 heads"           unsafe=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 safe=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 finalized=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 unsafe_origin=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 safe_origin=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847
t=2023-09-01T13:10:47+0000 lvl=info msg="Walking back L1Block by number"    curr=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 next=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 l2block=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0
t=2023-09-01T13:10:47+0000 lvl=info msg="Hit finalized L2 head, returning immediately" unsafe=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 safe=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 finalized=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 unsafe_origin=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 safe_origin=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:3>
t=2023-09-01T13:10:47+0000 lvl=info msg="Sync progress"                     reason="reset derivation work" l2_finalized=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 l2_safe=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 l2_unsafe=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80:0 l2_time=1,686,878,506 l1_derived=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847
t=2023-09-01T13:10:47+0000 lvl=info msg="completed reset of derivation pipeline" origin=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847
t=2023-09-01T13:10:47+0000 lvl=info msg="Reset of L1Retrieval done"              origin=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847
t=2023-09-01T13:10:47+0000 lvl=warn msg="Derivation process temporary error"     attempts=1 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:10:49+0000 lvl=warn msg="Derivation process temporary error"     attempts=2 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:10:50+0000 lvl=info msg="Received first L1 head signal"          l1_head=0xc09c372101afbb2e27fc49b22333b022e18382a8df5498a94b657ab5ffafe25a:32958992
t=2023-09-01T13:10:52+0000 lvl=info msg="attempting connection"                  peer=16Uiu2HAmC8JoaHFx1jaRT7NjksF1fCphVdRjxS2EytnKekdkSY7t
t=2023-09-01T13:10:53+0000 lvl=info msg="connected to peer"                      peer=16Uiu2HAmC8JoaHFx1jaRT7NjksF1fCphVdRjxS2EytnKekdkSY7t addr=/ip4/52.68.138.166/tcp/9003
t=2023-09-01T13:10:53+0000 lvl=info msg="Starting P2P sync client event loop"    peer=16Uiu2HAmC8JoaHFx1jaRT7NjksF1fCphVdRjxS2EytnKekdkSY7t
t=2023-09-01T13:10:53+0000 lvl=warn msg="Derivation process temporary error"     attempts=3 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:11:02+0000 lvl=warn msg="Derivation process temporary error"     attempts=4 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:11:08+0000 lvl=warn msg="L1 head signal indicates a possible L1 re-org" old_l1_head=0xc09c372101afbb2e27fc49b22333b022e18382a8df5498a94b657ab5ffafe25a:32958992 new_l1_head_parent=0x938239a1de6baf62bb8e5b9c2266f4d2287bd06276127fe52bab273f6cd34a9f new_l1_head=0x3291be58f1a93e21d5abcf95351dcf1e602288dc4a5429d97226eee6258a5628:32959002
t=2023-09-01T13:11:12+0000 lvl=warn msg="Derivation process temporary error"     attempts=5 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:11:22+0000 lvl=warn msg="Derivation process temporary error"     attempts=6 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:11:26+0000 lvl=warn msg="L1 head signal indicates a possible L1 re-org" old_l1_head=0x3291be58f1a93e21d5abcf95351dcf1e602288dc4a5429d97226eee6258a5628:32959002 new_l1_head_parent=0xacdfd431d3caa4a678310445e480f0b8a9e9564ac403ae01c7ec5c08ebd671a9 new_l1_head=0x9785ec1bd4e2dc537b6631dfdb94155d7d65677b9ebd91161051079d8710de31:32959009
t=2023-09-01T13:11:32+0000 lvl=warn msg="Derivation process temporary error"     attempts=7 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:11:32+0000 lvl=warn msg="failed to poll L1 block"                label=safe err="failed to fetch head header: not found"
t=2023-09-01T13:11:32+0000 lvl=warn msg="failed to poll L1 block"                label=finalized err="failed to fetch head header: not found"
t=2023-09-01T13:11:42+0000 lvl=warn msg="Derivation process temporary error"     attempts=8 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:11:52+0000 lvl=warn msg="Derivation process temporary error"     attempts=9 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
t=2023-09-01T13:12:02+0000 lvl=warn msg="Derivation process temporary error"     attempts=10 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"

@CocoStarZ
Copy link

please upgrade your node to 0.1.3 and retry

@artjoma
Copy link
Author

artjoma commented Sep 5, 2023

With 0.1.3 Node and 0.1.3 Geth same story:

INFO [09-05|10:18:19.575] Rollup Config                            l2_chain_id=5611 l2_network="unknown L2" l1_chain_id=97 l1_network="unknown L1" l2_start_time=1,686,878,506 l2_block_hash=0x51fa57729dfb1c27542c21b06cb72a0459c57440ceb43a465dae1307cd04fe80 l2_block_number=0 l1_block_hash=0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7 l1_block_number=30,727,847 regolith_time="@ genesis"
INFO [09-05|10:18:19.580] loaded new runtime config values!        p2p_seq_address=0x23264E1F3C04efBe84108E666a187D240DDAfcED
INFO [09-05|10:18:19.596] started p2p host                         addrs="[/ip4/162.19.170.87/tcp/9003 /ip4/127.0.0.1/tcp/9003]" peerID=16Uiu2HAmGtC8o3B5nGycPq9msfK7EvLj8Hb3pN5xAAa6YLvy2BEG
INFO [09-05|10:18:19.597] New local node record                    seq=1,693,908,945,438 id=28fffb0f43c1534d ip=<nil> udp=9003 tcp=9003
INFO [09-05|10:18:19.597] started discovery service                p2p=discv5 enr=enr:-JW4QHjYvYRl8Fln9PaHQ5rxnxh6_yvKcpSumCOoBo_GKtanTWhMTvhuYStzEPGeMwoYlB-gdYS2KzPOFACsZioeY5iGAYpk10oegmlkgnY0h29wc3RhY2uD6ysAiXNlY3AyNTZrMaEDPtCfgaS2v9YlQzW950vrGij90-snQGC5Z28Y-IuwrXGDdGNwgiMrg3VkcIIjKw id=28fffb0f43c1534d
INFO [09-05|10:18:19.597] Admin RPC enabled 
INFO [09-05|10:18:19.597] Starting JSON-RPC server 
INFO [09-05|10:18:19.597] starting metrics server                  addr=0.0.0.0 port=7300
INFO [09-05|10:18:19.597] Starting rollup node                     version=v0.0.0-e3639129-1691396703
INFO [09-05|10:18:19.597] Starting execution engine driver 
INFO [09-05|10:18:19.597] Rollup node started 
INFO [09-05|10:18:19.598] State loop started 
INFO [09-05|10:18:19.598] pprof server started                     addr=0.0.0.0:6060
ERROR[09-05|10:18:19.598] error starting pprof                     err="http server failed: listen tcp 0.0.0.0:6060: bind: address already in use"
INFO [09-05|10:18:19.599] Loaded current L2 heads                  unsafe=51fa57..04fe80:0 safe=51fa57..04fe80:0 finalized=51fa57..04fe80:0 unsafe_origin=c01a09..1c19f7:30727847 safe_origin=c01a09..1c19f7:30727847
INFO [09-05|10:18:19.600] Walking back L1Block by number           curr=c01a09..1c19f7:30727847 next=c01a09..1c19f7:30727847 l2block=51fa57..04fe80:0
INFO [09-05|10:18:19.600] Hit finalized L2 head, returning immediately unsafe=51fa57..04fe80:0 safe=51fa57..04fe80:0 finalized=51fa57..04fe80:0 unsafe_origin=c01a09..1c19f7:30727847 safe_origin=c01a09..1c19f7:30727847
INFO [09-05|10:18:19.600] Sync progress                            reason="reset derivation work" l2_finalized=51fa57..04fe80:0 l2_safe=51fa57..04fe80:0 l2_unsafe=51fa57..04fe80:0 l2_time=1,686,878,506 l1_derived=c01a09..1c19f7:30727847
INFO [09-05|10:18:19.600] completed reset of derivation pipeline   origin=c01a09..1c19f7:30727847
INFO [09-05|10:18:19.601] Reset of L1Retrieval done                origin=c01a09..1c19f7:30727847
WARN [09-05|10:18:19.606] Derivation process temporary error       attempts=1 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:18:21.628] Derivation process temporary error       attempts=2 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
INFO [09-05|10:18:22.578] Received first L1 head signal            l1_head=d0177d..1e1fa7:33070746
INFO [09-05|10:18:24.599] attempting connection                    peer=16Uiu2HAmC8JoaHFx1jaRT7NjksF1fCphVdRjxS2EytnKekdkSY7t
INFO [09-05|10:18:25.319] connected to peer                        peer=16Uiu2HAmC8JoaHFx1jaRT7NjksF1fCphVdRjxS2EytnKekdkSY7t addr=/ip4/52.68.138.166/tcp/9003
INFO [09-05|10:18:25.320] Starting P2P sync client event loop      peer=16Uiu2HAmC8JoaHFx1jaRT7NjksF1fCphVdRjxS2EytnKekdkSY7t
WARN [09-05|10:18:25.724] Derivation process temporary error       attempts=3 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:18:33.748] Derivation process temporary error       attempts=4 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:18:43.753] Derivation process temporary error       attempts=5 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:18:53.757] Derivation process temporary error       attempts=6 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:19:03.761] Derivation process temporary error       attempts=7 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:19:04.580] failed to poll L1 block                  label=safe err="failed to fetch head header: not found"
WARN [09-05|10:19:04.580] failed to poll L1 block                  label=finalized err="failed to fetch head header: not found"
WARN [09-05|10:19:13.765] Derivation process temporary error       attempts=8 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:19:16.618] L1 head signal indicates a possible L1 re-org old_l1_head=34b2be..4d337f:33070762 new_l1_head_parent=064800..b61d22 new_l1_head=043b46..729b5f:33070764
WARN [09-05|10:19:23.772] Derivation process temporary error       attempts=9 err="temp: failed to fetch receipts of L1 block 0xc01a09840419cd993cf4666309f36e6d38de39771af8dbffecfa0386321c19f7:30727847 for L1 sysCfg update: receipt 0 has unexpected block number 32864843, expected 30727848"
WARN [09-05|10:19:25.625] L1 head signal indicates a possible L1 re-org old_l1_head=043b46..729b5f:33070764 new_l1_head_parent=633dc0..2f4c27 new_l1_head=2d366d..c73f8a:33070767

@CocoStarZ
Copy link

Please upgrade to the latest version and retry.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants