Parent Log: http://ci.aztec-labs.com/b66f3d7434cdc44d Command: 85ebe83a9ef9464b yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/24972303091baff6f83c6389d7d1406c932357e9 Env: REF_NAME=gh-readonly-queue/next/pr-15042-a0a8617413ca6f4fba2ad190ce73dab59bd75a45 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 14:17:34 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15042_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:17:38 [14:17:38.536] INFO: world_state Created world state synchroniser with block history of infinity 14:17:38 [14:17:38.670] INFO: world_state Started world state synchronizer from block 1 14:17:39 [14:17:39.160] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":12.029481999999916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.164] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.7589850000003935,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.167] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.3286449999995966,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.385] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7298499999997148,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.388] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4908349999996062,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.389] INFO: world_state Stopped world state synchronizer 14:17:39 [14:17:39.391] INFO: world_state Stopped world state synchronizer 14:17:39 [14:17:39.394] INFO: world_state Created world state synchroniser with block history of infinity 14:17:39 [14:17:39.580] INFO: world_state Started world state synchronizer from block 1 14:17:39 [14:17:39.920] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.388235999999779,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.925] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.9895770000002813,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.931] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.9659249999995154,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.934] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.0014769999997952,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.936] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7077399999998306,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:39 [14:17:39.938] INFO: world_state Stopped world state synchronizer 14:17:39 [14:17:39.941] INFO: world_state Created world state synchroniser with block history of infinity 14:17:39 [14:17:39.942] INFO: world_state Started world state synchronizer from block 1 14:17:39 [14:17:39.943] INFO: world_state Stopped world state synchronizer 14:17:39 [14:17:39.944] INFO: world_state Created world state synchroniser with block history of infinity 14:17:39 [14:17:39.945] INFO: world_state Started world state synchronizer from block 1 14:17:39 [14:17:39.945] INFO: world_state Stopped world state synchronizer 14:17:39 [14:17:39.969] INFO: world_state Stopped world state synchronizer 14:17:39 [14:17:39.971] INFO: world_state Created world state synchroniser with block history of infinity 14:17:40 [14:17:40.153] INFO: world_state Started world state synchronizer from block 1 14:17:40 [14:17:40.503] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.670629999999619,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.505] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.43730400000004,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.507] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3689530000001469,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.509] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.297751000000062,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.511] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3908329999994749,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.710] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":10.115380000000187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.712] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9576429999997345,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:40 [14:17:40.713] INFO: world_state Stopped world state synchronizer 14:17:40 [14:17:40.714] INFO: world_state Created world state synchroniser with block history of infinity 14:17:40 [14:17:40.860] INFO: world_state Started world state synchronizer from block 1 14:17:41 [14:17:41.147] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4783950000000914,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.149] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2860399999999572,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.151] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2291989999994257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.152] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1820569999999861,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.154] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1664470000005167,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.448] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4459339999993972,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.450] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.339071000000331,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.452] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3895029999994222,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.454] INFO: world_state Stopped world state synchronizer 14:17:41 [14:17:41.456] INFO: world_state Created world state synchroniser with block history of infinity 14:17:41 [14:17:41.613] INFO: world_state Started world state synchronizer from block 1 14:17:41 [14:17:41.867] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9317129999999452,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.868] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.876390999999785,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.870] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2087689999998474,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.872] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2757700000001932,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.873] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1436469999998735,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:41 [14:17:41.875] INFO: world_state Stopped world state synchronizer 14:17:41 [14:17:41.876] INFO: world_state Created world state synchroniser with block history of infinity 14:17:42 [14:17:42.065] INFO: world_state Started world state synchronizer from block 1 14:17:42 [14:17:42.376] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":11.095902999999453,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:42 [14:17:42.378] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.22537900000043,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:42 [14:17:42.379] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8858609999997498,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:42 [14:17:42.380] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.032944000000498,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:42 [14:17:42.382] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8950910000003205,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:42 [14:17:42.383] INFO: world_state Stopped world state synchronizer 14:17:42 [14:17:42.384] INFO: world_state Created world state synchroniser with block history of infinity 14:17:42 [14:17:42.386] INFO: world_state Stopped world state synchronizer 14:17:42 [14:17:42.387] INFO: world_state Created world state synchroniser with block history of infinity 14:17:42 [14:17:42.569] INFO: world_state Started world state synchronizer from block 1 14:17:42 [14:17:42.902] INFO: world_state Stopped world state synchronizer 14:17:42 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.985 s) 14:17:42 ServerWorldStateSynchronizer 14:17:42 ✓ updates sync progress (863 ms) 14:17:42 ✓ handles multiple calls to start (546 ms) 14:17:42 ✓ immediately syncs if no new blocks (4 ms) 14:17:42 ✓ cannot be started if already stopped (26 ms) 14:17:42 ✓ can immediately sync to latest (743 ms) 14:17:42 ✓ can immediately sync to a minimum block number (740 ms) 14:17:42 ✓ sync returns immediately if block was already synced (421 ms) 14:17:42 ✓ throws if you try to sync to an unavailable block (507 ms) 14:17:42 ✓ throws if you try to immediate sync when not running (3 ms) 14:17:42 ✓ throws if handling blocks fails (517 ms) 14:17:42 14:17:42 Test Suites: 1 passed, 1 total 14:17:42 Tests: 10 passed, 10 total 14:17:42 Snapshots: 0 total 14:17:42 Time: 7.113 s 14:17:42 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:17:42 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?