Parent Log: http://ci.aztec-labs.com/8dcffbbcc559db48 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:40 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15042_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:17:44 [14:17:44.381] INFO: world_state Created world state synchroniser with block history of infinity 14:17:44 [14:17:44.531] INFO: world_state Started world state synchronizer from block 1 14:17:44 [14:17:44.967] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.612710999999763,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:44 [14:17:44.971] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.1601199999995515,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:44 [14:17:44.974] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.2893770000000586,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.111] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3713760000000548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.113] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1516639999999825,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.115] INFO: world_state Stopped world state synchronizer 14:17:45 [14:17:45.117] INFO: world_state Stopped world state synchronizer 14:17:45 [14:17:45.120] INFO: world_state Created world state synchroniser with block history of infinity 14:17:45 [14:17:45.273] INFO: world_state Started world state synchronizer from block 1 14:17:45 [14:17:45.561] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.376006000000416,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.563] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.090979999999945,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.565] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0419479999991381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.567] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4788120000002891,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.569] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6816539999999804,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:45 [14:17:45.570] INFO: world_state Stopped world state synchronizer 14:17:45 [14:17:45.572] INFO: world_state Created world state synchroniser with block history of infinity 14:17:45 [14:17:45.573] INFO: world_state Started world state synchronizer from block 1 14:17:45 [14:17:45.574] INFO: world_state Stopped world state synchronizer 14:17:45 [14:17:45.575] INFO: world_state Created world state synchroniser with block history of infinity 14:17:45 [14:17:45.576] INFO: world_state Started world state synchronizer from block 1 14:17:45 [14:17:45.576] INFO: world_state Stopped world state synchronizer 14:17:45 [14:17:45.595] INFO: world_state Stopped world state synchronizer 14:17:45 [14:17:45.598] INFO: world_state Created world state synchroniser with block history of infinity 14:17:45 [14:17:45.807] INFO: world_state Started world state synchronizer from block 1 14:17:46 [14:17:46.130] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6560610000005909,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.133] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3926070000006803,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.134] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2827109999998356,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.151] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":16.30806399999983,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.160] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.1329679999998916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.347] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.6074490000000878,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.349] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.340704000000187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.351] INFO: world_state Stopped world state synchronizer 14:17:46 [14:17:46.352] INFO: world_state Created world state synchroniser with block history of infinity 14:17:46 [14:17:46.553] INFO: world_state Started world state synchronizer from block 1 14:17:46 [14:17:46.869] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.0236919999997554,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.872] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.9776700000002165,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.875] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6367899999995643,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.877] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6462710000005245,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:46 [14:17:46.879] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5506459999996878,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.151] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.363976000000548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.153] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.667062999999871,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.156] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.6614520000002813,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.159] INFO: world_state Stopped world state synchronizer 14:17:47 [14:17:47.162] INFO: world_state Created world state synchroniser with block history of infinity 14:17:47 [14:17:47.319] INFO: world_state Started world state synchronizer from block 1 14:17:47 [14:17:47.654] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.1911620000000767,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.657] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4918430000006992,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.659] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4348399999998946,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.661] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5154130000000805,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.663] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4059379999998782,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:47 [14:17:47.667] INFO: world_state Stopped world state synchronizer 14:17:47 [14:17:47.670] INFO: world_state Created world state synchroniser with block history of infinity 14:17:47 [14:17:47.847] INFO: world_state Started world state synchronizer from block 1 14:17:48 [14:17:48.198] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5038039999999455,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:48 [14:17:48.200] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.184306000000106,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:48 [14:17:48.201] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2272290000000794,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:48 [14:17:48.203] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1879659999995056,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:48 [14:17:48.205] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.102270999999746,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:17:48 [14:17:48.207] INFO: world_state Stopped world state synchronizer 14:17:48 [14:17:48.209] INFO: world_state Created world state synchroniser with block history of infinity 14:17:48 [14:17:48.213] INFO: world_state Stopped world state synchronizer 14:17:48 [14:17:48.215] INFO: world_state Created world state synchroniser with block history of infinity 14:17:48 [14:17:48.419] INFO: world_state Started world state synchronizer from block 1 14:17:48 [14:17:48.768] INFO: world_state Stopped world state synchronizer 14:17:48 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.929 s) 14:17:48 ServerWorldStateSynchronizer 14:17:48 ✓ updates sync progress (742 ms) 14:17:48 ✓ handles multiple calls to start (452 ms) 14:17:48 ✓ immediately syncs if no new blocks (3 ms) 14:17:48 ✓ cannot be started if already stopped (22 ms) 14:17:48 ✓ can immediately sync to latest (755 ms) 14:17:48 ✓ can immediately sync to a minimum block number (808 ms) 14:17:48 ✓ sync returns immediately if block was already synced (506 ms) 14:17:48 ✓ throws if you try to sync to an unavailable block (538 ms) 14:17:48 ✓ throws if you try to immediate sync when not running (5 ms) 14:17:48 ✓ throws if handling blocks fails (555 ms) 14:17:48 14:17:48 Test Suites: 1 passed, 1 total 14:17:48 Tests: 10 passed, 10 total 14:17:48 Snapshots: 0 total 14:17:48 Time: 7.047 s 14:17:48 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:17:48 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?