Parent Log: http://ci.aztec-labs.com/6fbf8abddd36c45a Command: 70811dc7878fc723 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/9071986bfe3af58c70d2c80c10f523e22bfe4cb4 Env: REF_NAME=gh-readonly-queue/next/pr-15133-64d1ec347b1cea9fa1b04ff6fc2984f8ee073b2b CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Fri Jun 20 14:51:51 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15133_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:51:53 [14:51:53.834] INFO: world_state Created world state synchroniser with block history of infinity 14:51:53 [14:51:53.934] INFO: world_state Started world state synchronizer from block 1 14:51:54 [14:51:54.237] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.9965619999998125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.240] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.9292460000001483,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.242] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5117889999996805,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.384] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.451314999999795,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.386] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.274471000000176,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.387] INFO: world_state Stopped world state synchronizer 14:51:54 [14:51:54.389] INFO: world_state Stopped world state synchronizer 14:51:54 [14:51:54.392] INFO: world_state Created world state synchroniser with block history of infinity 14:51:54 [14:51:54.509] INFO: world_state Started world state synchronizer from block 1 14:51:54 [14:51:54.729] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2241140000000996,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.731] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1961040000001049,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.733] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2284779999999955,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.735] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5117690000001858,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.737] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3824549999999363,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:54 [14:51:54.738] INFO: world_state Stopped world state synchronizer 14:51:54 [14:51:54.740] INFO: world_state Created world state synchroniser with block history of infinity 14:51:54 [14:51:54.740] INFO: world_state Started world state synchronizer from block 1 14:51:54 [14:51:54.741] INFO: world_state Stopped world state synchronizer 14:51:54 [14:51:54.742] INFO: world_state Created world state synchroniser with block history of infinity 14:51:54 [14:51:54.742] INFO: world_state Started world state synchronizer from block 1 14:51:54 [14:51:54.743] INFO: world_state Stopped world state synchronizer 14:51:54 [14:51:54.757] INFO: world_state Stopped world state synchronizer 14:51:54 [14:51:54.758] INFO: world_state Created world state synchroniser with block history of infinity 14:51:54 [14:51:54.883] INFO: world_state Started world state synchronizer from block 1 14:51:55 [14:51:55.104] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9627399999999398,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.106] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8931149999998524,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.107] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8899759999999333,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.108] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.966928999999709,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.110] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.917185000000245,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.242] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8760149999998248,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.244] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8498039999999492,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.252] INFO: world_state Stopped world state synchronizer 14:51:55 [14:51:55.253] INFO: world_state Created world state synchroniser with block history of infinity 14:51:55 [14:51:55.370] INFO: world_state Started world state synchronizer from block 1 14:51:55 [14:51:55.591] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9149849999994331,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.592] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8726390000001629,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.594] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8990100000000893,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.596] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9542979999996533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.598] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8884559999996782,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.807] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9005160000006072,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.808] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8708870000000388,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.810] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.886066000000028,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:55 [14:51:55.811] INFO: world_state Stopped world state synchronizer 14:51:55 [14:51:55.813] INFO: world_state Created world state synchroniser with block history of infinity 14:51:55 [14:51:55.930] INFO: world_state Started world state synchronizer from block 1 14:51:56 [14:51:56.151] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.928223999999318,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.152] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8806029999996099,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.153] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8532869999999093,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.155] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9199459999999817,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.156] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9448579999998401,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.158] INFO: world_state Stopped world state synchronizer 14:51:56 [14:51:56.159] INFO: world_state Created world state synchroniser with block history of infinity 14:51:56 [14:51:56.283] INFO: world_state Started world state synchronizer from block 1 14:51:56 [14:51:56.498] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8400110000002314,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.499] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.845831999999973,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.500] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8238369999999122,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.502] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8076890000002095,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.503] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7989350000007107,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:51:56 [14:51:56.504] INFO: world_state Stopped world state synchronizer 14:51:56 [14:51:56.512] INFO: world_state Created world state synchroniser with block history of infinity 14:51:56 [14:51:56.515] INFO: world_state Stopped world state synchronizer 14:51:56 [14:51:56.516] INFO: world_state Created world state synchroniser with block history of infinity 14:51:56 [14:51:56.634] INFO: world_state Started world state synchronizer from block 1 14:51:56 [14:51:56.859] INFO: world_state Stopped world state synchronizer 14:51:56 PASS src/synchronizer/server_world_state_synchronizer.test.ts 14:51:56 ServerWorldStateSynchronizer 14:51:56 ✓ updates sync progress (559 ms) 14:51:56 ✓ handles multiple calls to start (347 ms) 14:51:56 ✓ immediately syncs if no new blocks (2 ms) 14:51:56 ✓ cannot be started if already stopped (16 ms) 14:51:56 ✓ can immediately sync to latest (495 ms) 14:51:56 ✓ can immediately sync to a minimum block number (558 ms) 14:51:56 ✓ sync returns immediately if block was already synced (346 ms) 14:51:56 ✓ throws if you try to sync to an unavailable block (347 ms) 14:51:56 ✓ throws if you try to immediate sync when not running (10 ms) 14:51:56 ✓ throws if handling blocks fails (343 ms) 14:51:56 14:51:56 Test Suites: 1 passed, 1 total 14:51:56 Tests: 10 passed, 10 total 14:51:56 Snapshots: 0 total 14:51:56 Time: 4.849 s 14:51:56 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:51:56 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?