Parent Log: http://ci.aztec-labs.com/284c9e4852412789 Command: 4d0fb449c606d482 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/263498dd65e8700218979d7a94dbfd25b2a8a8a8 Env: REF_NAME=gh-readonly-queue/next/pr-14921-4b0e4dc09fa55f0bc808fa0c7c3e95e8fa997069 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 20:36:20 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14921_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:36:23 [20:36:23.968] INFO: world_state Created world state synchroniser with block history of infinity 20:36:24 [20:36:24.103] INFO: world_state Started world state synchronizer from block 1 20:36:24 [20:36:24.527] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":4.932054999999764,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:24 [20:36:24.530] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.168149000000085,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:24 [20:36:24.533] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.610830999999962,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:24 [20:36:24.673] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.6161809999998695,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:24 [20:36:24.685] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":10.808149999999841,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:24 [20:36:24.687] INFO: world_state Stopped world state synchronizer 20:36:24 [20:36:24.689] INFO: world_state Stopped world state synchronizer 20:36:24 [20:36:24.691] INFO: world_state Created world state synchroniser with block history of infinity 20:36:24 [20:36:24.811] INFO: world_state Started world state synchronizer from block 1 20:36:25 [20:36:25.051] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4486160000005839,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.053] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2103180000003704,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.055] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1670569999996587,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.057] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4948370000001887,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.058] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2365189999991344,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.059] INFO: world_state Stopped world state synchronizer 20:36:25 [20:36:25.061] INFO: world_state Created world state synchroniser with block history of infinity 20:36:25 [20:36:25.061] INFO: world_state Started world state synchronizer from block 1 20:36:25 [20:36:25.062] INFO: world_state Stopped world state synchronizer 20:36:25 [20:36:25.063] INFO: world_state Created world state synchroniser with block history of infinity 20:36:25 [20:36:25.063] INFO: world_state Started world state synchronizer from block 1 20:36:25 [20:36:25.063] INFO: world_state Stopped world state synchronizer 20:36:25 [20:36:25.077] INFO: world_state Stopped world state synchronizer 20:36:25 [20:36:25.078] INFO: world_state Created world state synchroniser with block history of infinity 20:36:25 [20:36:25.232] INFO: world_state Started world state synchronizer from block 1 20:36:25 [20:36:25.567] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4602370000002338,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.570] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3571529999999257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.571] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.267809999999372,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.573] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2298289999998815,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.575] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.225228999999672,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.792] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.447345999999925,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.794] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2353489999995872,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:25 [20:36:25.796] INFO: world_state Stopped world state synchronizer 20:36:25 [20:36:25.797] INFO: world_state Created world state synchroniser with block history of infinity 20:36:26 [20:36:26.024] INFO: world_state Started world state synchronizer from block 1 20:36:26 [20:36:26.301] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9928319999999076,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.303] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7996160000002419,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.304] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8327559999997902,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.310] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.9694020000006276,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.312] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.357252000000699,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.586] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0065519999998287,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.587] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0166920000001483,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.589] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.4871170000005804,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:26 [20:36:26.591] INFO: world_state Stopped world state synchronizer 20:36:26 [20:36:26.592] INFO: world_state Created world state synchroniser with block history of infinity 20:36:26 [20:36:26.787] INFO: world_state Started world state synchronizer from block 1 20:36:27 [20:36:27.109] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.3264479999998,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.113] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.098265999999967,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.117] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.4752779999998893,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.120] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.0819659999997384,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.123] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0636739999999918,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.125] INFO: world_state Stopped world state synchronizer 20:36:27 [20:36:27.127] INFO: world_state Created world state synchroniser with block history of infinity 20:36:27 [20:36:27.255] INFO: world_state Started world state synchronizer from block 1 20:36:27 [20:36:27.560] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.323583000000326,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.562] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0654530000001614,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.563] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0307620000003226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.565] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.9496189999999842,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.566] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3436919999994643,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 20:36:27 [20:36:27.569] INFO: world_state Stopped world state synchronizer 20:36:27 [20:36:27.570] INFO: world_state Created world state synchroniser with block history of infinity 20:36:27 [20:36:27.573] INFO: world_state Stopped world state synchronizer 20:36:27 [20:36:27.575] INFO: world_state Created world state synchroniser with block history of infinity 20:36:27 [20:36:27.777] INFO: world_state Started world state synchronizer from block 1 20:36:28 [20:36:28.086] INFO: world_state Stopped world state synchronizer 20:36:28 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.259 s) 20:36:28 ServerWorldStateSynchronizer 20:36:28 ✓ updates sync progress (727 ms) 20:36:28 ✓ handles multiple calls to start (369 ms) 20:36:28 ✓ immediately syncs if no new blocks (2 ms) 20:36:28 ✓ cannot be started if already stopped (15 ms) 20:36:28 ✓ can immediately sync to latest (719 ms) 20:36:28 ✓ can immediately sync to a minimum block number (794 ms) 20:36:28 ✓ sync returns immediately if block was already synced (534 ms) 20:36:28 ✓ throws if you try to sync to an unavailable block (443 ms) 20:36:28 ✓ throws if you try to immediate sync when not running (4 ms) 20:36:28 ✓ throws if handling blocks fails (512 ms) 20:36:28 20:36:28 Test Suites: 1 passed, 1 total 20:36:28 Tests: 10 passed, 10 total 20:36:28 Snapshots: 0 total 20:36:28 Time: 6.349 s 20:36:28 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 20:36:28 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?