Parent Log: http://ci.aztec-labs.com/8f0e17f4e3d757c2 Command: f8dcf08d5c6024d3 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/254faae7d330e160b14c6eaaa099dc92d4a9cac7 Env: REF_NAME=gh-readonly-queue/next/pr-14870-10badd24359b04680068afd9ca24407383374db1 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 11:53:41 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14870_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 11:53:44 [11:53:44.413] INFO: world_state Created world state synchroniser with block history of infinity 11:53:44 [11:53:44.580] INFO: world_state Started world state synchronizer from block 1 11:53:45 [11:53:45.000] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.6856769999999415,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.003] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.8441429999998036,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.005] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2926099999999678,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.183] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5421550000000934,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.185] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2065079999997579,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.188] INFO: world_state Stopped world state synchronizer 11:53:45 [11:53:45.191] INFO: world_state Stopped world state synchronizer 11:53:45 [11:53:45.194] INFO: world_state Created world state synchroniser with block history of infinity 11:53:45 [11:53:45.334] INFO: world_state Started world state synchronizer from block 1 11:53:45 [11:53:45.678] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.787561000000096,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.681] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.432053000000451,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.683] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3380699999997887,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.686] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.8225720000000365,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.688] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3566510000000562,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:45 [11:53:45.690] INFO: world_state Stopped world state synchronizer 11:53:45 [11:53:45.692] INFO: world_state Created world state synchroniser with block history of infinity 11:53:45 [11:53:45.693] INFO: world_state Started world state synchronizer from block 1 11:53:45 [11:53:45.695] INFO: world_state Stopped world state synchronizer 11:53:45 [11:53:45.697] INFO: world_state Created world state synchroniser with block history of infinity 11:53:45 [11:53:45.697] INFO: world_state Started world state synchronizer from block 1 11:53:45 [11:53:45.697] INFO: world_state Stopped world state synchronizer 11:53:45 [11:53:45.715] INFO: world_state Stopped world state synchronizer 11:53:45 [11:53:45.717] INFO: world_state Created world state synchroniser with block history of infinity 11:53:45 [11:53:45.911] INFO: world_state Started world state synchronizer from block 1 11:53:46 [11:53:46.227] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.524065999999948,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.229] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2858190000006289,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.231] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.202527999999802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.233] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.681587999999465,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.236] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.326231000000007,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.463] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1101349999999002,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.465] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0242440000001807,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:46 [11:53:46.467] INFO: world_state Stopped world state synchronizer 11:53:46 [11:53:46.470] INFO: world_state Created world state synchroniser with block history of infinity 11:53:46 [11:53:46.704] INFO: world_state Started world state synchronizer from block 1 11:53:47 [11:53:47.080] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8981910000002244,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.081] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7144969999999375,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.082] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7162859999998545,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.083] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.6823450000001685,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.084] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.6748760000000402,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.384] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3442710000008447,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.386] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2780599999996411,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.388] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.118786,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.389] INFO: world_state Stopped world state synchronizer 11:53:47 [11:53:47.391] INFO: world_state Created world state synchroniser with block history of infinity 11:53:47 [11:53:47.571] INFO: world_state Started world state synchronizer from block 1 11:53:47 [11:53:47.879] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9005310000002282,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.881] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1473860000005516,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.882] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0965150000001813,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.884] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2311380000001009,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.886] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0607549999995172,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:47 [11:53:47.887] INFO: world_state Stopped world state synchronizer 11:53:47 [11:53:47.890] INFO: world_state Created world state synchroniser with block history of infinity 11:53:48 [11:53:48.077] INFO: world_state Started world state synchronizer from block 1 11:53:48 [11:53:48.524] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.0563670000001366,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:48 [11:53:48.528] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7853099999992992,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:48 [11:53:48.530] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2716190000001006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:48 [11:53:48.532] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0621739999996862,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:48 [11:53:48.533] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2440889999998035,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:53:48 [11:53:48.543] INFO: world_state Stopped world state synchronizer 11:53:48 [11:53:48.568] INFO: world_state Created world state synchroniser with block history of infinity 11:53:48 [11:53:48.573] INFO: world_state Stopped world state synchronizer 11:53:48 [11:53:48.574] INFO: world_state Created world state synchroniser with block history of infinity 11:53:48 [11:53:48.758] INFO: world_state Started world state synchronizer from block 1 11:53:49 [11:53:49.064] INFO: world_state Stopped world state synchronizer 11:53:49 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.942 s) 11:53:49 ServerWorldStateSynchronizer 11:53:49 ✓ updates sync progress (782 ms) 11:53:49 ✓ handles multiple calls to start (497 ms) 11:53:49 ✓ immediately syncs if no new blocks (5 ms) 11:53:49 ✓ cannot be started if already stopped (20 ms) 11:53:49 ✓ can immediately sync to latest (752 ms) 11:53:49 ✓ can immediately sync to a minimum block number (922 ms) 11:53:49 ✓ sync returns immediately if block was already synced (498 ms) 11:53:49 ✓ throws if you try to sync to an unavailable block (655 ms) 11:53:49 ✓ throws if you try to immediate sync when not running (7 ms) 11:53:49 ✓ throws if handling blocks fails (491 ms) 11:53:49 11:53:49 Test Suites: 1 passed, 1 total 11:53:49 Tests: 10 passed, 10 total 11:53:49 Snapshots: 0 total 11:53:49 Time: 7.031 s 11:53:49 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 11:53:49 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?