besu icon indicating copy to clipboard operation
besu copied to clipboard

Published 20 hours ago • verified publisher icon hyperledger

Besu RPC returns "result": false from eth_syncing request but It's not synced yet

Open xd1gital opened this issue 3 years ago • 1 comments

Description

My Teku CL client shows:

Syncing     *** Target slot: 4765031, Head slot: 4765030, Waiting for execution layer sync, Connected peers: 70

However when I ran eth_syncing, besu 2.7.3 returns this (indicated it's synced)

curl -s -X POST -H "Content-Type: application/json" --data '{"jsonrpc":"2.0","method":"eth_syncing","params":[],"id":1}' http://locahost:8545/

{
  "jsonrpc" : "2.0",
  "id" : 1,
  "result" : false
}

here last 50 lines of besu log

2022-09-24 14:18:52.566+07:00 | nioEventLoopGroup-3-3 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:18:52.656+07:00 | nioEventLoopGroup-3-4 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:18:52.656+07:00 | nioEventLoopGroup-3-4 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:18:52.881+07:00 | nioEventLoopGroup-3-1 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:18:52.881+07:00 | nioEventLoopGroup-3-1 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:17.695+07:00 | nioEventLoopGroup-3-10 | INFO  | ForwardSyncStep | Saved blocks 15593333 -> 15593356 (target: 15601679)				
2022-09-24 14:19:17.699+07:00 | ForkJoinPool.commonPool-worker-13 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:19.977+07:00 | nioEventLoopGroup-3-2 | INFO  | ForwardSyncStep | Saved blocks 15593357 -> 15593357 (target: 15601679)				
2022-09-24 14:19:19.978+07:00 | ForkJoinPool.commonPool-worker-13 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:20.401+07:00 | nioEventLoopGroup-3-2 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:20.401+07:00 | nioEventLoopGroup-3-2 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:20.972+07:00 | nioEventLoopGroup-3-8 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:20.973+07:00 | nioEventLoopGroup-3-8 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:21.215+07:00 | nioEventLoopGroup-3-7 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:21.215+07:00 | nioEventLoopGroup-3-7 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:21.648+07:00 | nioEventLoopGroup-3-4 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:21.650+07:00 | nioEventLoopGroup-3-4 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:21.900+07:00 | nioEventLoopGroup-3-4 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:21.901+07:00 | nioEventLoopGroup-3-4 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:22.189+07:00 | nioEventLoopGroup-3-9 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:22.189+07:00 | nioEventLoopGroup-3-9 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:22.395+07:00 | nioEventLoopGroup-3-8 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:22.395+07:00 | nioEventLoopGroup-3-8 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:22.598+07:00 | nioEventLoopGroup-3-9 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:22.598+07:00 | nioEventLoopGroup-3-9 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:24.310+07:00 | nioEventLoopGroup-3-1 | INFO  | ForwardSyncStep | Saved blocks 15593358 -> 15593358 (target: 15601679)				
2022-09-24 14:19:24.312+07:00 | ForkJoinPool.commonPool-worker-13 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:24.362+07:00 | nioEventLoopGroup-3-3 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:24.363+07:00 | nioEventLoopGroup-3-3 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:24.452+07:00 | nioEventLoopGroup-3-4 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:24.452+07:00 | nioEventLoopGroup-3-4 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:24.754+07:00 | nioEventLoopGroup-3-1 | INFO  | ForwardSyncStep | No blocks to save...				
2022-09-24 14:19:24.755+07:00 | nioEventLoopGroup-3-1 | INFO  | BackwardsSyncAlgorithm | Backward sync reached ancestor header, starting Forward sync				
2022-09-24 14:19:43.518+07:00 | nioEventLoopGroup-3-10 | INFO  | ForwardSyncStep | Saved blocks 15593359 -> 15593380 (target: 15601681)				
2022-09-24 14:20:00.253+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0xc3e3b85536d370545b6af777a1dd33f01e2fc555dd383f1e518ea85f6a5dcaab,	finalized:	0xae8e2442fd4a2970bf2efd3aaa9aa5a0d0723642f7da926c0ea979b94c0844a9,	safeBlockHash:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea
2022-09-24 14:21:00.469+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x5294a0f584273b9c2284a4af39e09013c225fe62bf06740391ed67d097202369,	finalized:	0xae8e2442fd4a2970bf2efd3aaa9aa5a0d0723642f7da926c0ea979b94c0844a9,	safeBlockHash:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea
2022-09-24 14:22:12.396+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0xbbc69ada5ce710002a31b2afb8415629fb2f7257c3269910d397cb1fb00362bb,	finalized:	0xae8e2442fd4a2970bf2efd3aaa9aa5a0d0723642f7da926c0ea979b94c0844a9,	safeBlockHash:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea
2022-09-24 14:23:13.973+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x14d4b7a8c5015ba35d002fdbd73670d5085cd72414f818565575d569877ccd7a,	finalized:	0xae8e2442fd4a2970bf2efd3aaa9aa5a0d0723642f7da926c0ea979b94c0844a9,	safeBlockHash:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea
2022-09-24 14:24:14.287+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x195093ab4e811d333490d911d6e930354e8517d1f96dbc454bbeced916daf14d,	finalized:	0xae8e2442fd4a2970bf2efd3aaa9aa5a0d0723642f7da926c0ea979b94c0844a9,	safeBlockHash:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea
2022-09-24 14:25:24.046+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x22e36b0041d3df91ba329d3a3a4e7573fc5776eca47f116477c5776981f54a53,	finalized:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea,	safeBlockHash:	0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156
2022-09-24 14:26:36.101+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x044a9539c575b17863c79445d370cc5676ceec2acca898adce4697cbd54b97c4,	finalized:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea,	safeBlockHash:	0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156
2022-09-24 14:27:36.442+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x7318f83b5120769295d9cac8601548ac99b44a03c1f0e699090bc54c1b3a404c,	finalized:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea,	safeBlockHash:	0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156
2022-09-24 14:28:37.048+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x6b929c3dd5f35807af1db668f7adb54a1d7a34be8486bbffae785a85b535f8e2,	finalized:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea,	safeBlockHash:	0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156
2022-09-24 14:29:48.233+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x7d51aa851eba9a73cbe567292b4763a08a59b31c84c5f09d5499718776dfeb16,	finalized:	0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea,	safeBlockHash:	0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156
2022-09-24 14:30:49.723+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0xc7ddc7def9f50b7e32a946de63ae821d66add5e8abbedc746d987bd216dc7dfe, finalized: 0xd432cf64226bf81a9599e27fcb5cdc6dcb1c6ccfed4ed75735ef7738462cb6ea, safeBlockHash: 0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156
2022-09-24 14:32:00.971+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0xa7a5330cca2192774f90d1cd294e39154caaf638d041b2b5678767600bacbec9, finalized: 0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156, safeBlockHash: 0x4379f9d8ad6677419341270addd0267ef85dab56d3cc7a1a42ddd823f081ab36
2022-09-24 14:33:12.743+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0xc28cf5c1d31aaca905f6c9a564b85adb7bb14eff4da2e985419bdd128bdb7f41, finalized: 0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156, safeBlockHash: 0x4379f9d8ad6677419341270addd0267ef85dab56d3cc7a1a42ddd823f081ab36
2022-09-24 14:34:24.851+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x30d9ca2936777e968bed9c3501fbf28a87660cd8a98c8dc22d0d6e19a78aeb4d, finalized: 0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156, safeBlockHash: 0x4379f9d8ad6677419341270addd0267ef85dab56d3cc7a1a42ddd823f081ab36
2022-09-24 14:35:36.305+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x152fbcb240bb5cb6e0a8c04d512d1a1d9e7c176322a25965c94caca1009e384d, finalized: 0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156, safeBlockHash: 0x4379f9d8ad6677419341270addd0267ef85dab56d3cc7a1a42ddd823f081ab36
2022-09-24 14:36:48.533+07:00 | vert.x-worker-thread-0 | INFO  | EngineForkchoiceUpdated | SYNCING for fork-choice-update: head: 0x3d2d98ef09e34a59af04dc866532f94e6e5ba46bf652f23b92dc9835b3274c49, finalized: 0x2e63e925a1967e82f696082824f13f7ef15cbc469f92fed43863f67742f0b156, safeBlockHash: 0x4379f9d8ad6677419341270addd0267ef85dab56d3cc7a1a42ddd823f081ab36

Versions (Add all that apply)

  • Software version: 2.7.3
  • Java version:
openjdk version "11.0.16" 2022-07-19
OpenJDK Runtime Environment (build 11.0.16+8-post-Ubuntu-0ubuntu120.04)
OpenJDK 64-Bit Server VM (build 11.0.16+8-post-Ubuntu-0ubuntu120.04, mixed mode, sharing)
  • OS Name & Version: Ubuntu 20.04.5 LTS
  • Kernel Version: Linux 5.4.0-125-generic Ubuntu SMP

Additional Information (Add any of the following or anything else that may be relevant)

  • Besu setup info: data-storage-format="BONSAI"
  • System info:
CPU: Intel(R) Core(TM) i7-4770K CPU @ 3.50GHz
RAM: 32GB
Besu runs on 1TB NVMe EVO PLUS

xd1gital avatar Sep 24 '22 07:09 xd1gital

Updated: same problem on 22.7.4 and 22.7.5

xd1gital avatar Oct 06 '22 06:10 xd1gital

@xd1gital The CL is using a different set of APIs (Engine API) to interact with Besu, which return a different set of statuses. They're detailed here: https://github.com/ethereum/execution-apis/blob/main/src/engine/specification.md

The response from eth_syncing may need to be updated to reflect the new sync states.

I've created ticket #4556 to address this.

mark-terry avatar Oct 25 '22 12:10 mark-terry