Parent Log: http://ci.aztec-labs.com/0813959a3b08c9c9 Command: f682b45a820409ef yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/75d792847d8434a0c504e7adf5c102a913065272 Env: REF_NAME=gh-readonly-queue/next/pr-15015-cf8be0f9e81e248048560619de041e90d9d6990a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 08:35:51 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15015_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 08:35:54 [08:35:54.475] INFO: world_state Created world state synchroniser with block history of infinity 08:35:54 [08:35:54.637] INFO: world_state Started world state synchronizer from block 1 08:35:55 [08:35:55.033] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.954266000000189,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.038] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.185866999999689,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.041] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.8342130000000907,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.195] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.429935000000114,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.197] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.255453000000216,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.198] INFO: world_state Stopped world state synchronizer 08:35:55 [08:35:55.199] INFO: world_state Stopped world state synchronizer 08:35:55 [08:35:55.201] INFO: world_state Created world state synchroniser with block history of infinity 08:35:55 [08:35:55.329] INFO: world_state Started world state synchronizer from block 1 08:35:55 [08:35:55.622] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5202470000003814,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.625] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2819220000001224,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.626] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2358720000001995,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.628] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5390770000003613,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.630] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4122050000005402,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:55 [08:35:55.632] INFO: world_state Stopped world state synchronizer 08:35:55 [08:35:55.634] INFO: world_state Created world state synchroniser with block history of infinity 08:35:55 [08:35:55.634] INFO: world_state Started world state synchronizer from block 1 08:35:55 [08:35:55.635] INFO: world_state Stopped world state synchronizer 08:35:55 [08:35:55.636] INFO: world_state Created world state synchroniser with block history of infinity 08:35:55 [08:35:55.637] INFO: world_state Started world state synchronizer from block 1 08:35:55 [08:35:55.637] INFO: world_state Stopped world state synchronizer 08:35:55 [08:35:55.668] INFO: world_state Stopped world state synchronizer 08:35:55 [08:35:55.671] INFO: world_state Created world state synchroniser with block history of infinity 08:35:55 [08:35:55.845] INFO: world_state Started world state synchronizer from block 1 08:35:56 [08:35:56.156] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3074539999997796,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.158] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1335599999993065,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.160] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.977788000000146,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.161] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8036949999996068,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.162] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9287570000005871,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.324] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.8954960000000938,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.325] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.7132320000000618,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.326] INFO: world_state Stopped world state synchronizer 08:35:56 [08:35:56.328] INFO: world_state Created world state synchroniser with block history of infinity 08:35:56 [08:35:56.509] INFO: world_state Started world state synchronizer from block 1 08:35:56 [08:35:56.805] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9905979999994088,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.806] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.779222999999547,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.807] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7960739999998623,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.808] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7440130000004501,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:56 [08:35:56.809] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7090720000005604,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.052] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1526800000001458,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.054] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1144699999995282,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.055] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.8839459999999235,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.056] INFO: world_state Stopped world state synchronizer 08:35:57 [08:35:57.058] INFO: world_state Created world state synchroniser with block history of infinity 08:35:57 [08:35:57.213] INFO: world_state Started world state synchronizer from block 1 08:35:57 [08:35:57.572] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.434266000000207,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.574] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2617229999996198,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.575] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.08600000000024,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.577] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.015277999999853,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.579] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.110779999999977,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.581] INFO: world_state Stopped world state synchronizer 08:35:57 [08:35:57.582] INFO: world_state Created world state synchroniser with block history of infinity 08:35:57 [08:35:57.741] INFO: world_state Started world state synchronizer from block 1 08:35:57 [08:35:57.984] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2361310000005687,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.986] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9735769999997501,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.987] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9982680000002802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.988] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0143580000003567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.991] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9477269999997588,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 08:35:57 [08:35:57.993] INFO: world_state Stopped world state synchronizer 08:35:57 [08:35:57.995] INFO: world_state Created world state synchroniser with block history of infinity 08:35:58 [08:35:58.010] INFO: world_state Stopped world state synchronizer 08:35:58 [08:35:58.012] INFO: world_state Created world state synchroniser with block history of infinity 08:35:58 [08:35:58.170] INFO: world_state Started world state synchronizer from block 1 08:35:58 [08:35:58.461] INFO: world_state Stopped world state synchronizer 08:35:58 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.118 s) 08:35:58 ServerWorldStateSynchronizer 08:35:58 ✓ updates sync progress (731 ms) 08:35:58 ✓ handles multiple calls to start (431 ms) 08:35:58 ✓ immediately syncs if no new blocks (2 ms) 08:35:58 ✓ cannot be started if already stopped (33 ms) 08:35:58 ✓ can immediately sync to latest (658 ms) 08:35:58 ✓ can immediately sync to a minimum block number (730 ms) 08:35:58 ✓ sync returns immediately if block was already synced (524 ms) 08:35:58 ✓ throws if you try to sync to an unavailable block (413 ms) 08:35:58 ✓ throws if you try to immediate sync when not running (17 ms) 08:35:58 ✓ throws if handling blocks fails (451 ms) 08:35:58 08:35:58 Test Suites: 1 passed, 1 total 08:35:58 Tests: 10 passed, 10 total 08:35:58 Snapshots: 0 total 08:35:58 Time: 6.204 s 08:35:58 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 08:35:58 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?