Parent Log: http://ci.aztec-labs.com/c3dce723e533e8b6 Command: ed996b4a4522d156 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/6e2955d0d2cd7db82346ef547a4d19b57116ecb4 Env: REF_NAME=gh-readonly-queue/next/pr-15120-3c1b9d57eadcc8fb03a7ed42610cf0a1ae4a32eb CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 22:18:20 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15120_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 22:18:24 [22:18:24.095] INFO: world_state Created world state synchroniser with block history of infinity 22:18:24 [22:18:24.260] INFO: world_state Started world state synchronizer from block 1 22:18:24 [22:18:24.707] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.443856000000778,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:24 [22:18:24.714] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":5.166639000000032,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:24 [22:18:24.717] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.310707000000548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:24 [22:18:24.899] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.206375000000662,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:24 [22:18:24.902] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.048490999999558,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:24 [22:18:24.904] INFO: world_state Stopped world state synchronizer 22:18:24 [22:18:24.918] INFO: world_state Stopped world state synchronizer 22:18:24 [22:18:24.921] INFO: world_state Created world state synchroniser with block history of infinity 22:18:25 [22:18:25.052] INFO: world_state Started world state synchronizer from block 1 22:18:25 [22:18:25.415] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6771720000006098,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.418] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4031449999993129,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.420] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3031729999993331,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.423] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.581674000000021,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.425] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4646860000002562,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.426] INFO: world_state Stopped world state synchronizer 22:18:25 [22:18:25.428] INFO: world_state Created world state synchroniser with block history of infinity 22:18:25 [22:18:25.429] INFO: world_state Started world state synchronizer from block 1 22:18:25 [22:18:25.430] INFO: world_state Stopped world state synchronizer 22:18:25 [22:18:25.431] INFO: world_state Created world state synchroniser with block history of infinity 22:18:25 [22:18:25.432] INFO: world_state Started world state synchronizer from block 1 22:18:25 [22:18:25.432] INFO: world_state Stopped world state synchronizer 22:18:25 [22:18:25.453] INFO: world_state Stopped world state synchronizer 22:18:25 [22:18:25.457] INFO: world_state Created world state synchroniser with block history of infinity 22:18:25 [22:18:25.608] INFO: world_state Started world state synchronizer from block 1 22:18:25 [22:18:25.901] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4447959999997693,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.903] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2851320000008855,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.920] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":16.303218000000015,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.922] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.087866999999278,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:25 [22:18:25.923] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.240310999999565,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.144] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":2.062952000000223,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.147] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.769495000000461,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.150] INFO: world_state Stopped world state synchronizer 22:18:26 [22:18:26.154] INFO: world_state Created world state synchroniser with block history of infinity 22:18:26 [22:18:26.368] INFO: world_state Started world state synchronizer from block 1 22:18:26 [22:18:26.697] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3436639999999898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.699] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3268230000003314,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.701] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2067999999999302,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.703] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3105830000004062,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:26 [22:18:26.705] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3726740000001882,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.018] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5394689999993716,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.020] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2356010000003153,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.022] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9929039999997258,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.023] INFO: world_state Stopped world state synchronizer 22:18:27 [22:18:27.025] INFO: world_state Created world state synchroniser with block history of infinity 22:18:27 [22:18:27.213] INFO: world_state Started world state synchronizer from block 1 22:18:27 [22:18:27.514] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0653569999994943,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.516] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4562569999998232,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.517] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8279010000005655,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.518] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7993700000006356,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.520] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0293760000004113,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.522] INFO: world_state Stopped world state synchronizer 22:18:27 [22:18:27.523] INFO: world_state Created world state synchroniser with block history of infinity 22:18:27 [22:18:27.671] INFO: world_state Started world state synchronizer from block 1 22:18:27 [22:18:27.977] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5008080000006885,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.979] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3237329999992653,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.981] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2765420000005179,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.983] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1391490000005433,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.984] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0449859999998807,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 22:18:27 [22:18:27.986] INFO: world_state Stopped world state synchronizer 22:18:27 [22:18:27.987] INFO: world_state Created world state synchroniser with block history of infinity 22:18:27 [22:18:27.990] INFO: world_state Stopped world state synchronizer 22:18:27 [22:18:27.992] INFO: world_state Created world state synchroniser with block history of infinity 22:18:28 [22:18:28.188] INFO: world_state Started world state synchronizer from block 1 22:18:28 [22:18:28.548] INFO: world_state Stopped world state synchronizer 22:18:28 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.061 s) 22:18:28 ServerWorldStateSynchronizer 22:18:28 ✓ updates sync progress (829 ms) 22:18:28 ✓ handles multiple calls to start (506 ms) 22:18:28 ✓ immediately syncs if no new blocks (3 ms) 22:18:28 ✓ cannot be started if already stopped (23 ms) 22:18:28 ✓ can immediately sync to latest (696 ms) 22:18:28 ✓ can immediately sync to a minimum block number (872 ms) 22:18:28 ✓ sync returns immediately if block was already synced (498 ms) 22:18:28 ✓ throws if you try to sync to an unavailable block (463 ms) 22:18:28 ✓ throws if you try to immediate sync when not running (4 ms) 22:18:28 ✓ throws if handling blocks fails (558 ms) 22:18:28 22:18:28 Test Suites: 1 passed, 1 total 22:18:28 Tests: 10 passed, 10 total 22:18:28 Snapshots: 0 total 22:18:28 Time: 7.196 s 22:18:28 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 22:18:28 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?