perf record: Fix wrong size in perf_record_mmap for last kernel module
authorThomas Richter <tmricht@linux.vnet.ibm.com>
Thu, 3 Aug 2017 13:49:02 +0000 (15:49 +0200)
committerArnaldo Carvalho de Melo <acme@redhat.com>
Fri, 11 Aug 2017 19:06:32 +0000 (16:06 -0300)
During work on perf report for s390 I ran into the following issue:

0 0x318 [0x78]: PERF_RECORD_MMAP -1/0:
        [0x3ff804d6990(0xfffffc007fb2966f) @ 0]:
        x /lib/modules/4.12.0perf1+/kernel/drivers/s390/net/qeth_l2.ko

This is a PERF_RECORD_MMAP entry of the perf.data file with an invalid
module size for qeth_l2.ko (the s390 ethernet device driver).

Even a mainframe does not have 0xfffffc007fb2966f bytes of main memory.

It turned out that this wrong size is created by the perf record
command.  What happens is this function call sequence from
__cmd_record():

  perf_session__new():
    perf_session__create_kernel_maps():
      machine__create_kernel_maps():
        machine__create_modules():   Creates map for all loaded kernel modules.
          modules__parse():   Reads /proc/modules and extracts module name and
                              load address (1st and last column)
            machine__create_module():   Called for every module found in /proc/modules.
                              Creates a new map for every module found and enters
                              module name and start address into the map. Since the
                              module end address is unknown it is set to zero.

This ends up with a kernel module map list sorted by module start
addresses.  All module end addresses are zero.

Last machine__create_kernel_maps() calls function map_groups__fixup_end().
This function iterates through the maps and assigns each map entry's
end address the successor map entry start address. The last entry of the
map group has no successor, so ~0 is used as end to consume the remaining
memory.

Later __cmd_record calls function record__synthesize() which in turn calls
perf_event__synthesize_kernel_mmap() and perf_event__synthesize_modules()
to create PERF_REPORT_MMAP entries into the perf.data file.

