Parent Log: http://ci.aztec-labs.com/11d263800318d38c Command: 782f38c6306b3c5e yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/d5a262aabc20f5384a720a0d831e2ec28badc7f9 Env: REF_NAME=gh-readonly-queue/next/pr-15042-17ea18ade041a1bb437806e047c30b29da124094 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Wed Jun 18 18:09:27 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15042_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 18:09:29 [18:09:29.548] INFO: world_state Created world state synchroniser with block history of infinity 18:09:29 [18:09:29.651] INFO: world_state Started world state synchronizer from block 1 18:09:29 [18:09:29.964] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.07125300000007,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:29 [18:09:29.968] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.0151810000002115,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:29 [18:09:29.970] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5698280000001432,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.116] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5360399999999572,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.118] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3526160000001255,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.119] INFO: world_state Stopped world state synchronizer 18:09:30 [18:09:30.121] INFO: world_state Stopped world state synchronizer 18:09:30 [18:09:30.124] INFO: world_state Created world state synchroniser with block history of infinity 18:09:30 [18:09:30.244] INFO: world_state Started world state synchronizer from block 1 18:09:30 [18:09:30.471] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2486810000000332,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.474] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3139869999999974,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.475] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.186790000000201,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.477] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6393520000001445,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.479] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1319610000000466,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.480] INFO: world_state Stopped world state synchronizer 18:09:30 [18:09:30.482] INFO: world_state Created world state synchroniser with block history of infinity 18:09:30 [18:09:30.483] INFO: world_state Started world state synchronizer from block 1 18:09:30 [18:09:30.483] INFO: world_state Stopped world state synchronizer 18:09:30 [18:09:30.485] INFO: world_state Created world state synchroniser with block history of infinity 18:09:30 [18:09:30.485] INFO: world_state Started world state synchronizer from block 1 18:09:30 [18:09:30.485] INFO: world_state Stopped world state synchronizer 18:09:30 [18:09:30.500] INFO: world_state Stopped world state synchronizer 18:09:30 [18:09:30.501] INFO: world_state Created world state synchroniser with block history of infinity 18:09:30 [18:09:30.628] INFO: world_state Started world state synchronizer from block 1 18:09:30 [18:09:30.856] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9674639999998362,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.858] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8975799999998344,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.859] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9241619999997965,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.860] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9117160000000695,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:30 [18:09:30.861] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8304819999998472,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.004] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9163580000004004,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.005] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8850370000000112,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.006] INFO: world_state Stopped world state synchronizer 18:09:31 [18:09:31.008] INFO: world_state Created world state synchroniser with block history of infinity 18:09:31 [18:09:31.127] INFO: world_state Started world state synchronizer from block 1 18:09:31 [18:09:31.353] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8839530000004743,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.354] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8428709999998318,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.355] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8013760000003458,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.357] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.862250000000131,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.358] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.820835999999872,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.572] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8838279999999941,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.573] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8586850000001505,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.575] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9276049999998577,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.576] INFO: world_state Stopped world state synchronizer 18:09:31 [18:09:31.577] INFO: world_state Created world state synchroniser with block history of infinity 18:09:31 [18:09:31.697] INFO: world_state Started world state synchronizer from block 1 18:09:31 [18:09:31.924] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9631909999998243,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.925] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8892400000004272,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.926] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8792619999994713,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.928] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9088480000000345,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.929] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9258270000000266,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:31 [18:09:31.931] INFO: world_state Stopped world state synchronizer 18:09:31 [18:09:31.932] INFO: world_state Created world state synchroniser with block history of infinity 18:09:32 [18:09:32.059] INFO: world_state Started world state synchronizer from block 1 18:09:32 [18:09:32.280] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8738910000001852,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:32 [18:09:32.288] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":7.978493999999955,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:32 [18:09:32.290] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8785020000004806,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:32 [18:09:32.291] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8449549999995725,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:32 [18:09:32.292] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8330789999999979,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:09:32 [18:09:32.294] INFO: world_state Stopped world state synchronizer 18:09:32 [18:09:32.295] INFO: world_state Created world state synchroniser with block history of infinity 18:09:32 [18:09:32.298] INFO: world_state Stopped world state synchronizer 18:09:32 [18:09:32.299] INFO: world_state Created world state synchroniser with block history of infinity 18:09:32 [18:09:32.418] INFO: world_state Started world state synchronizer from block 1 18:09:32 [18:09:32.648] INFO: world_state Stopped world state synchronizer 18:09:32 PASS src/synchronizer/server_world_state_synchronizer.test.ts 18:09:32 ServerWorldStateSynchronizer 18:09:32 ✓ updates sync progress (577 ms) 18:09:32 ✓ handles multiple calls to start (358 ms) 18:09:32 ✓ immediately syncs if no new blocks (3 ms) 18:09:32 ✓ cannot be started if already stopped (16 ms) 18:09:32 ✓ can immediately sync to latest (507 ms) 18:09:32 ✓ can immediately sync to a minimum block number (569 ms) 18:09:32 ✓ sync returns immediately if block was already synced (354 ms) 18:09:32 ✓ throws if you try to sync to an unavailable block (363 ms) 18:09:32 ✓ throws if you try to immediate sync when not running (4 ms) 18:09:32 ✓ throws if handling blocks fails (350 ms) 18:09:32 18:09:32 Test Suites: 1 passed, 1 total 18:09:32 Tests: 10 passed, 10 total 18:09:32 Snapshots: 0 total 18:09:32 Time: 4.834 s 18:09:32 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 18:09:32 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?