Parent Log: http://ci.aztec-labs.com/844bec8772ac4116 Command: fa3d426c5ffed922 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/ddabb45f79cc171e41a0a5330544775de9fdf7fd Env: REF_NAME=gh-readonly-queue/next/pr-14983-4e03f15ca8099f25d50eddd19c4914764b84fe7b CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 14:38:42 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14983_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:38:45 [14:38:45.925] INFO: world_state Created world state synchroniser with block history of infinity 14:38:46 [14:38:46.094] INFO: world_state Started world state synchronizer from block 1 14:38:46 [14:38:46.521] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.639093000000685,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:46 [14:38:46.525] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.2070569999996223,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:46 [14:38:46.529] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.899486999999681,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:46 [14:38:46.743] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.243376999999782,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:46 [14:38:46.746] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.992935000000216,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:46 [14:38:46.748] INFO: world_state Stopped world state synchronizer 14:38:46 [14:38:46.750] INFO: world_state Stopped world state synchronizer 14:38:46 [14:38:46.753] INFO: world_state Created world state synchroniser with block history of infinity 14:38:46 [14:38:46.897] INFO: world_state Started world state synchronizer from block 1 14:38:47 [14:38:47.213] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.060500999999931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.214] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9157820000000356,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.215] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7726840000004813,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.217] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.004718000000139,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.218] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8943019999996977,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.219] INFO: world_state Stopped world state synchronizer 14:38:47 [14:38:47.221] INFO: world_state Created world state synchroniser with block history of infinity 14:38:47 [14:38:47.221] INFO: world_state Started world state synchronizer from block 1 14:38:47 [14:38:47.222] INFO: world_state Stopped world state synchronizer 14:38:47 [14:38:47.222] INFO: world_state Created world state synchroniser with block history of infinity 14:38:47 [14:38:47.223] INFO: world_state Started world state synchronizer from block 1 14:38:47 [14:38:47.224] INFO: world_state Stopped world state synchronizer 14:38:47 [14:38:47.243] INFO: world_state Stopped world state synchronizer 14:38:47 [14:38:47.244] INFO: world_state Created world state synchroniser with block history of infinity 14:38:47 [14:38:47.503] INFO: world_state Started world state synchronizer from block 1 14:38:47 [14:38:47.862] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4763349999993807,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.868] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":4.604645999999775,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.870] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4632139999994251,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.872] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4652740000001359,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:47 [14:38:47.874] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.282404000000497,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.036] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2761940000000322,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.038] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2419610000006287,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.039] INFO: world_state Stopped world state synchronizer 14:38:48 [14:38:48.054] INFO: world_state Created world state synchroniser with block history of infinity 14:38:48 [14:38:48.268] INFO: world_state Started world state synchronizer from block 1 14:38:48 [14:38:48.618] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3936299999995754,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.620] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1800579999999172,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.622] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3087359999999535,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.624] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.153625999999349,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.626] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2390910000003714,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.924] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9743259999995644,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.925] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8349179999995613,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.927] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.7972060000001875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:48 [14:38:48.928] INFO: world_state Stopped world state synchronizer 14:38:48 [14:38:48.929] INFO: world_state Created world state synchroniser with block history of infinity 14:38:49 [14:38:49.063] INFO: world_state Started world state synchronizer from block 1 14:38:49 [14:38:49.381] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4071210000001884,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.383] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.424181999999746,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.386] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3933710000001156,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.387] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1446960000002946,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.389] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0980429999999615,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.391] INFO: world_state Stopped world state synchronizer 14:38:49 [14:38:49.392] INFO: world_state Created world state synchroniser with block history of infinity 14:38:49 [14:38:49.541] INFO: world_state Started world state synchronizer from block 1 14:38:49 [14:38:49.898] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3153149999998277,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.901] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8902109999999084,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.917] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5354280000001381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.919] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8955509999996139,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.920] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7650039999998626,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:38:49 [14:38:49.923] INFO: world_state Stopped world state synchronizer 14:38:49 [14:38:49.926] INFO: world_state Created world state synchroniser with block history of infinity 14:38:49 [14:38:49.930] INFO: world_state Stopped world state synchronizer 14:38:49 [14:38:49.931] INFO: world_state Created world state synchroniser with block history of infinity 14:38:50 [14:38:50.101] INFO: world_state Started world state synchronizer from block 1 14:38:50 [14:38:50.410] INFO: world_state Stopped world state synchronizer 14:38:50 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.999 s) 14:38:50 ServerWorldStateSynchronizer 14:38:50 ✓ updates sync progress (830 ms) 14:38:50 ✓ handles multiple calls to start (467 ms) 14:38:50 ✓ immediately syncs if no new blocks (2 ms) 14:38:50 ✓ cannot be started if already stopped (21 ms) 14:38:50 ✓ can immediately sync to latest (796 ms) 14:38:50 ✓ can immediately sync to a minimum block number (888 ms) 14:38:50 ✓ sync returns immediately if block was already synced (462 ms) 14:38:50 ✓ throws if you try to sync to an unavailable block (532 ms) 14:38:50 ✓ throws if you try to immediate sync when not running (5 ms) 14:38:50 ✓ throws if handling blocks fails (480 ms) 14:38:50 14:38:50 Test Suites: 1 passed, 1 total 14:38:50 Tests: 10 passed, 10 total 14:38:50 Snapshots: 0 total 14:38:50 Time: 7.097 s 14:38:50 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 14:38:50 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?