Parent Log: http://ci.aztec-labs.com/0d00976eba32988c Command: f44e1b4f382283e1 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/be1fa8aacb33d330cf496352bb1446439e34c51a Env: REF_NAME=gh-readonly-queue/next/pr-15162-7d1abcb337009939ee47da8445b5fee80f39fb58 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 20 10:05:39 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15162_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 10:05:42 [10:05:42.995] INFO: world_state Created world state synchroniser with block history of infinity 10:05:43 [10:05:43.130] INFO: world_state Started world state synchronizer from block 1 10:05:43 [10:05:43.536] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.046549000000141,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:43 [10:05:43.539] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7240209999999934,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:43 [10:05:43.542] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.0969740000000456,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:43 [10:05:43.750] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7693719999997484,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:43 [10:05:43.752] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5407480000003488,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:43 [10:05:43.754] INFO: world_state Stopped world state synchronizer 10:05:43 [10:05:43.755] INFO: world_state Stopped world state synchronizer 10:05:43 [10:05:43.758] INFO: world_state Created world state synchroniser with block history of infinity 10:05:43 [10:05:43.915] INFO: world_state Started world state synchronizer from block 1 10:05:44 [10:05:44.186] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6268150000005335,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.189] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.382289000000128,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.191] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3420960000003106,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.193] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5725110000003042,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.195] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5336379999998826,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.197] INFO: world_state Stopped world state synchronizer 10:05:44 [10:05:44.198] INFO: world_state Created world state synchroniser with block history of infinity 10:05:44 [10:05:44.199] INFO: world_state Started world state synchronizer from block 1 10:05:44 [10:05:44.200] INFO: world_state Stopped world state synchronizer 10:05:44 [10:05:44.201] INFO: world_state Created world state synchroniser with block history of infinity 10:05:44 [10:05:44.202] INFO: world_state Started world state synchronizer from block 1 10:05:44 [10:05:44.202] INFO: world_state Stopped world state synchronizer 10:05:44 [10:05:44.228] INFO: world_state Stopped world state synchronizer 10:05:44 [10:05:44.229] INFO: world_state Created world state synchroniser with block history of infinity 10:05:44 [10:05:44.364] INFO: world_state Started world state synchronizer from block 1 10:05:44 [10:05:44.622] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1366529999995691,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.624] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0108350000000428,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.625] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9011779999991631,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.626] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9419199999992998,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.628] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8796259999999165,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.826] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0596189999996568,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.828] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9921830000002956,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:44 [10:05:44.829] INFO: world_state Stopped world state synchronizer 10:05:44 [10:05:44.831] INFO: world_state Created world state synchroniser with block history of infinity 10:05:45 [10:05:45.005] INFO: world_state Started world state synchronizer from block 1 10:05:45 [10:05:45.311] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3431259999997565,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.313] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1365619999996852,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.315] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0967399999999543,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.316] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1271130000004632,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.319] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1534040000005916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.609] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8155520000000251,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.611] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0128749999994398,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.613] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3472460000002684,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:45 [10:05:45.614] INFO: world_state Stopped world state synchronizer 10:05:45 [10:05:45.616] INFO: world_state Created world state synchroniser with block history of infinity 10:05:45 [10:05:45.766] INFO: world_state Started world state synchronizer from block 1 10:05:46 [10:05:46.127] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.320585000000392,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.129] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1449930000007953,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.130] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.126351999999315,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.134] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.6735420000004524,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.135] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9585219999999026,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.137] INFO: world_state Stopped world state synchronizer 10:05:46 [10:05:46.138] INFO: world_state Created world state synchroniser with block history of infinity 10:05:46 [10:05:46.328] INFO: world_state Started world state synchronizer from block 1 10:05:46 [10:05:46.603] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2805019999996148,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.604] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.827871999999843,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.606] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9656709999999293,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.607] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8188310000005004,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.608] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9566809999996622,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:05:46 [10:05:46.611] INFO: world_state Stopped world state synchronizer 10:05:46 [10:05:46.613] INFO: world_state Created world state synchroniser with block history of infinity 10:05:46 [10:05:46.616] INFO: world_state Stopped world state synchronizer 10:05:46 [10:05:46.617] INFO: world_state Created world state synchroniser with block history of infinity 10:05:46 [10:05:46.781] INFO: world_state Started world state synchronizer from block 1 10:05:47 [10:05:47.040] INFO: world_state Stopped world state synchronizer 10:05:47 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.378 s) 10:05:47 ServerWorldStateSynchronizer 10:05:47 ✓ updates sync progress (765 ms) 10:05:47 ✓ handles multiple calls to start (439 ms) 10:05:47 ✓ immediately syncs if no new blocks (4 ms) 10:05:47 ✓ cannot be started if already stopped (27 ms) 10:05:47 ✓ can immediately sync to latest (601 ms) 10:05:47 ✓ can immediately sync to a minimum block number (785 ms) 10:05:47 ✓ sync returns immediately if block was already synced (522 ms) 10:05:47 ✓ throws if you try to sync to an unavailable block (474 ms) 10:05:47 ✓ throws if you try to immediate sync when not running (4 ms) 10:05:47 ✓ throws if handling blocks fails (425 ms) 10:05:47 10:05:47 Test Suites: 1 passed, 1 total 10:05:47 Tests: 10 passed, 10 total 10:05:47 Snapshots: 0 total 10:05:47 Time: 6.481 s 10:05:47 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 10:05:47 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?