Parent Log: http://ci.aztec-labs.com/ef28baa8c095c429 Command: 13dd8684e4e32fd7 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/1c9ca312bfdace816082212846900a49694e1e50 Env: REF_NAME=gh-readonly-queue/next/pr-15182-af094bce13530e078c78de9f3264280e6693d533 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 24 08:56:22 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15182_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 08:56:25 [08:56:25.500] INFO: world_state Created world state synchroniser with block history of infinity 08:56:25 [08:56:25.658] INFO: world_state Started world state synchronizer from block 1 08:56:26 [08:56:26.060] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.7189320000002226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.073] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":11.873802000000069,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.075] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6945599999999104,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.283] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.229964999999993,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.286] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7665850000003047,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.288] INFO: world_state Stopped world state synchronizer 08:56:26 [08:56:26.290] INFO: world_state Stopped world state synchronizer 08:56:26 [08:56:26.293] INFO: world_state Created world state synchroniser with block history of infinity 08:56:26 [08:56:26.512] INFO: world_state Started world state synchronizer from block 1 08:56:26 [08:56:26.858] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7956169999997655,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.861] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7948670000005222,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.863] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6923710000000938,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.866] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.053823000000193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.868] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2051980000005642,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:26 [08:56:26.869] INFO: world_state Stopped world state synchronizer 08:56:26 [08:56:26.870] INFO: world_state Created world state synchroniser with block history of infinity 08:56:26 [08:56:26.871] INFO: world_state Started world state synchronizer from block 1 08:56:26 [08:56:26.871] INFO: world_state Stopped world state synchronizer 08:56:26 [08:56:26.872] INFO: world_state Created world state synchroniser with block history of infinity 08:56:26 [08:56:26.872] INFO: world_state Started world state synchronizer from block 1 08:56:26 [08:56:26.873] INFO: world_state Stopped world state synchronizer 08:56:26 [08:56:26.893] INFO: world_state Stopped world state synchronizer 08:56:26 [08:56:26.895] INFO: world_state Created world state synchroniser with block history of infinity 08:56:27 [08:56:27.052] INFO: world_state Started world state synchronizer from block 1 08:56:27 [08:56:27.355] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9515719999999419,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.356] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8341039999995701,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.358] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8257640000001629,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.359] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9202300000006289,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.360] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9374009999992268,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.592] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5889440000000832,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.594] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2787530000005063,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:27 [08:56:27.596] INFO: world_state Stopped world state synchronizer 08:56:27 [08:56:27.598] INFO: world_state Created world state synchroniser with block history of infinity 08:56:27 [08:56:27.785] INFO: world_state Started world state synchronizer from block 1 08:56:28 [08:56:28.091] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2026379999997516,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.092] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0882910000000265,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.094] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1376230000005307,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.096] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1207329999997455,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.097] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1527759999999034,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.410] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.7395130000004428,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.412] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2295999999996639,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.414] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.2204390000006242,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.417] INFO: world_state Stopped world state synchronizer 08:56:28 [08:56:28.419] INFO: world_state Created world state synchroniser with block history of infinity 08:56:28 [08:56:28.583] INFO: world_state Started world state synchronizer from block 1 08:56:28 [08:56:28.882] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2416610000000219,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.884] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0586789999997563,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.885] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0219770000003336,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.887] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9662130000006073,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.888] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8669959999997445,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:28 [08:56:28.890] INFO: world_state Stopped world state synchronizer 08:56:28 [08:56:28.891] INFO: world_state Created world state synchroniser with block history of infinity 08:56:29 [08:56:29.055] INFO: world_state Started world state synchronizer from block 1 08:56:29 [08:56:29.353] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2555410000004485,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:29 [08:56:29.355] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0383879999999408,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:29 [08:56:29.357] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1048829999999725,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:29 [08:56:29.358] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.004146000000219,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:29 [08:56:29.360] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.002255000000332,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:56:29 [08:56:29.362] INFO: world_state Stopped world state synchronizer 08:56:29 [08:56:29.363] INFO: world_state Created world state synchroniser with block history of infinity 08:56:29 [08:56:29.366] INFO: world_state Stopped world state synchronizer 08:56:29 [08:56:29.368] INFO: world_state Created world state synchroniser with block history of infinity 08:56:29 [08:56:29.564] INFO: world_state Started world state synchronizer from block 1 08:56:29 [08:56:29.854] INFO: world_state Stopped world state synchronizer 08:56:29 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.725 s) 08:56:29 ServerWorldStateSynchronizer 08:56:29 ✓ updates sync progress (795 ms) 08:56:29 ✓ handles multiple calls to start (577 ms) 08:56:29 ✓ immediately syncs if no new blocks (2 ms) 08:56:29 ✓ cannot be started if already stopped (21 ms) 08:56:29 ✓ can immediately sync to latest (702 ms) 08:56:29 ✓ can immediately sync to a minimum block number (820 ms) 08:56:29 ✓ sync returns immediately if block was already synced (472 ms) 08:56:29 ✓ throws if you try to sync to an unavailable block (471 ms) 08:56:29 ✓ throws if you try to immediate sync when not running (5 ms) 08:56:29 ✓ throws if handling blocks fails (487 ms) 08:56:29 08:56:29 Test Suites: 1 passed, 1 total 08:56:29 Tests: 10 passed, 10 total 08:56:29 Snapshots: 0 total 08:56:29 Time: 6.802 s 08:56:29 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 08:56:29 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?