Parent Log: http://ci.aztec-labs.com/bad7d4089c78c89a Command: a8cc061dbe484831 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/58696523cc93fda453138a4f2c2dff72b21f0bfa Env: REF_NAME=gh-readonly-queue/next/pr-15180-a923b0dd4c74291fcefa86c41b3b5dffca7e4178 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 20 13:10:52 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15180_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 13:10:56 [13:10:56.155] INFO: world_state Created world state synchroniser with block history of infinity 13:10:56 [13:10:56.312] INFO: world_state Started world state synchronizer from block 1 13:10:56 [13:10:56.731] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.586428999999953,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:56 [13:10:56.735] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7857300000000578,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:56 [13:10:56.737] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.464310999999725,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:56 [13:10:56.917] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.784668000000238,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:56 [13:10:56.934] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":15.509907000000112,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:56 [13:10:56.936] INFO: world_state Stopped world state synchronizer 13:10:56 [13:10:56.938] INFO: world_state Stopped world state synchronizer 13:10:56 [13:10:56.943] INFO: world_state Created world state synchroniser with block history of infinity 13:10:57 [13:10:57.119] INFO: world_state Started world state synchronizer from block 1 13:10:57 [13:10:57.491] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.1074390000003405,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.495] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.8390119999994567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.499] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.6545450000003257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.502] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.9501749999999447,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.504] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.072229999999763,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.505] INFO: world_state Stopped world state synchronizer 13:10:57 [13:10:57.507] INFO: world_state Created world state synchroniser with block history of infinity 13:10:57 [13:10:57.508] INFO: world_state Started world state synchronizer from block 1 13:10:57 [13:10:57.509] INFO: world_state Stopped world state synchronizer 13:10:57 [13:10:57.510] INFO: world_state Created world state synchroniser with block history of infinity 13:10:57 [13:10:57.510] INFO: world_state Started world state synchronizer from block 1 13:10:57 [13:10:57.510] INFO: world_state Stopped world state synchronizer 13:10:57 [13:10:57.528] INFO: world_state Stopped world state synchronizer 13:10:57 [13:10:57.530] INFO: world_state Created world state synchroniser with block history of infinity 13:10:57 [13:10:57.702] INFO: world_state Started world state synchronizer from block 1 13:10:57 [13:10:57.953] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.11033099999986,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.954] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8299230000002353,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.955] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7943519999998898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.956] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8011929999993299,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:57 [13:10:57.958] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1136509999996633,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.135] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4952430000003005,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.137] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3943689999996423,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.139] INFO: world_state Stopped world state synchronizer 13:10:58 [13:10:58.140] INFO: world_state Created world state synchroniser with block history of infinity 13:10:58 [13:10:58.279] INFO: world_state Started world state synchronizer from block 1 13:10:58 [13:10:58.620] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.135559999999714,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.622] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2472250000000713,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.624] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2470349999994141,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.626] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.028548999999657,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.627] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.03128900000047,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.880] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2384149999998044,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.882] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1066110000001572,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.884] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3804089999994176,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:58 [13:10:58.886] INFO: world_state Stopped world state synchronizer 13:10:58 [13:10:58.897] INFO: world_state Created world state synchroniser with block history of infinity 13:10:59 [13:10:59.030] INFO: world_state Started world state synchronizer from block 1 13:10:59 [13:10:59.301] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1984130000000732,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.303] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1871430000001055,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.304] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.063119999999799,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.307] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.347106000000167,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.308] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9040059999997538,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.310] INFO: world_state Stopped world state synchronizer 13:10:59 [13:10:59.311] INFO: world_state Created world state synchroniser with block history of infinity 13:10:59 [13:10:59.464] INFO: world_state Started world state synchronizer from block 1 13:10:59 [13:10:59.703] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1934040000005552,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.705] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0896309999998266,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.706] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0545400000000882,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.708] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0388400000001639,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.709] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0169990000003963,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:10:59 [13:10:59.711] INFO: world_state Stopped world state synchronizer 13:10:59 [13:10:59.713] INFO: world_state Created world state synchroniser with block history of infinity 13:10:59 [13:10:59.716] INFO: world_state Stopped world state synchronizer 13:10:59 [13:10:59.717] INFO: world_state Created world state synchroniser with block history of infinity 13:10:59 [13:10:59.871] INFO: world_state Started world state synchronizer from block 1 13:11:00 [13:11:00.179] INFO: world_state Stopped world state synchronizer 13:11:00 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.253 s) 13:11:00 ServerWorldStateSynchronizer 13:11:00 ✓ updates sync progress (790 ms) 13:11:00 ✓ handles multiple calls to start (564 ms) 13:11:00 ✓ immediately syncs if no new blocks (3 ms) 13:11:00 ✓ cannot be started if already stopped (20 ms) 13:11:00 ✓ can immediately sync to latest (610 ms) 13:11:00 ✓ can immediately sync to a minimum block number (747 ms) 13:11:00 ✓ sync returns immediately if block was already synced (423 ms) 13:11:00 ✓ throws if you try to sync to an unavailable block (401 ms) 13:11:00 ✓ throws if you try to immediate sync when not running (4 ms) 13:11:00 ✓ throws if handling blocks fails (462 ms) 13:11:00 13:11:00 Test Suites: 1 passed, 1 total 13:11:00 Tests: 10 passed, 10 total 13:11:00 Snapshots: 0 total 13:11:00 Time: 6.35 s 13:11:00 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:11:00 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?