Parent Log: http://ci.aztec-labs.com/bbd24c41c3ef4011 Command: 5e456509c4335308 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/1b10c7d500621ca2e4c0db764df67f3085beb282 Env: REF_NAME=gh-readonly-queue/next/pr-15229-99e234fe4473771b32124e0402885610a6a3f98a CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Tue Jun 24 10:07:48 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15229_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 10:07:50 [10:07:50.836] INFO: world_state Created world state synchroniser with block history of infinity 10:07:50 [10:07:50.936] INFO: world_state Started world state synchronizer from block 1 10:07:51 [10:07:51.240] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.778128999999808,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.243] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.095966000000317,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.246] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.7757589999996526,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.389] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.825999000000138,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.392] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6358070000001135,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.393] INFO: world_state Stopped world state synchronizer 10:07:51 [10:07:51.395] INFO: world_state Stopped world state synchronizer 10:07:51 [10:07:51.398] INFO: world_state Created world state synchroniser with block history of infinity 10:07:51 [10:07:51.516] INFO: world_state Started world state synchronizer from block 1 10:07:51 [10:07:51.739] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1577189999998154,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.741] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.157101999999668,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.742] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1404520000000957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.744] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3727060000001075,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.746] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.193931999999677,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:51 [10:07:51.747] INFO: world_state Stopped world state synchronizer 10:07:51 [10:07:51.749] INFO: world_state Created world state synchroniser with block history of infinity 10:07:51 [10:07:51.750] INFO: world_state Started world state synchronizer from block 1 10:07:51 [10:07:51.750] INFO: world_state Stopped world state synchronizer 10:07:51 [10:07:51.751] INFO: world_state Created world state synchroniser with block history of infinity 10:07:51 [10:07:51.752] INFO: world_state Started world state synchronizer from block 1 10:07:51 [10:07:51.752] INFO: world_state Stopped world state synchronizer 10:07:51 [10:07:51.766] INFO: world_state Stopped world state synchronizer 10:07:51 [10:07:51.767] INFO: world_state Created world state synchroniser with block history of infinity 10:07:51 [10:07:51.892] INFO: world_state Started world state synchronizer from block 1 10:07:52 [10:07:52.115] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0983940000000985,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.116] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0626579999998285,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.118] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9811939999999595,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.119] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9598340000002281,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.120] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.956862000000001,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.261] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0354160000001684,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.263] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0107579999998961,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.264] INFO: world_state Stopped world state synchronizer 10:07:52 [10:07:52.265] INFO: world_state Created world state synchroniser with block history of infinity 10:07:52 [10:07:52.383] INFO: world_state Started world state synchronizer from block 1 10:07:52 [10:07:52.605] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0247460000000501,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.606] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9806629999993675,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.607] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9828010000001086,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.609] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9661430000005566,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.610] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9566130000002886,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.821] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0101919999997335,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.822] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0810300000002826,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.824] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.080696999999418,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:52 [10:07:52.825] INFO: world_state Stopped world state synchronizer 10:07:52 [10:07:52.827] INFO: world_state Created world state synchroniser with block history of infinity 10:07:52 [10:07:52.944] INFO: world_state Started world state synchronizer from block 1 10:07:53 [10:07:53.168] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0573779999995168,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.169] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0219090000000506,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.171] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.001933999999892,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.172] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.03351499999917,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.174] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0409989999998288,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.176] INFO: world_state Stopped world state synchronizer 10:07:53 [10:07:53.177] INFO: world_state Created world state synchroniser with block history of infinity 10:07:53 [10:07:53.303] INFO: world_state Started world state synchronizer from block 1 10:07:53 [10:07:53.531] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.003577000000405,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.533] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9979939999993803,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.534] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9770950000001903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.536] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9673219999995126,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.537] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9433669999998529,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:07:53 [10:07:53.538] INFO: world_state Stopped world state synchronizer 10:07:53 [10:07:53.540] INFO: world_state Created world state synchroniser with block history of infinity 10:07:53 [10:07:53.543] INFO: world_state Stopped world state synchronizer 10:07:53 [10:07:53.544] INFO: world_state Created world state synchroniser with block history of infinity 10:07:53 [10:07:53.661] INFO: world_state Started world state synchronizer from block 1 10:07:53 [10:07:53.888] INFO: world_state Stopped world state synchronizer 10:07:53 PASS src/synchronizer/server_world_state_synchronizer.test.ts 10:07:53 ServerWorldStateSynchronizer 10:07:53 ✓ updates sync progress (563 ms) 10:07:53 ✓ handles multiple calls to start (351 ms) 10:07:53 ✓ immediately syncs if no new blocks (2 ms) 10:07:53 ✓ cannot be started if already stopped (15 ms) 10:07:53 ✓ can immediately sync to latest (497 ms) 10:07:53 ✓ can immediately sync to a minimum block number (561 ms) 10:07:53 ✓ sync returns immediately if block was already synced (350 ms) 10:07:53 ✓ throws if you try to sync to an unavailable block (363 ms) 10:07:53 ✓ throws if you try to immediate sync when not running (4 ms) 10:07:53 ✓ throws if handling blocks fails (345 ms) 10:07:53 10:07:53 Test Suites: 1 passed, 1 total 10:07:53 Tests: 10 passed, 10 total 10:07:53 Snapshots: 0 total 10:07:53 Time: 4.852 s 10:07:53 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 10:07:53 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?