Parent Log:
http://ci.aztec-labs.com/29098e34bc98632e
Command: fb52012d377692f9 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/1e338a3fb2e2077f1feaee8b86c42644ff8a5352
Env: REF_NAME=gh-readonly-queue/next/pr-15075-fa4d5ef48c8de52059b5658bbd42e4514386f7db CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 16:42:51 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15075_amd64_x2-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next
16:42:55 [16:42:55.403]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:55 [16:42:55.541]
INFO:
world_state Started world state synchronizer from block 1
16:42:55 [16:42:55.968]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":5.16504199999963,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:55 [16:42:55.973]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.656753000000208,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:55 [16:42:55.975]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.46100000000024,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.235]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":3.6382199999998193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.237]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.533010999999533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.239]
INFO:
world_state Stopped world state synchronizer
16:42:56 [16:42:56.240]
INFO:
world_state Stopped world state synchronizer
16:42:56 [16:42:56.243]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:56 [16:42:56.415]
INFO:
world_state Started world state synchronizer from block 1
16:42:56 [16:42:56.719]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.3556990000006408,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.722]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.2593669999996564,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.723]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.1033149999993839,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.725]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.3936690000000453,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.727]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.133045999999922,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:56 [16:42:56.728]
INFO:
world_state Stopped world state synchronizer
16:42:56 [16:42:56.730]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:56 [16:42:56.730]
INFO:
world_state Started world state synchronizer from block 1
16:42:56 [16:42:56.731]
INFO:
world_state Stopped world state synchronizer
16:42:56 [16:42:56.732]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:56 [16:42:56.733]
INFO:
world_state Started world state synchronizer from block 1
16:42:56 [16:42:56.733]
INFO:
world_state Stopped world state synchronizer
16:42:56 [16:42:56.749]
INFO:
world_state Stopped world state synchronizer
16:42:56 [16:42:56.751]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:56 [16:42:56.953]
INFO:
world_state Started world state synchronizer from block 1
16:42:57 [16:42:57.310]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.5539110000008804,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.311]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.9847540000000663,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.313]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.919832999999926,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.314]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.9198220000007495,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.315]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.8973219999998037,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.516]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":1.0614040000000386,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.518]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":0.9649929999995948,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:57 [16:42:57.519]
INFO:
world_state Stopped world state synchronizer
16:42:57 [16:42:57.520]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:57 [16:42:57.723]
INFO:
world_state Started world state synchronizer from block 1
16:42:58 [16:42:58.052]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.5043009999999413,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.054]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.4991210000007413,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.057]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.712242999999944,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.059]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.5463110000000597,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.061]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.3455180000000837,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.388]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":4.952397999999448,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.391]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.8435559999998077,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.394]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":1.7572950000003402,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.397]
INFO:
world_state Stopped world state synchronizer
16:42:58 [16:42:58.399]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:58 [16:42:58.570]
INFO:
world_state Started world state synchronizer from block 1
16:42:58 [16:42:58.865]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.019894000000022,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.867]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.2504670000007536,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.869]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.3070779999998194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.872]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":2.819388999999319,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.875]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.5622919999996157,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:58 [16:42:58.877]
INFO:
world_state Stopped world state synchronizer
16:42:58 [16:42:58.878]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:59 [16:42:59.075]
INFO:
world_state Started world state synchronizer from block 1
16:42:59 [16:42:59.413]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.3024179999993066,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:59 [16:42:59.414]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.8961419999995996,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:59 [16:42:59.415]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.7711810000000696,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:59 [16:42:59.416]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.7320499999996173,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:59 [16:42:59.417]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.7378899999994246,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
16:42:59 [16:42:59.427]
INFO:
world_state Stopped world state synchronizer
16:42:59 [16:42:59.428]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:59 [16:42:59.431]
INFO:
world_state Stopped world state synchronizer
16:42:59 [16:42:59.432]
INFO:
world_state Created world state synchroniser with block history of infinity
16:42:59 [16:42:59.568]
INFO:
world_state Started world state synchronizer from block 1
16:42:59 [16:42:59.925]
INFO:
world_state Stopped world state synchronizer
16:42:59
PASS src/synchronizer/server_world_state_synchronizer.test.ts (
7.045 s)
16:42:59 ServerWorldStateSynchronizer
16:42:59
✓ updates sync progress (843 ms)
16:42:59
✓ handles multiple calls to start (487 ms)
16:42:59
✓ immediately syncs if no new blocks (3 ms)
16:42:59
✓ cannot be started if already stopped (18 ms)
16:42:59
✓ can immediately sync to latest (769 ms)
16:42:59
✓ can immediately sync to a minimum block number (877 ms)
16:42:59
✓ sync returns immediately if block was already synced (479 ms)
16:42:59
✓ throws if you try to sync to an unavailable block (549 ms)
16:42:59
✓ throws if you try to immediate sync when not running (4 ms)
16:42:59
✓ throws if handling blocks fails (494 ms)
16:42:59
16:42:59
Test Suites: 1 passed, 1 total
16:42:59
Tests: 10 passed, 10 total
16:42:59
Snapshots: 0 total
16:42:59
Time: 7.174 s
16:42:59
Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts
.
16:42:59
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?