Parent Log: http://ci.aztec-labs.com/33a1b119926f6359 Command: 5b4d9f16dc72b5a7 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/1b10c7d500621ca2e4c0db764df67f3085beb282 Env: REF_NAME=gh-readonly-queue/next/pr-15229-99e234fe4473771b32124e0402885610a6a3f98a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 24 10:05:27 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15229_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:05:31 [10:05:31.340] INFO: world_state Created world state synchroniser with block history of infinity 10:05:31 [10:05:31.502] INFO: world_state Started world state synchronizer from block 1 10:05:31 [10:05:31.910] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.439005000000179,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.913] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7694769999998243,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:31 [10:05:31.916] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.9731289999999717,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.074] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.2776229999999487,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.078] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.1268410000002405,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.081] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.083] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.098] INFO: world_state Created world state synchroniser with block history of infinity 10:05:32 [10:05:32.256] INFO: world_state Started world state synchronizer from block 1 10:05:32 [10:05:32.555] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.135417000000416,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.557] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9640639999997802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.559] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8320020000001023,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.560] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.124735999999757,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.561] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0210250000000087,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:32 [10:05:32.563] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.564] INFO: world_state Created world state synchroniser with block history of infinity 10:05:32 [10:05:32.565] INFO: world_state Started world state synchronizer from block 1 10:05:32 [10:05:32.565] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.567] INFO: world_state Created world state synchroniser with block history of infinity 10:05:32 [10:05:32.567] INFO: world_state Started world state synchronizer from block 1 10:05:32 [10:05:32.567] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.591] INFO: world_state Stopped world state synchronizer 10:05:32 [10:05:32.594] INFO: world_state Created world state synchroniser with block history of infinity 10:05:32 [10:05:32.797] INFO: world_state Started world state synchronizer from block 1 10:05:33 [10:05:33.072] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4643220000007204,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.075] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3190800000002127,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.076] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2906290000000809,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.085] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9891039999993154,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.086] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8023620000003575,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.259] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3275989999992817,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.261] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2019370000007257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.263] INFO: world_state Stopped world state synchronizer 10:05:33 [10:05:33.264] INFO: world_state Created world state synchroniser with block history of infinity 10:05:33 [10:05:33.431] INFO: world_state Started world state synchronizer from block 1 10:05:33 [10:05:33.686] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6410850000002029,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.688] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1184869999997318,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.690] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9249330000002374,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.691] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7793710000005376,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.692] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9172639999997045,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.923] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4301320000004125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.925] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3574200000002747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.929] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":3.4937010000003283,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:33 [10:05:33.931] INFO: world_state Stopped world state synchronizer 10:05:33 [10:05:33.933] INFO: world_state Created world state synchroniser with block history of infinity 10:05:34 [10:05:34.144] INFO: world_state Started world state synchronizer from block 1 10:05:34 [10:05:34.453] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9858439999998154,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.455] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9465240000008635,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.456] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8293920000005528,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.457] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7950010000004113,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.458] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7244810000001962,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.460] INFO: world_state Stopped world state synchronizer 10:05:34 [10:05:34.461] INFO: world_state Created world state synchroniser with block history of infinity 10:05:34 [10:05:34.618] INFO: world_state Started world state synchronizer from block 1 10:05:34 [10:05:34.977] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.151221999999507,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.979] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.833372999999483,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.980] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7852709999997387,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.981] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7003599999998187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.982] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7316209999999046,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:34 [10:05:34.984] INFO: world_state Stopped world state synchronizer 10:05:34 [10:05:34.987] INFO: world_state Created world state synchroniser with block history of infinity 10:05:34 [10:05:34.991] INFO: world_state Stopped world state synchronizer 10:05:34 [10:05:34.992] INFO: world_state Created world state synchroniser with block history of infinity 10:05:35 [10:05:35.165] INFO: world_state Started world state synchronizer from block 1 10:05:35 [10:05:35.467] INFO: world_state Stopped world state synchronizer 10:05:35 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.564 s) 10:05:35 ServerWorldStateSynchronizer 10:05:35 ✓ updates sync progress (749 ms) 10:05:35 ✓ handles multiple calls to start (477 ms) 10:05:35 ✓ immediately syncs if no new blocks (3 ms) 10:05:35 ✓ cannot be started if already stopped (26 ms) 10:05:35 ✓ can immediately sync to latest (670 ms) 10:05:35 ✓ can immediately sync to a minimum block number (669 ms) 10:05:35 ✓ sync returns immediately if block was already synced (528 ms) 10:05:35 ✓ throws if you try to sync to an unavailable block (524 ms) 10:05:35 ✓ throws if you try to immediate sync when not running (5 ms) 10:05:35 ✓ throws if handling blocks fails (477 ms) 10:05:35 10:05:35 Test Suites: 1 passed, 1 total 10:05:35 Tests: 10 passed, 10 total 10:05:35 Snapshots: 0 total 10:05:35 Time: 6.667 s 10:05:35 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 10:05:35 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?