Parent Log: http://ci.aztec-labs.com/6060ff546087cc03 Command: 73379369dc8552ae yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/7a1b59a9ea7f085cd243d25401ffbea660430ebd Env: REF_NAME=gh-readonly-queue/next/pr-15163-4608046e462faf9ff3fbee265ba34dbecb5d0b31 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 23 13:50:57 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15163_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:51:00 [13:51:00.794] INFO: world_state Created world state synchroniser with block history of infinity 13:51:00 [13:51:00.931] INFO: world_state Started world state synchronizer from block 1 13:51:01 [13:51:01.393] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.223637999999937,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:01 [13:51:01.398] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.8148999999998523,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:01 [13:51:01.401] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.8981950000002143,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:01 [13:51:01.567] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4006939999999304,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:01 [13:51:01.582] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":13.897183999999925,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:01 [13:51:01.584] INFO: world_state Stopped world state synchronizer 13:51:01 [13:51:01.585] INFO: world_state Stopped world state synchronizer 13:51:01 [13:51:01.587] INFO: world_state Created world state synchroniser with block history of infinity 13:51:01 [13:51:01.718] INFO: world_state Started world state synchronizer from block 1 13:51:02 [13:51:02.039] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2485120000001189,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.042] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.660385000000133,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.045] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4866510000001654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.048] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.288676000000123,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.052] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.6335739999994985,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.054] INFO: world_state Stopped world state synchronizer 13:51:02 [13:51:02.056] INFO: world_state Created world state synchroniser with block history of infinity 13:51:02 [13:51:02.057] INFO: world_state Started world state synchronizer from block 1 13:51:02 [13:51:02.058] INFO: world_state Stopped world state synchronizer 13:51:02 [13:51:02.059] INFO: world_state Created world state synchroniser with block history of infinity 13:51:02 [13:51:02.060] INFO: world_state Started world state synchronizer from block 1 13:51:02 [13:51:02.060] INFO: world_state Stopped world state synchronizer 13:51:02 [13:51:02.082] INFO: world_state Stopped world state synchronizer 13:51:02 [13:51:02.085] INFO: world_state Created world state synchroniser with block history of infinity 13:51:02 [13:51:02.263] INFO: world_state Started world state synchronizer from block 1 13:51:02 [13:51:02.576] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2902249999997366,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.578] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0909389999997074,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.579] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0573459999995976,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.581] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1351129999993645,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.582] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1652149999999892,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.776] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.267612999999983,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.778] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1359229999998206,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:02 [13:51:02.780] INFO: world_state Stopped world state synchronizer 13:51:02 [13:51:02.781] INFO: world_state Created world state synchroniser with block history of infinity 13:51:02 [13:51:02.958] INFO: world_state Started world state synchronizer from block 1 13:51:03 [13:51:03.289] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3342090000005555,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.291] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0720069999997577,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.293] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0646770000003016,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.294] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.047125000000051,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.296] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0737380000000485,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.528] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8555790000000343,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.530] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0323239999997895,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.531] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.0118919999995342,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:03 [13:51:03.533] INFO: world_state Stopped world state synchronizer 13:51:03 [13:51:03.534] INFO: world_state Created world state synchroniser with block history of infinity 13:51:03 [13:51:03.708] INFO: world_state Started world state synchronizer from block 1 13:51:04 [13:51:04.007] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8594499999999243,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.008] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0452749999994921,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.010] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9693290000004708,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.011] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3437290000001667,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.013] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9917500000001382,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.014] INFO: world_state Stopped world state synchronizer 13:51:04 [13:51:04.016] INFO: world_state Created world state synchroniser with block history of infinity 13:51:04 [13:51:04.185] INFO: world_state Started world state synchronizer from block 1 13:51:04 [13:51:04.502] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.8625000000001819,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.503] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7203589999999167,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.504] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7117969999999332,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.506] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9702790000001187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.507] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8481289999999717,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:51:04 [13:51:04.508] INFO: world_state Stopped world state synchronizer 13:51:04 [13:51:04.510] INFO: world_state Created world state synchroniser with block history of infinity 13:51:04 [13:51:04.512] INFO: world_state Stopped world state synchronizer 13:51:04 [13:51:04.513] INFO: world_state Created world state synchroniser with block history of infinity 13:51:04 [13:51:04.683] INFO: world_state Started world state synchronizer from block 1 13:51:05 [13:51:05.012] INFO: world_state Stopped world state synchronizer 13:51:05 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.219 s) 13:51:05 ServerWorldStateSynchronizer 13:51:05 ✓ updates sync progress (797 ms) 13:51:05 ✓ handles multiple calls to start (467 ms) 13:51:05 ✓ immediately syncs if no new blocks (3 ms) 13:51:05 ✓ cannot be started if already stopped (24 ms) 13:51:05 ✓ can immediately sync to latest (696 ms) 13:51:05 ✓ can immediately sync to a minimum block number (752 ms) 13:51:05 ✓ sync returns immediately if block was already synced (482 ms) 13:51:05 ✓ throws if you try to sync to an unavailable block (494 ms) 13:51:05 ✓ throws if you try to immediate sync when not running (3 ms) 13:51:05 ✓ throws if handling blocks fails (499 ms) 13:51:05 13:51:05 Test Suites: 1 passed, 1 total 13:51:05 Tests: 10 passed, 10 total 13:51:05 Snapshots: 0 total 13:51:05 Time: 6.296 s 13:51:05 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:51:05 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?