Parent Log: http://ci.aztec-labs.com/91d1f12a37080b18 Command: ebfed4061172f77e yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/07aee119a58dd438ddfb5bd53e124e7269e6c651 Env: REF_NAME=gh-readonly-queue/next/pr-15083-9b801754ba98479ee645488c29d2fda1eecbfd85 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 21:06:40 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15083_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:06:43 [21:06:43.727] INFO: world_state Created world state synchroniser with block history of infinity 21:06:43 [21:06:43.894] INFO: world_state Started world state synchronizer from block 1 21:06:44 [21:06:44.366] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.0546949999998105,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:44 [21:06:44.371] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.1363169999999627,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:44 [21:06:44.374] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.186772000000019,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:44 [21:06:44.601] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3849079999999958,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:44 [21:06:44.603] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.04482199999984,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:44 [21:06:44.604] INFO: world_state Stopped world state synchronizer 21:06:44 [21:06:44.607] INFO: world_state Stopped world state synchronizer 21:06:44 [21:06:44.610] INFO: world_state Created world state synchroniser with block history of infinity 21:06:44 [21:06:44.790] INFO: world_state Started world state synchronizer from block 1 21:06:45 [21:06:45.182] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.3804369999998016,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.185] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.8828780000003462,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.189] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.155439000000115,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.192] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.024938000000475,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.194] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.8752370000001974,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.196] INFO: world_state Stopped world state synchronizer 21:06:45 [21:06:45.198] INFO: world_state Created world state synchroniser with block history of infinity 21:06:45 [21:06:45.199] INFO: world_state Started world state synchronizer from block 1 21:06:45 [21:06:45.200] INFO: world_state Stopped world state synchronizer 21:06:45 [21:06:45.201] INFO: world_state Created world state synchroniser with block history of infinity 21:06:45 [21:06:45.201] INFO: world_state Started world state synchronizer from block 1 21:06:45 [21:06:45.202] INFO: world_state Stopped world state synchronizer 21:06:45 [21:06:45.222] INFO: world_state Stopped world state synchronizer 21:06:45 [21:06:45.224] INFO: world_state Created world state synchroniser with block history of infinity 21:06:45 [21:06:45.407] INFO: world_state Started world state synchronizer from block 1 21:06:45 [21:06:45.749] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.680862000000161,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.751] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.092384999999922,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.752] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8059629999997924,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.753] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9033110000000306,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.755] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.222896000000219,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.948] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4092000000000553,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.950] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0899060000001555,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:45 [21:06:45.952] INFO: world_state Stopped world state synchronizer 21:06:45 [21:06:45.954] INFO: world_state Created world state synchroniser with block history of infinity 21:06:46 [21:06:46.140] INFO: world_state Started world state synchronizer from block 1 21:06:46 [21:06:46.470] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.654088999999658,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.472] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3838589999995747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.474] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3815279999998893,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.476] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.362437000000682,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.478] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.339165000000321,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.782] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3250039999993533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.783] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1808320000000094,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.785] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.1222979999993186,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:46 [21:06:46.796] INFO: world_state Stopped world state synchronizer 21:06:46 [21:06:46.798] INFO: world_state Created world state synchroniser with block history of infinity 21:06:46 [21:06:46.956] INFO: world_state Started world state synchronizer from block 1 21:06:47 [21:06:47.302] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3612370000000737,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.304] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1043369999997594,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.305] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0503929999995307,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.307] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1097170000002734,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.308] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.147780000000239,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.311] INFO: world_state Stopped world state synchronizer 21:06:47 [21:06:47.312] INFO: world_state Created world state synchroniser with block history of infinity 21:06:47 [21:06:47.489] INFO: world_state Started world state synchronizer from block 1 21:06:47 [21:06:47.846] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9364729999997508,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.847] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.059903000000304,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.850] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5435310000002573,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.851] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8946900000000824,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.853] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7976119999993898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:47 [21:06:47.855] INFO: world_state Stopped world state synchronizer 21:06:47 [21:06:47.858] INFO: world_state Created world state synchroniser with block history of infinity 21:06:47 [21:06:47.861] INFO: world_state Stopped world state synchronizer 21:06:47 [21:06:47.863] INFO: world_state Created world state synchroniser with block history of infinity 21:06:48 [21:06:48.063] INFO: world_state Started world state synchronizer from block 1 21:06:48 [21:06:48.387] INFO: world_state Stopped world state synchronizer 21:06:48 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.854 s) 21:06:48 ServerWorldStateSynchronizer 21:06:48 ✓ updates sync progress (885 ms) 21:06:48 ✓ handles multiple calls to start (588 ms) 21:06:48 ✓ immediately syncs if no new blocks (3 ms) 21:06:48 ✓ cannot be started if already stopped (22 ms) 21:06:48 ✓ can immediately sync to latest (729 ms) 21:06:48 ✓ can immediately sync to a minimum block number (844 ms) 21:06:48 ✓ sync returns immediately if block was already synced (514 ms) 21:06:48 ✓ throws if you try to sync to an unavailable block (543 ms) 21:06:48 ✓ throws if you try to immediate sync when not running (5 ms) 21:06:48 ✓ throws if handling blocks fails (526 ms) 21:06:48 21:06:48 Test Suites: 1 passed, 1 total 21:06:48 Tests: 10 passed, 10 total 21:06:48 Snapshots: 0 total 21:06:48 Time: 6.948 s 21:06:48 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 21:06:48 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?