Parent Log: http://ci.aztec-labs.com/025889bb38746a8e Command: 02573248fd9c66ba yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/712835e3cfa2ed6f980f2d482aa4b0ae767046a7 Env: REF_NAME=gh-readonly-queue/next/pr-15077-4b0e4dc09fa55f0bc808fa0c7c3e95e8fa997069 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 21:08:36 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15077_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:08:40 [21:08:40.304] INFO: world_state Created world state synchroniser with block history of infinity 21:08:40 [21:08:40.444] INFO: world_state Started world state synchronizer from block 1 21:08:40 [21:08:40.904] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.018622999999934,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:40 [21:08:40.910] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.8977219999997033,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:40 [21:08:40.912] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.6572609999993801,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.114] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.4050090000000637,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.118] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.413829000000078,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.120] INFO: world_state Stopped world state synchronizer 21:08:41 [21:08:41.135] INFO: world_state Stopped world state synchronizer 21:08:41 [21:08:41.139] INFO: world_state Created world state synchroniser with block history of infinity 21:08:41 [21:08:41.319] INFO: world_state Started world state synchronizer from block 1 21:08:41 [21:08:41.624] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.7253920000002836,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.627] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.320042000000285,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.629] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4281249999994543,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.633] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.531457000000046,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.637] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.047711000000163,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:41 [21:08:41.640] INFO: world_state Stopped world state synchronizer 21:08:41 [21:08:41.643] INFO: world_state Created world state synchroniser with block history of infinity 21:08:41 [21:08:41.644] INFO: world_state Started world state synchronizer from block 1 21:08:41 [21:08:41.645] INFO: world_state Stopped world state synchronizer 21:08:41 [21:08:41.646] INFO: world_state Created world state synchroniser with block history of infinity 21:08:41 [21:08:41.647] INFO: world_state Started world state synchronizer from block 1 21:08:41 [21:08:41.647] INFO: world_state Stopped world state synchronizer 21:08:41 [21:08:41.683] INFO: world_state Stopped world state synchronizer 21:08:41 [21:08:41.685] INFO: world_state Created world state synchroniser with block history of infinity 21:08:41 [21:08:41.881] INFO: world_state Started world state synchronizer from block 1 21:08:42 [21:08:42.231] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2335899999998219,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.233] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2402000000001863,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.235] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3814839999995456,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.251] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":15.329977999999755,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.255] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4096349999999802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.496] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5422980000003008,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.498] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.4224450000001525,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:42 [21:08:42.500] INFO: world_state Stopped world state synchronizer 21:08:42 [21:08:42.502] INFO: world_state Created world state synchroniser with block history of infinity 21:08:42 [21:08:42.679] INFO: world_state Started world state synchronizer from block 1 21:08:43 [21:08:43.008] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9444530000000668,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.010] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1116970000002766,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.011] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1071869999996125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.013] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1452979999994568,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.014] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1552890000002662,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.305] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3267329999998765,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.307] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2119200000006458,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.308] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.0886569999993299,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.310] INFO: world_state Stopped world state synchronizer 21:08:43 [21:08:43.312] INFO: world_state Created world state synchroniser with block history of infinity 21:08:43 [21:08:43.457] INFO: world_state Started world state synchronizer from block 1 21:08:43 [21:08:43.745] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.204319999999825,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.747] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0472260000005917,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.748] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0385660000001735,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.750] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9969240000000354,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.751] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0754170000000158,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:43 [21:08:43.753] INFO: world_state Stopped world state synchronizer 21:08:43 [21:08:43.755] INFO: world_state Created world state synchroniser with block history of infinity 21:08:43 [21:08:43.927] INFO: world_state Started world state synchronizer from block 1 21:08:44 [21:08:44.217] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9375629999994999,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:44 [21:08:44.218] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7768290000003617,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:44 [21:08:44.219] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7047069999998712,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:44 [21:08:44.220] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.6737359999997352,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:44 [21:08:44.221] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.6659060000001773,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:44 [21:08:44.223] INFO: world_state Stopped world state synchronizer 21:08:44 [21:08:44.224] INFO: world_state Created world state synchroniser with block history of infinity 21:08:44 [21:08:44.226] INFO: world_state Stopped world state synchronizer 21:08:44 [21:08:44.227] INFO: world_state Created world state synchroniser with block history of infinity 21:08:44 [21:08:44.399] INFO: world_state Started world state synchronizer from block 1 21:08:44 [21:08:44.708] INFO: world_state Stopped world state synchronizer 21:08:44 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.948 s) 21:08:44 ServerWorldStateSynchronizer 21:08:44 ✓ updates sync progress (835 ms) 21:08:44 ✓ handles multiple calls to start (502 ms) 21:08:44 ✓ immediately syncs if no new blocks (4 ms) 21:08:44 ✓ cannot be started if already stopped (38 ms) 21:08:44 ✓ can immediately sync to latest (816 ms) 21:08:44 ✓ can immediately sync to a minimum block number (809 ms) 21:08:44 ✓ sync returns immediately if block was already synced (443 ms) 21:08:44 ✓ throws if you try to sync to an unavailable block (469 ms) 21:08:44 ✓ throws if you try to immediate sync when not running (3 ms) 21:08:44 ✓ throws if handling blocks fails (482 ms) 21:08:44 21:08:44 Test Suites: 1 passed, 1 total 21:08:44 Tests: 10 passed, 10 total 21:08:44 Snapshots: 0 total 21:08:44 Time: 7.079 s 21:08:44 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 21:08:44 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?