Parent Log: http://ci.aztec-labs.com/e6ca5c92d453aa5e Command: 7036b634d1ccdbba yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/b6c045c8e9bbe748f5441bd1e65a9beeb9c62e73 Env: REF_NAME=gh-readonly-queue/next/pr-15067-24972303091baff6f83c6389d7d1406c932357e9 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 14:19:37 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15067_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 14:19:41 [14:19:41.003] INFO: world_state Created world state synchroniser with block history of infinity 14:19:41 [14:19:41.129] INFO: world_state Started world state synchronizer from block 1 14:19:41 [14:19:41.504] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.8830120000002353,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:41 [14:19:41.507] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.166341000000102,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:41 [14:19:41.509] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5102080000006026,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:41 [14:19:41.693] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4987569999993866,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:41 [14:19:41.695] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1274730000004638,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:41 [14:19:41.697] INFO: world_state Stopped world state synchronizer 14:19:41 [14:19:41.698] INFO: world_state Stopped world state synchronizer 14:19:41 [14:19:41.701] INFO: world_state Created world state synchroniser with block history of infinity 14:19:41 [14:19:41.868] INFO: world_state Started world state synchronizer from block 1 14:19:42 [14:19:42.134] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.16035600000032,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.136] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0639089999995122,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.137] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9759729999996125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.139] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1570160000001124,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.140] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.121752000000015,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.142] INFO: world_state Stopped world state synchronizer 14:19:42 [14:19:42.143] INFO: world_state Created world state synchroniser with block history of infinity 14:19:42 [14:19:42.144] INFO: world_state Started world state synchronizer from block 1 14:19:42 [14:19:42.145] INFO: world_state Stopped world state synchronizer 14:19:42 [14:19:42.146] INFO: world_state Created world state synchroniser with block history of infinity 14:19:42 [14:19:42.146] INFO: world_state Started world state synchronizer from block 1 14:19:42 [14:19:42.147] INFO: world_state Stopped world state synchronizer 14:19:42 [14:19:42.175] INFO: world_state Stopped world state synchronizer 14:19:42 [14:19:42.176] INFO: world_state Created world state synchroniser with block history of infinity 14:19:42 [14:19:42.342] INFO: world_state Started world state synchronizer from block 1 14:19:42 [14:19:42.634] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5911740000001373,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.636] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.04859899999974,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.637] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1818069999999352,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.639] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0766700000003766,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.640] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9637319999992542,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.873] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5807119999999486,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.876] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.455394000000524,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:42 [14:19:42.878] INFO: world_state Stopped world state synchronizer 14:19:42 [14:19:42.880] INFO: world_state Created world state synchroniser with block history of infinity 14:19:43 [14:19:43.093] INFO: world_state Started world state synchronizer from block 1 14:19:43 [14:19:43.439] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3121849999997721,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.440] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.116613000000143,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.442] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0265470000003916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.443] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0159859999994296,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.445] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9947050000000672,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.786] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.415541999999732,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.788] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3108650000003763,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.790] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.3133449999995719,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:43 [14:19:43.792] INFO: world_state Stopped world state synchronizer 14:19:43 [14:19:43.794] INFO: world_state Created world state synchroniser with block history of infinity 14:19:43 [14:19:43.991] INFO: world_state Started world state synchronizer from block 1 14:19:44 [14:19:44.334] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8453100000006089,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.336] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.263821999999891,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.338] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2648019999996905,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.340] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8473659999999654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.341] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8390650000001187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.344] INFO: world_state Stopped world state synchronizer 14:19:44 [14:19:44.346] INFO: world_state Created world state synchroniser with block history of infinity 14:19:44 [14:19:44.505] INFO: world_state Started world state synchronizer from block 1 14:19:44 [14:19:44.832] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2068680000002132,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.835] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0800099999996746,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.837] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1049819999998363,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.838] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9746940000004543,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.840] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9691229999998541,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 14:19:44 [14:19:44.842] INFO: world_state Stopped world state synchronizer 14:19:44 [14:19:44.844] INFO: world_state Created world state synchroniser with block history of infinity 14:19:44 [14:19:44.847] INFO: world_state Stopped world state synchronizer 14:19:44 [14:19:44.849] INFO: world_state Created world state synchroniser with block history of infinity 14:19:45 [14:19:45.027] INFO: world_state Started world state synchronizer from block 1 14:19:45 [14:19:45.356] INFO: world_state Stopped world state synchronizer 14:19:45 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.862 s) 14:19:45 ServerWorldStateSynchronizer 14:19:45 ✓ updates sync progress (700 ms) 14:19:45 ✓ handles multiple calls to start (442 ms) 14:19:45 ✓ immediately syncs if no new blocks (2 ms) 14:19:45 ✓ cannot be started if already stopped (30 ms) 14:19:45 ✓ can immediately sync to latest (702 ms) 14:19:45 ✓ can immediately sync to a minimum block number (913 ms) 14:19:45 ✓ sync returns immediately if block was already synced (551 ms) 14:19:45 ✓ throws if you try to sync to an unavailable block (498 ms) 14:19:45 ✓ throws if you try to immediate sync when not running (4 ms) 14:19:45 ✓ throws if handling blocks fails (509 ms) 14:19:45 14:19:45 Test Suites: 1 passed, 1 total 14:19:45 Tests: 10 passed, 10 total 14:19:45 Snapshots: 0 total 14:19:45 Time: 6.981 s 14:19:45 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 14:19:45 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?