Parent Log: http://ci.aztec-labs.com/a474c905046e6ed0 Command: 4d0fb449c606d482 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/263498dd65e8700218979d7a94dbfd25b2a8a8a8 Env: REF_NAME=gh-readonly-queue/next/pr-14921-4b0e4dc09fa55f0bc808fa0c7c3e95e8fa997069 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 20:35:52 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14921_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 20:35:56 [20:35:56.235] INFO: world_state Created world state synchroniser with block history of infinity 20:35:56 [20:35:56.390] INFO: world_state Started world state synchronizer from block 1 20:35:56 [20:35:56.744] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.3440340000001925,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:56 [20:35:56.748] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.2526960000000145,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:56 [20:35:56.751] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.776274999999714,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:56 [20:35:56.948] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7900049999998373,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:56 [20:35:56.951] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.530927999999676,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:56 [20:35:56.952] INFO: world_state Stopped world state synchronizer 20:35:56 [20:35:56.954] INFO: world_state Stopped world state synchronizer 20:35:56 [20:35:56.957] INFO: world_state Created world state synchroniser with block history of infinity 20:35:57 [20:35:57.138] INFO: world_state Started world state synchronizer from block 1 20:35:57 [20:35:57.463] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0991979999998875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:57 [20:35:57.465] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9260629999998855,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:57 [20:35:57.466] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9019120000002658,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:57 [20:35:57.468] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1990200000000186,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:57 [20:35:57.469] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.042885999999271,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:57 [20:35:57.470] INFO: world_state Stopped world state synchronizer 20:35:57 [20:35:57.472] INFO: world_state Created world state synchroniser with block history of infinity 20:35:57 [20:35:57.473] INFO: world_state Started world state synchronizer from block 1 20:35:57 [20:35:57.474] INFO: world_state Stopped world state synchronizer 20:35:57 [20:35:57.475] INFO: world_state Created world state synchroniser with block history of infinity 20:35:57 [20:35:57.475] INFO: world_state Started world state synchronizer from block 1 20:35:57 [20:35:57.476] INFO: world_state Stopped world state synchronizer 20:35:57 [20:35:57.508] INFO: world_state Stopped world state synchronizer 20:35:57 [20:35:57.510] INFO: world_state Created world state synchroniser with block history of infinity 20:35:57 [20:35:57.666] INFO: world_state Started world state synchronizer from block 1 20:35:58 [20:35:58.013] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4269359999998414,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.016] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1545289999994566,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.017] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.049935999999434,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.019] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0964679999997315,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.021] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1475879999998142,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.237] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1289779999997336,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.238] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8371509999997215,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.239] INFO: world_state Stopped world state synchronizer 20:35:58 [20:35:58.241] INFO: world_state Created world state synchroniser with block history of infinity 20:35:58 [20:35:58.411] INFO: world_state Started world state synchronizer from block 1 20:35:58 [20:35:58.655] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4391359999999622,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.657] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3230329999996684,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.659] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2847819999997228,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.660] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7791390000002139,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.661] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3435829999998532,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.979] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5538690000003044,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.981] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.4037749999997686,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.983] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3707539999995788,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:58 [20:35:58.985] INFO: world_state Stopped world state synchronizer 20:35:58 [20:35:58.987] INFO: world_state Created world state synchroniser with block history of infinity 20:35:59 [20:35:59.147] INFO: world_state Started world state synchronizer from block 1 20:35:59 [20:35:59.441] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3957650000002104,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.443] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9422130000002653,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.445] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8240610000002562,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.447] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.821316000000479,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.449] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.259632000000238,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.452] INFO: world_state Stopped world state synchronizer 20:35:59 [20:35:59.455] INFO: world_state Created world state synchroniser with block history of infinity 20:35:59 [20:35:59.617] INFO: world_state Started world state synchronizer from block 1 20:35:59 [20:35:59.892] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4168849999996382,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.894] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2207610000004934,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.896] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1732099999999264,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.897] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0765769999998156,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.899] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1123680000000604,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:35:59 [20:35:59.901] INFO: world_state Stopped world state synchronizer 20:35:59 [20:35:59.902] INFO: world_state Created world state synchroniser with block history of infinity 20:35:59 [20:35:59.905] INFO: world_state Stopped world state synchronizer 20:35:59 [20:35:59.906] INFO: world_state Created world state synchroniser with block history of infinity 20:36:00 [20:36:00.068] INFO: world_state Started world state synchronizer from block 1 20:36:00 [20:36:00.392] INFO: world_state Stopped world state synchronizer 20:36:00 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.538 s) 20:36:00 ServerWorldStateSynchronizer 20:36:00 ✓ updates sync progress (725 ms) 20:36:00 ✓ handles multiple calls to start (515 ms) 20:36:00 ✓ immediately syncs if no new blocks (3 ms) 20:36:00 ✓ cannot be started if already stopped (35 ms) 20:36:00 ✓ can immediately sync to latest (730 ms) 20:36:00 ✓ can immediately sync to a minimum block number (746 ms) 20:36:00 ✓ sync returns immediately if block was already synced (467 ms) 20:36:00 ✓ throws if you try to sync to an unavailable block (447 ms) 20:36:00 ✓ throws if you try to immediate sync when not running (4 ms) 20:36:00 ✓ throws if handling blocks fails (486 ms) 20:36:00 20:36:00 Test Suites: 1 passed, 1 total 20:36:00 Tests: 10 passed, 10 total 20:36:00 Snapshots: 0 total 20:36:00 Time: 6.639 s 20:36:00 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 20:36:00 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?