Parent Log: http://ci.aztec-labs.com/10093e311e033622 Command: c9ea3de086d87c28 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/c245b3e704a64008c8dea40ee7b26418fd59554d Env: REF_NAME=gh-readonly-queue/next/pr-15176-301dce04331dcfb583b7508b91491de618d4acf4 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 23 11:47:19 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15176_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 11:47:22 [11:47:22.767] INFO: world_state Created world state synchroniser with block history of infinity 11:47:22 [11:47:22.897] INFO: world_state Started world state synchronizer from block 1 11:47:23 [11:47:23.306] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.1286049999998795,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:23 [11:47:23.310] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.1065929999999753,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:23 [11:47:23.313] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.1647240000002057,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:23 [11:47:23.492] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2668260000000373,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:23 [11:47:23.493] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9805900000001202,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:23 [11:47:23.495] INFO: world_state Stopped world state synchronizer 11:47:23 [11:47:23.507] INFO: world_state Stopped world state synchronizer 11:47:23 [11:47:23.510] INFO: world_state Created world state synchroniser with block history of infinity 11:47:23 [11:47:23.691] INFO: world_state Started world state synchronizer from block 1 11:47:23 [11:47:23.997] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.876737999999932,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.000] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5717219999996814,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.002] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5098010000001523,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.005] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.27481699999953,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.007] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.699695000000247,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.009] INFO: world_state Stopped world state synchronizer 11:47:24 [11:47:24.011] INFO: world_state Created world state synchroniser with block history of infinity 11:47:24 [11:47:24.011] INFO: world_state Started world state synchronizer from block 1 11:47:24 [11:47:24.012] INFO: world_state Stopped world state synchronizer 11:47:24 [11:47:24.014] INFO: world_state Created world state synchroniser with block history of infinity 11:47:24 [11:47:24.014] INFO: world_state Started world state synchronizer from block 1 11:47:24 [11:47:24.014] INFO: world_state Stopped world state synchronizer 11:47:24 [11:47:24.036] INFO: world_state Stopped world state synchronizer 11:47:24 [11:47:24.038] INFO: world_state Created world state synchroniser with block history of infinity 11:47:24 [11:47:24.243] INFO: world_state Started world state synchronizer from block 1 11:47:24 [11:47:24.549] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":8.925621999999748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.554] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.6131729999997333,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.556] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.52042099999926,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.557] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3232269999998607,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.559] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3028870000007373,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.737] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5854019999997035,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.740] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.5131409999994503,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:24 [11:47:24.742] INFO: world_state Stopped world state synchronizer 11:47:24 [11:47:24.744] INFO: world_state Created world state synchroniser with block history of infinity 11:47:24 [11:47:24.923] INFO: world_state Started world state synchronizer from block 1 11:47:25 [11:47:25.262] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8777780000000348,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.264] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9003679999996166,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.266] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.2060739999997168,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.268] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4055490000000646,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.270] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4329589999997552,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.538] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9652699999996912,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.540] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1214529999997467,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.541] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3495780000002924,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:25 [11:47:25.553] INFO: world_state Stopped world state synchronizer 11:47:25 [11:47:25.556] INFO: world_state Created world state synchroniser with block history of infinity 11:47:25 [11:47:25.740] INFO: world_state Started world state synchronizer from block 1 11:47:26 [11:47:26.067] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5971220000001267,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.069] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3601479999997537,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.071] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3125869999994393,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.073] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.351846999999907,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.075] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3967079999993075,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.078] INFO: world_state Stopped world state synchronizer 11:47:26 [11:47:26.080] INFO: world_state Created world state synchroniser with block history of infinity 11:47:26 [11:47:26.240] INFO: world_state Started world state synchronizer from block 1 11:47:26 [11:47:26.580] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5248520000004646,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.582] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.275405999999748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.584] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2205149999999776,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.586] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2692859999997381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.588] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.164614000000256,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 11:47:26 [11:47:26.592] INFO: world_state Stopped world state synchronizer 11:47:26 [11:47:26.596] INFO: world_state Created world state synchroniser with block history of infinity 11:47:26 [11:47:26.599] INFO: world_state Stopped world state synchronizer 11:47:26 [11:47:26.601] INFO: world_state Created world state synchroniser with block history of infinity 11:47:26 [11:47:26.761] INFO: world_state Started world state synchronizer from block 1 11:47:27 [11:47:27.063] INFO: world_state Stopped world state synchronizer 11:47:27 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.715 s) 11:47:27 ServerWorldStateSynchronizer 11:47:27 ✓ updates sync progress (746 ms) 11:47:27 ✓ handles multiple calls to start (500 ms) 11:47:27 ✓ immediately syncs if no new blocks (3 ms) 11:47:27 ✓ cannot be started if already stopped (23 ms) 11:47:27 ✓ can immediately sync to latest (705 ms) 11:47:27 ✓ can immediately sync to a minimum block number (811 ms) 11:47:27 ✓ sync returns immediately if block was already synced (524 ms) 11:47:27 ✓ throws if you try to sync to an unavailable block (513 ms) 11:47:27 ✓ throws if you try to immediate sync when not running (7 ms) 11:47:27 ✓ throws if handling blocks fails (464 ms) 11:47:27 11:47:27 Test Suites: 1 passed, 1 total 11:47:27 Tests: 10 passed, 10 total 11:47:27 Snapshots: 0 total 11:47:27 Time: 6.811 s 11:47:27 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 11:47:27 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?