Parent Log: http://ci.aztec-labs.com/689bf7188b21e6fd Command: dc7127b43d957436 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/106f897363bb5aee27ddd091b5be9641b011c5bb Env: REF_NAME=gh-readonly-queue/next/pr-15004-2b9c409698cf0f475a7a9f5884117c8ad2a4f79a CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Thu Jun 12 15:54:33 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15004_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 15:54:35 [15:54:35.261] INFO: world_state Created world state synchroniser with block history of infinity 15:54:35 [15:54:35.353] INFO: world_state Started world state synchronizer from block 1 15:54:35 [15:54:35.653] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.9269110000000182,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:35 [15:54:35.656] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.789929999999913,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:35 [15:54:35.659] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4468940000001567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:35 [15:54:35.794] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.442649000000074,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:35 [15:54:35.798] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.568960000000061,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:35 [15:54:35.799] INFO: world_state Stopped world state synchronizer 15:54:35 [15:54:35.801] INFO: world_state Stopped world state synchronizer 15:54:35 [15:54:35.804] INFO: world_state Created world state synchroniser with block history of infinity 15:54:35 [15:54:35.912] INFO: world_state Started world state synchronizer from block 1 15:54:36 [15:54:36.116] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.166233999999804,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.118] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1674400000001697,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.119] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1817249999999149,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.121] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.48747800000001,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.123] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3651859999999942,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.124] INFO: world_state Stopped world state synchronizer 15:54:36 [15:54:36.126] INFO: world_state Created world state synchroniser with block history of infinity 15:54:36 [15:54:36.127] INFO: world_state Started world state synchronizer from block 1 15:54:36 [15:54:36.127] INFO: world_state Stopped world state synchronizer 15:54:36 [15:54:36.128] INFO: world_state Created world state synchroniser with block history of infinity 15:54:36 [15:54:36.129] INFO: world_state Started world state synchronizer from block 1 15:54:36 [15:54:36.129] INFO: world_state Stopped world state synchronizer 15:54:36 [15:54:36.144] INFO: world_state Stopped world state synchronizer 15:54:36 [15:54:36.145] INFO: world_state Created world state synchroniser with block history of infinity 15:54:36 [15:54:36.259] INFO: world_state Started world state synchronizer from block 1 15:54:36 [15:54:36.465] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8872940000001108,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.466] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.861138999999639,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.467] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8182919999999285,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.469] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8798179999998865,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.470] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8729870000001938,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.601] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8512749999999869,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.602] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8256700000001729,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.603] INFO: world_state Stopped world state synchronizer 15:54:36 [15:54:36.604] INFO: world_state Created world state synchroniser with block history of infinity 15:54:36 [15:54:36.713] INFO: world_state Started world state synchronizer from block 1 15:54:36 [15:54:36.918] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8914839999997639,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.919] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8265440000000126,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.921] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7998700000002827,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.922] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8063259999998991,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:36 [15:54:36.923] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7979900000000271,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.119] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8579750000003514,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.120] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8281739999997626,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.122] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.8792170000001533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.123] INFO: world_state Stopped world state synchronizer 15:54:37 [15:54:37.124] INFO: world_state Created world state synchroniser with block history of infinity 15:54:37 [15:54:37.232] INFO: world_state Started world state synchronizer from block 1 15:54:37 [15:54:37.436] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8731620000007752,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.437] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8009799999999814,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.438] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7841760000001159,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.440] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8195789999999761,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.441] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8068699999994351,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.443] INFO: world_state Stopped world state synchronizer 15:54:37 [15:54:37.444] INFO: world_state Created world state synchroniser with block history of infinity 15:54:37 [15:54:37.558] INFO: world_state Started world state synchronizer from block 1 15:54:37 [15:54:37.761] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8292869999995673,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.763] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7921200000000681,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.764] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7620299999998679,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.765] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7668149999999514,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.766] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7816469999997935,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:54:37 [15:54:37.767] INFO: world_state Stopped world state synchronizer 15:54:37 [15:54:37.769] INFO: world_state Created world state synchroniser with block history of infinity 15:54:37 [15:54:37.771] INFO: world_state Stopped world state synchronizer 15:54:37 [15:54:37.772] INFO: world_state Created world state synchroniser with block history of infinity 15:54:37 [15:54:37.880] INFO: world_state Started world state synchronizer from block 1 15:54:38 [15:54:38.085] INFO: world_state Stopped world state synchronizer 15:54:38 PASS src/synchronizer/server_world_state_synchronizer.test.ts 15:54:38 ServerWorldStateSynchronizer 15:54:38 ✓ updates sync progress (544 ms) 15:54:38 ✓ handles multiple calls to start (322 ms) 15:54:38 ✓ immediately syncs if no new blocks (3 ms) 15:54:38 ✓ cannot be started if already stopped (16 ms) 15:54:38 ✓ can immediately sync to latest (459 ms) 15:54:38 ✓ can immediately sync to a minimum block number (519 ms) 15:54:38 ✓ sync returns immediately if block was already synced (319 ms) 15:54:38 ✓ throws if you try to sync to an unavailable block (325 ms) 15:54:38 ✓ throws if you try to immediate sync when not running (3 ms) 15:54:38 ✓ throws if handling blocks fails (313 ms) 15:54:38 15:54:38 Test Suites: 1 passed, 1 total 15:54:38 Tests: 10 passed, 10 total 15:54:38 Snapshots: 0 total 15:54:38 Time: 4.353 s 15:54:38 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 15:54:38 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?