Parent Log: http://ci.aztec-labs.com/b325d16c0a95c660 Command: 4f771e618b80a60c yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/991b313d676f7cf820bb62a33e57cf5a4c8cf9cf Env: REF_NAME=gh-readonly-queue/next/pr-15075-af42fafbeb7d6a4440329d9e9e5b1df459fa2e2e CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 16:02:46 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15075_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 16:02:50 [16:02:50.163] INFO: world_state Created world state synchroniser with block history of infinity 16:02:50 [16:02:50.330] INFO: world_state Started world state synchronizer from block 1 16:02:50 [16:02:50.821] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.703962000000502,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:50 [16:02:50.829] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.178133999999773,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:50 [16:02:50.832] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.0891920000003665,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.018] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.8801690000000235,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.035] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.716255999999703,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.041] INFO: world_state Stopped world state synchronizer 16:02:51 [16:02:51.043] INFO: world_state Stopped world state synchronizer 16:02:51 [16:02:51.047] INFO: world_state Created world state synchroniser with block history of infinity 16:02:51 [16:02:51.205] INFO: world_state Started world state synchronizer from block 1 16:02:51 [16:02:51.588] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4944030000006023,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.590] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4305119999999079,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.592] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4883819999995467,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.595] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.741095999999743,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.597] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7342960000005405,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:51 [16:02:51.599] INFO: world_state Stopped world state synchronizer 16:02:51 [16:02:51.600] INFO: world_state Created world state synchroniser with block history of infinity 16:02:51 [16:02:51.601] INFO: world_state Started world state synchronizer from block 1 16:02:51 [16:02:51.602] INFO: world_state Stopped world state synchronizer 16:02:51 [16:02:51.603] INFO: world_state Created world state synchroniser with block history of infinity 16:02:51 [16:02:51.603] INFO: world_state Started world state synchronizer from block 1 16:02:51 [16:02:51.604] INFO: world_state Stopped world state synchronizer 16:02:51 [16:02:51.623] INFO: world_state Stopped world state synchronizer 16:02:51 [16:02:51.625] INFO: world_state Created world state synchroniser with block history of infinity 16:02:51 [16:02:51.781] INFO: world_state Started world state synchronizer from block 1 16:02:52 [16:02:52.134] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.088596999999936,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.136] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.6240760000000591,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.144] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.084027999999307,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.148] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.6838830000006055,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.151] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.0315529999998034,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.365] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.140237999999954,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.367] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1377689999999347,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.368] INFO: world_state Stopped world state synchronizer 16:02:52 [16:02:52.370] INFO: world_state Created world state synchroniser with block history of infinity 16:02:52 [16:02:52.538] INFO: world_state Started world state synchronizer from block 1 16:02:52 [16:02:52.827] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.274290000000292,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.829] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.12873799999943,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.831] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.013705999999729,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.833] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4066430000002583,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:52 [16:02:52.834] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9682049999992159,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.144] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.6389760000001843,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.147] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.5215850000004139,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.150] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3411009999999806,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.154] INFO: world_state Stopped world state synchronizer 16:02:53 [16:02:53.157] INFO: world_state Created world state synchroniser with block history of infinity 16:02:53 [16:02:53.314] INFO: world_state Started world state synchronizer from block 1 16:02:53 [16:02:53.645] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3625720000000001,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.647] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9771860000000743,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.649] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1542490000001635,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.656] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":6.610185999999885,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.658] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4468440000000555,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:53 [16:02:53.661] INFO: world_state Stopped world state synchronizer 16:02:53 [16:02:53.662] INFO: world_state Created world state synchroniser with block history of infinity 16:02:53 [16:02:53.815] INFO: world_state Started world state synchronizer from block 1 16:02:54 [16:02:54.159] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6254059999992023,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:54 [16:02:54.161] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4306829999995898,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:54 [16:02:54.163] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.117377999999917,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:54 [16:02:54.164] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0909369999999399,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:54 [16:02:54.166] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9875449999999546,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:02:54 [16:02:54.168] INFO: world_state Stopped world state synchronizer 16:02:54 [16:02:54.170] INFO: world_state Created world state synchroniser with block history of infinity 16:02:54 [16:02:54.173] INFO: world_state Stopped world state synchronizer 16:02:54 [16:02:54.174] INFO: world_state Created world state synchroniser with block history of infinity 16:02:54 [16:02:54.385] INFO: world_state Started world state synchronizer from block 1 16:02:54 [16:02:54.708] INFO: world_state Stopped world state synchronizer 16:02:54 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.012 s) 16:02:54 ServerWorldStateSynchronizer 16:02:54 ✓ updates sync progress (888 ms) 16:02:54 ✓ handles multiple calls to start (553 ms) 16:02:54 ✓ immediately syncs if no new blocks (3 ms) 16:02:54 ✓ cannot be started if already stopped (22 ms) 16:02:54 ✓ can immediately sync to latest (744 ms) 16:02:54 ✓ can immediately sync to a minimum block number (786 ms) 16:02:54 ✓ sync returns immediately if block was already synced (505 ms) 16:02:54 ✓ throws if you try to sync to an unavailable block (508 ms) 16:02:54 ✓ throws if you try to immediate sync when not running (4 ms) 16:02:54 ✓ throws if handling blocks fails (534 ms) 16:02:54 16:02:54 Test Suites: 1 passed, 1 total 16:02:54 Tests: 10 passed, 10 total 16:02:54 Snapshots: 0 total 16:02:54 Time: 7.13 s 16:02:54 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 16:02:54 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?