Parent Log: http://ci.aztec-labs.com/20565fb19cf53bed Command: 557c108a8ed544a3 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/4b0e4dc09fa55f0bc808fa0c7c3e95e8fa997069 Env: REF_NAME=gh-readonly-queue/next/pr-15116-433ba6218aed45169029991a493e4232b30b8ec6 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 20:31:16 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15116_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 20:31:20 [20:31:20.161] INFO: world_state Created world state synchroniser with block history of infinity 20:31:20 [20:31:20.318] INFO: world_state Started world state synchronizer from block 1 20:31:20 [20:31:20.803] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":7.062699000000066,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:20 [20:31:20.809] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.6043110000000524,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:20 [20:31:20.813] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.404554000000644,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.002] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4444630000007237,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.004] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.157455999999911,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.005] INFO: world_state Stopped world state synchronizer 20:31:21 [20:31:21.006] INFO: world_state Stopped world state synchronizer 20:31:21 [20:31:21.009] INFO: world_state Created world state synchroniser with block history of infinity 20:31:21 [20:31:21.214] INFO: world_state Started world state synchronizer from block 1 20:31:21 [20:31:21.507] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8181009999998423,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.510] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.7506290000001172,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.512] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5737950000002456,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.515] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.9466229999998177,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.517] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3625700000002325,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:21 [20:31:21.518] INFO: world_state Stopped world state synchronizer 20:31:21 [20:31:21.520] INFO: world_state Created world state synchroniser with block history of infinity 20:31:21 [20:31:21.521] INFO: world_state Started world state synchronizer from block 1 20:31:21 [20:31:21.521] INFO: world_state Stopped world state synchronizer 20:31:21 [20:31:21.522] INFO: world_state Created world state synchroniser with block history of infinity 20:31:21 [20:31:21.523] INFO: world_state Started world state synchronizer from block 1 20:31:21 [20:31:21.523] INFO: world_state Stopped world state synchronizer 20:31:21 [20:31:21.545] INFO: world_state Stopped world state synchronizer 20:31:21 [20:31:21.547] INFO: world_state Created world state synchroniser with block history of infinity 20:31:21 [20:31:21.718] INFO: world_state Started world state synchronizer from block 1 20:31:22 [20:31:22.031] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.261899000000085,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.033] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9650519999995595,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.035] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.107255000000805,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.036] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7175770000003467,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.037] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7519769999998971,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.250] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4346320000004198,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.252] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0645839999997406,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.254] INFO: world_state Stopped world state synchronizer 20:31:22 [20:31:22.256] INFO: world_state Created world state synchroniser with block history of infinity 20:31:22 [20:31:22.485] INFO: world_state Started world state synchronizer from block 1 20:31:22 [20:31:22.750] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3783210000001418,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.752] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9981920000000173,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.754] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1959069999993517,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.756] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1346450000000914,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:22 [20:31:22.757] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0602439999993294,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.001] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0431330000001253,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.003] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9535320000004504,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.004] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9913230000001931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.006] INFO: world_state Stopped world state synchronizer 20:31:23 [20:31:23.007] INFO: world_state Created world state synchroniser with block history of infinity 20:31:23 [20:31:23.162] INFO: world_state Started world state synchronizer from block 1 20:31:23 [20:31:23.426] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2616989999996804,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.428] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0740239999995538,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.429] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0336130000005141,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.431] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0967149999996764,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.432] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0329130000000077,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.434] INFO: world_state Stopped world state synchronizer 20:31:23 [20:31:23.436] INFO: world_state Created world state synchroniser with block history of infinity 20:31:23 [20:31:23.598] INFO: world_state Started world state synchronizer from block 1 20:31:23 [20:31:23.893] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3736410000001342,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.895] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2250670000003083,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.897] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2037770000006276,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.899] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1698560000004363,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.900] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.129555999999866,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:31:23 [20:31:23.902] INFO: world_state Stopped world state synchronizer 20:31:23 [20:31:23.904] INFO: world_state Created world state synchroniser with block history of infinity 20:31:23 [20:31:23.907] INFO: world_state Stopped world state synchronizer 20:31:23 [20:31:23.909] INFO: world_state Created world state synchroniser with block history of infinity 20:31:24 [20:31:24.130] INFO: world_state Started world state synchronizer from block 1 20:31:24 [20:31:24.516] INFO: world_state Stopped world state synchronizer 20:31:24 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.06 s) 20:31:24 ServerWorldStateSynchronizer 20:31:24 ✓ updates sync progress (853 ms) 20:31:24 ✓ handles multiple calls to start (511 ms) 20:31:24 ✓ immediately syncs if no new blocks (3 ms) 20:31:24 ✓ cannot be started if already stopped (24 ms) 20:31:24 ✓ can immediately sync to latest (708 ms) 20:31:24 ✓ can immediately sync to a minimum block number (751 ms) 20:31:24 ✓ sync returns immediately if block was already synced (428 ms) 20:31:24 ✓ throws if you try to sync to an unavailable block (468 ms) 20:31:24 ✓ throws if you try to immediate sync when not running (4 ms) 20:31:24 ✓ throws if handling blocks fails (608 ms) 20:31:24 20:31:24 Test Suites: 1 passed, 1 total 20:31:24 Tests: 10 passed, 10 total 20:31:24 Snapshots: 0 total 20:31:24 Time: 7.175 s 20:31:24 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 20:31:24 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?