Parent Log: http://ci.aztec-labs.com/171b2d80c85afdbd Command: eebb3ae31c0c785a yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/cbd66b52b44f3aad75bf6e52a67987ed206598aa Env: REF_NAME=gh-readonly-queue/next/pr-15121-5d017313171ed95ebc6dbf88c1dffe207497338e CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Wed Jun 18 20:44:10 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15121_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 20:44:13 [20:44:13.284] INFO: world_state Created world state synchroniser with block history of infinity 20:44:13 [20:44:13.384] INFO: world_state Started world state synchronizer from block 1 20:44:13 [20:44:13.701] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.5801729999998315,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:13 [20:44:13.704] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7660460000001876,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:13 [20:44:13.707] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6657360000003791,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:13 [20:44:13.851] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.030550999999832,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:13 [20:44:13.853] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.715744000000086,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:13 [20:44:13.855] INFO: world_state Stopped world state synchronizer 20:44:13 [20:44:13.856] INFO: world_state Stopped world state synchronizer 20:44:13 [20:44:13.859] INFO: world_state Created world state synchroniser with block history of infinity 20:44:13 [20:44:13.979] INFO: world_state Started world state synchronizer from block 1 20:44:14 [20:44:14.204] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1513390000000072,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.206] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1740740000000187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.208] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.055938999999853,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.210] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4227569999998195,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.212] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2216699999999037,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.213] INFO: world_state Stopped world state synchronizer 20:44:14 [20:44:14.215] INFO: world_state Created world state synchroniser with block history of infinity 20:44:14 [20:44:14.215] INFO: world_state Started world state synchronizer from block 1 20:44:14 [20:44:14.216] INFO: world_state Stopped world state synchronizer 20:44:14 [20:44:14.217] INFO: world_state Created world state synchroniser with block history of infinity 20:44:14 [20:44:14.217] INFO: world_state Started world state synchronizer from block 1 20:44:14 [20:44:14.218] INFO: world_state Stopped world state synchronizer 20:44:14 [20:44:14.232] INFO: world_state Stopped world state synchronizer 20:44:14 [20:44:14.233] INFO: world_state Created world state synchroniser with block history of infinity 20:44:14 [20:44:14.359] INFO: world_state Started world state synchronizer from block 1 20:44:14 [20:44:14.584] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0677120000000286,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.586] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.024442999999792,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.587] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.985454000000118,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.589] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9688790000000154,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.590] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9779790000002322,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.733] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0632489999998143,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.734] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0298440000001392,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:14 [20:44:14.735] INFO: world_state Stopped world state synchronizer 20:44:14 [20:44:14.737] INFO: world_state Created world state synchroniser with block history of infinity 20:44:14 [20:44:14.854] INFO: world_state Started world state synchronizer from block 1 20:44:15 [20:44:15.076] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0543430000006992,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.077] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0454349999999977,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.079] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0450160000000324,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.080] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9938349999993079,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.081] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9996059999994031,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.292] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0779360000005909,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.294] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.005127000000357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.295] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.0512079999998605,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.297] INFO: world_state Stopped world state synchronizer 20:44:15 [20:44:15.298] INFO: world_state Created world state synchroniser with block history of infinity 20:44:15 [20:44:15.416] INFO: world_state Started world state synchronizer from block 1 20:44:15 [20:44:15.639] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0601779999997234,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.640] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.990896000000248,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.642] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9917519999999058,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.643] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.013520000000426,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.645] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0086499999997613,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.646] INFO: world_state Stopped world state synchronizer 20:44:15 [20:44:15.647] INFO: world_state Created world state synchroniser with block history of infinity 20:44:15 [20:44:15.772] INFO: world_state Started world state synchronizer from block 1 20:44:15 [20:44:15.996] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9925140000004831,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.997] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9633899999998903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:15.999] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.997881000000234,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:15 [20:44:16.000] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9434719999999288,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:16 [20:44:16.001] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9717869999994946,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:44:16 [20:44:16.003] INFO: world_state Stopped world state synchronizer 20:44:16 [20:44:16.004] INFO: world_state Created world state synchroniser with block history of infinity 20:44:16 [20:44:16.007] INFO: world_state Stopped world state synchronizer 20:44:16 [20:44:16.008] INFO: world_state Created world state synchroniser with block history of infinity 20:44:16 [20:44:16.125] INFO: world_state Started world state synchronizer from block 1 20:44:16 [20:44:16.348] INFO: world_state Stopped world state synchronizer 20:44:16 PASS src/synchronizer/server_world_state_synchronizer.test.ts 20:44:16 ServerWorldStateSynchronizer 20:44:16 ✓ updates sync progress (576 ms) 20:44:16 ✓ handles multiple calls to start (355 ms) 20:44:16 ✓ immediately syncs if no new blocks (2 ms) 20:44:16 ✓ cannot be started if already stopped (16 ms) 20:44:16 ✓ can immediately sync to latest (504 ms) 20:44:16 ✓ can immediately sync to a minimum block number (561 ms) 20:44:16 ✓ sync returns immediately if block was already synced (350 ms) 20:44:16 ✓ throws if you try to sync to an unavailable block (356 ms) 20:44:16 ✓ throws if you try to immediate sync when not running (4 ms) 20:44:16 ✓ throws if handling blocks fails (342 ms) 20:44:16 20:44:16 Test Suites: 1 passed, 1 total 20:44:16 Tests: 10 passed, 10 total 20:44:16 Snapshots: 0 total 20:44:16 Time: 4.842 s 20:44:16 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 20:44:16 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?