blob: 9fd62335782d7f4570e0e2bf97eeb9b5e702ebcc [file] [log] [blame]
Denys Vlasenkoff027d62010-05-04 15:45:25 +02001/* vi: set sw=4 ts=4: */
2/*
Denys Vlasenko0ef64bd2010-08-16 20:14:46 +02003 * Licensed under GPLv2 or later, see file LICENSE in this source tree.
Denys Vlasenkoff027d62010-05-04 15:45:25 +02004 */
Denys Vlasenkoadbbee42010-06-21 07:17:23 +02005
Denys Vlasenkob9f2d9f2011-01-18 13:58:01 +01006//applet:IF_BOOTCHARTD(APPLET(bootchartd, BB_DIR_SBIN, BB_SUID_DROP))
Denys Vlasenkob1db09b2010-10-12 13:47:15 +02007
8//kbuild:lib-$(CONFIG_BOOTCHARTD) += bootchartd.o
9
Denys Vlasenkoadbbee42010-06-21 07:17:23 +020010//config:config BOOTCHARTD
11//config: bool "bootchartd"
12//config: default y
13//config: help
14//config: bootchartd is commonly used to profile the boot process
15//config: for the purpose of speeding it up. In this case, it is started
16//config: by the kernel as the init process. This is configured by adding
17//config: the init=/sbin/bootchartd option to the kernel command line.
18//config:
19//config: It can also be used to monitor the resource usage of a specific
20//config: application or the running system in general. In this case,
21//config: bootchartd is started interactively by running bootchartd start
22//config: and stopped using bootchartd stop.
23//config:
24//config:config FEATURE_BOOTCHARTD_BLOATED_HEADER
Denys Vlasenko7a2aa872010-07-06 15:49:01 +020025//config: bool "Compatible, bloated header"
Denys Vlasenkoadbbee42010-06-21 07:17:23 +020026//config: default y
27//config: depends on BOOTCHARTD
28//config: help
29//config: Create extended header file compatible with "big" bootchartd.
30//config: "Big" bootchartd is a shell script and it dumps some
31//config: "convenient" info int the header, such as:
32//config: title = Boot chart for `hostname` (`date`)
33//config: system.uname = `uname -srvm`
34//config: system.release = `cat /etc/DISTRO-release`
35//config: system.cpu = `grep '^model name' /proc/cpuinfo | head -1` ($cpucount)
36//config: system.kernel.options = `cat /proc/cmdline`
37//config: This data is not mandatory for bootchart graph generation,
38//config: and is considered bloat. Nevertheless, this option
39//config: makes bootchartd applet to dump a subset of it.
40//config:
41//config:config FEATURE_BOOTCHARTD_CONFIG_FILE
Denys Vlasenko7a2aa872010-07-06 15:49:01 +020042//config: bool "Support bootchartd.conf"
Denys Vlasenkoadbbee42010-06-21 07:17:23 +020043//config: default y
44//config: depends on BOOTCHARTD
45//config: help
Denys Vlasenko6d9c88a2010-06-21 07:25:36 +020046//config: Enable reading and parsing of $PWD/bootchartd.conf
47//config: and /etc/bootchartd.conf files.
Denys Vlasenkoadbbee42010-06-21 07:17:23 +020048
Denys Vlasenkoff027d62010-05-04 15:45:25 +020049#include "libbb.h"
Denys Vlasenkoadbbee42010-06-21 07:17:23 +020050/* After libbb.h, since it needs sys/types.h on some systems */
51#include <sys/utsname.h>
Jeremie Koenige7a06322010-07-29 04:29:53 +020052
53#ifdef __linux__
54# include <sys/mount.h>
55# ifndef MS_SILENT
56# define MS_SILENT (1 << 15)
57# endif
58# ifndef MNT_DETACH
59# define MNT_DETACH 0x00000002
60# endif
Denys Vlasenkoff027d62010-05-04 15:45:25 +020061#endif
62
63#define BC_VERSION_STR "0.8"
64
65/* For debugging, set to 0:
66 * strace won't work with DO_SIGNAL_SYNC set to 1.
67 */
68#define DO_SIGNAL_SYNC 1
69
70
Denys Vlasenkoadbbee42010-06-21 07:17:23 +020071//$PWD/bootchartd.conf and /etc/bootchartd.conf:
72//supported options:
73//# Sampling period (in seconds)
74//SAMPLE_PERIOD=0.2
75//
76//not yet supported:
Denys Vlasenkoff027d62010-05-04 15:45:25 +020077//# tmpfs size
78//# (32 MB should suffice for ~20 minutes worth of log data, but YMMV)
79//TMPFS_SIZE=32m
80//
Denys Vlasenkoff027d62010-05-04 15:45:25 +020081//# Whether to enable and store BSD process accounting information. The
82//# kernel needs to be configured to enable v3 accounting
83//# (CONFIG_BSD_PROCESS_ACCT_V3). accton from the GNU accounting utilities
84//# is also required.
85//PROCESS_ACCOUNTING="no"
86//
87//# Tarball for the various boot log files
88//BOOTLOG_DEST=/var/log/bootchart.tgz
89//
90//# Whether to automatically stop logging as the boot process completes.
91//# The logger will look for known processes that indicate bootup completion
92//# at a specific runlevel (e.g. gdm-binary, mingetty, etc.).
93//AUTO_STOP_LOGGER="yes"
94//
95//# Whether to automatically generate the boot chart once the boot logger
96//# completes. The boot chart will be generated in $AUTO_RENDER_DIR.
97//# Note that the bootchart package must be installed.
98//AUTO_RENDER="no"
99//
100//# Image format to use for the auto-generated boot chart
101//# (choose between png, svg and eps).
102//AUTO_RENDER_FORMAT="png"
103//
104//# Output directory for auto-generated boot charts
105//AUTO_RENDER_DIR="/var/log"
106
107
108/* Globals */
109struct globals {
Denys Vlasenko82dd14a2010-05-17 10:10:01 +0200110 char jiffy_line[COMMON_BUFSIZE];
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200111} FIX_ALIASING;
112#define G (*(struct globals*)&bb_common_bufsiz1)
113#define INIT_G() do { } while (0)
114
115static void dump_file(FILE *fp, const char *filename)
116{
117 int fd = open(filename, O_RDONLY);
118 if (fd >= 0) {
119 fputs(G.jiffy_line, fp);
120 fflush(fp);
121 bb_copyfd_eof(fd, fileno(fp));
122 close(fd);
123 fputc('\n', fp);
124 }
125}
126
127static int dump_procs(FILE *fp, int look_for_login_process)
128{
129 struct dirent *entry;
130 DIR *dir = opendir("/proc");
131 int found_login_process = 0;
132
133 fputs(G.jiffy_line, fp);
134 while ((entry = readdir(dir)) != NULL) {
135 char name[sizeof("/proc/%u/cmdline") + sizeof(int)*3];
136 int stat_fd;
137 unsigned pid = bb_strtou(entry->d_name, NULL, 10);
138 if (errno)
139 continue;
140
141 /* Android's version reads /proc/PID/cmdline and extracts
142 * non-truncated process name. Do we want to do that? */
143
144 sprintf(name, "/proc/%u/stat", pid);
145 stat_fd = open(name, O_RDONLY);
146 if (stat_fd >= 0) {
147 char *p;
148 char stat_line[4*1024];
149 int rd = safe_read(stat_fd, stat_line, sizeof(stat_line)-2);
150
151 close(stat_fd);
152 if (rd < 0)
153 continue;
154 stat_line[rd] = '\0';
155 p = strchrnul(stat_line, '\n');
156 *p++ = '\n';
157 *p = '\0';
158 fputs(stat_line, fp);
159 if (!look_for_login_process)
160 continue;
161 p = strchr(stat_line, '(');
162 if (!p)
163 continue;
164 p++;
165 strchrnul(p, ')')[0] = '\0';
Pascal Bellardff377992010-06-28 15:50:22 +0200166 /* Is it gdm, kdm or a getty? */
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200167 if (((p[0] == 'g' || p[0] == 'k' || p[0] == 'x') && p[1] == 'd' && p[2] == 'm')
168 || strstr(p, "getty")
169 ) {
170 found_login_process = 1;
171 }
172 }
173 }
174 closedir(dir);
175 fputc('\n', fp);
176 return found_login_process;
177}
178
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200179static char *make_tempdir(void)
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200180{
181 char template[] = "/tmp/bootchart.XXXXXX";
182 char *tempdir = xstrdup(mkdtemp(template));
183 if (!tempdir) {
Jeremie Koenige7a06322010-07-29 04:29:53 +0200184#ifdef __linux__
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200185 /* /tmp is not writable (happens when we are used as init).
186 * Try to mount a tmpfs, them cd and lazily unmount it.
187 * Since we unmount it at once, we can mount it anywhere.
188 * Try a few locations which are likely ti exist.
189 */
190 static const char dirs[] = "/mnt\0""/tmp\0""/boot\0""/proc\0";
191 const char *try_dir = dirs;
192 while (mount("none", try_dir, "tmpfs", MS_SILENT, "size=16m") != 0) {
193 try_dir += strlen(try_dir) + 1;
194 if (!try_dir[0])
195 bb_perror_msg_and_die("can't %smount tmpfs", "");
196 }
197 //bb_error_msg("mounted tmpfs on %s", try_dir);
198 xchdir(try_dir);
199 if (umount2(try_dir, MNT_DETACH) != 0) {
200 bb_perror_msg_and_die("can't %smount tmpfs", "un");
201 }
Jeremie Koenige7a06322010-07-29 04:29:53 +0200202#else
203 bb_perror_msg_and_die("can't create temporary directory");
204#endif
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200205 } else {
206 xchdir(tempdir);
207 }
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200208 return tempdir;
209}
210
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100211static void do_logging(unsigned sample_period_us, int process_accounting)
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200212{
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200213 FILE *proc_stat = xfopen("proc_stat.log", "w");
214 FILE *proc_diskstats = xfopen("proc_diskstats.log", "w");
215 //FILE *proc_netdev = xfopen("proc_netdev.log", "w");
216 FILE *proc_ps = xfopen("proc_ps.log", "w");
217 int look_for_login_process = (getppid() == 1);
Keisuke Yasuic03fb3c2010-06-28 16:04:00 +0200218 unsigned count = 60*1000*1000 / sample_period_us; /* ~1 minute */
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200219
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100220 if (process_accounting) {
221 close(xopen("kernel_pacct", O_WRONLY | O_CREAT | O_TRUNC));
222 acct("kernel_pacct");
223 }
224
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200225 while (--count && !bb_got_signal) {
226 char *p;
227 int len = open_read_close("/proc/uptime", G.jiffy_line, sizeof(G.jiffy_line)-2);
228 if (len < 0)
229 goto wait_more;
230 /* /proc/uptime has format "NNNNNN.MM NNNNNNN.MM" */
231 /* we convert it to "NNNNNNMM\n" (using first value) */
232 G.jiffy_line[len] = '\0';
233 p = strchr(G.jiffy_line, '.');
234 if (!p)
235 goto wait_more;
236 while (isdigit(*++p))
237 p[-1] = *p;
238 p[-1] = '\n';
239 p[0] = '\0';
240
241 dump_file(proc_stat, "/proc/stat");
242 dump_file(proc_diskstats, "/proc/diskstats");
243 //dump_file(proc_netdev, "/proc/net/dev");
244 if (dump_procs(proc_ps, look_for_login_process)) {
245 /* dump_procs saw a getty or {g,k,x}dm
246 * stop logging in 2 seconds:
247 */
Keisuke Yasuic03fb3c2010-06-28 16:04:00 +0200248 if (count > 2*1000*1000 / sample_period_us)
249 count = 2*1000*1000 / sample_period_us;
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200250 }
251 fflush_all();
252 wait_more:
Denys Vlasenko64606c62010-06-22 18:33:15 +0200253 usleep(sample_period_us);
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200254 }
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200255}
256
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100257static void finalize(char *tempdir, const char *prog, int process_accounting)
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200258{
259 //# Stop process accounting if configured
260 //local pacct=
261 //[ -e kernel_pacct ] && pacct=kernel_pacct
262
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200263 FILE *header_fp = xfopen("header", "w");
264
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100265 if (process_accounting)
266 acct(NULL);
267
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200268 if (prog)
269 fprintf(header_fp, "profile.process = %s\n", prog);
270
271 fputs("version = "BC_VERSION_STR"\n", header_fp);
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200272 if (ENABLE_FEATURE_BOOTCHARTD_BLOATED_HEADER) {
273 char *hostname;
274 char *kcmdline;
275 time_t t;
276 struct tm tm_time;
Pascal Bellardff377992010-06-28 15:50:22 +0200277 /* x2 for possible localized weekday/month names */
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200278 char date_buf[sizeof("Mon Jun 21 05:29:03 CEST 2010") * 2];
279 struct utsname unamebuf;
280
281 hostname = safe_gethostname();
282 time(&t);
283 localtime_r(&t, &tm_time);
284 strftime(date_buf, sizeof(date_buf), "%a %b %e %H:%M:%S %Z %Y", &tm_time);
285 fprintf(header_fp, "title = Boot chart for %s (%s)\n", hostname, date_buf);
286 if (ENABLE_FEATURE_CLEAN_UP)
287 free(hostname);
288
289 uname(&unamebuf); /* never fails */
290 /* same as uname -srvm */
291 fprintf(header_fp, "system.uname = %s %s %s %s\n",
292 unamebuf.sysname,
293 unamebuf.release,
294 unamebuf.version,
295 unamebuf.machine
296 );
297
298 //system.release = `cat /etc/DISTRO-release`
299 //system.cpu = `grep '^model name' /proc/cpuinfo | head -1` ($cpucount)
300
301 kcmdline = xmalloc_open_read_close("/proc/cmdline", NULL);
302 /* kcmdline includes trailing "\n" */
303 fprintf(header_fp, "system.kernel.options = %s", kcmdline);
304 if (ENABLE_FEATURE_CLEAN_UP)
305 free(kcmdline);
306 }
307 fclose(header_fp);
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200308
309 /* Package log files */
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100310 system(xasprintf("tar -zcf /var/log/bootlog.tgz header %s *.log", process_accounting ? "kernel_pacct" : ""));
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200311 /* Clean up (if we are not in detached tmpfs) */
312 if (tempdir) {
313 unlink("header");
314 unlink("proc_stat.log");
315 unlink("proc_diskstats.log");
316 //unlink("proc_netdev.log");
317 unlink("proc_ps.log");
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100318 if (process_accounting)
319 unlink("kernel_pacct");
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200320 rmdir(tempdir);
321 }
322
323 /* shell-based bootchartd tries to run /usr/bin/bootchart if $AUTO_RENDER=yes:
324 * /usr/bin/bootchart -o "$AUTO_RENDER_DIR" -f $AUTO_RENDER_FORMAT "$BOOTLOG_DEST"
325 */
326}
327
Pascal Bellardff377992010-06-28 15:50:22 +0200328//usage:#define bootchartd_trivial_usage
329//usage: "start [PROG ARGS]|stop|init"
330//usage:#define bootchartd_full_usage "\n\n"
331//usage: "Create /var/log/bootchart.tgz with boot chart data\n"
Pascal Bellardff377992010-06-28 15:50:22 +0200332//usage: "\nstart: start background logging; with PROG, run PROG, then kill logging with USR1"
333//usage: "\nstop: send USR1 to all bootchartd processes"
334//usage: "\ninit: start background logging; stop when getty/xdm is seen (for init scripts)"
335//usage: "\nUnder PID 1: as init, then exec $bootchart_init, /init, /sbin/init"
336
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200337int bootchartd_main(int argc, char **argv) MAIN_EXTERNALLY_VISIBLE;
338int bootchartd_main(int argc UNUSED_PARAM, char **argv)
339{
Keisuke Yasuic03fb3c2010-06-28 16:04:00 +0200340 unsigned sample_period_us;
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200341 pid_t parent_pid, logger_pid;
342 smallint cmd;
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100343 int process_accounting;
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200344 enum {
345 CMD_STOP = 0,
346 CMD_START,
347 CMD_INIT,
348 CMD_PID1, /* used to mark pid 1 case */
349 };
350
351 INIT_G();
352
353 parent_pid = getpid();
354 if (argv[1]) {
355 cmd = index_in_strings("stop\0""start\0""init\0", argv[1]);
356 if (cmd < 0)
357 bb_show_usage();
358 if (cmd == CMD_STOP) {
359 pid_t *pidList = find_pid_by_name("bootchartd");
360 while (*pidList != 0) {
361 if (*pidList != parent_pid)
362 kill(*pidList, SIGUSR1);
363 pidList++;
364 }
365 return EXIT_SUCCESS;
366 }
367 } else {
368 if (parent_pid != 1)
369 bb_show_usage();
370 cmd = CMD_PID1;
371 }
372
Pascal Bellardff377992010-06-28 15:50:22 +0200373 /* Here we are in START, INIT or CMD_PID1 state */
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200374
375 /* Read config file: */
Denys Vlasenko64606c62010-06-22 18:33:15 +0200376 sample_period_us = 200 * 1000;
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100377 process_accounting = 0;
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200378 if (ENABLE_FEATURE_BOOTCHARTD_CONFIG_FILE) {
379 char* token[2];
380 parser_t *parser = config_open2("/etc/bootchartd.conf" + 5, fopen_for_read);
381 if (!parser)
382 parser = config_open2("/etc/bootchartd.conf", fopen_for_read);
383 while (config_read(parser, token, 2, 0, "#=", PARSE_NORMAL & ~PARSE_COLLAPSE)) {
384 if (strcmp(token[0], "SAMPLE_PERIOD") == 0 && token[1])
Denys Vlasenko64606c62010-06-22 18:33:15 +0200385 sample_period_us = atof(token[1]) * 1000000;
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100386 if (strcmp(token[0], "PROCESS_ACCOUNTING") == 0 && token[1]
387 && (strcmp(token[1], "on") == 0 || strcmp(token[1], "yes") == 0)
388 ) {
389 process_accounting = 1;
390 }
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200391 }
392 config_close(parser);
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100393 if ((int)sample_period_us <= 0)
394 sample_period_us = 1; /* prevent division by 0 */
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200395 }
396
397 /* Create logger child: */
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200398 logger_pid = fork_or_rexec(argv);
399
400 if (logger_pid == 0) { /* child */
401 char *tempdir;
402
403 bb_signals(0
404 + (1 << SIGUSR1)
405 + (1 << SIGUSR2)
406 + (1 << SIGTERM)
407 + (1 << SIGQUIT)
408 + (1 << SIGINT)
409 + (1 << SIGHUP)
410 , record_signo);
411
412 if (DO_SIGNAL_SYNC)
413 /* Inform parent that we are ready */
414 raise(SIGSTOP);
415
Denys Vlasenkob8ba6b62010-05-05 00:40:15 +0200416 /* If we are started by kernel, PATH might be unset.
417 * In order to find "tar", let's set some sane PATH:
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200418 */
419 if (cmd == CMD_PID1 && !getenv("PATH"))
420 putenv((char*)bb_PATH_root_path);
Denys Vlasenkob8ba6b62010-05-05 00:40:15 +0200421
Denys Vlasenkoadbbee42010-06-21 07:17:23 +0200422 tempdir = make_tempdir();
Quentin Casasnovasc1586012012-01-18 02:12:13 +0100423 do_logging(sample_period_us, process_accounting);
424 finalize(tempdir, cmd == CMD_START ? argv[2] : NULL, process_accounting);
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200425 return EXIT_SUCCESS;
426 }
427
428 /* parent */
429
Denys Vlasenkod2277e22011-11-22 17:19:26 +0100430 USE_FOR_NOMMU(argv[0][0] &= 0x7f); /* undo fork_or_rexec() damage */
431
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200432 if (DO_SIGNAL_SYNC) {
433 /* Wait for logger child to set handlers, then unpause it.
434 * Otherwise with short-lived PROG (e.g. "bootchartd start true")
435 * we might send SIGUSR1 before logger sets its handler.
436 */
437 waitpid(logger_pid, NULL, WUNTRACED);
438 kill(logger_pid, SIGCONT);
439 }
440
441 if (cmd == CMD_PID1) {
442 char *bootchart_init = getenv("bootchart_init");
443 if (bootchart_init)
444 execl(bootchart_init, bootchart_init, NULL);
445 execl("/init", "init", NULL);
446 execl("/sbin/init", "init", NULL);
Pascal Bellardff377992010-06-28 15:50:22 +0200447 bb_perror_msg_and_die("can't execute '%s'", "/sbin/init");
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200448 }
449
450 if (cmd == CMD_START && argv[2]) { /* "start PROG ARGS" */
Pascal Bellard926031b2010-07-04 15:32:38 +0200451 pid_t pid = xvfork();
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200452 if (pid == 0) { /* child */
453 argv += 2;
Denys Vlasenko1c31e9e2010-11-28 04:34:09 +0100454 BB_EXECVP_or_die(argv);
Denys Vlasenkoff027d62010-05-04 15:45:25 +0200455 }
456 /* parent */
457 waitpid(pid, NULL, 0);
458 kill(logger_pid, SIGUSR1);
459 }
460
461 return EXIT_SUCCESS;
462}