Parent Log: http://ci.aztec-labs.com/a44a7be5cf1b53ae Command: 5b4d9f16dc72b5a7 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=1 Date: Tue Jun 24 10:05:26 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15229_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 10:05:29 [10:05:29.667] INFO: world_state Created world state synchroniser with block history of infinity 10:05:29 [10:05:29.838] INFO: world_state Started world state synchronizer from block 1 10:05:30 [10:05:30.264] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.460747999999967,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.267] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7959889999997358,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.270] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.633125000000291,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.465] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7375460000002931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.468] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4400099999993472,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.470] INFO: world_state Stopped world state synchronizer 10:05:30 [10:05:30.471] INFO: world_state Stopped world state synchronizer 10:05:30 [10:05:30.474] INFO: world_state Created world state synchroniser with block history of infinity 10:05:30 [10:05:30.620] INFO: world_state Started world state synchronizer from block 1 10:05:30 [10:05:30.938] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.9142769999998563,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.941] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5383750000000873,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.943] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5126740000005157,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.946] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.811330999999882,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.948] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6877739999999903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:30 [10:05:30.950] INFO: world_state Stopped world state synchronizer 10:05:30 [10:05:30.952] INFO: world_state Created world state synchroniser with block history of infinity 10:05:30 [10:05:30.953] INFO: world_state Started world state synchronizer from block 1 10:05:30 [10:05:30.954] INFO: world_state Stopped world state synchronizer 10:05:30 [10:05:30.955] INFO: world_state Created world state synchroniser with block history of infinity 10:05:30 [10:05:30.955] INFO: world_state Started world state synchronizer from block 1 10:05:30 [10:05:30.956] INFO: world_state Stopped world state synchronizer 10:05:30 [10:05:30.978] INFO: world_state Stopped world state synchronizer 10:05:30 [10:05:30.981] INFO: world_state Created world state synchroniser with block history of infinity 10:05:31 [10:05:31.189] INFO: world_state Started world state synchronizer from block 1 10:05:31 [10:05:31.486] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6262100000003556,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.488] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3719359999995504,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.490] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3580149999997957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.492] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2874609999998938,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.494] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.324522999999317,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.694] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.647820999999567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.697] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.4566899999999805,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.698] INFO: world_state Stopped world state synchronizer 10:05:31 [10:05:31.701] INFO: world_state Created world state synchroniser with block history of infinity 10:05:31 [10:05:31.900] INFO: world_state Started world state synchronizer from block 1 10:05:32 [10:05:32.238] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.382405999999719,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.240] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4085380000005898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.242] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4664409999995769,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.244] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.45658099999946,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.246] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.249069999999847,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.486] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":16.869174000000385,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.488] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.5085730000000694,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.490] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.430819000000156,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.492] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.493] INFO: world_state Created world state synchroniser with block history of infinity 10:05:32 [10:05:32.650] INFO: world_state Started world state synchronizer from block 1 10:05:32 [10:05:32.949] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8422019999998156,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.951] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4110179999997854,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.953] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4393899999995483,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.955] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5389350000004924,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.957] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5716360000005807,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.960] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.962] INFO: world_state Created world state synchroniser with block history of infinity 10:05:33 [10:05:33.117] INFO: world_state Started world state synchronizer from block 1 10:05:33 [10:05:33.380] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6054590000003373,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.383] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4922120000001087,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.385] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.517203999999765,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.387] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4609000000000378,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.389] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1940959999992629,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.391] INFO: world_state Stopped world state synchronizer 10:05:33 [10:05:33.392] INFO: world_state Created world state synchroniser with block history of infinity 10:05:33 [10:05:33.395] INFO: world_state Stopped world state synchronizer 10:05:33 [10:05:33.412] INFO: world_state Created world state synchroniser with block history of infinity 10:05:33 [10:05:33.580] INFO: world_state Started world state synchronizer from block 1 10:05:33 [10:05:33.931] INFO: world_state Stopped world state synchronizer 10:05:33 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.712 s) 10:05:33 ServerWorldStateSynchronizer 10:05:33 ✓ updates sync progress (810 ms) 10:05:33 ✓ handles multiple calls to start (477 ms) 10:05:33 ✓ immediately syncs if no new blocks (3 ms) 10:05:33 ✓ cannot be started if already stopped (25 ms) 10:05:33 ✓ can immediately sync to latest (719 ms) 10:05:33 ✓ can immediately sync to a minimum block number (792 ms) 10:05:33 ✓ sync returns immediately if block was already synced (468 ms) 10:05:33 ✓ throws if you try to sync to an unavailable block (430 ms) 10:05:33 ✓ throws if you try to immediate sync when not running (19 ms) 10:05:33 ✓ throws if handling blocks fails (521 ms) 10:05:33 10:05:33 Test Suites: 1 passed, 1 total 10:05:33 Tests: 10 passed, 10 total 10:05:33 Snapshots: 0 total 10:05:33 Time: 6.815 s 10:05:33 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 10:05:33 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?