Parent Log: http://ci.aztec-labs.com/eb42bb2e1b2e3d28 Command: 4f771e618b80a60c yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/991b313d676f7cf820bb62a33e57cf5a4c8cf9cf Env: REF_NAME=gh-readonly-queue/next/pr-15075-af42fafbeb7d6a4440329d9e9e5b1df459fa2e2e CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 15:56:57 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15075_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 15:57:00 [15:57:00.886] INFO: world_state Created world state synchroniser with block history of infinity 15:57:01 [15:57:01.055] INFO: world_state Started world state synchronizer from block 1 15:57:01 [15:57:01.507] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":9.677685999999994,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:01 [15:57:01.515] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":4.155616000000009,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:01 [15:57:01.519] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":3.0316170000005513,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:01 [15:57:01.772] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.909048000000439,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:01 [15:57:01.774] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7217259999997623,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:01 [15:57:01.776] INFO: world_state Stopped world state synchronizer 15:57:01 [15:57:01.778] INFO: world_state Stopped world state synchronizer 15:57:01 [15:57:01.784] INFO: world_state Created world state synchroniser with block history of infinity 15:57:01 [15:57:01.932] INFO: world_state Started world state synchronizer from block 1 15:57:02 [15:57:02.211] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2466370000001916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.213] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.259888000000501,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.215] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1007580000004964,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.217] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3828749999993306,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.219] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3871759999992719,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.220] INFO: world_state Stopped world state synchronizer 15:57:02 [15:57:02.222] INFO: world_state Created world state synchroniser with block history of infinity 15:57:02 [15:57:02.223] INFO: world_state Started world state synchronizer from block 1 15:57:02 [15:57:02.224] INFO: world_state Stopped world state synchronizer 15:57:02 [15:57:02.225] INFO: world_state Created world state synchroniser with block history of infinity 15:57:02 [15:57:02.226] INFO: world_state Started world state synchronizer from block 1 15:57:02 [15:57:02.226] INFO: world_state Stopped world state synchronizer 15:57:02 [15:57:02.256] INFO: world_state Stopped world state synchronizer 15:57:02 [15:57:02.259] INFO: world_state Created world state synchroniser with block history of infinity 15:57:02 [15:57:02.441] INFO: world_state Started world state synchronizer from block 1 15:57:02 [15:57:02.798] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4525100000000748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.801] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4158769999994547,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.803] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3992960000005041,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.805] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4312079999999696,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:02 [15:57:02.807] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.172631999999794,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.045] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4110670000000027,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.047] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2489970000005997,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.053] INFO: world_state Stopped world state synchronizer 15:57:03 [15:57:03.061] INFO: world_state Created world state synchroniser with block history of infinity 15:57:03 [15:57:03.234] INFO: world_state Started world state synchronizer from block 1 15:57:03 [15:57:03.613] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4402789999994638,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.616] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2956199999998717,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.618] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2179349999996703,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.620] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3210909999997966,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.622] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.293149000000085,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.991] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9608189999999013,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.993] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8412920000000668,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.994] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.7827079999997295,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:03 [15:57:03.995] INFO: world_state Stopped world state synchronizer 15:57:03 [15:57:03.997] INFO: world_state Created world state synchroniser with block history of infinity 15:57:04 [15:57:04.134] INFO: world_state Started world state synchronizer from block 1 15:57:04 [15:57:04.487] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0162230000005366,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:04 [15:57:04.488] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8605130000005374,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:04 [15:57:04.490] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0323539999999412,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:04 [15:57:04.491] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.993851000000177,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:04 [15:57:04.493] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3298020000001998,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:04 [15:57:04.496] INFO: world_state Stopped world state synchronizer 15:57:04 [15:57:04.497] INFO: world_state Created world state synchroniser with block history of infinity 15:57:04 [15:57:04.682] INFO: world_state Started world state synchronizer from block 1 15:57:05 [15:57:05.018] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.328161999999793,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:05 [15:57:05.020] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.072306000000026,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:05 [15:57:05.022] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5039319999996223,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:05 [15:57:05.024] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0948279999993247,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:05 [15:57:05.025] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9931120000001101,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:57:05 [15:57:05.027] INFO: world_state Stopped world state synchronizer 15:57:05 [15:57:05.029] INFO: world_state Created world state synchroniser with block history of infinity 15:57:05 [15:57:05.032] INFO: world_state Stopped world state synchronizer 15:57:05 [15:57:05.034] INFO: world_state Created world state synchroniser with block history of infinity 15:57:05 [15:57:05.196] INFO: world_state Started world state synchronizer from block 1 15:57:05 [15:57:05.513] INFO: world_state Stopped world state synchronizer 15:57:05 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.069 s) 15:57:05 ServerWorldStateSynchronizer 15:57:05 ✓ updates sync progress (900 ms) 15:57:05 ✓ handles multiple calls to start (437 ms) 15:57:05 ✓ immediately syncs if no new blocks (3 ms) 15:57:05 ✓ cannot be started if already stopped (32 ms) 15:57:05 ✓ can immediately sync to latest (796 ms) 15:57:05 ✓ can immediately sync to a minimum block number (937 ms) 15:57:05 ✓ sync returns immediately if block was already synced (500 ms) 15:57:05 ✓ throws if you try to sync to an unavailable block (531 ms) 15:57:05 ✓ throws if you try to immediate sync when not running (4 ms) 15:57:05 ✓ throws if handling blocks fails (481 ms) 15:57:05 15:57:05 Test Suites: 1 passed, 1 total 15:57:05 Tests: 10 passed, 10 total 15:57:05 Snapshots: 0 total 15:57:05 Time: 7.199 s 15:57:05 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 15:57:05 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?