Parent Log: http://ci.aztec-labs.com/c8343c83be8844f5 Command: 07e0464d6c7ed50c yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/aedcee89a2544b0e6baf93c4e71d88991f09111e Env: REF_NAME=gh-readonly-queue/next/pr-15183-016def8adbfe93f34b41a41f439b146b5318c895 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Tue Jun 24 13:35:41 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15183_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 13:35:43 [13:35:43.916] INFO: world_state Created world state synchroniser with block history of infinity 13:35:44 [13:35:44.015] INFO: world_state Started world state synchronizer from block 1 13:35:44 [13:35:44.327] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.027271999999812,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.330] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.0462870000001203,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.333] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.8749649999999747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.476] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4704619999997703,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.478] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3044009999998707,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.480] INFO: world_state Stopped world state synchronizer 13:35:44 [13:35:44.481] INFO: world_state Stopped world state synchronizer 13:35:44 [13:35:44.484] INFO: world_state Created world state synchroniser with block history of infinity 13:35:44 [13:35:44.602] INFO: world_state Started world state synchronizer from block 1 13:35:44 [13:35:44.825] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2839199999998527,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.827] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1262400000000525,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.828] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1026889999998275,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.831] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4683460000001105,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.832] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.28220999999985,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:44 [13:35:44.834] INFO: world_state Stopped world state synchronizer 13:35:44 [13:35:44.835] INFO: world_state Created world state synchroniser with block history of infinity 13:35:44 [13:35:44.836] INFO: world_state Started world state synchronizer from block 1 13:35:44 [13:35:44.836] INFO: world_state Stopped world state synchronizer 13:35:44 [13:35:44.837] INFO: world_state Created world state synchroniser with block history of infinity 13:35:44 [13:35:44.838] INFO: world_state Started world state synchronizer from block 1 13:35:44 [13:35:44.838] INFO: world_state Stopped world state synchronizer 13:35:44 [13:35:44.852] INFO: world_state Stopped world state synchronizer 13:35:44 [13:35:44.853] INFO: world_state Created world state synchroniser with block history of infinity 13:35:44 [13:35:44.978] INFO: world_state Started world state synchronizer from block 1 13:35:45 [13:35:45.199] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1494970000003377,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.201] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0885979999998199,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.202] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0412820000001375,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.204] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.02929499999982,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.205] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0249240000002828,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.345] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.098435999999765,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.346] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0739490000000842,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.347] INFO: world_state Stopped world state synchronizer 13:35:45 [13:35:45.349] INFO: world_state Created world state synchroniser with block history of infinity 13:35:45 [13:35:45.466] INFO: world_state Started world state synchronizer from block 1 13:35:45 [13:35:45.687] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0826859999997396,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.688] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1219450000007782,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.690] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0184030000000348,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.691] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0056439999998474,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.693] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9976800000004005,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.905] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1030309999996462,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.906] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0459099999998216,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.908] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.1368779999993421,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:45 [13:35:45.909] INFO: world_state Stopped world state synchronizer 13:35:45 [13:35:45.911] INFO: world_state Created world state synchroniser with block history of infinity 13:35:46 [13:35:46.026] INFO: world_state Started world state synchronizer from block 1 13:35:46 [13:35:46.247] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1413860000002387,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.249] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0595729999995456,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.250] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0464160000001357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.252] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1007399999998597,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.253] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0948979999993753,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.255] INFO: world_state Stopped world state synchronizer 13:35:46 [13:35:46.256] INFO: world_state Created world state synchroniser with block history of infinity 13:35:46 [13:35:46.381] INFO: world_state Started world state synchronizer from block 1 13:35:46 [13:35:46.602] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0828129999999874,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.603] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.036667999999736,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.605] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.003725999999915,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.606] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.066757000000507,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.608] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.128230999999687,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:46 [13:35:46.609] INFO: world_state Stopped world state synchronizer 13:35:46 [13:35:46.610] INFO: world_state Created world state synchroniser with block history of infinity 13:35:46 [13:35:46.613] INFO: world_state Stopped world state synchronizer 13:35:46 [13:35:46.614] INFO: world_state Created world state synchroniser with block history of infinity 13:35:46 [13:35:46.731] INFO: world_state Started world state synchronizer from block 1 13:35:46 [13:35:46.955] INFO: world_state Stopped world state synchronizer 13:35:46 PASS src/synchronizer/server_world_state_synchronizer.test.ts 13:35:46 ServerWorldStateSynchronizer 13:35:46 ✓ updates sync progress (569 ms) 13:35:46 ✓ handles multiple calls to start (351 ms) 13:35:46 ✓ immediately syncs if no new blocks (3 ms) 13:35:46 ✓ cannot be started if already stopped (16 ms) 13:35:46 ✓ can immediately sync to latest (495 ms) 13:35:46 ✓ can immediately sync to a minimum block number (561 ms) 13:35:46 ✓ sync returns immediately if block was already synced (345 ms) 13:35:46 ✓ throws if you try to sync to an unavailable block (353 ms) 13:35:46 ✓ throws if you try to immediate sync when not running (3 ms) 13:35:46 ✓ throws if handling blocks fails (342 ms) 13:35:46 13:35:46 Test Suites: 1 passed, 1 total 13:35:46 Tests: 10 passed, 10 total 13:35:46 Snapshots: 0 total 13:35:46 Time: 4.786 s 13:35:46 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:35:46 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?