perf: clear vfs audit_cache before each run When generating a stream clone, we spend a large amount of time auditing path. Before this changes, the first run was warming the vfs cache for the other runs, leading to a large runtime difference and a "faulty" reported timing for the operation. We now clear this important cache between run to get a more realistic timing. Below are some example of median time change when clearing these cases. The maximum time for a run did not changed significantly. ### data-env-vars.name = mozilla-central-2018-08-01-zstd-sparse-revlog # benchmark.name = hg.perf.exchange.stream.generate # bin-env-vars.hg.flavor = default # bin-env-vars.hg.py-re2-module = default # benchmark.variants.version = latest no-clearing: 17.289905 cache-clearing: 21.587965 (+24.86%, +4.30) ## data-env-vars.name = mozilla-central-2024-03-22-zstd-sparse-revlog no-clearing: 32.670748 cache-clearing: 40.467095 (+23.86%, +7.80) ## data-env-vars.name = mozilla-try-2019-02-18-zstd-sparse-revlog no-clearing: 37.838858 cache-clearing: 46.072749 (+21.76%, +8.23) ## data-env-vars.name = mozilla-unified-2024-03-22-zstd-sparse-revlog no-clearing: 32.969395 cache-clearing: 39.646209 (+20.25%, +6.68) In addition, this significantly reduce the timing difference between the performance command, from the perf extensions and a `real `hg bundle` call producing a stream bundle. Some significant differences remain especially on the "mozilla-try" repositories, but they are now smaller. Note that some of that difference will actually not be attributable to the stream generation (like maybe phases or branch map computation). Below are some benchmarks done on a currently draft changeset fixing some unrelated slowness in `hg bundle` (34a78972af409d1ff37c29e60f6ca811ad1a457d) ### data-env-vars.name = mozilla-central-2018-08-01-zstd-sparse-revlog # bin-env-vars.hg.flavor = default # bin-env-vars.hg.py-re2-module = default hg.perf.exchange.stream.generate: 21.587965 hg.command.bundle: 24.301799 (+12.57%, +2.71) ## data-env-vars.name = mozilla-central-2024-03-22-zstd-sparse-revlog hg.perf.exchange.stream.generate: 40.467095 hg.command.bundle: 44.831317 (+10.78%, +4.36) ## data-env-vars.name = mozilla-unified-2024-03-22-zstd-sparse-revlog hg.perf.exchange.stream.generate: 39.646209 hg.command.bundle: 45.395258 (+14.50%, +5.75) ## data-env-vars.name = mozilla-try-2019-02-18-zstd-sparse-revlog hg.perf.exchange.stream.generate: 46.072749 hg.command.bundle: 55.882608 (+21.29%, +9.81) ## data-env-vars.name = mozilla-try-2023-03-22-zlib-general-delta hg.perf.exchange.stream.generate: 334.716708 hg.command.bundle: 377.856767 (+12.89%, +43.14) ## data-env-vars.name = mozilla-try-2023-03-22-zstd-sparse-revlog hg.perf.exchange.stream.generate: 302.972301 hg.command.bundle: 326.098755 (+7.63%, +23.13)

     1

#!/usr/bin/env python3

     2

#

     3

# Dumps output generated by Mercurial's command server in a formatted style to a

     4

# given file or stderr if '-' is specified. Output is also written in its raw

     5

# format to stdout.

     6

#

     7

# $ ./hg serve --cmds pipe | ./contrib/debugcmdserver.py -

     8

# o, 52   -> 'capabilities: getencoding runcommand\nencoding: UTF-8'

     9

    10

import struct

    11

import sys

    12

    13

if len(sys.argv) != 2:

    14

    print('usage: debugcmdserver.py FILE')

    15

    sys.exit(1)

    16

    17

outputfmt = '>cI'

    18

outputfmtsize = struct.calcsize(outputfmt)

    19

    20

if sys.argv[1] == '-':

    21

    log = sys.stderr

    22

else:

    23

    log = open(sys.argv[1], 'a')

    24

    25

    26

def read(size):

    27

    data = sys.stdin.read(size)

    28

    if not data:

    29

        raise EOFError

    30

    sys.stdout.write(data)

    31

    sys.stdout.flush()

    32

    return data

    33

    34

    35

try:

    36

    while True:

    37

        header = read(outputfmtsize)

    38

        channel, length = struct.unpack(outputfmt, header)

    39

        log.write('%s, %-4d' % (channel, length))

    40

        if channel in 'IL':

    41

            log.write(' -> waiting for input\n')

    42

        else:

    43

            data = read(length)

    44

            log.write(' -> %r\n' % data)

    45

        log.flush()

    46

except EOFError:

    47

    pass

    48

finally:

    49

    if log != sys.stderr:

    50

        log.close()