Parent Log: http://ci.aztec-labs.com/24d9da29e964c9c1 Command: 270716767bef7882 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/aedcee89a2544b0e6baf93c4e71d88991f09111e Env: REF_NAME=gh-readonly-queue/next/pr-15183-016def8adbfe93f34b41a41f439b146b5318c895 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 24 13:35:53 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15183_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:35:56 [13:35:56.724] INFO: world_state Created world state synchroniser with block history of infinity 13:35:56 [13:35:56.863] INFO: world_state Started world state synchronizer from block 1 13:35:57 [13:35:57.249] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.137979000000087,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.253] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.5387809999997444,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.256] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.8210059999996702,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.468] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5017250000000786,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.470] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1431620000003022,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.472] INFO: world_state Stopped world state synchronizer 13:35:57 [13:35:57.474] INFO: world_state Stopped world state synchronizer 13:35:57 [13:35:57.477] INFO: world_state Created world state synchroniser with block history of infinity 13:35:57 [13:35:57.627] INFO: world_state Started world state synchronizer from block 1 13:35:57 [13:35:57.939] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2811520000004748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.940] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1551050000007308,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.942] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9475320000001375,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.943] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1573349999998754,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.945] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9773329999998168,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:57 [13:35:57.946] INFO: world_state Stopped world state synchronizer 13:35:57 [13:35:57.947] INFO: world_state Created world state synchroniser with block history of infinity 13:35:57 [13:35:57.948] INFO: world_state Started world state synchronizer from block 1 13:35:57 [13:35:57.949] INFO: world_state Stopped world state synchronizer 13:35:57 [13:35:57.950] INFO: world_state Created world state synchroniser with block history of infinity 13:35:57 [13:35:57.950] INFO: world_state Started world state synchronizer from block 1 13:35:57 [13:35:57.950] INFO: world_state Stopped world state synchronizer 13:35:57 [13:35:57.966] INFO: world_state Stopped world state synchronizer 13:35:57 [13:35:57.968] INFO: world_state Created world state synchroniser with block history of infinity 13:35:58 [13:35:58.140] INFO: world_state Started world state synchronizer from block 1 13:35:58 [13:35:58.450] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6537570000000414,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.452] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.413391000000047,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.454] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3407870000000912,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.456] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3206559999998717,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.458] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3503270000001066,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.649] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4677849999998216,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.651] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2221490000001722,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:58 [13:35:58.652] INFO: world_state Stopped world state synchronizer 13:35:58 [13:35:58.653] INFO: world_state Created world state synchroniser with block history of infinity 13:35:58 [13:35:58.816] INFO: world_state Started world state synchronizer from block 1 13:35:59 [13:35:59.123] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0308069999991858,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.125] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9017579999999725,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.126] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8721159999995507,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.127] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9049580000000788,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.128] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8882669999993595,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.371] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1859059999997044,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.373] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.13719299999957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.375] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.2782829999996466,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.376] INFO: world_state Stopped world state synchronizer 13:35:59 [13:35:59.377] INFO: world_state Created world state synchroniser with block history of infinity 13:35:59 [13:35:59.537] INFO: world_state Started world state synchronizer from block 1 13:35:59 [13:35:59.825] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0471179999995002,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.826] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9285499999996318,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.828] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8879580000002534,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.829] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0621779999992214,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.831] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3323460000001432,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:35:59 [13:35:59.833] INFO: world_state Stopped world state synchronizer 13:35:59 [13:35:59.834] INFO: world_state Created world state synchroniser with block history of infinity 13:35:59 [13:35:59.989] INFO: world_state Started world state synchronizer from block 1 13:36:00 [13:36:00.284] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3595580000001064,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:36:00 [13:36:00.286] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1290120000003299,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:36:00 [13:36:00.287] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0897709999999279,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:36:00 [13:36:00.289] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1359029999994164,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:36:00 [13:36:00.290] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1098819999997431,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 13:36:00 [13:36:00.293] INFO: world_state Stopped world state synchronizer 13:36:00 [13:36:00.295] INFO: world_state Created world state synchroniser with block history of infinity 13:36:00 [13:36:00.298] INFO: world_state Stopped world state synchronizer 13:36:00 [13:36:00.300] INFO: world_state Created world state synchroniser with block history of infinity 13:36:00 [13:36:00.445] INFO: world_state Started world state synchronizer from block 1 13:36:00 [13:36:00.742] INFO: world_state Stopped world state synchronizer 13:36:00 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.246 s) 13:36:00 ServerWorldStateSynchronizer 13:36:00 ✓ updates sync progress (756 ms) 13:36:00 ✓ handles multiple calls to start (470 ms) 13:36:00 ✓ immediately syncs if no new blocks (3 ms) 13:36:00 ✓ cannot be started if already stopped (17 ms) 13:36:00 ✓ can immediately sync to latest (685 ms) 13:36:00 ✓ can immediately sync to a minimum block number (724 ms) 13:36:00 ✓ sync returns immediately if block was already synced (456 ms) 13:36:00 ✓ throws if you try to sync to an unavailable block (459 ms) 13:36:00 ✓ throws if you try to immediate sync when not running (5 ms) 13:36:00 ✓ throws if handling blocks fails (444 ms) 13:36:00 13:36:00 Test Suites: 1 passed, 1 total 13:36:00 Tests: 10 passed, 10 total 13:36:00 Snapshots: 0 total 13:36:00 Time: 6.329 s 13:36:00 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 13:36:00 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?