Parent Log: http://ci.aztec-labs.com/7d50fe3fd123434b Command: 9e675ed54321cc5a yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/96a426245731b3f48fcb6dd5e2a683c858706602 Env: REF_NAME=gh-readonly-queue/next/pr-15083-5867520ed258adecfee692b3694d693b2c7964ca CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 21:54:22 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15083_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:54:26 [21:54:26.445] INFO: world_state Created world state synchroniser with block history of infinity 21:54:26 [21:54:26.625] INFO: world_state Started world state synchronizer from block 1 21:54:27 [21:54:27.121] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.190005000000383,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.125] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.440221000000747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.128] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5578089999999065,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.381] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.803694999999607,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.384] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.280696999999236,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.386] INFO: world_state Stopped world state synchronizer 21:54:27 [21:54:27.387] INFO: world_state Stopped world state synchronizer 21:54:27 [21:54:27.390] INFO: world_state Created world state synchroniser with block history of infinity 21:54:27 [21:54:27.541] INFO: world_state Started world state synchronizer from block 1 21:54:27 [21:54:27.946] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4438359999994645,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.949] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.744803999999931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.952] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.548239000000649,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.955] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.45719199999985,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.959] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.440801000000647,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:27 [21:54:27.962] INFO: world_state Stopped world state synchronizer 21:54:27 [21:54:27.964] INFO: world_state Created world state synchroniser with block history of infinity 21:54:27 [21:54:27.965] INFO: world_state Started world state synchronizer from block 1 21:54:27 [21:54:27.967] INFO: world_state Stopped world state synchronizer 21:54:27 [21:54:27.968] INFO: world_state Created world state synchroniser with block history of infinity 21:54:27 [21:54:27.969] INFO: world_state Started world state synchronizer from block 1 21:54:27 [21:54:27.970] INFO: world_state Stopped world state synchronizer 21:54:27 [21:54:27.998] INFO: world_state Stopped world state synchronizer 21:54:28 [21:54:28.001] INFO: world_state Created world state synchroniser with block history of infinity 21:54:28 [21:54:28.216] INFO: world_state Started world state synchronizer from block 1 21:54:28 [21:54:28.538] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.606209999999919,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.540] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.349844000000303,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.542] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1291780000001381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.543] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9978449999998702,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.545] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.029685000000427,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.732] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9785739999997531,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.734] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.7369680000001608,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:28 [21:54:28.735] INFO: world_state Stopped world state synchronizer 21:54:28 [21:54:28.736] INFO: world_state Created world state synchroniser with block history of infinity 21:54:28 [21:54:28.896] INFO: world_state Started world state synchronizer from block 1 21:54:29 [21:54:29.207] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9887250000001586,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.209] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7992300000005343,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.211] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5265790000003108,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.213] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2604419999997845,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.215] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.176288999999997,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.531] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4969179999998232,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.533] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3808650000000853,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.535] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3926050000000032,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:29 [21:54:29.537] INFO: world_state Stopped world state synchronizer 21:54:29 [21:54:29.548] INFO: world_state Created world state synchroniser with block history of infinity 21:54:29 [21:54:29.725] INFO: world_state Started world state synchronizer from block 1 21:54:30 [21:54:30.028] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8385459999999512,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.030] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3465239999995902,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.032] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1734089999999924,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.034] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2481010000001334,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.035] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.308802999999898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.037] INFO: world_state Stopped world state synchronizer 21:54:30 [21:54:30.039] INFO: world_state Created world state synchroniser with block history of infinity 21:54:30 [21:54:30.230] INFO: world_state Started world state synchronizer from block 1 21:54:30 [21:54:30.520] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.659352000000581,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.522] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3397039999999834,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.524] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.349804000000404,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.526] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2319109999998545,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.528] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3273040000003675,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:54:30 [21:54:30.530] INFO: world_state Stopped world state synchronizer 21:54:30 [21:54:30.532] INFO: world_state Created world state synchroniser with block history of infinity 21:54:30 [21:54:30.535] INFO: world_state Stopped world state synchronizer 21:54:30 [21:54:30.537] INFO: world_state Created world state synchroniser with block history of infinity 21:54:30 [21:54:30.712] INFO: world_state Started world state synchronizer from block 1 21:54:31 [21:54:31.001] INFO: world_state Stopped world state synchronizer 21:54:31 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.168 s) 21:54:31 ServerWorldStateSynchronizer 21:54:31 ✓ updates sync progress (948 ms) 21:54:31 ✓ handles multiple calls to start (573 ms) 21:54:31 ✓ immediately syncs if no new blocks (4 ms) 21:54:31 ✓ cannot be started if already stopped (32 ms) 21:54:31 ✓ can immediately sync to latest (735 ms) 21:54:31 ✓ can immediately sync to a minimum block number (810 ms) 21:54:31 ✓ sync returns immediately if block was already synced (491 ms) 21:54:31 ✓ throws if you try to sync to an unavailable block (493 ms) 21:54:31 ✓ throws if you try to immediate sync when not running (5 ms) 21:54:31 ✓ throws if handling blocks fails (465 ms) 21:54:31 21:54:31 Test Suites: 1 passed, 1 total 21:54:31 Tests: 10 passed, 10 total 21:54:31 Snapshots: 0 total 21:54:31 Time: 7.282 s 21:54:31 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 21:54:31 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?