On s390 this results in the last module qeth_l2.ko
(which has highest start address, see module table:
        [root@s8360047 perf]# cat /proc/modules
        qeth_l2 86016 1 - Live 0x000003ff804d6000
        qeth 266240 1 qeth_l2, Live 0x000003ff80296000
        ccwgroup 24576 1 qeth, Live 0x000003ff80218000
        vmur 36864 0 - Live 0x000003ff80182000
        qdio 143360 2 qeth_l2,qeth, Live 0x000003ff80002000
        [root@s8360047 perf]# )
to be the last entry and its map has an end address of ~0.

When the PERF_RECORD_MMAP entry is created for kernel module qeth_l2.ko
its start address and length is written. The length is calculated in line:
    event->mmap.len   = pos->end - pos->start;
and results in 0xffffffffffffffff - 0x3ff804d6990(*) = 0xfffffc007fb2966f

(*) On s390 the module start address is actually determined by a __weak function
named arch__fix_module_text_start() in machine__create_module().

I think this improvable. We can use the module size (2nd column of /proc/modules)
to get each loaded kernel module size and calculate its end address.
Only for map entries which do not have a valid end address (end is still zero)
we can use the heuristic we have now, that is use successor start address or ~0.

Signed-off-by: Thomas-Mich Richter <tmricht@linux.vnet.ibm.com>
Reviewed-by: Arnaldo Carvalho de Melo <acme@redhat.com>
Cc: Hendrik Brueckner <brueckner@linux.vnet.ibm.com>
Cc: Thomas-Mich Richter <tmricht@linux.vnet.ibm.com>
Cc: Zvonko Kosic <zvonko.kosic@de.ibm.com>
LPU-Reference: 20170803134902.47207-2-tmricht@linux.vnet.ibm.com
Link: http://lkml.kernel.org/n/tip-nmoqij5b5vxx7rq2ckwu8iaj@git.kernel.org
Signed-off-by: Arnaldo Carvalho de Melo <acme@redhat.com>
tools/perf/util/machine.c
tools/perf/util/symbol-elf.c
tools/perf/util/symbol.c
tools/perf/util/symbol.h

index d4df353051af81a8a4d570162984b6f36a5bcb68..5c8eacaca4f4f3bce32db13ee2f86cf55a90634a 100644 (file)
@@ -1138,7 +1138,8 @@ int __weak arch__fix_module_text_start(u64 *start __maybe_unused,
        return 0;
 }
 
-static int machine__create_module(void *arg, const char *name, u64 start)
+static int machine__create_module(void *arg, const char *name, u64 start,
+                                 u64 size)
 {
        struct machine *machine = arg;
        struct map *map;
@@ -1149,6 +1150,7 @@ static int machine__create_module(void *arg, const char *name, u64 start)
        map = machine__findnew_module_map(machine, start, name);
        if (map == NULL)
                return -1;
+       map->end = start + size;
 
        dso__kernel_module_get_build_id(map->dso, machine->root_dir);
 
index 7cf18f14e1528e86b8a25eefd9848606c770065d..98deabb9b47e5e98fc789157b0287220fbdb4f77 100644 (file)
@@ -1442,7 +1442,7 @@ static int kcore_copy__parse_kallsyms(struct kcore_copy_info *kci,
 
 static int kcore_copy__process_modules(void *arg,
                                       const char *name __maybe_unused,
-                                      u64 start)
+                                      u64 start, u64 size __maybe_unused)
 {
        struct kcore_copy_info *kci = arg;
 
index 971b990557b4565bbf83cc4ad4a7b4366005dcef..5909ee4c7ade439c4f060724fad05927d2eff34d 100644 (file)
@@ -233,7 +233,8 @@ void __map_groups__fixup_end(struct map_groups *mg, enum map_type type)
                goto out_unlock;
 
        for (next = map__next(curr); next; next = map__next(curr)) {
-               curr->end = next->start;
+               if (!curr->end)
+                       curr->end = next->start;
                curr = next;
        }
 
@@ -241,7 +242,8 @@ void __map_groups__fixup_end(struct map_groups *mg, enum map_type type)
         * We still haven't the actual symbols, so guess the
         * last map final address.
         */
-       curr->end = ~0ULL;
+       if (!curr->end)
+               curr->end = ~0ULL;
 
 out_unlock:
        pthread_rwlock_unlock(&maps->lock);
@@ -552,7 +554,7 @@ void dso__sort_by_name(struct dso *dso, enum map_type type)
 
 int modules__parse(const char *filename, void *arg,
                   int (*process_module)(void *arg, const char *name,
-                                        u64 start))
+                                        u64 start, u64 size))
 {
        char *line = NULL;
        size_t n;
@@ -565,8 +567,8 @@ int modules__parse(const char *filename, void *arg,
 
        while (1) {
                char name[PATH_MAX];
-               u64 start;
-               char *sep;
+               u64 start, size;
+               char *sep, *endptr;
                ssize_t line_len;
 
                line_len = getline(&line, &n, file);
@@ -598,7 +600,11 @@ int modules__parse(const char *filename, void *arg,
 
                scnprintf(name, sizeof(name), "[%s]", line);
 
-               err = process_module(arg, name, start);
+               size = strtoul(sep + 1, &endptr, 0);
+               if (*endptr != ' ' && *endptr != '\t')
+                       continue;
+
+               err = process_module(arg, name, start, size);
                if (err)
                        break;
        }
@@ -945,7 +951,8 @@ static struct module_info *find_module(const char *name,
        return NULL;
 }
 
-static int __read_proc_modules(void *arg, const char *name, u64 start)
+static int __read_proc_modules(void *arg, const char *name, u64 start,
+                              u64 size __maybe_unused)
 {
        struct rb_root *modules = arg;
        struct module_info *mi;
index f0b08810d7fa0d43000e4edfef3823a0bc4718df..b221671070e2a31ee5ee4aec67711bbc49ba77b5 100644 (file)
@@ -273,7 +273,7 @@ int filename__read_build_id(const char *filename, void *bf, size_t size);
 int sysfs__read_build_id(const char *filename, void *bf, size_t size);
 int modules__parse(const char *filename, void *arg,
                   int (*process_module)(void *arg, const char *name,
-                                        u64 start));
+                                        u64 start, u64 size));
 int filename__read_debuglink(const char *filename, char *debuglink,
                             size_t size);