Parent Log: http://ci.aztec-labs.com/523a3b1793b6a592 Command: c118fea9c063e772 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/12d931e5ea9343eec403068931d3121e1d10e37e Env: REF_NAME=gh-readonly-queue/next/pr-15042-254faae7d330e160b14c6eaaa099dc92d4a9cac7 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 12:35:37 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15042_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 12:35:40 [12:35:40.695] INFO: world_state Created world state synchroniser with block history of infinity 12:35:40 [12:35:40.830] INFO: world_state Started world state synchronizer from block 1 12:35:41 [12:35:41.233] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.682639999999992,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.237] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.94031700000005,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.240] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.2058820000002015,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.389] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.180209999999988,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.391] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6390480000000025,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.393] INFO: world_state Stopped world state synchronizer 12:35:41 [12:35:41.395] INFO: world_state Stopped world state synchronizer 12:35:41 [12:35:41.397] INFO: world_state Created world state synchroniser with block history of infinity 12:35:41 [12:35:41.519] INFO: world_state Started world state synchronizer from block 1 12:35:41 [12:35:41.832] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.312377999999626,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.833] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9536769999995158,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.835] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8350599999994301,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.836] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0662040000006527,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.837] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0064000000002125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:41 [12:35:41.839] INFO: world_state Stopped world state synchronizer 12:35:41 [12:35:41.840] INFO: world_state Created world state synchroniser with block history of infinity 12:35:41 [12:35:41.840] INFO: world_state Started world state synchronizer from block 1 12:35:41 [12:35:41.841] INFO: world_state Stopped world state synchronizer 12:35:41 [12:35:41.842] INFO: world_state Created world state synchroniser with block history of infinity 12:35:41 [12:35:41.842] INFO: world_state Started world state synchronizer from block 1 12:35:41 [12:35:41.842] INFO: world_state Stopped world state synchronizer 12:35:41 [12:35:41.859] INFO: world_state Stopped world state synchronizer 12:35:41 [12:35:41.861] INFO: world_state Created world state synchroniser with block history of infinity 12:35:42 [12:35:42.046] INFO: world_state Started world state synchronizer from block 1 12:35:42 [12:35:42.366] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0627030000005107,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.368] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4842399999997724,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.371] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.646867999999813,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.373] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0309420000003229,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.375] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3046180000001186,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.572] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.335599999999431,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.574] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1020259999995687,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:42 [12:35:42.590] INFO: world_state Stopped world state synchronizer 12:35:42 [12:35:42.592] INFO: world_state Created world state synchroniser with block history of infinity 12:35:42 [12:35:42.755] INFO: world_state Started world state synchronizer from block 1 12:35:43 [12:35:43.080] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0173910000003161,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.081] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8279389999997875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.082] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7604959999998755,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.083] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7399939999995695,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.084] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7347639999998137,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.406] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4971699999996417,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.408] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3207889999994222,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.411] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.7320630000003803,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.413] INFO: world_state Stopped world state synchronizer 12:35:43 [12:35:43.415] INFO: world_state Created world state synchroniser with block history of infinity 12:35:43 [12:35:43.592] INFO: world_state Started world state synchronizer from block 1 12:35:43 [12:35:43.904] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4591070000005857,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.906] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.270676000000094,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.912] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5894250000001193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.914] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6705400000000736,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.920] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":5.196840999999949,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:43 [12:35:43.926] INFO: world_state Stopped world state synchronizer 12:35:43 [12:35:43.929] INFO: world_state Created world state synchroniser with block history of infinity 12:35:44 [12:35:44.137] INFO: world_state Started world state synchronizer from block 1 12:35:44 [12:35:44.442] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.376103000000512,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:44 [12:35:44.444] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1558089999998629,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:44 [12:35:44.454] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.7732560000004014,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:44 [12:35:44.455] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.973999000000731,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:44 [12:35:44.456] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9428060000000187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:44 [12:35:44.458] INFO: world_state Stopped world state synchronizer 12:35:44 [12:35:44.460] INFO: world_state Created world state synchroniser with block history of infinity 12:35:44 [12:35:44.462] INFO: world_state Stopped world state synchronizer 12:35:44 [12:35:44.463] INFO: world_state Created world state synchroniser with block history of infinity 12:35:44 [12:35:44.622] INFO: world_state Started world state synchronizer from block 1 12:35:44 [12:35:44.971] INFO: world_state Stopped world state synchronizer 12:35:44 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.281 s) 12:35:44 ServerWorldStateSynchronizer 12:35:44 ✓ updates sync progress (706 ms) 12:35:44 ✓ handles multiple calls to start (442 ms) 12:35:44 ✓ immediately syncs if no new blocks (2 ms) 12:35:44 ✓ cannot be started if already stopped (19 ms) 12:35:44 ✓ can immediately sync to latest (731 ms) 12:35:44 ✓ can immediately sync to a minimum block number (822 ms) 12:35:44 ✓ sync returns immediately if block was already synced (514 ms) 12:35:44 ✓ throws if you try to sync to an unavailable block (530 ms) 12:35:44 ✓ throws if you try to immediate sync when not running (4 ms) 12:35:44 ✓ throws if handling blocks fails (509 ms) 12:35:44 12:35:44 Test Suites: 1 passed, 1 total 12:35:44 Tests: 10 passed, 10 total 12:35:44 Snapshots: 0 total 12:35:44 Time: 6.382 s 12:35:44 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 12:35:44 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?