Parent Log: http://ci.aztec-labs.com/2aac72a9f0a3e7d4 Command: b818050160cbcbd8 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/184d5f7d956dd7251670a2dd6728f313cfdf3caf Env: REF_NAME=gh-readonly-queue/next/pr-14822-e56baa7f24bac54baf9e2f22f6f33ae6fa8b8c0f CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 21:18:14 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14822_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:18:18 [21:18:18.088] INFO: world_state Created world state synchroniser with block history of infinity 21:18:18 [21:18:18.195] INFO: world_state Started world state synchronizer from block 1 21:18:18 [21:18:18.567] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.903135999999904,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:18 [21:18:18.570] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.9940349999997125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:18 [21:18:18.573] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4185819999997875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:18 [21:18:18.763] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.0022539999999935,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:18 [21:18:18.766] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2015970000002199,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:18 [21:18:18.767] INFO: world_state Stopped world state synchronizer 21:18:18 [21:18:18.769] INFO: world_state Stopped world state synchronizer 21:18:18 [21:18:18.771] INFO: world_state Created world state synchroniser with block history of infinity 21:18:18 [21:18:18.922] INFO: world_state Started world state synchronizer from block 1 21:18:19 [21:18:19.183] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.220766999999796,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.185] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2660280000000057,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.187] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1453550000005635,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.188] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.251788000000488,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.190] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.090263999999479,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.191] INFO: world_state Stopped world state synchronizer 21:18:19 [21:18:19.192] INFO: world_state Created world state synchroniser with block history of infinity 21:18:19 [21:18:19.193] INFO: world_state Started world state synchronizer from block 1 21:18:19 [21:18:19.193] INFO: world_state Stopped world state synchronizer 21:18:19 [21:18:19.194] INFO: world_state Created world state synchroniser with block history of infinity 21:18:19 [21:18:19.195] INFO: world_state Started world state synchronizer from block 1 21:18:19 [21:18:19.195] INFO: world_state Stopped world state synchronizer 21:18:19 [21:18:19.208] INFO: world_state Stopped world state synchronizer 21:18:19 [21:18:19.210] INFO: world_state Created world state synchroniser with block history of infinity 21:18:19 [21:18:19.356] INFO: world_state Started world state synchronizer from block 1 21:18:19 [21:18:19.604] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9974130000000514,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.605] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7700079999995069,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.606] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.853279000000839,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.608] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7843480000001364,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.609] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7624759999998787,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.772] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0680929999998625,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.774] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0963839999994889,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:19 [21:18:19.776] INFO: world_state Stopped world state synchronizer 21:18:19 [21:18:19.778] INFO: world_state Created world state synchroniser with block history of infinity 21:18:19 [21:18:19.953] INFO: world_state Started world state synchronizer from block 1 21:18:20 [21:18:20.192] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9403710000005958,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.193] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7721869999995761,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.195] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9009200000000419,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.197] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.057064000000537,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.198] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0791739999995116,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.498] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.255537999999433,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.500] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.109173999999257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.501] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9559010000002672,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.503] INFO: world_state Stopped world state synchronizer 21:18:20 [21:18:20.504] INFO: world_state Created world state synchroniser with block history of infinity 21:18:20 [21:18:20.667] INFO: world_state Started world state synchronizer from block 1 21:18:20 [21:18:20.985] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3127889999996114,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.987] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.076532999999472,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.988] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9934219999995548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.990] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0672230000000127,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.992] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1375849999994898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:20 [21:18:20.994] INFO: world_state Stopped world state synchronizer 21:18:20 [21:18:20.995] INFO: world_state Created world state synchroniser with block history of infinity 21:18:21 [21:18:21.167] INFO: world_state Started world state synchronizer from block 1 21:18:21 [21:18:21.461] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2729079999999158,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:21 [21:18:21.463] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2831590000005235,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:21 [21:18:21.465] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1434849999996004,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:21 [21:18:21.467] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9531809999998586,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:21 [21:18:21.468] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7338369999997667,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:18:21 [21:18:21.479] INFO: world_state Stopped world state synchronizer 21:18:21 [21:18:21.480] INFO: world_state Created world state synchroniser with block history of infinity 21:18:21 [21:18:21.483] INFO: world_state Stopped world state synchronizer 21:18:21 [21:18:21.484] INFO: world_state Created world state synchroniser with block history of infinity 21:18:21 [21:18:21.636] INFO: world_state Started world state synchronizer from block 1 21:18:22 [21:18:22.031] INFO: world_state Stopped world state synchronizer 21:18:22 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.05 s) 21:18:22 ServerWorldStateSynchronizer 21:18:22 ✓ updates sync progress (684 ms) 21:18:22 ✓ handles multiple calls to start (421 ms) 21:18:22 ✓ immediately syncs if no new blocks (2 ms) 21:18:22 ✓ cannot be started if already stopped (14 ms) 21:18:22 ✓ can immediately sync to latest (567 ms) 21:18:22 ✓ can immediately sync to a minimum block number (726 ms) 21:18:22 ✓ sync returns immediately if block was already synced (490 ms) 21:18:22 ✓ throws if you try to sync to an unavailable block (484 ms) 21:18:22 ✓ throws if you try to immediate sync when not running (3 ms) 21:18:22 ✓ throws if handling blocks fails (549 ms) 21:18:22 21:18:22 Test Suites: 1 passed, 1 total 21:18:22 Tests: 10 passed, 10 total 21:18:22 Snapshots: 0 total 21:18:22 Time: 6.146 s 21:18:22 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 21:18:22 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?