Parent Log: http://ci.aztec-labs.com/701a4364c73bba1e Command: a8cc061dbe484831 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/58696523cc93fda453138a4f2c2dff72b21f0bfa Env: REF_NAME=gh-readonly-queue/next/pr-15180-a923b0dd4c74291fcefa86c41b3b5dffca7e4178 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 20 13:10:55 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15180_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 13:10:59 [13:10:59.483] INFO: world_state Created world state synchroniser with block history of infinity 13:10:59 [13:10:59.659] INFO: world_state Started world state synchronizer from block 1 13:11:00 [13:11:00.082] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.0310050000002775,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.096] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":12.918769000000339,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.100] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.7590079999999944,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.240] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7157749999996668,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.243] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3775619999996707,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.244] INFO: world_state Stopped world state synchronizer 13:11:00 [13:11:00.246] INFO: world_state Stopped world state synchronizer 13:11:00 [13:11:00.248] INFO: world_state Created world state synchroniser with block history of infinity 13:11:00 [13:11:00.382] INFO: world_state Started world state synchronizer from block 1 13:11:00 [13:11:00.723] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7520479999993768,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.726] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5924279999999271,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.728] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4626280000002225,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.731] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6468910000003234,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.733] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4554079999998066,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:00 [13:11:00.735] INFO: world_state Stopped world state synchronizer 13:11:00 [13:11:00.737] INFO: world_state Created world state synchroniser with block history of infinity 13:11:00 [13:11:00.738] INFO: world_state Started world state synchronizer from block 1 13:11:00 [13:11:00.738] INFO: world_state Stopped world state synchronizer 13:11:00 [13:11:00.739] INFO: world_state Created world state synchroniser with block history of infinity 13:11:00 [13:11:00.740] INFO: world_state Started world state synchronizer from block 1 13:11:00 [13:11:00.740] INFO: world_state Stopped world state synchronizer 13:11:00 [13:11:00.755] INFO: world_state Stopped world state synchronizer 13:11:00 [13:11:00.757] INFO: world_state Created world state synchroniser with block history of infinity 13:11:00 [13:11:00.909] INFO: world_state Started world state synchronizer from block 1 13:11:01 [13:11:01.220] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.737716999999975,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.223] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4264960000000428,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.224] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2798270000002958,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.226] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1683179999999993,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.228] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.208071000000018,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.399] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0353100000002087,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.401] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9821259999998802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.403] INFO: world_state Stopped world state synchronizer 13:11:01 [13:11:01.405] INFO: world_state Created world state synchroniser with block history of infinity 13:11:01 [13:11:01.551] INFO: world_state Started world state synchronizer from block 1 13:11:01 [13:11:01.838] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.621490000000449,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.840] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.348681000000397,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.842] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3202689999998256,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.844] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2959969999992609,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:01 [13:11:01.845] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.28625700000066,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.114] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0823829999999361,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.116] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.312727999999879,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.118] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.2652850000004037,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.119] INFO: world_state Stopped world state synchronizer 13:11:02 [13:11:02.122] INFO: world_state Created world state synchroniser with block history of infinity 13:11:02 [13:11:02.276] INFO: world_state Started world state synchronizer from block 1 13:11:02 [13:11:02.532] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1135549999999057,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.533] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1480970000002344,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.539] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2899170000000595,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.541] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2762250000005224,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.543] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2721959999998944,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.548] INFO: world_state Stopped world state synchronizer 13:11:02 [13:11:02.549] INFO: world_state Created world state synchroniser with block history of infinity 13:11:02 [13:11:02.680] INFO: world_state Started world state synchronizer from block 1 13:11:02 [13:11:02.946] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4378260000003138,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.948] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.138836999999512,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.949] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8799300000000585,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.950] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7550409999994372,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.952] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7927630000003774,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:02 [13:11:02.953] INFO: world_state Stopped world state synchronizer 13:11:02 [13:11:02.955] INFO: world_state Created world state synchroniser with block history of infinity 13:11:02 [13:11:02.957] INFO: world_state Stopped world state synchronizer 13:11:02 [13:11:02.959] INFO: world_state Created world state synchroniser with block history of infinity 13:11:03 [13:11:03.142] INFO: world_state Started world state synchronizer from block 1 13:11:03 [13:11:03.498] INFO: world_state Stopped world state synchronizer 13:11:03 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.478 s) 13:11:03 ServerWorldStateSynchronizer 13:11:03 ✓ updates sync progress (773 ms) 13:11:03 ✓ handles multiple calls to start (487 ms) 13:11:03 ✓ immediately syncs if no new blocks (2 ms) 13:11:03 ✓ cannot be started if already stopped (17 ms) 13:11:03 ✓ can immediately sync to latest (647 ms) 13:11:03 ✓ can immediately sync to a minimum block number (716 ms) 13:11:03 ✓ sync returns immediately if block was already synced (427 ms) 13:11:03 ✓ throws if you try to sync to an unavailable block (404 ms) 13:11:03 ✓ throws if you try to immediate sync when not running (4 ms) 13:11:03 ✓ throws if handling blocks fails (541 ms) 13:11:03 13:11:03 Test Suites: 1 passed, 1 total 13:11:03 Tests: 10 passed, 10 total 13:11:03 Snapshots: 0 total 13:11:03 Time: 6.567 s 13:11:03 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:11:03 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?