Parent Log: http://ci.aztec-labs.com/fcec035fcb93a883 Command: bdef8c432fe28910 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/a9f91dd1e5946aecfeb192ce869eb3e8eca2742e Env: REF_NAME=gh-readonly-queue/next/pr-15099-a48851a8c6884f4b9615a154f8862a549722d25e CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 12:34:31 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15099_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 12:34:35 [12:34:35.933] INFO: world_state Created world state synchroniser with block history of infinity 12:34:36 [12:34:36.150] INFO: world_state Started world state synchronizer from block 1 12:34:36 [12:34:36.650] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.015997000000425,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:36 [12:34:36.654] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.5684790000004796,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:36 [12:34:36.657] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.001655000000028,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:36 [12:34:36.909] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.654645999999957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:36 [12:34:36.912] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.2034810000004654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:36 [12:34:36.915] INFO: world_state Stopped world state synchronizer 12:34:36 [12:34:36.917] INFO: world_state Stopped world state synchronizer 12:34:36 [12:34:36.921] INFO: world_state Created world state synchroniser with block history of infinity 12:34:37 [12:34:37.092] INFO: world_state Started world state synchronizer from block 1 12:34:37 [12:34:37.415] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5666119999996226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.418] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3899280000005092,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.421] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.0608799999999974,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.424] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.0701010000002498,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.426] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6681600000001708,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.428] INFO: world_state Stopped world state synchronizer 12:34:37 [12:34:37.430] INFO: world_state Created world state synchroniser with block history of infinity 12:34:37 [12:34:37.431] INFO: world_state Started world state synchronizer from block 1 12:34:37 [12:34:37.432] INFO: world_state Stopped world state synchronizer 12:34:37 [12:34:37.433] INFO: world_state Created world state synchroniser with block history of infinity 12:34:37 [12:34:37.434] INFO: world_state Started world state synchronizer from block 1 12:34:37 [12:34:37.434] INFO: world_state Stopped world state synchronizer 12:34:37 [12:34:37.448] INFO: world_state Stopped world state synchronizer 12:34:37 [12:34:37.449] INFO: world_state Created world state synchroniser with block history of infinity 12:34:37 [12:34:37.637] INFO: world_state Started world state synchronizer from block 1 12:34:37 [12:34:37.961] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6449670000001788,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.964] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4108189999997194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.965] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3290430000006381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.967] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2178850000000239,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:37 [12:34:37.969] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.182252000000517,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.183] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.6327069999997548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.185] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.339694000000236,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.187] INFO: world_state Stopped world state synchronizer 12:34:38 [12:34:38.190] INFO: world_state Created world state synchroniser with block history of infinity 12:34:38 [12:34:38.369] INFO: world_state Started world state synchronizer from block 1 12:34:38 [12:34:38.664] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9624750000002678,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.666] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9661459999997533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.667] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7638790000000881,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.668] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7137359999996988,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.669] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7387779999999111,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.922] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":0.9838369999997667,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.923] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.8004220000002533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.925] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.047182000000248,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:38 [12:34:38.926] INFO: world_state Stopped world state synchronizer 12:34:38 [12:34:38.927] INFO: world_state Created world state synchroniser with block history of infinity 12:34:39 [12:34:39.076] INFO: world_state Started world state synchronizer from block 1 12:34:39 [12:34:39.363] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.41696999999931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.365] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.112767000000531,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.367] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9856669999999212,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.368] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0839740000001257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.370] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0378710000004503,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.372] INFO: world_state Stopped world state synchronizer 12:34:39 [12:34:39.374] INFO: world_state Created world state synchroniser with block history of infinity 12:34:39 [12:34:39.530] INFO: world_state Started world state synchronizer from block 1 12:34:39 [12:34:39.801] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3899989999999889,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.803] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7628089999998338,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.804] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7416869999997289,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.805] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7126450000005207,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.806] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.7358070000000225,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 12:34:39 [12:34:39.822] INFO: world_state Stopped world state synchronizer 12:34:39 [12:34:39.824] INFO: world_state Created world state synchroniser with block history of infinity 12:34:39 [12:34:39.826] INFO: world_state Stopped world state synchronizer 12:34:39 [12:34:39.828] INFO: world_state Created world state synchroniser with block history of infinity 12:34:39 [12:34:39.980] INFO: world_state Started world state synchronizer from block 1 12:34:40 [12:34:40.252] INFO: world_state Stopped world state synchronizer 12:34:40 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.16 s) 12:34:40 ServerWorldStateSynchronizer 12:34:40 updates sync progress (990 ms) 12:34:40 handles multiple calls to start (509 ms) 12:34:40 immediately syncs if no new blocks (3 ms) 12:34:40 cannot be started if already stopped (15 ms) 12:34:40 can immediately sync to latest (738 ms) 12:34:40 can immediately sync to a minimum block number (737 ms) 12:34:40 sync returns immediately if block was already synced (446 ms) 12:34:40 throws if you try to sync to an unavailable block (449 ms) 12:34:40 throws if you try to immediate sync when not running (4 ms) 12:34:40 throws if handling blocks fails (425 ms) 12:34:40 12:34:40 Test Suites: 1 passed, 1 total 12:34:40 Tests: 10 passed, 10 total 12:34:40 Snapshots: 0 total 12:34:40 Time: 7.29 s 12:34:40 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 12:34:40 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?