Parent Log: http://ci.aztec-labs.com/6edadffa1e55a16f Command: 2f5a01bdc943190c yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/b4e88ec5c5067a9b12be306fb60258508bcfdcf8 Env: REF_NAME=gh-readonly-queue/next/pr-15196-812a53d5d7c2057744dbf808172864443b5de7af CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 26 14:24:38 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15196_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:24:42 [14:24:42.214] INFO: world_state Created world state synchroniser with block history of infinity 14:24:42 [14:24:42.339] INFO: world_state Started world state synchronizer from block 1 14:24:42 [14:24:42.744] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.105658999999832,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:42 [14:24:42.749] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.646150999999918,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:42 [14:24:42.752] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.441678000000138,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:42 [14:24:42.941] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.253954000000249,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:42 [14:24:42.944] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.8756660000003649,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:42 [14:24:42.953] INFO: world_state Stopped world state synchronizer 14:24:42 [14:24:42.956] INFO: world_state Stopped world state synchronizer 14:24:42 [14:24:42.962] INFO: world_state Created world state synchroniser with block history of infinity 14:24:43 [14:24:43.127] INFO: world_state Started world state synchronizer from block 1 14:24:43 [14:24:43.400] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9836489999997866,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.401] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.816396000000168,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.402] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7591739999998026,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.404] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4454980000000432,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.406] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2146539999994275,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.407] INFO: world_state Stopped world state synchronizer 14:24:43 [14:24:43.408] INFO: world_state Created world state synchroniser with block history of infinity 14:24:43 [14:24:43.409] INFO: world_state Started world state synchronizer from block 1 14:24:43 [14:24:43.409] INFO: world_state Stopped world state synchronizer 14:24:43 [14:24:43.410] INFO: world_state Created world state synchroniser with block history of infinity 14:24:43 [14:24:43.411] INFO: world_state Started world state synchronizer from block 1 14:24:43 [14:24:43.411] INFO: world_state Stopped world state synchronizer 14:24:43 [14:24:43.429] INFO: world_state Stopped world state synchronizer 14:24:43 [14:24:43.430] INFO: world_state Created world state synchroniser with block history of infinity 14:24:43 [14:24:43.595] INFO: world_state Started world state synchronizer from block 1 14:24:43 [14:24:43.852] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4665390000000116,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.872] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.2631439999995564,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.874] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4760189999997237,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.876] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2604550000005474,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:43 [14:24:43.878] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2420640000000276,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.053] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1287320000001273,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.054] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8245059999999285,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.056] INFO: world_state Stopped world state synchronizer 14:24:44 [14:24:44.057] INFO: world_state Created world state synchroniser with block history of infinity 14:24:44 [14:24:44.225] INFO: world_state Started world state synchronizer from block 1 14:24:44 [14:24:44.544] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9710479999994277,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.546] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8143359999994573,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.547] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8152460000001156,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.548] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7798839999995835,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.549] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7593339999993987,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.823] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.916096999999354,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.824] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9204970000000685,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.826] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.1702919999997903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:44 [14:24:44.827] INFO: world_state Stopped world state synchronizer 14:24:44 [14:24:44.828] INFO: world_state Created world state synchroniser with block history of infinity 14:24:44 [14:24:44.989] INFO: world_state Started world state synchronizer from block 1 14:24:45 [14:24:45.302] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4529469999997673,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.305] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5074490000006335,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.307] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3710360000004584,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.308] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.225043000000369,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.311] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.2354020000002492,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.313] INFO: world_state Stopped world state synchronizer 14:24:45 [14:24:45.315] INFO: world_state Created world state synchroniser with block history of infinity 14:24:45 [14:24:45.506] INFO: world_state Started world state synchronizer from block 1 14:24:45 [14:24:45.779] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4159159999999247,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.782] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1499620000004143,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.783] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.828085000000101,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.784] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7065130000000863,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.785] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7689440000003742,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:24:45 [14:24:45.787] INFO: world_state Stopped world state synchronizer 14:24:45 [14:24:45.788] INFO: world_state Created world state synchroniser with block history of infinity 14:24:45 [14:24:45.790] INFO: world_state Stopped world state synchronizer 14:24:45 [14:24:45.791] INFO: world_state Created world state synchroniser with block history of infinity 14:24:45 [14:24:45.938] INFO: world_state Started world state synchronizer from block 1 14:24:46 [14:24:46.197] INFO: world_state Stopped world state synchronizer 14:24:46 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.281 s) 14:24:46 ServerWorldStateSynchronizer 14:24:46 ✓ updates sync progress (747 ms) 14:24:46 ✓ handles multiple calls to start (448 ms) 14:24:46 ✓ immediately syncs if no new blocks (2 ms) 14:24:46 ✓ cannot be started if already stopped (19 ms) 14:24:46 ✓ can immediately sync to latest (626 ms) 14:24:46 ✓ can immediately sync to a minimum block number (771 ms) 14:24:46 ✓ sync returns immediately if block was already synced (486 ms) 14:24:46 ✓ throws if you try to sync to an unavailable block (473 ms) 14:24:46 ✓ throws if you try to immediate sync when not running (4 ms) 14:24:46 ✓ throws if handling blocks fails (406 ms) 14:24:46 14:24:46 Test Suites: 1 passed, 1 total 14:24:46 Tests: 10 passed, 10 total 14:24:46 Snapshots: 0 total 14:24:46 Time: 6.38 s 14:24:46 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:24:46 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?