Parent Log: http://ci.aztec-labs.com/4fe6e45c33ed5dad Command: 4ef547fa5e299294 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/016def8adbfe93f34b41a41f439b146b5318c895 Env: REF_NAME=gh-readonly-queue/next/pr-15237-d4893155ff105399557b55c16450c39921c70d11 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 24 11:56:23 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15237_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 11:56:26 [11:56:26.741] INFO: world_state Created world state synchroniser with block history of infinity 11:56:26 [11:56:26.879] INFO: world_state Started world state synchronizer from block 1 11:56:27 [11:56:27.301] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.480816000000232,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.305] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.990766999999778,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.309] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.3671320000003107,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.499] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6846239999999852,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.501] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0346879999997327,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.502] INFO: world_state Stopped world state synchronizer 11:56:27 [11:56:27.504] INFO: world_state Stopped world state synchronizer 11:56:27 [11:56:27.507] INFO: world_state Created world state synchroniser with block history of infinity 11:56:27 [11:56:27.680] INFO: world_state Started world state synchronizer from block 1 11:56:27 [11:56:27.966] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7357369999999719,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.968] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5730679999996937,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.970] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5465659999999843,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.973] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7478979999996227,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.974] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3875680000001012,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:27 [11:56:27.976] INFO: world_state Stopped world state synchronizer 11:56:27 [11:56:27.977] INFO: world_state Created world state synchroniser with block history of infinity 11:56:27 [11:56:27.978] INFO: world_state Started world state synchronizer from block 1 11:56:27 [11:56:27.978] INFO: world_state Stopped world state synchronizer 11:56:27 [11:56:27.979] INFO: world_state Created world state synchroniser with block history of infinity 11:56:27 [11:56:27.980] INFO: world_state Started world state synchronizer from block 1 11:56:27 [11:56:27.980] INFO: world_state Stopped world state synchronizer 11:56:27 [11:56:27.992] INFO: world_state Stopped world state synchronizer 11:56:27 [11:56:27.994] INFO: world_state Created world state synchroniser with block history of infinity 11:56:28 [11:56:28.191] INFO: world_state Started world state synchronizer from block 1 11:56:28 [11:56:28.471] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.218368000000737,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.474] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.99731200000042,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.477] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4596019999999044,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.480] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.1325290000004316,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.484] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6482919999998558,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.695] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3905079999994996,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.697] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2402499999998327,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:28 [11:56:28.699] INFO: world_state Stopped world state synchronizer 11:56:28 [11:56:28.702] INFO: world_state Created world state synchroniser with block history of infinity 11:56:28 [11:56:28.899] INFO: world_state Started world state synchronizer from block 1 11:56:29 [11:56:29.249] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2994530000005398,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.251] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3020230000001902,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.253] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0986309999998412,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.255] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1847060000000056,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.257] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1382940000003146,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.529] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3112840000003416,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.532] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.4027180000002772,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.534] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.367127000000437,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:29 [11:56:29.537] INFO: world_state Stopped world state synchronizer 11:56:29 [11:56:29.539] INFO: world_state Created world state synchroniser with block history of infinity 11:56:29 [11:56:29.713] INFO: world_state Started world state synchronizer from block 1 11:56:30 [11:56:30.041] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2408789999999499,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.043] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0545890000003055,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.044] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9916960000000472,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.046] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0502989999995407,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.047] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0214569999998275,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.049] INFO: world_state Stopped world state synchronizer 11:56:30 [11:56:30.050] INFO: world_state Created world state synchroniser with block history of infinity 11:56:30 [11:56:30.202] INFO: world_state Started world state synchronizer from block 1 11:56:30 [11:56:30.523] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2608099999997648,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.525] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1967869999998584,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.527] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2865609999998924,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.529] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0738899999996647,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.530] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0334670000002006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:56:30 [11:56:30.532] INFO: world_state Stopped world state synchronizer 11:56:30 [11:56:30.534] INFO: world_state Created world state synchroniser with block history of infinity 11:56:30 [11:56:30.537] INFO: world_state Stopped world state synchronizer 11:56:30 [11:56:30.538] INFO: world_state Created world state synchroniser with block history of infinity 11:56:30 [11:56:30.744] INFO: world_state Started world state synchronizer from block 1 11:56:31 [11:56:31.041] INFO: world_state Stopped world state synchronizer 11:56:31 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.565 s) 11:56:31 ServerWorldStateSynchronizer 11:56:31 ✓ updates sync progress (768 ms) 11:56:31 ✓ handles multiple calls to start (470 ms) 11:56:31 ✓ immediately syncs if no new blocks (3 ms) 11:56:31 ✓ cannot be started if already stopped (14 ms) 11:56:31 ✓ can immediately sync to latest (707 ms) 11:56:31 ✓ can immediately sync to a minimum block number (836 ms) 11:56:31 ✓ sync returns immediately if block was already synced (511 ms) 11:56:31 ✓ throws if you try to sync to an unavailable block (483 ms) 11:56:31 ✓ throws if you try to immediate sync when not running (4 ms) 11:56:31 ✓ throws if handling blocks fails (503 ms) 11:56:31 11:56:31 Test Suites: 1 passed, 1 total 11:56:31 Tests: 10 passed, 10 total 11:56:31 Snapshots: 0 total 11:56:31 Time: 6.663 s 11:56:31 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 11:56:31 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?