Parent Log: http://ci.aztec-labs.com/2feadc10a0482910 Command: 7036b634d1ccdbba yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/b6c045c8e9bbe748f5441bd1e65a9beeb9c62e73 Env: REF_NAME=gh-readonly-queue/next/pr-15067-24972303091baff6f83c6389d7d1406c932357e9 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 14:19:23 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15067_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:19:27 [14:19:27.915] INFO: world_state Created world state synchroniser with block history of infinity 14:19:28 [14:19:28.050] INFO: world_state Started world state synchronizer from block 1 14:19:28 [14:19:28.480] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.1358259999997244,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:28 [14:19:28.485] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.7511059999997087,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:28 [14:19:28.487] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.389208999999937,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:28 [14:19:28.643] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6353060000001278,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:28 [14:19:28.645] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.501137000000199,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:28 [14:19:28.647] INFO: world_state Stopped world state synchronizer 14:19:28 [14:19:28.648] INFO: world_state Stopped world state synchronizer 14:19:28 [14:19:28.651] INFO: world_state Created world state synchroniser with block history of infinity 14:19:28 [14:19:28.814] INFO: world_state Started world state synchronizer from block 1 14:19:29 [14:19:29.105] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5125870000001669,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.108] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.88834499999939,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.110] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3984700000000885,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.112] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3642479999998613,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.114] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4326120000005176,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.115] INFO: world_state Stopped world state synchronizer 14:19:29 [14:19:29.117] INFO: world_state Created world state synchroniser with block history of infinity 14:19:29 [14:19:29.117] INFO: world_state Started world state synchronizer from block 1 14:19:29 [14:19:29.117] INFO: world_state Stopped world state synchronizer 14:19:29 [14:19:29.118] INFO: world_state Created world state synchroniser with block history of infinity 14:19:29 [14:19:29.119] INFO: world_state Started world state synchronizer from block 1 14:19:29 [14:19:29.119] INFO: world_state Stopped world state synchronizer 14:19:29 [14:19:29.137] INFO: world_state Stopped world state synchronizer 14:19:29 [14:19:29.139] INFO: world_state Created world state synchroniser with block history of infinity 14:19:29 [14:19:29.321] INFO: world_state Started world state synchronizer from block 1 14:19:29 [14:19:29.596] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4832049999995434,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.598] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2653000000000247,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.600] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.209737000000132,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.615] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6766990000005535,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.617] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2662510000000111,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.813] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5063180000006469,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.815] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3827179999998407,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:29 [14:19:29.816] INFO: world_state Stopped world state synchronizer 14:19:29 [14:19:29.818] INFO: world_state Created world state synchroniser with block history of infinity 14:19:30 [14:19:30.004] INFO: world_state Started world state synchronizer from block 1 14:19:30 [14:19:30.296] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4713149999997768,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.298] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2574100000001636,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.300] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1325100000003658,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.301] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1265000000003056,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.303] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0620150000004287,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.632] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5172679999996035,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.634] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.389129000000139,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.636] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3637870000002295,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:30 [14:19:30.638] INFO: world_state Stopped world state synchronizer 14:19:30 [14:19:30.640] INFO: world_state Created world state synchroniser with block history of infinity 14:19:30 [14:19:30.801] INFO: world_state Started world state synchronizer from block 1 14:19:31 [14:19:31.103] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0211019999997006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.105] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.092768000000433,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.106] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9712600000002567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.108] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0391639999998006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.109] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0070019999993747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.111] INFO: world_state Stopped world state synchronizer 14:19:31 [14:19:31.113] INFO: world_state Created world state synchroniser with block history of infinity 14:19:31 [14:19:31.275] INFO: world_state Started world state synchronizer from block 1 14:19:31 [14:19:31.587] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5306289999998626,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.590] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2556299999996554,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.591] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1574629999995523,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.593] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.091048000000228,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.594] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.074106999999458,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:31 [14:19:31.596] INFO: world_state Stopped world state synchronizer 14:19:31 [14:19:31.598] INFO: world_state Created world state synchroniser with block history of infinity 14:19:31 [14:19:31.600] INFO: world_state Stopped world state synchronizer 14:19:31 [14:19:31.602] INFO: world_state Created world state synchroniser with block history of infinity 14:19:31 [14:19:31.751] INFO: world_state Started world state synchronizer from block 1 14:19:32 [14:19:32.027] INFO: world_state Stopped world state synchronizer 14:19:32 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.783 s) 14:19:32 ServerWorldStateSynchronizer 14:19:32 ✓ updates sync progress (739 ms) 14:19:32 ✓ handles multiple calls to start (465 ms) 14:19:32 ✓ immediately syncs if no new blocks (2 ms) 14:19:32 ✓ cannot be started if already stopped (19 ms) 14:19:32 ✓ can immediately sync to latest (679 ms) 14:19:32 ✓ can immediately sync to a minimum block number (821 ms) 14:19:32 ✓ sync returns immediately if block was already synced (472 ms) 14:19:32 ✓ throws if you try to sync to an unavailable block (485 ms) 14:19:32 ✓ throws if you try to immediate sync when not running (4 ms) 14:19:32 ✓ throws if handling blocks fails (426 ms) 14:19:32 14:19:32 Test Suites: 1 passed, 1 total 14:19:32 Tests: 10 passed, 10 total 14:19:32 Snapshots: 0 total 14:19:32 Time: 6.906 s 14:19:32 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:19:32 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?