Parent Log: http://ci.aztec-labs.com/5b78f67da94557f7 Command: e4e37220d2336322 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/282da3bd25d49b92970e6fc85f110092e8566299 Env: REF_NAME=gh-readonly-queue/next/pr-14610-ee24aac96469b4f1cb8d70e614b2dd27bf0eb134 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 24 14:18:43 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14610_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:18:46 [14:18:46.875] INFO: world_state Created world state synchroniser with block history of infinity 14:18:47 [14:18:47.027] INFO: world_state Started world state synchronizer from block 1 14:18:47 [14:18:47.434] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.254545000000235,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:47 [14:18:47.438] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.7900759999997717,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:47 [14:18:47.442] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.208498999999847,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:47 [14:18:47.616] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6929120000004332,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:47 [14:18:47.627] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":10.319083999999748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:47 [14:18:47.629] INFO: world_state Stopped world state synchronizer 14:18:47 [14:18:47.631] INFO: world_state Stopped world state synchronizer 14:18:47 [14:18:47.634] INFO: world_state Created world state synchroniser with block history of infinity 14:18:47 [14:18:47.828] INFO: world_state Started world state synchronizer from block 1 14:18:48 [14:18:48.116] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.633560999999645,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.118] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.562170000000151,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.121] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3995770000001357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.123] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.503549000000021,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.124] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3748679999998785,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.126] INFO: world_state Stopped world state synchronizer 14:18:48 [14:18:48.128] INFO: world_state Created world state synchroniser with block history of infinity 14:18:48 [14:18:48.128] INFO: world_state Started world state synchronizer from block 1 14:18:48 [14:18:48.129] INFO: world_state Stopped world state synchronizer 14:18:48 [14:18:48.130] INFO: world_state Created world state synchroniser with block history of infinity 14:18:48 [14:18:48.131] INFO: world_state Started world state synchronizer from block 1 14:18:48 [14:18:48.131] INFO: world_state Stopped world state synchronizer 14:18:48 [14:18:48.149] INFO: world_state Stopped world state synchronizer 14:18:48 [14:18:48.150] INFO: world_state Created world state synchroniser with block history of infinity 14:18:48 [14:18:48.319] INFO: world_state Started world state synchronizer from block 1 14:18:48 [14:18:48.588] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":12.424827000000732,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.589] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9305910000002768,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.592] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1575940000002447,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.593] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1159239999997226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.595] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9468220000007932,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.721] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.967572000000473,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.722] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0288030000001527,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:48 [14:18:48.723] INFO: world_state Stopped world state synchronizer 14:18:48 [14:18:48.725] INFO: world_state Created world state synchroniser with block history of infinity 14:18:48 [14:18:48.884] INFO: world_state Started world state synchronizer from block 1 14:18:49 [14:18:49.207] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9784920000001875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.209] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0220030000000406,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.210] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9542019999998956,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.211] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9429319999999279,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.212] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9489619999994829,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.512] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2057560000002923,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.514] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3374770000000353,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.516] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.1509649999998146,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.518] INFO: world_state Stopped world state synchronizer 14:18:49 [14:18:49.519] INFO: world_state Created world state synchroniser with block history of infinity 14:18:49 [14:18:49.682] INFO: world_state Started world state synchronizer from block 1 14:18:49 [14:18:49.946] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9054509999996299,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.948] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9139809999996942,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.949] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8348509999996168,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.950] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8383199999998396,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.952] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1150539999998728,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:49 [14:18:49.954] INFO: world_state Stopped world state synchronizer 14:18:49 [14:18:49.955] INFO: world_state Created world state synchroniser with block history of infinity 14:18:50 [14:18:50.116] INFO: world_state Started world state synchronizer from block 1 14:18:50 [14:18:50.459] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.844662999999855,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:50 [14:18:50.461] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2518260000006194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:50 [14:18:50.463] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.202954999999747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:50 [14:18:50.464] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3011360000000423,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:50 [14:18:50.466] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2437760000002527,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:18:50 [14:18:50.469] INFO: world_state Stopped world state synchronizer 14:18:50 [14:18:50.471] INFO: world_state Created world state synchroniser with block history of infinity 14:18:50 [14:18:50.475] INFO: world_state Stopped world state synchronizer 14:18:50 [14:18:50.477] INFO: world_state Created world state synchroniser with block history of infinity 14:18:50 [14:18:50.648] INFO: world_state Started world state synchronizer from block 1 14:18:50 [14:18:50.968] INFO: world_state Stopped world state synchronizer 14:18:50 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.48 s) 14:18:50 ServerWorldStateSynchronizer 14:18:50 updates sync progress (762 ms) 14:18:50 handles multiple calls to start (493 ms) 14:18:50 immediately syncs if no new blocks (3 ms) 14:18:50 cannot be started if already stopped (19 ms) 14:18:50 can immediately sync to latest (574 ms) 14:18:50 can immediately sync to a minimum block number (794 ms) 14:18:50 sync returns immediately if block was already synced (435 ms) 14:18:50 throws if you try to sync to an unavailable block (514 ms) 14:18:50 throws if you try to immediate sync when not running (5 ms) 14:18:50 throws if handling blocks fails (493 ms) 14:18:50 14:18:50 Test Suites: 1 passed, 1 total 14:18:50 Tests: 10 passed, 10 total 14:18:50 Snapshots: 0 total 14:18:50 Time: 6.568 s 14:18:50 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:18:50 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?