Parent Log: http://ci.aztec-labs.com/d6b9e3e678db815e Command: 857695163c0e152a yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/267ac35e8ccb487bdc79bbe12d428f4c8b4d4d9f Env: REF_NAME=gh-readonly-queue/master/pr-15002-1338cef09c870378254c56748f972ae827c4d482 CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Fri Jun 13 15:22:49 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15002_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_master 15:22:51 [15:22:51.892] INFO: world_state Created world state synchroniser with block history of infinity 15:22:51 [15:22:51.980] INFO: world_state Started world state synchronizer from block 1 15:22:52 [15:22:52.110] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":10.130749999999807,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.115] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.3183799999997063,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.117] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5892770000000382,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.237] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.610153999999966,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.239] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.544550000000072,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.241] INFO: world_state Stopped world state synchronizer 15:22:52 [15:22:52.242] INFO: world_state Stopped world state synchronizer 15:22:52 [15:22:52.245] INFO: world_state Created world state synchroniser with block history of infinity 15:22:52 [15:22:52.356] INFO: world_state Started world state synchronizer from block 1 15:22:52 [15:22:52.552] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1109980000001087,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.553] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1526820000003681,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.555] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.005304000000251,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.557] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3801180000000386,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.559] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0721459999999752,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.560] INFO: world_state Stopped world state synchronizer 15:22:52 [15:22:52.561] INFO: world_state Created world state synchroniser with block history of infinity 15:22:52 [15:22:52.562] INFO: world_state Started world state synchronizer from block 1 15:22:52 [15:22:52.563] INFO: world_state Stopped world state synchronizer 15:22:52 [15:22:52.563] INFO: world_state Created world state synchroniser with block history of infinity 15:22:52 [15:22:52.564] INFO: world_state Started world state synchronizer from block 1 15:22:52 [15:22:52.564] INFO: world_state Stopped world state synchronizer 15:22:52 [15:22:52.578] INFO: world_state Stopped world state synchronizer 15:22:52 [15:22:52.579] INFO: world_state Created world state synchroniser with block history of infinity 15:22:52 [15:22:52.691] INFO: world_state Started world state synchronizer from block 1 15:22:52 [15:22:52.881] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9718119999997725,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.883] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9532839999997123,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.884] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9396289999999681,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.885] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9244639999997162,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:52 [15:22:52.887] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8953980000001138,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.010] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9570699999999306,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.012] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9020189999996546,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.013] INFO: world_state Stopped world state synchronizer 15:22:53 [15:22:53.014] INFO: world_state Created world state synchroniser with block history of infinity 15:22:53 [15:22:53.125] INFO: world_state Started world state synchronizer from block 1 15:22:53 [15:22:53.324] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9893139999999221,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.325] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0045390000000225,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.327] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.021697000000131,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.328] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.904156999999941,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.330] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9340640000000349,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.514] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9623399999995854,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.516] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9519870000003721,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.517] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9833490000000893,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.518] INFO: world_state Stopped world state synchronizer 15:22:53 [15:22:53.520] INFO: world_state Created world state synchroniser with block history of infinity 15:22:53 [15:22:53.630] INFO: world_state Started world state synchronizer from block 1 15:22:53 [15:22:53.831] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9706650000007357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.833] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9196810000003097,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.834] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9630700000006982,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.835] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.921730000000025,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.837] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8855210000001534,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:53 [15:22:53.838] INFO: world_state Stopped world state synchronizer 15:22:53 [15:22:53.839] INFO: world_state Created world state synchroniser with block history of infinity 15:22:53 [15:22:53.942] INFO: world_state Started world state synchronizer from block 1 15:22:54 [15:22:54.142] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0212369999999282,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:54 [15:22:54.143] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9146439999994982,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:54 [15:22:54.145] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8799900000003618,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:54 [15:22:54.146] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8761889999996129,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:54 [15:22:54.147] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8701570000002903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:22:54 [15:22:54.149] INFO: world_state Stopped world state synchronizer 15:22:54 [15:22:54.150] INFO: world_state Created world state synchroniser with block history of infinity 15:22:54 [15:22:54.152] INFO: world_state Stopped world state synchronizer 15:22:54 [15:22:54.153] INFO: world_state Created world state synchroniser with block history of infinity 15:22:54 [15:22:54.275] INFO: world_state Started world state synchronizer from block 1 15:22:54 [15:22:54.473] INFO: world_state Stopped world state synchronizer 15:22:54 PASS src/synchronizer/server_world_state_synchronizer.test.ts 15:22:54 ServerWorldStateSynchronizer 15:22:54 ✓ updates sync progress (355 ms) 15:22:54 ✓ handles multiple calls to start (316 ms) 15:22:54 ✓ immediately syncs if no new blocks (3 ms) 15:22:54 ✓ cannot be started if already stopped (15 ms) 15:22:54 ✓ can immediately sync to latest (434 ms) 15:22:54 ✓ can immediately sync to a minimum block number (506 ms) 15:22:54 ✓ sync returns immediately if block was already synced (320 ms) 15:22:54 ✓ throws if you try to sync to an unavailable block (310 ms) 15:22:54 ✓ throws if you try to immediate sync when not running (3 ms) 15:22:54 ✓ throws if handling blocks fails (320 ms) 15:22:54 15:22:54 Test Suites: 1 passed, 1 total 15:22:54 Tests: 10 passed, 10 total 15:22:54 Snapshots: 0 total 15:22:54 Time: 4.274 s 15:22:54 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 15:22:54 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?