Parent Log: http://ci.aztec-labs.com/a079291c5cb4bf29 Command: 9e580e2a65a38075 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/184d5f7d956dd7251670a2dd6728f313cfdf3caf Env: REF_NAME=gh-readonly-queue/next/pr-14822-e56baa7f24bac54baf9e2f22f6f33ae6fa8b8c0f CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Fri Jun 13 21:22:08 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-14822_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:22:10 [21:22:10.333] INFO: world_state Created world state synchroniser with block history of infinity 21:22:10 [21:22:10.424] INFO: world_state Started world state synchronizer from block 1 21:22:10 [21:22:10.718] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.677589000000353,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:10 [21:22:10.721] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.8102139999996325,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:10 [21:22:10.724] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.822671999999784,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:10 [21:22:10.854] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3917569999998705,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:10 [21:22:10.855] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1724220000000969,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:10 [21:22:10.857] INFO: world_state Stopped world state synchronizer 21:22:10 [21:22:10.858] INFO: world_state Stopped world state synchronizer 21:22:10 [21:22:10.861] INFO: world_state Created world state synchroniser with block history of infinity 21:22:10 [21:22:10.968] INFO: world_state Started world state synchronizer from block 1 21:22:11 [21:22:11.172] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2188750000000255,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.174] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0833830000001399,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.176] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.02952600000026,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.178] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.402505999999903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.179] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2165500000000975,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.181] INFO: world_state Stopped world state synchronizer 21:22:11 [21:22:11.182] INFO: world_state Created world state synchroniser with block history of infinity 21:22:11 [21:22:11.183] INFO: world_state Started world state synchronizer from block 1 21:22:11 [21:22:11.183] INFO: world_state Stopped world state synchronizer 21:22:11 [21:22:11.184] INFO: world_state Created world state synchroniser with block history of infinity 21:22:11 [21:22:11.185] INFO: world_state Started world state synchronizer from block 1 21:22:11 [21:22:11.185] INFO: world_state Stopped world state synchronizer 21:22:11 [21:22:11.199] INFO: world_state Stopped world state synchronizer 21:22:11 [21:22:11.200] INFO: world_state Created world state synchroniser with block history of infinity 21:22:11 [21:22:11.313] INFO: world_state Started world state synchronizer from block 1 21:22:11 [21:22:11.517] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.075340999999753,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.519] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0106760000003305,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.520] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9657120000001669,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.521] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9561589999998432,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.523] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.946498999999676,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.652] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0059620000001814,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.654] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9869209999997111,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.655] INFO: world_state Stopped world state synchronizer 21:22:11 [21:22:11.656] INFO: world_state Created world state synchroniser with block history of infinity 21:22:11 [21:22:11.764] INFO: world_state Started world state synchronizer from block 1 21:22:11 [21:22:11.968] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0422490000000835,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.969] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.032329000000118,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.971] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9944009999999253,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.972] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0353519999998753,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:11 [21:22:11.974] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9509269999998651,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.166] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0037870000005569,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.167] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9553449999993973,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.169] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9998759999998583,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.170] INFO: world_state Stopped world state synchronizer 21:22:12 [21:22:12.171] INFO: world_state Created world state synchroniser with block history of infinity 21:22:12 [21:22:12.278] INFO: world_state Started world state synchronizer from block 1 21:22:12 [21:22:12.483] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0529280000000654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.485] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.000796999999693,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.486] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9920710000005784,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.488] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.026918000000478,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.489] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0429370000001654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.491] INFO: world_state Stopped world state synchronizer 21:22:12 [21:22:12.492] INFO: world_state Created world state synchroniser with block history of infinity 21:22:12 [21:22:12.607] INFO: world_state Started world state synchronizer from block 1 21:22:12 [21:22:12.813] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9775570000001608,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.814] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9518580000003567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.815] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9382009999999354,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.817] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.911337999999887,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.818] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9717140000002473,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:22:12 [21:22:12.820] INFO: world_state Stopped world state synchronizer 21:22:12 [21:22:12.821] INFO: world_state Created world state synchroniser with block history of infinity 21:22:12 [21:22:12.823] INFO: world_state Stopped world state synchronizer 21:22:12 [21:22:12.824] INFO: world_state Created world state synchroniser with block history of infinity 21:22:12 [21:22:12.932] INFO: world_state Started world state synchronizer from block 1 21:22:13 [21:22:13.140] INFO: world_state Stopped world state synchronizer 21:22:13 PASS src/synchronizer/server_world_state_synchronizer.test.ts 21:22:13 ServerWorldStateSynchronizer 21:22:13 ✓ updates sync progress (529 ms) 21:22:13 ✓ handles multiple calls to start (321 ms) 21:22:13 ✓ immediately syncs if no new blocks (3 ms) 21:22:13 ✓ cannot be started if already stopped (15 ms) 21:22:13 ✓ can immediately sync to latest (456 ms) 21:22:13 ✓ can immediately sync to a minimum block number (514 ms) 21:22:13 ✓ sync returns immediately if block was already synced (320 ms) 21:22:13 ✓ throws if you try to sync to an unavailable block (328 ms) 21:22:13 ✓ throws if you try to immediate sync when not running (3 ms) 21:22:13 ✓ throws if handling blocks fails (316 ms) 21:22:13 21:22:13 Test Suites: 1 passed, 1 total 21:22:13 Tests: 10 passed, 10 total 21:22:13 Snapshots: 0 total 21:22:13 Time: 4.443 s 21:22:13 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 21:22:13 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?