Parent Log: http://ci.aztec-labs.com/956d98f80dd95e7b Command: f803628267cda2b6 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/21a568ac0c9ef351b1923375be41d4620add2b60 Env: REF_NAME=gh-readonly-queue/next/pr-15042-b80949775e5c27908a6055ad24592f7d98bdc45a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Sun Jun 15 12:35:43 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15042_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 12:35:46 [12:35:46.439] INFO: world_state Created world state synchroniser with block history of infinity 12:35:46 [12:35:46.567] INFO: world_state Started world state synchronizer from block 1 12:35:46 [12:35:46.983] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.492553999999927,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:46 [12:35:46.986] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7485569999998916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:46 [12:35:46.989] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6049630000002253,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.175] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2085019999999531,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.177] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.900684000000183,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.179] INFO: world_state Stopped world state synchronizer 12:35:47 [12:35:47.180] INFO: world_state Stopped world state synchronizer 12:35:47 [12:35:47.182] INFO: world_state Created world state synchroniser with block history of infinity 12:35:47 [12:35:47.357] INFO: world_state Started world state synchronizer from block 1 12:35:47 [12:35:47.641] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7346559999996316,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.643] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4125770000000557,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.645] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.272783999999774,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.647] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.514669999999569,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.649] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4010070000003907,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:47 [12:35:47.651] INFO: world_state Stopped world state synchronizer 12:35:47 [12:35:47.652] INFO: world_state Created world state synchroniser with block history of infinity 12:35:47 [12:35:47.653] INFO: world_state Started world state synchronizer from block 1 12:35:47 [12:35:47.654] INFO: world_state Stopped world state synchronizer 12:35:47 [12:35:47.655] INFO: world_state Created world state synchroniser with block history of infinity 12:35:47 [12:35:47.655] INFO: world_state Started world state synchronizer from block 1 12:35:47 [12:35:47.655] INFO: world_state Stopped world state synchronizer 12:35:47 [12:35:47.675] INFO: world_state Stopped world state synchronizer 12:35:47 [12:35:47.676] INFO: world_state Created world state synchroniser with block history of infinity 12:35:47 [12:35:47.861] INFO: world_state Started world state synchronizer from block 1 12:35:48 [12:35:48.163] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.093619000000217,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.164] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8020619999997507,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.166] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8484730000000127,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.167] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7696710000000166,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.168] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7639399999998204,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.329] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4828999999999724,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.331] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1966119999997318,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.333] INFO: world_state Stopped world state synchronizer 12:35:48 [12:35:48.335] INFO: world_state Created world state synchroniser with block history of infinity 12:35:48 [12:35:48.534] INFO: world_state Started world state synchronizer from block 1 12:35:48 [12:35:48.809] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.582561999999598,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.811] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3680760000006558,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.813] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4071180000000822,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.815] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4063079999996262,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:48 [12:35:48.817] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3384059999998499,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.185] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4808789999997316,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.189] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3137159999996584,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.190] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.0417170000000624,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.193] INFO: world_state Stopped world state synchronizer 12:35:49 [12:35:49.196] INFO: world_state Created world state synchroniser with block history of infinity 12:35:49 [12:35:49.403] INFO: world_state Started world state synchronizer from block 1 12:35:49 [12:35:49.663] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2213130000000092,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.665] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9121139999997467,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.666] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9048350000002756,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.668] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9015239999998812,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.669] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2483929999998509,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:49 [12:35:49.672] INFO: world_state Stopped world state synchronizer 12:35:49 [12:35:49.673] INFO: world_state Created world state synchroniser with block history of infinity 12:35:49 [12:35:49.827] INFO: world_state Started world state synchronizer from block 1 12:35:50 [12:35:50.129] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4659590000001117,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:50 [12:35:50.131] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2798549999997704,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:50 [12:35:50.143] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":10.809839000000466,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:50 [12:35:50.145] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3186249999998836,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:50 [12:35:50.147] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3425470000001951,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:35:50 [12:35:50.149] INFO: world_state Stopped world state synchronizer 12:35:50 [12:35:50.151] INFO: world_state Created world state synchroniser with block history of infinity 12:35:50 [12:35:50.155] INFO: world_state Stopped world state synchronizer 12:35:50 [12:35:50.156] INFO: world_state Created world state synchroniser with block history of infinity 12:35:50 [12:35:50.311] INFO: world_state Started world state synchronizer from block 1 12:35:50 [12:35:50.611] INFO: world_state Stopped world state synchronizer 12:35:50 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.394 s) 12:35:50 ServerWorldStateSynchronizer 12:35:50 ✓ updates sync progress (745 ms) 12:35:50 ✓ handles multiple calls to start (470 ms) 12:35:50 ✓ immediately syncs if no new blocks (3 ms) 12:35:50 ✓ cannot be started if already stopped (21 ms) 12:35:50 ✓ can immediately sync to latest (658 ms) 12:35:50 ✓ can immediately sync to a minimum block number (859 ms) 12:35:50 ✓ sync returns immediately if block was already synced (477 ms) 12:35:50 ✓ throws if you try to sync to an unavailable block (478 ms) 12:35:50 ✓ throws if you try to immediate sync when not running (5 ms) 12:35:50 ✓ throws if handling blocks fails (455 ms) 12:35:50 12:35:50 Test Suites: 1 passed, 1 total 12:35:50 Tests: 10 passed, 10 total 12:35:50 Snapshots: 0 total 12:35:50 Time: 6.47 s 12:35:50 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 12:35:50 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?