Parent Log: http://ci.aztec-labs.com/9772f35bf3dda20b Command: 2d72990a54a9c534 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/7edf16da6c056f9499e2dfd9c71fb9b7580f9bfc Env: REF_NAME=gh-readonly-queue/next/pr-15215-1b10c7d500621ca2e4c0db764df67f3085beb282 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 24 10:17:30 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15215_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 10:17:34 [10:17:34.061] INFO: world_state Created world state synchroniser with block history of infinity 10:17:34 [10:17:34.193] INFO: world_state Started world state synchronizer from block 1 10:17:34 [10:17:34.649] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.538908999999876,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:34 [10:17:34.653] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.653841999999713,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:34 [10:17:34.657] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.4712899999999536,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:34 [10:17:34.847] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.8488019999999779,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:34 [10:17:34.849] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5274730000001,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:34 [10:17:34.851] INFO: world_state Stopped world state synchronizer 10:17:34 [10:17:34.853] INFO: world_state Stopped world state synchronizer 10:17:34 [10:17:34.869] INFO: world_state Created world state synchroniser with block history of infinity 10:17:35 [10:17:35.021] INFO: world_state Started world state synchronizer from block 1 10:17:35 [10:17:35.263] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1796709999998711,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.265] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3908559999999852,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.267] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2418149999994057,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.269] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2958690000004935,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.270] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2800680000000284,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.272] INFO: world_state Stopped world state synchronizer 10:17:35 [10:17:35.273] INFO: world_state Created world state synchroniser with block history of infinity 10:17:35 [10:17:35.274] INFO: world_state Started world state synchronizer from block 1 10:17:35 [10:17:35.274] INFO: world_state Stopped world state synchronizer 10:17:35 [10:17:35.275] INFO: world_state Created world state synchroniser with block history of infinity 10:17:35 [10:17:35.276] INFO: world_state Started world state synchronizer from block 1 10:17:35 [10:17:35.276] INFO: world_state Stopped world state synchronizer 10:17:35 [10:17:35.294] INFO: world_state Stopped world state synchronizer 10:17:35 [10:17:35.295] INFO: world_state Created world state synchroniser with block history of infinity 10:17:35 [10:17:35.452] INFO: world_state Started world state synchronizer from block 1 10:17:35 [10:17:35.728] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6224089999996067,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.730] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.26604800000041,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.745] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":14.656533000000309,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.747] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.287438999999722,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.749] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3265810000002602,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.948] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5075619999997798,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.950] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3507129999998142,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:35 [10:17:35.952] INFO: world_state Stopped world state synchronizer 10:17:35 [10:17:35.953] INFO: world_state Created world state synchroniser with block history of infinity 10:17:36 [10:17:36.138] INFO: world_state Started world state synchronizer from block 1 10:17:36 [10:17:36.501] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5247129999997924,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.503] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3354410000001735,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.505] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3057189999999537,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.507] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3833740000000034,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.508] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3288910000001124,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.761] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4342380000007324,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.763] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2492359999996552,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.765] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.4656789999999091,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:36 [10:17:36.766] INFO: world_state Stopped world state synchronizer 10:17:36 [10:17:36.768] INFO: world_state Created world state synchroniser with block history of infinity 10:17:36 [10:17:36.919] INFO: world_state Started world state synchronizer from block 1 10:17:37 [10:17:37.208] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0314330000001064,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.209] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8533919999999853,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.210] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7587160000002768,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.212] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0463240000008227,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.213] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9941109999999753,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.215] INFO: world_state Stopped world state synchronizer 10:17:37 [10:17:37.216] INFO: world_state Created world state synchroniser with block history of infinity 10:17:37 [10:17:37.378] INFO: world_state Started world state synchronizer from block 1 10:17:37 [10:17:37.696] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2328149999993911,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.698] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1247380000004341,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.699] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2088239999993675,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.701] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2150940000001356,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.702] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8792840000005526,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 10:17:37 [10:17:37.704] INFO: world_state Stopped world state synchronizer 10:17:37 [10:17:37.705] INFO: world_state Created world state synchroniser with block history of infinity 10:17:37 [10:17:37.707] INFO: world_state Stopped world state synchronizer 10:17:37 [10:17:37.708] INFO: world_state Created world state synchroniser with block history of infinity 10:17:37 [10:17:37.859] INFO: world_state Started world state synchronizer from block 1 10:17:38 [10:17:38.122] INFO: world_state Stopped world state synchronizer 10:17:38 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.301 s) 10:17:38 ServerWorldStateSynchronizer 10:17:38 ✓ updates sync progress (797 ms) 10:17:38 ✓ handles multiple calls to start (417 ms) 10:17:38 ✓ immediately syncs if no new blocks (3 ms) 10:17:38 ✓ cannot be started if already stopped (19 ms) 10:17:38 ✓ can immediately sync to latest (658 ms) 10:17:38 ✓ can immediately sync to a minimum block number (814 ms) 10:17:38 ✓ sync returns immediately if block was already synced (449 ms) 10:17:38 ✓ throws if you try to sync to an unavailable block (488 ms) 10:17:38 ✓ throws if you try to immediate sync when not running (3 ms) 10:17:38 ✓ throws if handling blocks fails (414 ms) 10:17:38 10:17:38 Test Suites: 1 passed, 1 total 10:17:38 Tests: 10 passed, 10 total 10:17:38 Snapshots: 0 total 10:17:38 Time: 6.392 s 10:17:38 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 10:17:38 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?