Parent Log: http://ci.aztec-labs.com/85449a36e9425412 Command: ebfed4061172f77e yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/07aee119a58dd438ddfb5bd53e124e7269e6c651 Env: REF_NAME=gh-readonly-queue/next/pr-15083-9b801754ba98479ee645488c29d2fda1eecbfd85 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 21:06:03 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15083_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:06:06 [21:06:06.908] INFO: world_state Created world state synchroniser with block history of infinity 21:06:07 [21:06:07.107] INFO: world_state Started world state synchronizer from block 1 21:06:07 [21:06:07.533] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.922499999999673,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:07 [21:06:07.538] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.068457999999737,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:07 [21:06:07.542] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.8838030000006256,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:07 [21:06:07.729] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3584939999991548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:07 [21:06:07.730] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9570349999994505,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:07 [21:06:07.732] INFO: world_state Stopped world state synchronizer 21:06:07 [21:06:07.734] INFO: world_state Stopped world state synchronizer 21:06:07 [21:06:07.736] INFO: world_state Created world state synchroniser with block history of infinity 21:06:07 [21:06:07.930] INFO: world_state Started world state synchronizer from block 1 21:06:08 [21:06:08.266] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.9029680000003282,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.268] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5127179999999498,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.270] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4425860000001194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.272] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2566820000001826,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.273] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9993150000000242,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.274] INFO: world_state Stopped world state synchronizer 21:06:08 [21:06:08.276] INFO: world_state Created world state synchroniser with block history of infinity 21:06:08 [21:06:08.277] INFO: world_state Started world state synchronizer from block 1 21:06:08 [21:06:08.277] INFO: world_state Stopped world state synchronizer 21:06:08 [21:06:08.278] INFO: world_state Created world state synchroniser with block history of infinity 21:06:08 [21:06:08.278] INFO: world_state Started world state synchronizer from block 1 21:06:08 [21:06:08.279] INFO: world_state Stopped world state synchronizer 21:06:08 [21:06:08.295] INFO: world_state Stopped world state synchronizer 21:06:08 [21:06:08.297] INFO: world_state Created world state synchroniser with block history of infinity 21:06:08 [21:06:08.473] INFO: world_state Started world state synchronizer from block 1 21:06:08 [21:06:08.773] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1007380000000921,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.775] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1195189999998547,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.790] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.9953000000004977,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.792] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4995180000005348,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.794] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5168079999994006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.967] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0305260000004637,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.969] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8554119999998875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:08 [21:06:08.970] INFO: world_state Stopped world state synchronizer 21:06:08 [21:06:08.971] INFO: world_state Created world state synchroniser with block history of infinity 21:06:09 [21:06:09.173] INFO: world_state Started world state synchronizer from block 1 21:06:09 [21:06:09.502] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4375060000002122,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.503] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9604239999998754,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.505] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2491119999995135,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.507] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2392110000000685,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.508] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1544190000004164,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.797] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2213009999995847,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.799] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0842780000002676,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.801] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.1317890000000261,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:09 [21:06:09.802] INFO: world_state Stopped world state synchronizer 21:06:09 [21:06:09.803] INFO: world_state Created world state synchroniser with block history of infinity 21:06:09 [21:06:09.980] INFO: world_state Started world state synchronizer from block 1 21:06:10 [21:06:10.339] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5885500000003958,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.341] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.307332999999744,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.343] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1942400000007183,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.344] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.227831000000151,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.346] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2741320000004634,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.348] INFO: world_state Stopped world state synchronizer 21:06:10 [21:06:10.349] INFO: world_state Created world state synchroniser with block history of infinity 21:06:10 [21:06:10.522] INFO: world_state Started world state synchronizer from block 1 21:06:10 [21:06:10.838] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0128349999995407,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.839] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.826361000000361,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.840] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8085609999998269,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.841] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8128210000004401,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.843] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.204569999999876,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:06:10 [21:06:10.845] INFO: world_state Stopped world state synchronizer 21:06:10 [21:06:10.846] INFO: world_state Created world state synchroniser with block history of infinity 21:06:10 [21:06:10.849] INFO: world_state Stopped world state synchronizer 21:06:10 [21:06:10.850] INFO: world_state Created world state synchroniser with block history of infinity 21:06:11 [21:06:11.060] INFO: world_state Started world state synchronizer from block 1 21:06:11 [21:06:11.367] INFO: world_state Stopped world state synchronizer 21:06:11 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.92 s) 21:06:11 ServerWorldStateSynchronizer 21:06:11 ✓ updates sync progress (830 ms) 21:06:11 ✓ handles multiple calls to start (539 ms) 21:06:11 ✓ immediately syncs if no new blocks (2 ms) 21:06:11 ✓ cannot be started if already stopped (18 ms) 21:06:11 ✓ can immediately sync to latest (674 ms) 21:06:11 ✓ can immediately sync to a minimum block number (832 ms) 21:06:11 ✓ sync returns immediately if block was already synced (545 ms) 21:06:11 ✓ throws if you try to sync to an unavailable block (496 ms) 21:06:11 ✓ throws if you try to immediate sync when not running (3 ms) 21:06:11 ✓ throws if handling blocks fails (517 ms) 21:06:11 21:06:11 Test Suites: 1 passed, 1 total 21:06:11 Tests: 10 passed, 10 total 21:06:11 Snapshots: 0 total 21:06:11 Time: 7.029 s 21:06:11 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 21:06:11 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?