Parent Log: http://ci.aztec-labs.com/f58a71454a9abef7 Command: 68e9475192d7aeac yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f495236d35f9bb0d1086b7ec79256c2c2b7c98b8 Env: REF_NAME=gh-readonly-queue/staging/pr-15201-f0619dd82429a5973f3e1da8d7eb0877264908e3 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Sat Jun 21 13:20:49 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15201_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_staging 13:20:52 [13:20:52.836] INFO: world_state Created world state synchroniser with block history of infinity 13:20:52 [13:20:52.965] INFO: world_state Started world state synchronizer from block 1 13:20:53 [13:20:53.376] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.580245999999988,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:53 [13:20:53.381] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.7710690000003524,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:53 [13:20:53.384] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.2105270000001838,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:53 [13:20:53.580] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.281050999999934,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:53 [13:20:53.583] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.9385160000001633,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:53 [13:20:53.584] INFO: world_state Stopped world state synchronizer 13:20:53 [13:20:53.585] INFO: world_state Stopped world state synchronizer 13:20:53 [13:20:53.595] INFO: world_state Created world state synchroniser with block history of infinity 13:20:53 [13:20:53.757] INFO: world_state Started world state synchronizer from block 1 13:20:54 [13:20:54.068] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.603621000000203,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.070] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4410780000007435,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.072] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4102060000004712,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.075] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.8756810000004407,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.077] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6452339999996184,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.079] INFO: world_state Stopped world state synchronizer 13:20:54 [13:20:54.081] INFO: world_state Created world state synchroniser with block history of infinity 13:20:54 [13:20:54.081] INFO: world_state Started world state synchronizer from block 1 13:20:54 [13:20:54.082] INFO: world_state Stopped world state synchronizer 13:20:54 [13:20:54.084] INFO: world_state Created world state synchroniser with block history of infinity 13:20:54 [13:20:54.084] INFO: world_state Started world state synchronizer from block 1 13:20:54 [13:20:54.085] INFO: world_state Stopped world state synchronizer 13:20:54 [13:20:54.110] INFO: world_state Stopped world state synchronizer 13:20:54 [13:20:54.111] INFO: world_state Created world state synchroniser with block history of infinity 13:20:54 [13:20:54.330] INFO: world_state Started world state synchronizer from block 1 13:20:54 [13:20:54.635] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.67183599999953,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.637] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2584449999994831,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.639] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2598550000002433,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.641] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2171909999997297,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.659] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":17.527469999999994,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.863] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5364259999996648,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.865] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.341750999999931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:54 [13:20:54.868] INFO: world_state Stopped world state synchronizer 13:20:54 [13:20:54.870] INFO: world_state Created world state synchroniser with block history of infinity 13:20:55 [13:20:55.062] INFO: world_state Started world state synchronizer from block 1 13:20:55 [13:20:55.383] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5134840000000622,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.385] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3091690000001108,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.387] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3067979999996169,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.389] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1783790000008594,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.391] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3502120000002833,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.679] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9340199999996912,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.680] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8600050000004558,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.682] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.124775000000227,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:55 [13:20:55.684] INFO: world_state Stopped world state synchronizer 13:20:55 [13:20:55.685] INFO: world_state Created world state synchroniser with block history of infinity 13:20:55 [13:20:55.866] INFO: world_state Started world state synchronizer from block 1 13:20:56 [13:20:56.144] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9430110000002969,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.146] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1402560000005906,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.147] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0575189999999566,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.149] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9361109999999826,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.151] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1711679999998523,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.153] INFO: world_state Stopped world state synchronizer 13:20:56 [13:20:56.154] INFO: world_state Created world state synchroniser with block history of infinity 13:20:56 [13:20:56.318] INFO: world_state Started world state synchronizer from block 1 13:20:56 [13:20:56.640] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.472421000000395,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.641] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8347730000004958,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.643] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1334160000005795,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.645] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2087409999994634,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.646] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9027080000005299,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:20:56 [13:20:56.647] INFO: world_state Stopped world state synchronizer 13:20:56 [13:20:56.649] INFO: world_state Created world state synchroniser with block history of infinity 13:20:56 [13:20:56.652] INFO: world_state Stopped world state synchronizer 13:20:56 [13:20:56.653] INFO: world_state Created world state synchroniser with block history of infinity 13:20:56 [13:20:56.819] INFO: world_state Started world state synchronizer from block 1 13:20:57 [13:20:57.127] INFO: world_state Stopped world state synchronizer 13:20:57 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.796 s) 13:20:57 ServerWorldStateSynchronizer 13:20:57 ✓ updates sync progress (755 ms) 13:20:57 ✓ handles multiple calls to start (492 ms) 13:20:57 ✓ immediately syncs if no new blocks (4 ms) 13:20:57 ✓ cannot be started if already stopped (27 ms) 13:20:57 ✓ can immediately sync to latest (757 ms) 13:20:57 ✓ can immediately sync to a minimum block number (815 ms) 13:20:57 ✓ sync returns immediately if block was already synced (468 ms) 13:20:57 ✓ throws if you try to sync to an unavailable block (494 ms) 13:20:57 ✓ throws if you try to immediate sync when not running (4 ms) 13:20:57 ✓ throws if handling blocks fails (475 ms) 13:20:57 13:20:57 Test Suites: 1 passed, 1 total 13:20:57 Tests: 10 passed, 10 total 13:20:57 Snapshots: 0 total 13:20:57 Time: 6.892 s 13:20:57 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:20:57 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?