Parent Log: http://ci.aztec-labs.com/058a10c61a6638d4 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:11:05 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15180_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 13:11:08 [13:11:08.661] INFO: world_state Created world state synchroniser with block history of infinity 13:11:08 [13:11:08.808] INFO: world_state Started world state synchronizer from block 1 13:11:09 [13:11:09.173] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.627212999999756,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.179] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.3818280000000414,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.183] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.4675350000002254,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.373] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.085425000000214,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.376] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7053949999999531,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.391] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.392] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.395] INFO: world_state Created world state synchroniser with block history of infinity 13:11:09 [13:11:09.562] INFO: world_state Started world state synchronizer from block 1 13:11:09 [13:11:09.881] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.938810999999987,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.884] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5511500000002343,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.890] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.7372550000000047,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.894] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.6679299999996147,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.896] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7452759999996488,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:09 [13:11:09.898] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.901] INFO: world_state Created world state synchroniser with block history of infinity 13:11:09 [13:11:09.902] INFO: world_state Started world state synchronizer from block 1 13:11:09 [13:11:09.903] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.904] INFO: world_state Created world state synchroniser with block history of infinity 13:11:09 [13:11:09.905] INFO: world_state Started world state synchronizer from block 1 13:11:09 [13:11:09.906] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.928] INFO: world_state Stopped world state synchronizer 13:11:09 [13:11:09.929] INFO: world_state Created world state synchroniser with block history of infinity 13:11:10 [13:11:10.124] INFO: world_state Started world state synchronizer from block 1 13:11:10 [13:11:10.476] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.373805999999604,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.478] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1130089999996926,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.480] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3753160000005664,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.482] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2405419999995502,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.484] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2543129999994562,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.681] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.782376999999542,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.683] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.5875710000000254,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:10 [13:11:10.689] INFO: world_state Stopped world state synchronizer 13:11:10 [13:11:10.691] INFO: world_state Created world state synchroniser with block history of infinity 13:11:10 [13:11:10.869] INFO: world_state Started world state synchronizer from block 1 13:11:11 [13:11:11.128] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.332965000000513,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.130] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0513380000002144,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.132] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0978089999998701,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.133] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0782079999999041,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.135] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.005406000000221,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.388] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1717710000002626,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.391] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.6155720000006113,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.393] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.442537999999331,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.404] INFO: world_state Stopped world state synchronizer 13:11:11 [13:11:11.406] INFO: world_state Created world state synchroniser with block history of infinity 13:11:11 [13:11:11.569] INFO: world_state Started world state synchronizer from block 1 13:11:11 [13:11:11.877] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7837470000004032,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.879] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9577449999997043,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.880] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9482050000005984,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.882] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0981689999998707,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.884] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3898859999999331,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:11 [13:11:11.888] INFO: world_state Stopped world state synchronizer 13:11:11 [13:11:11.891] INFO: world_state Created world state synchroniser with block history of infinity 13:11:12 [13:11:12.043] INFO: world_state Started world state synchronizer from block 1 13:11:12 [13:11:12.316] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3818060000003243,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:12 [13:11:12.318] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1115990000007514,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:12 [13:11:12.320] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9445350000005419,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:12 [13:11:12.321] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7839610000000903,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:12 [13:11:12.322] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7629699999997683,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:11:12 [13:11:12.324] INFO: world_state Stopped world state synchronizer 13:11:12 [13:11:12.325] INFO: world_state Created world state synchroniser with block history of infinity 13:11:12 [13:11:12.328] INFO: world_state Stopped world state synchronizer 13:11:12 [13:11:12.330] INFO: world_state Created world state synchroniser with block history of infinity 13:11:12 [13:11:12.509] INFO: world_state Started world state synchronizer from block 1 13:11:12 [13:11:12.808] INFO: world_state Stopped world state synchronizer 13:11:12 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.589 s) 13:11:12 ServerWorldStateSynchronizer 13:11:12 ✓ updates sync progress (737 ms) 13:11:12 ✓ handles multiple calls to start (505 ms) 13:11:12 ✓ immediately syncs if no new blocks (4 ms) 13:11:12 ✓ cannot be started if already stopped (24 ms) 13:11:12 ✓ can immediately sync to latest (760 ms) 13:11:12 ✓ can immediately sync to a minimum block number (714 ms) 13:11:12 ✓ sync returns immediately if block was already synced (483 ms) 13:11:12 ✓ throws if you try to sync to an unavailable block (434 ms) 13:11:12 ✓ throws if you try to immediate sync when not running (5 ms) 13:11:12 ✓ throws if handling blocks fails (479 ms) 13:11:12 13:11:12 Test Suites: 1 passed, 1 total 13:11:12 Tests: 10 passed, 10 total 13:11:12 Snapshots: 0 total 13:11:12 Time: 6.691 s 13:11:12 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:11:12 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?