Parent Log: http://ci.aztec-labs.com/00d5d0cbbd477ac8 Command: dd02bf67482af96b yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/12b762635a976e343151861f393574b7b5ce7d52 Env: REF_NAME=gh-readonly-queue/next/pr-15319-e340440b20c8e6058b811ce607aaf8447cf11c15 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 26 19:02:37 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15319_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 19:02:41 [19:02:41.047] INFO: world_state Created world state synchroniser with block history of infinity 19:02:41 [19:02:41.179] INFO: world_state Started world state synchronizer from block 1 19:02:41 [19:02:41.565] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.413108000000193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:41 [19:02:41.570] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.9433970000000045,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:41 [19:02:41.572] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3024310000000696,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:41 [19:02:41.740] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.384969000000183,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:41 [19:02:41.743] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.8974110000003748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:41 [19:02:41.748] INFO: world_state Stopped world state synchronizer 19:02:41 [19:02:41.765] INFO: world_state Stopped world state synchronizer 19:02:41 [19:02:41.768] INFO: world_state Created world state synchroniser with block history of infinity 19:02:41 [19:02:41.916] INFO: world_state Started world state synchronizer from block 1 19:02:42 [19:02:42.283] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.523283999999876,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.285] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3636520000000019,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.287] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4025430000001506,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.289] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7077479999998104,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.292] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.61577699999998,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.293] INFO: world_state Stopped world state synchronizer 19:02:42 [19:02:42.295] INFO: world_state Created world state synchroniser with block history of infinity 19:02:42 [19:02:42.296] INFO: world_state Started world state synchronizer from block 1 19:02:42 [19:02:42.297] INFO: world_state Stopped world state synchronizer 19:02:42 [19:02:42.298] INFO: world_state Created world state synchroniser with block history of infinity 19:02:42 [19:02:42.298] INFO: world_state Started world state synchronizer from block 1 19:02:42 [19:02:42.299] INFO: world_state Stopped world state synchronizer 19:02:42 [19:02:42.321] INFO: world_state Stopped world state synchronizer 19:02:42 [19:02:42.323] INFO: world_state Created world state synchroniser with block history of infinity 19:02:42 [19:02:42.510] INFO: world_state Started world state synchronizer from block 1 19:02:42 [19:02:42.784] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.345302000000629,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.786] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.15820900000017,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.788] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0085559999997713,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.789] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1400680000006105,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.801] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":10.938178000000335,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.964] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2943109999996523,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.965] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0717869999998584,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:42 [19:02:42.967] INFO: world_state Stopped world state synchronizer 19:02:42 [19:02:42.969] INFO: world_state Created world state synchroniser with block history of infinity 19:02:43 [19:02:43.126] INFO: world_state Started world state synchronizer from block 1 19:02:43 [19:02:43.426] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2910010000005059,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.428] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0986579999998867,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.429] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8839739999993981,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.430] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9686350000001767,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.432] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2780499999998938,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.696] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8945349999994505,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.698] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.7923829999999725,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.699] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.7118419999997059,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:43 [19:02:43.700] INFO: world_state Stopped world state synchronizer 19:02:43 [19:02:43.701] INFO: world_state Created world state synchroniser with block history of infinity 19:02:43 [19:02:43.905] INFO: world_state Started world state synchronizer from block 1 19:02:44 [19:02:44.197] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1724789999998393,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.199] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8692049999999654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.200] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8138829999998052,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.201] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8837239999993471,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.203] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2167799999997442,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.205] INFO: world_state Stopped world state synchronizer 19:02:44 [19:02:44.206] INFO: world_state Created world state synchroniser with block history of infinity 19:02:44 [19:02:44.367] INFO: world_state Started world state synchronizer from block 1 19:02:44 [19:02:44.699] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8460240000003978,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.700] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.928236000000652,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.702] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0194369999999253,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.703] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0045159999999669,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.704] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7607820000002903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 19:02:44 [19:02:44.705] INFO: world_state Stopped world state synchronizer 19:02:44 [19:02:44.707] INFO: world_state Created world state synchroniser with block history of infinity 19:02:44 [19:02:44.708] INFO: world_state Stopped world state synchronizer 19:02:44 [19:02:44.709] INFO: world_state Created world state synchroniser with block history of infinity 19:02:44 [19:02:44.922] INFO: world_state Started world state synchronizer from block 1 19:02:45 [19:02:45.230] INFO: world_state Stopped world state synchronizer 19:02:45 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.537 s) 19:02:45 ServerWorldStateSynchronizer 19:02:45 ✓ updates sync progress (726 ms) 19:02:45 ✓ handles multiple calls to start (526 ms) 19:02:45 ✓ immediately syncs if no new blocks (3 ms) 19:02:45 ✓ cannot be started if already stopped (25 ms) 19:02:45 ✓ can immediately sync to latest (646 ms) 19:02:45 ✓ can immediately sync to a minimum block number (732 ms) 19:02:45 ✓ sync returns immediately if block was already synced (505 ms) 19:02:45 ✓ throws if you try to sync to an unavailable block (500 ms) 19:02:45 ✓ throws if you try to immediate sync when not running (2 ms) 19:02:45 ✓ throws if handling blocks fails (522 ms) 19:02:45 19:02:45 Test Suites: 1 passed, 1 total 19:02:45 Tests: 10 passed, 10 total 19:02:45 Snapshots: 0 total 19:02:45 Time: 6.612 s 19:02:45 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 19:02:45 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?