Parent Log: http://ci.aztec-labs.com/117fd8a75fa699eb Command: 4dcaaab13058c9f1 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/1542a83b8e029762e119474de1725d84a1aee3d2 Env: REF_NAME=gh-readonly-queue/next/pr-15095-eb7990c89ac679ce7fdfc2e985670cbf85c04be2 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 10:15:41 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15095_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 10:15:45 [10:15:45.277] INFO: world_state Created world state synchroniser with block history of infinity 10:15:45 [10:15:45.429] INFO: world_state Started world state synchronizer from block 1 10:15:45 [10:15:45.873] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.102065999999468,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:45 [10:15:45.879] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":4.272442999999839,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:45 [10:15:45.883] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.756155000000035,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.113] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":13.035488000000441,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.116] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6952030000002196,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.118] INFO: world_state Stopped world state synchronizer 10:15:46 [10:15:46.119] INFO: world_state Stopped world state synchronizer 10:15:46 [10:15:46.122] INFO: world_state Created world state synchroniser with block history of infinity 10:15:46 [10:15:46.262] INFO: world_state Started world state synchronizer from block 1 10:15:46 [10:15:46.596] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7366760000004433,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.598] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4545230000003357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.600] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.388108000000102,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.602] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7672069999998712,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.605] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5863540000000285,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:46 [10:15:46.606] INFO: world_state Stopped world state synchronizer 10:15:46 [10:15:46.608] INFO: world_state Created world state synchroniser with block history of infinity 10:15:46 [10:15:46.610] INFO: world_state Started world state synchronizer from block 1 10:15:46 [10:15:46.611] INFO: world_state Stopped world state synchronizer 10:15:46 [10:15:46.612] INFO: world_state Created world state synchroniser with block history of infinity 10:15:46 [10:15:46.613] INFO: world_state Started world state synchronizer from block 1 10:15:46 [10:15:46.613] INFO: world_state Stopped world state synchronizer 10:15:46 [10:15:46.629] INFO: world_state Stopped world state synchronizer 10:15:46 [10:15:46.631] INFO: world_state Created world state synchroniser with block history of infinity 10:15:46 [10:15:46.825] INFO: world_state Started world state synchronizer from block 1 10:15:47 [10:15:47.106] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5906549999999697,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.108] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2637690000001385,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.110] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2725990000008096,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.112] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2769289999996545,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.114] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2410970000000816,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.273] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.397399000000405,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.275] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8417749999998705,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.276] INFO: world_state Stopped world state synchronizer 10:15:47 [10:15:47.278] INFO: world_state Created world state synchroniser with block history of infinity 10:15:47 [10:15:47.431] INFO: world_state Started world state synchronizer from block 1 10:15:47 [10:15:47.767] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3387849999999162,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.769] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.079294000000118,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.771] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.070502999999917,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.772] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.988256999999976,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:47 [10:15:47.774] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1182769999995799,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.144] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.6735109999999622,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.147] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.5741829999997208,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.149] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.605435999999827,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.151] INFO: world_state Stopped world state synchronizer 10:15:48 [10:15:48.166] INFO: world_state Created world state synchroniser with block history of infinity 10:15:48 [10:15:48.390] INFO: world_state Started world state synchronizer from block 1 10:15:48 [10:15:48.800] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4079000000001543,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.803] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2868599999992512,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.804] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1969829999998183,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.806] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2576689999996233,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.808] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.086033999999927,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:48 [10:15:48.810] INFO: world_state Stopped world state synchronizer 10:15:48 [10:15:48.811] INFO: world_state Created world state synchroniser with block history of infinity 10:15:49 [10:15:49.014] INFO: world_state Started world state synchronizer from block 1 10:15:49 [10:15:49.283] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4989470000000438,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:49 [10:15:49.284] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0736640000004627,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:49 [10:15:49.286] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8491759999997157,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:49 [10:15:49.287] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7838109999993321,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:49 [10:15:49.288] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.806643000000804,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:15:49 [10:15:49.290] INFO: world_state Stopped world state synchronizer 10:15:49 [10:15:49.292] INFO: world_state Created world state synchroniser with block history of infinity 10:15:49 [10:15:49.295] INFO: world_state Stopped world state synchronizer 10:15:49 [10:15:49.296] INFO: world_state Created world state synchroniser with block history of infinity 10:15:49 [10:15:49.478] INFO: world_state Started world state synchronizer from block 1 10:15:49 [10:15:49.761] INFO: world_state Stopped world state synchronizer 10:15:49 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.308 s) 10:15:49 ServerWorldStateSynchronizer 10:15:49 ✓ updates sync progress (848 ms) 10:15:49 ✓ handles multiple calls to start (486 ms) 10:15:49 ✓ immediately syncs if no new blocks (4 ms) 10:15:49 ✓ cannot be started if already stopped (17 ms) 10:15:49 ✓ can immediately sync to latest (646 ms) 10:15:49 ✓ can immediately sync to a minimum block number (875 ms) 10:15:49 ✓ sync returns immediately if block was already synced (658 ms) 10:15:49 ✓ throws if you try to sync to an unavailable block (479 ms) 10:15:49 ✓ throws if you try to immediate sync when not running (4 ms) 10:15:49 ✓ throws if handling blocks fails (466 ms) 10:15:49 10:15:49 Test Suites: 1 passed, 1 total 10:15:49 Tests: 10 passed, 10 total 10:15:49 Snapshots: 0 total 10:15:49 Time: 7.423 s 10:15:49 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 10:15:49 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?