Parent Log: http://ci.aztec-labs.com/d9cbe39da05505e1 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/c0e766a133071c44b2c0d8fac5df352c6e059df1 Env: REF_NAME=gh-readonly-queue/next/pr-15015-cf8be0f9e81e248048560619de041e90d9d6990a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 07:56:33 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15015_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 07:56:36 [07:56:36.830] INFO: world_state Created world state synchroniser with block history of infinity 07:56:36 [07:56:36.959] INFO: world_state Started world state synchronizer from block 1 07:56:37 [07:56:37.345] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.05219599999964,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.350] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.5566619999999602,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.352] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3862219999996341,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.526] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5233319999997548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.528] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2106189999999515,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.529] INFO: world_state Stopped world state synchronizer 07:56:37 [07:56:37.530] INFO: world_state Stopped world state synchronizer 07:56:37 [07:56:37.532] INFO: world_state Created world state synchroniser with block history of infinity 07:56:37 [07:56:37.649] INFO: world_state Started world state synchronizer from block 1 07:56:37 [07:56:37.917] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0163050000001022,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.919] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5050010000004477,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.921] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.9122170000000551,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.922] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0290159999995012,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.925] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4661880000003293,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:37 [07:56:37.926] INFO: world_state Stopped world state synchronizer 07:56:37 [07:56:37.927] INFO: world_state Created world state synchroniser with block history of infinity 07:56:37 [07:56:37.928] INFO: world_state Started world state synchronizer from block 1 07:56:37 [07:56:37.928] INFO: world_state Stopped world state synchronizer 07:56:37 [07:56:37.929] INFO: world_state Created world state synchroniser with block history of infinity 07:56:37 [07:56:37.929] INFO: world_state Started world state synchronizer from block 1 07:56:37 [07:56:37.929] INFO: world_state Stopped world state synchronizer 07:56:37 [07:56:37.943] INFO: world_state Stopped world state synchronizer 07:56:37 [07:56:37.945] INFO: world_state Created world state synchroniser with block history of infinity 07:56:38 [07:56:38.098] INFO: world_state Started world state synchronizer from block 1 07:56:38 [07:56:38.393] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.3816820000001826,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.395] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2034779999994498,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.396] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0755890000000363,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.398] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0522769999997763,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.399] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0817489999999452,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.558] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.1883770000004006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.560] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":0.9795819999999367,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:38 [07:56:38.561] INFO: world_state Stopped world state synchronizer 07:56:38 [07:56:38.563] INFO: world_state Created world state synchroniser with block history of infinity 07:56:38 [07:56:38.715] INFO: world_state Started world state synchronizer from block 1 07:56:39 [07:56:39.031] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1987680000002001,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.033] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1556049999999232,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.035] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1707659999992757,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.037] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0138139999999112,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.038] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9865820000004533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.397] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":2.10560600000008,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.400] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1181929999993372,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.402] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.896497000000636,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.404] INFO: world_state Stopped world state synchronizer 07:56:39 [07:56:39.408] INFO: world_state Created world state synchroniser with block history of infinity 07:56:39 [07:56:39.566] INFO: world_state Started world state synchronizer from block 1 07:56:39 [07:56:39.834] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9091179999995802,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.836] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7172529999998005,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.837] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.6376870000003692,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.837] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.6896409999999378,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.838] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.6480179999998654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:39 [07:56:39.840] INFO: world_state Stopped world state synchronizer 07:56:39 [07:56:39.842] INFO: world_state Created world state synchroniser with block history of infinity 07:56:40 [07:56:40.028] INFO: world_state Started world state synchronizer from block 1 07:56:40 [07:56:40.327] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1639859999995679,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:40 [07:56:40.329] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.8804149999996298,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:40 [07:56:40.330] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8075589999998556,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:40 [07:56:40.331] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7849580000001879,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:40 [07:56:40.332] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8745739999994839,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 07:56:40 [07:56:40.334] INFO: world_state Stopped world state synchronizer 07:56:40 [07:56:40.335] INFO: world_state Created world state synchroniser with block history of infinity 07:56:40 [07:56:40.338] INFO: world_state Stopped world state synchronizer 07:56:40 [07:56:40.339] INFO: world_state Created world state synchroniser with block history of infinity 07:56:40 [07:56:40.499] INFO: world_state Started world state synchronizer from block 1 07:56:40 [07:56:40.814] INFO: world_state Stopped world state synchronizer 07:56:40 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.113 s) 07:56:40 ServerWorldStateSynchronizer 07:56:40 ✓ updates sync progress (704 ms) 07:56:40 ✓ handles multiple calls to start (394 ms) 07:56:40 ✓ immediately syncs if no new blocks (2 ms) 07:56:40 ✓ cannot be started if already stopped (16 ms) 07:56:40 ✓ can immediately sync to latest (618 ms) 07:56:40 ✓ can immediately sync to a minimum block number (843 ms) 07:56:40 ✓ sync returns immediately if block was already synced (434 ms) 07:56:40 ✓ throws if you try to sync to an unavailable block (493 ms) 07:56:40 ✓ throws if you try to immediate sync when not running (3 ms) 07:56:40 ✓ throws if handling blocks fails (477 ms) 07:56:40 07:56:40 Test Suites: 1 passed, 1 total 07:56:40 Tests: 10 passed, 10 total 07:56:40 Snapshots: 0 total 07:56:40 Time: 6.2 s 07:56:40 Ran all test suites matching /world-state\/src\/synchronizer\/server_world_state_synchronizer.test.ts/i. 07:56:40 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?