Parent Log: http://ci.aztec-labs.com/8cf43b9a3d0ad089 Command: 02573248fd9c66ba yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/712835e3cfa2ed6f980f2d482aa4b0ae767046a7 Env: REF_NAME=gh-readonly-queue/next/pr-15077-4b0e4dc09fa55f0bc808fa0c7c3e95e8fa997069 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 21:08:41 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15077_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 21:08:45 [21:08:45.312] INFO: world_state Created world state synchroniser with block history of infinity 21:08:45 [21:08:45.437] INFO: world_state Started world state synchronizer from block 1 21:08:45 [21:08:45.856] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.287168000000747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:45 [21:08:45.860] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.2951640000001134,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:45 [21:08:45.861] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.213383000000249,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.017] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.1190590000005614,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.020] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.9098430000003646,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.022] INFO: world_state Stopped world state synchronizer 21:08:46 [21:08:46.024] INFO: world_state Stopped world state synchronizer 21:08:46 [21:08:46.028] INFO: world_state Created world state synchroniser with block history of infinity 21:08:46 [21:08:46.218] INFO: world_state Started world state synchronizer from block 1 21:08:46 [21:08:46.531] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.846650999999838,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.534] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4801610000004075,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.536] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.568702999999914,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.538] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.8426509999999325,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.541] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.8392210000001796,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:46 [21:08:46.543] INFO: world_state Stopped world state synchronizer 21:08:46 [21:08:46.545] INFO: world_state Created world state synchroniser with block history of infinity 21:08:46 [21:08:46.546] INFO: world_state Started world state synchronizer from block 1 21:08:46 [21:08:46.547] INFO: world_state Stopped world state synchronizer 21:08:46 [21:08:46.549] INFO: world_state Created world state synchroniser with block history of infinity 21:08:46 [21:08:46.549] INFO: world_state Started world state synchronizer from block 1 21:08:46 [21:08:46.550] INFO: world_state Stopped world state synchronizer 21:08:46 [21:08:46.576] INFO: world_state Stopped world state synchronizer 21:08:46 [21:08:46.578] INFO: world_state Created world state synchroniser with block history of infinity 21:08:46 [21:08:46.772] INFO: world_state Started world state synchronizer from block 1 21:08:47 [21:08:47.025] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3101470000001427,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.027] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1647620000003371,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.029] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.94229599999926,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.030] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0475289999994857,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.031] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0039179999994303,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.229] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3488469999992958,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.231] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2782659999993484,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.233] INFO: world_state Stopped world state synchronizer 21:08:47 [21:08:47.235] INFO: world_state Created world state synchroniser with block history of infinity 21:08:47 [21:08:47.393] INFO: world_state Started world state synchronizer from block 1 21:08:47 [21:08:47.656] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.389549000000443,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.658] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1489419999998063,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.659] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0720400000000154,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.661] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0499689999996917,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.662] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0639789999995628,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.974] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.4753710000004503,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.976] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.309095999999954,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.978] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.2539449999994758,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:47 [21:08:47.980] INFO: world_state Stopped world state synchronizer 21:08:47 [21:08:47.982] INFO: world_state Created world state synchroniser with block history of infinity 21:08:48 [21:08:48.160] INFO: world_state Started world state synchronizer from block 1 21:08:48 [21:08:48.478] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8449310000005426,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.481] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2683650000008129,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.483] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3009760000004462,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.485] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3364570000003368,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.487] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2839859999994587,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.490] INFO: world_state Stopped world state synchronizer 21:08:48 [21:08:48.493] INFO: world_state Created world state synchroniser with block history of infinity 21:08:48 [21:08:48.651] INFO: world_state Started world state synchronizer from block 1 21:08:48 [21:08:48.959] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3006759999998394,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.961] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1616519999997763,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.963] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1740930000005392,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.965] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1466920000002574,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.966] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0939010000001872,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 21:08:48 [21:08:48.968] INFO: world_state Stopped world state synchronizer 21:08:48 [21:08:48.969] INFO: world_state Created world state synchroniser with block history of infinity 21:08:48 [21:08:48.973] INFO: world_state Stopped world state synchronizer 21:08:48 [21:08:48.975] INFO: world_state Created world state synchroniser with block history of infinity 21:08:49 [21:08:49.121] INFO: world_state Started world state synchronizer from block 1 21:08:49 [21:08:49.385] INFO: world_state Stopped world state synchronizer 21:08:49 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.769 s) 21:08:49 ServerWorldStateSynchronizer 21:08:49 ✓ updates sync progress (717 ms) 21:08:49 ✓ handles multiple calls to start (516 ms) 21:08:49 ✓ immediately syncs if no new blocks (4 ms) 21:08:49 ✓ cannot be started if already stopped (28 ms) 21:08:49 ✓ can immediately sync to latest (656 ms) 21:08:49 ✓ can immediately sync to a minimum block number (746 ms) 21:08:49 ✓ sync returns immediately if block was already synced (510 ms) 21:08:49 ✓ throws if you try to sync to an unavailable block (476 ms) 21:08:49 ✓ throws if you try to immediate sync when not running (6 ms) 21:08:49 ✓ throws if handling blocks fails (412 ms) 21:08:49 21:08:49 Test Suites: 1 passed, 1 total 21:08:49 Tests: 10 passed, 10 total 21:08:49 Snapshots: 0 total 21:08:49 Time: 6.908 s 21:08:49 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 21:08:49 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?