2 * Copyright (c) 2017 Colin Percival
5 * Redistribution and use in source and binary forms, with or without
6 * modification, are permitted provided that the following conditions
8 * 1. Redistributions of source code must retain the above copyright
9 * notice, this list of conditions and the following disclaimer.
10 * 2. Redistributions in binary form must reproduce the above copyright
11 * notice, this list of conditions and the following disclaimer in the
12 * documentation and/or other materials provided with the distribution.
14 * THIS SOFTWARE IS PROVIDED BY THE AUTHOR AND CONTRIBUTORS ``AS IS'' AND
15 * ANY EXPRESS OR IMPLIED WARRANTIES, INCLUDING, BUT NOT LIMITED TO, THE
16 * IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS FOR A PARTICULAR PURPOSE
17 * ARE DISCLAIMED. IN NO EVENT SHALL THE AUTHOR OR CONTRIBUTORS BE LIABLE
18 * FOR ANY DIRECT, INDIRECT, INCIDENTAL, SPECIAL, EXEMPLARY, OR CONSEQUENTIAL
19 * DAMAGES (INCLUDING, BUT NOT LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS
20 * OR SERVICES; LOSS OF USE, DATA, OR PROFITS; OR BUSINESS INTERRUPTION)
21 * HOWEVER CAUSED AND ON ANY THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT
22 * LIABILITY, OR TORT (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY
23 * OUT OF THE USE OF THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF
27 #include <sys/cdefs.h>
28 __FBSDID("$FreeBSD$");
30 #include <sys/param.h>
32 #include <sys/sysctl.h>
33 #include <sys/systm.h>
34 #include <sys/tslog.h>
36 #include <machine/atomic.h>
37 #include <machine/cpu.h>
40 #define TSLOGSIZE 262144
43 static volatile long nrecs = 0;
44 static struct timestamp {
50 } timestamps[TSLOGSIZE];
53 tslog(void * td, int type, const char * f, const char * s)
55 uint64_t tsc = get_cyclecount();
59 pos = atomic_fetchadd_long(&nrecs, 1);
62 if (pos < nitems(timestamps)) {
63 timestamps[pos].td = td;
64 timestamps[pos].type = type;
65 timestamps[pos].f = f;
66 timestamps[pos].s = s;
67 timestamps[pos].tsc = tsc;
72 sysctl_debug_tslog(SYSCTL_HANDLER_ARGS)
79 * This code can race against the code in tslog() which stores
80 * records: Theoretically we could end up reading a record after
81 * its slots have been reserved but before it has been written.
82 * Since this code takes orders of magnitude longer to run than
83 * tslog() takes to write a record, it is highly unlikely that
84 * anyone will ever experience this race.
86 sb = sbuf_new_for_sysctl(NULL, NULL, 1024, req);
87 limit = MIN(nrecs, nitems(timestamps));
88 for (i = 0; i < limit; i++) {
89 sbuf_printf(sb, "%p", timestamps[i].td);
90 sbuf_printf(sb, " %llu",
91 (unsigned long long)timestamps[i].tsc);
92 switch (timestamps[i].type) {
94 sbuf_printf(sb, " ENTER");
97 sbuf_printf(sb, " EXIT");
100 sbuf_printf(sb, " THREAD");
103 sbuf_printf(sb, " EVENT");
106 sbuf_printf(sb, " %s", timestamps[i].f ? timestamps[i].f : "(null)");
108 sbuf_printf(sb, " %s\n", timestamps[i].s);
110 sbuf_printf(sb, "\n");
112 error = sbuf_finish(sb);
117 SYSCTL_PROC(_debug, OID_AUTO, tslog, CTLTYPE_STRING|CTLFLAG_RD|CTLFLAG_MPSAFE,
118 0, 0, sysctl_debug_tslog, "", "Dump recorded event timestamps");