Parent Log: http://ci.aztec-labs.com/ddf305e3c7df868f Command: 29957fbe93665d48 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/4608046e462faf9ff3fbee265ba34dbecb5d0b31 Env: REF_NAME=gh-readonly-queue/next/pr-15169-2868628b6ae039db35b4267ab3975abc64a5d9b4 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 23 13:08:17 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15169_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 13:08:21 [13:08:21.314] INFO: world_state Created world state synchroniser with block history of infinity 13:08:21 [13:08:21.486] INFO: world_state Started world state synchronizer from block 1 13:08:21 [13:08:21.912] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.765314999999646,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:21 [13:08:21.915] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.9989380000001802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:21 [13:08:21.918] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6823209999997744,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.138] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.8350989999999,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.158] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":18.013794999999845,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.160] INFO: world_state Stopped world state synchronizer 13:08:22 [13:08:22.162] INFO: world_state Stopped world state synchronizer 13:08:22 [13:08:22.165] INFO: world_state Created world state synchroniser with block history of infinity 13:08:22 [13:08:22.339] INFO: world_state Started world state synchronizer from block 1 13:08:22 [13:08:22.635] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.9069259999996575,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.638] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7202909999996336,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.640] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.438575000000128,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.643] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7797430000000531,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.647] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":3.905354000000443,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:22 [13:08:22.650] INFO: world_state Stopped world state synchronizer 13:08:22 [13:08:22.652] INFO: world_state Created world state synchroniser with block history of infinity 13:08:22 [13:08:22.653] INFO: world_state Started world state synchronizer from block 1 13:08:22 [13:08:22.654] INFO: world_state Stopped world state synchronizer 13:08:22 [13:08:22.655] INFO: world_state Created world state synchroniser with block history of infinity 13:08:22 [13:08:22.656] INFO: world_state Started world state synchronizer from block 1 13:08:22 [13:08:22.657] INFO: world_state Stopped world state synchronizer 13:08:22 [13:08:22.681] INFO: world_state Stopped world state synchronizer 13:08:22 [13:08:22.683] INFO: world_state Created world state synchroniser with block history of infinity 13:08:22 [13:08:22.878] INFO: world_state Started world state synchronizer from block 1 13:08:23 [13:08:23.194] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3644530000001396,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.196] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8494109999992361,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.197] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0041840000003504,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.199] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.230609999999615,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.201] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.008813999999802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.417] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5294569999996384,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.420] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":2.196042999999918,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.421] INFO: world_state Stopped world state synchronizer 13:08:23 [13:08:23.423] INFO: world_state Created world state synchroniser with block history of infinity 13:08:23 [13:08:23.617] INFO: world_state Started world state synchronizer from block 1 13:08:23 [13:08:23.918] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2039889999996376,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.919] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8627710000000661,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.921] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8671809999996185,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.922] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7960600000005797,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:23 [13:08:23.923] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7945990000007441,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.244] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5948889999999665,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.251] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":5.753828999999314,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.259] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":5.6885870000005525,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.265] INFO: world_state Stopped world state synchronizer 13:08:24 [13:08:24.267] INFO: world_state Created world state synchroniser with block history of infinity 13:08:24 [13:08:24.471] INFO: world_state Started world state synchronizer from block 1 13:08:24 [13:08:24.833] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5258670000002894,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.835] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.216750000000502,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.837] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2932609999998022,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.839] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1831990000000587,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.841] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1542679999993197,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:24 [13:08:24.844] INFO: world_state Stopped world state synchronizer 13:08:24 [13:08:24.846] INFO: world_state Created world state synchroniser with block history of infinity 13:08:25 [13:08:25.024] INFO: world_state Started world state synchronizer from block 1 13:08:25 [13:08:25.322] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.445625000000291,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:25 [13:08:25.324] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2766409999994721,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:25 [13:08:25.328] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":3.420561999999336,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:25 [13:08:25.332] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.36244699999952,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:25 [13:08:25.334] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0831659999994372,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:08:25 [13:08:25.336] INFO: world_state Stopped world state synchronizer 13:08:25 [13:08:25.338] INFO: world_state Created world state synchroniser with block history of infinity 13:08:25 [13:08:25.341] INFO: world_state Stopped world state synchronizer 13:08:25 [13:08:25.342] INFO: world_state Created world state synchroniser with block history of infinity 13:08:25 [13:08:25.565] INFO: world_state Started world state synchronizer from block 1 13:08:25 [13:08:25.871] INFO: world_state Stopped world state synchronizer 13:08:25 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.88 s) 13:08:25 ServerWorldStateSynchronizer 13:08:25 ✓ updates sync progress (854 ms) 13:08:25 ✓ handles multiple calls to start (486 ms) 13:08:25 ✓ immediately syncs if no new blocks (4 ms) 13:08:25 ✓ cannot be started if already stopped (28 ms) 13:08:25 ✓ can immediately sync to latest (740 ms) 13:08:25 ✓ can immediately sync to a minimum block number (843 ms) 13:08:25 ✓ sync returns immediately if block was already synced (578 ms) 13:08:25 ✓ throws if you try to sync to an unavailable block (491 ms) 13:08:25 ✓ throws if you try to immediate sync when not running (4 ms) 13:08:25 ✓ throws if handling blocks fails (530 ms) 13:08:25 13:08:25 Test Suites: 1 passed, 1 total 13:08:25 Tests: 10 passed, 10 total 13:08:25 Snapshots: 0 total 13:08:25 Time: 6.978 s 13:08:25 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:08:25 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?