Parent Log: http://ci.aztec-labs.com/f83f1f9579928671 Command: 17e0d785507e6983 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/5867520ed258adecfee692b3694d693b2c7964ca Env: REF_NAME=gh-readonly-queue/next/pr-14770-9b801754ba98479ee645488c29d2fda1eecbfd85 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 21:52:22 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14770_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:52:25 [21:52:25.827] INFO: world_state Created world state synchroniser with block history of infinity 21:52:25 [21:52:25.978] INFO: world_state Started world state synchronizer from block 1 21:52:26 [21:52:26.384] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.317490999999791,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:26 [21:52:26.387] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.000623999999334,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:26 [21:52:26.390] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.8228419999995822,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:26 [21:52:26.607] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.162804999999935,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:26 [21:52:26.610] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.973442999999861,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:26 [21:52:26.612] INFO: world_state Stopped world state synchronizer 21:52:26 [21:52:26.614] INFO: world_state Stopped world state synchronizer 21:52:26 [21:52:26.617] INFO: world_state Created world state synchroniser with block history of infinity 21:52:26 [21:52:26.796] INFO: world_state Started world state synchronizer from block 1 21:52:27 [21:52:27.105] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6079780000000028,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.107] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3651210000007268,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.109] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.281036000000313,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.111] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6696519999995871,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.114] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.191507000000456,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.116] INFO: world_state Stopped world state synchronizer 21:52:27 [21:52:27.118] INFO: world_state Created world state synchroniser with block history of infinity 21:52:27 [21:52:27.118] INFO: world_state Started world state synchronizer from block 1 21:52:27 [21:52:27.119] INFO: world_state Stopped world state synchronizer 21:52:27 [21:52:27.120] INFO: world_state Created world state synchroniser with block history of infinity 21:52:27 [21:52:27.121] INFO: world_state Started world state synchronizer from block 1 21:52:27 [21:52:27.121] INFO: world_state Stopped world state synchronizer 21:52:27 [21:52:27.135] INFO: world_state Stopped world state synchronizer 21:52:27 [21:52:27.137] INFO: world_state Created world state synchroniser with block history of infinity 21:52:27 [21:52:27.311] INFO: world_state Started world state synchronizer from block 1 21:52:27 [21:52:27.671] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4406859999999142,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.673] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2235419999997248,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.675] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0853420000003098,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.676] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.05786100000023,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.678] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.14123600000039,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.860] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.55433499999981,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.862] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1992899999995643,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:27 [21:52:27.864] INFO: world_state Stopped world state synchronizer 21:52:27 [21:52:27.866] INFO: world_state Created world state synchroniser with block history of infinity 21:52:28 [21:52:28.057] INFO: world_state Started world state synchronizer from block 1 21:52:28 [21:52:28.350] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3918240000002697,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.352] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2292520000000877,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.354] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1652780000003986,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.355] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0047770000001037,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.357] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0876230000003488,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.615] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4543269999994664,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.617] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.081912999999986,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.618] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.0336489999999685,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:28 [21:52:28.620] INFO: world_state Stopped world state synchronizer 21:52:28 [21:52:28.621] INFO: world_state Created world state synchroniser with block history of infinity 21:52:28 [21:52:28.760] INFO: world_state Started world state synchronizer from block 1 21:52:29 [21:52:29.025] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8566069999997126,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.026] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7221879999997327,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.027] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7453800000002957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.028] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7638719999995374,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.029] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.6911069999996471,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.033] INFO: world_state Stopped world state synchronizer 21:52:29 [21:52:29.034] INFO: world_state Created world state synchroniser with block history of infinity 21:52:29 [21:52:29.211] INFO: world_state Started world state synchronizer from block 1 21:52:29 [21:52:29.548] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5454140000001644,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.554] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4852200000004814,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.556] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3901930000001812,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.558] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2252619999999297,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.560] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1475769999997283,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:52:29 [21:52:29.562] INFO: world_state Stopped world state synchronizer 21:52:29 [21:52:29.563] INFO: world_state Created world state synchroniser with block history of infinity 21:52:29 [21:52:29.571] INFO: world_state Stopped world state synchronizer 21:52:29 [21:52:29.573] INFO: world_state Created world state synchroniser with block history of infinity 21:52:29 [21:52:29.795] INFO: world_state Started world state synchronizer from block 1 21:52:30 [21:52:30.100] INFO: world_state Stopped world state synchronizer 21:52:30 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.868 s) 21:52:30 ServerWorldStateSynchronizer 21:52:30 ✓ updates sync progress (792 ms) 21:52:30 ✓ handles multiple calls to start (500 ms) 21:52:30 ✓ immediately syncs if no new blocks (3 ms) 21:52:30 ✓ cannot be started if already stopped (15 ms) 21:52:30 ✓ can immediately sync to latest (728 ms) 21:52:30 ✓ can immediately sync to a minimum block number (755 ms) 21:52:30 ✓ sync returns immediately if block was already synced (412 ms) 21:52:30 ✓ throws if you try to sync to an unavailable block (529 ms) 21:52:30 ✓ throws if you try to immediate sync when not running (9 ms) 21:52:30 ✓ throws if handling blocks fails (528 ms) 21:52:30 21:52:30 Test Suites: 1 passed, 1 total 21:52:30 Tests: 10 passed, 10 total 21:52:30 Snapshots: 0 total 21:52:30 Time: 6.991 s 21:52:30 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 21:52:30 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?