1 /* 2 * lib/dynamic_debug.c 3 * 4 * make pr_debug()/dev_dbg() calls runtime configurable based upon their 5 * source module. 6 * 7 * Copyright (C) 2008 Jason Baron <jbaron@redhat.com> 8 * By Greg Banks <gnb@melbourne.sgi.com> 9 * Copyright (c) 2008 Silicon Graphics Inc. All Rights Reserved. 10 * Copyright (C) 2011 Bart Van Assche. All Rights Reserved. 11 * Copyright (C) 2013 Du, Changbin <changbin.du@gmail.com> 12 */ 13 14 #define pr_fmt(fmt) KBUILD_MODNAME ":%s: " fmt, __func__ 15 16 #include <linux/kernel.h> 17 #include <linux/module.h> 18 #include <linux/moduleparam.h> 19 #include <linux/kallsyms.h> 20 #include <linux/types.h> 21 #include <linux/mutex.h> 22 #include <linux/proc_fs.h> 23 #include <linux/seq_file.h> 24 #include <linux/list.h> 25 #include <linux/sysctl.h> 26 #include <linux/ctype.h> 27 #include <linux/string.h> 28 #include <linux/parser.h> 29 #include <linux/string_helpers.h> 30 #include <linux/uaccess.h> 31 #include <linux/dynamic_debug.h> 32 #include <linux/debugfs.h> 33 #include <linux/slab.h> 34 #include <linux/jump_label.h> 35 #include <linux/hardirq.h> 36 #include <linux/sched.h> 37 #include <linux/device.h> 38 #include <linux/netdevice.h> 39 40 extern struct _ddebug __start___verbose[]; 41 extern struct _ddebug __stop___verbose[]; 42 43 struct ddebug_table { 44 struct list_head link; 45 char *mod_name; 46 unsigned int num_ddebugs; 47 struct _ddebug *ddebugs; 48 }; 49 50 struct ddebug_query { 51 const char *filename; 52 const char *module; 53 const char *function; 54 const char *format; 55 unsigned int first_lineno, last_lineno; 56 }; 57 58 struct ddebug_iter { 59 struct ddebug_table *table; 60 unsigned int idx; 61 }; 62 63 static DEFINE_MUTEX(ddebug_lock); 64 static LIST_HEAD(ddebug_tables); 65 static int verbose; 66 module_param(verbose, int, 0644); 67 68 /* Return the path relative to source root */ 69 static inline const char *trim_prefix(const char *path) 70 { 71 int skip = strlen(__FILE__) - strlen("lib/dynamic_debug.c"); 72 73 if (strncmp(path, __FILE__, skip)) 74 skip = 0; /* prefix mismatch, don't skip */ 75 76 return path + skip; 77 } 78 79 static struct { unsigned flag:8; char opt_char; } opt_array[] = { 80 { _DPRINTK_FLAGS_PRINT, 'p' }, 81 { _DPRINTK_FLAGS_INCL_MODNAME, 'm' }, 82 { _DPRINTK_FLAGS_INCL_FUNCNAME, 'f' }, 83 { _DPRINTK_FLAGS_INCL_LINENO, 'l' }, 84 { _DPRINTK_FLAGS_INCL_TID, 't' }, 85 { _DPRINTK_FLAGS_NONE, '_' }, 86 }; 87 88 /* format a string into buf[] which describes the _ddebug's flags */ 89 static char *ddebug_describe_flags(struct _ddebug *dp, char *buf, 90 size_t maxlen) 91 { 92 char *p = buf; 93 int i; 94 95 BUG_ON(maxlen < 6); 96 for (i = 0; i < ARRAY_SIZE(opt_array); ++i) 97 if (dp->flags & opt_array[i].flag) 98 *p++ = opt_array[i].opt_char; 99 if (p == buf) 100 *p++ = '_'; 101 *p = '\0'; 102 103 return buf; 104 } 105 106 #define vpr_info(fmt, ...) \ 107 do { \ 108 if (verbose) \ 109 pr_info(fmt, ##__VA_ARGS__); \ 110 } while (0) 111 112 static void vpr_info_dq(const struct ddebug_query *query, const char *msg) 113 { 114 /* trim any trailing newlines */ 115 int fmtlen = 0; 116 117 if (query->format) { 118 fmtlen = strlen(query->format); 119 while (fmtlen && query->format[fmtlen - 1] == '\n') 120 fmtlen--; 121 } 122 123 vpr_info("%s: func=\"%s\" file=\"%s\" module=\"%s\" format=\"%.*s\" lineno=%u-%u\n", 124 msg, 125 query->function ? query->function : "", 126 query->filename ? query->filename : "", 127 query->module ? query->module : "", 128 fmtlen, query->format ? query->format : "", 129 query->first_lineno, query->last_lineno); 130 } 131 132 /* 133 * Search the tables for _ddebug's which match the given `query' and 134 * apply the `flags' and `mask' to them. Returns number of matching 135 * callsites, normally the same as number of changes. If verbose, 136 * logs the changes. Takes ddebug_lock. 137 */ 138 static int ddebug_change(const struct ddebug_query *query, 139 unsigned int flags, unsigned int mask) 140 { 141 int i; 142 struct ddebug_table *dt; 143 unsigned int newflags; 144 unsigned int nfound = 0; 145 char flagbuf[10]; 146 147 /* search for matching ddebugs */ 148 mutex_lock(&ddebug_lock); 149 list_for_each_entry(dt, &ddebug_tables, link) { 150 151 /* match against the module name */ 152 if (query->module && 153 !match_wildcard(query->module, dt->mod_name)) 154 continue; 155 156 for (i = 0; i < dt->num_ddebugs; i++) { 157 struct _ddebug *dp = &dt->ddebugs[i]; 158 159 /* match against the source filename */ 160 if (query->filename && 161 !match_wildcard(query->filename, dp->filename) && 162 !match_wildcard(query->filename, 163 kbasename(dp->filename)) && 164 !match_wildcard(query->filename, 165 trim_prefix(dp->filename))) 166 continue; 167 168 /* match against the function */ 169 if (query->function && 170 !match_wildcard(query->function, dp->function)) 171 continue; 172 173 /* match against the format */ 174 if (query->format && 175 !strstr(dp->format, query->format)) 176 continue; 177 178 /* match against the line number range */ 179 if (query->first_lineno && 180 dp->lineno < query->first_lineno) 181 continue; 182 if (query->last_lineno && 183 dp->lineno > query->last_lineno) 184 continue; 185 186 nfound++; 187 188 newflags = (dp->flags & mask) | flags; 189 if (newflags == dp->flags) 190 continue; 191 dp->flags = newflags; 192 vpr_info("changed %s:%d [%s]%s =%s\n", 193 trim_prefix(dp->filename), dp->lineno, 194 dt->mod_name, dp->function, 195 ddebug_describe_flags(dp, flagbuf, 196 sizeof(flagbuf))); 197 } 198 } 199 mutex_unlock(&ddebug_lock); 200 201 if (!nfound && verbose) 202 pr_info("no matches for query\n"); 203 204 return nfound; 205 } 206 207 /* 208 * Split the buffer `buf' into space-separated words. 209 * Handles simple " and ' quoting, i.e. without nested, 210 * embedded or escaped \". Return the number of words 211 * or <0 on error. 212 */ 213 static int ddebug_tokenize(char *buf, char *words[], int maxwords) 214 { 215 int nwords = 0; 216 217 while (*buf) { 218 char *end; 219 220 /* Skip leading whitespace */ 221 buf = skip_spaces(buf); 222 if (!*buf) 223 break; /* oh, it was trailing whitespace */ 224 if (*buf == '#') 225 break; /* token starts comment, skip rest of line */ 226 227 /* find `end' of word, whitespace separated or quoted */ 228 if (*buf == '"' || *buf == '\'') { 229 int quote = *buf++; 230 for (end = buf; *end && *end != quote; end++) 231 ; 232 if (!*end) { 233 pr_err("unclosed quote: %s\n", buf); 234 return -EINVAL; /* unclosed quote */ 235 } 236 } else { 237 for (end = buf; *end && !isspace(*end); end++) 238 ; 239 BUG_ON(end == buf); 240 } 241 242 /* `buf' is start of word, `end' is one past its end */ 243 if (nwords == maxwords) { 244 pr_err("too many words, legal max <=%d\n", maxwords); 245 return -EINVAL; /* ran out of words[] before bytes */ 246 } 247 if (*end) 248 *end++ = '\0'; /* terminate the word */ 249 words[nwords++] = buf; 250 buf = end; 251 } 252 253 if (verbose) { 254 int i; 255 pr_info("split into words:"); 256 for (i = 0; i < nwords; i++) 257 pr_cont(" \"%s\"", words[i]); 258 pr_cont("\n"); 259 } 260 261 return nwords; 262 } 263 264 /* 265 * Parse a single line number. Note that the empty string "" 266 * is treated as a special case and converted to zero, which 267 * is later treated as a "don't care" value. 268 */ 269 static inline int parse_lineno(const char *str, unsigned int *val) 270 { 271 BUG_ON(str == NULL); 272 if (*str == '\0') { 273 *val = 0; 274 return 0; 275 } 276 if (kstrtouint(str, 10, val) < 0) { 277 pr_err("bad line-number: %s\n", str); 278 return -EINVAL; 279 } 280 return 0; 281 } 282 283 static int check_set(const char **dest, char *src, char *name) 284 { 285 int rc = 0; 286 287 if (*dest) { 288 rc = -EINVAL; 289 pr_err("match-spec:%s val:%s overridden by %s\n", 290 name, *dest, src); 291 } 292 *dest = src; 293 return rc; 294 } 295 296 /* 297 * Parse words[] as a ddebug query specification, which is a series 298 * of (keyword, value) pairs chosen from these possibilities: 299 * 300 * func <function-name> 301 * file <full-pathname> 302 * file <base-filename> 303 * module <module-name> 304 * format <escaped-string-to-find-in-format> 305 * line <lineno> 306 * line <first-lineno>-<last-lineno> // where either may be empty 307 * 308 * Only 1 of each type is allowed. 309 * Returns 0 on success, <0 on error. 310 */ 311 static int ddebug_parse_query(char *words[], int nwords, 312 struct ddebug_query *query, const char *modname) 313 { 314 unsigned int i; 315 int rc = 0; 316 317 /* check we have an even number of words */ 318 if (nwords % 2 != 0) { 319 pr_err("expecting pairs of match-spec <value>\n"); 320 return -EINVAL; 321 } 322 memset(query, 0, sizeof(*query)); 323 324 if (modname) 325 /* support $modname.dyndbg=<multiple queries> */ 326 query->module = modname; 327 328 for (i = 0; i < nwords; i += 2) { 329 if (!strcmp(words[i], "func")) { 330 rc = check_set(&query->function, words[i+1], "func"); 331 } else if (!strcmp(words[i], "file")) { 332 rc = check_set(&query->filename, words[i+1], "file"); 333 } else if (!strcmp(words[i], "module")) { 334 rc = check_set(&query->module, words[i+1], "module"); 335 } else if (!strcmp(words[i], "format")) { 336 string_unescape_inplace(words[i+1], UNESCAPE_SPACE | 337 UNESCAPE_OCTAL | 338 UNESCAPE_SPECIAL); 339 rc = check_set(&query->format, words[i+1], "format"); 340 } else if (!strcmp(words[i], "line")) { 341 char *first = words[i+1]; 342 char *last = strchr(first, '-'); 343 if (query->first_lineno || query->last_lineno) { 344 pr_err("match-spec: line used 2x\n"); 345 return -EINVAL; 346 } 347 if (last) 348 *last++ = '\0'; 349 if (parse_lineno(first, &query->first_lineno) < 0) 350 return -EINVAL; 351 if (last) { 352 /* range <first>-<last> */ 353 if (parse_lineno(last, &query->last_lineno) < 0) 354 return -EINVAL; 355 356 if (query->last_lineno < query->first_lineno) { 357 pr_err("last-line:%d < 1st-line:%d\n", 358 query->last_lineno, 359 query->first_lineno); 360 return -EINVAL; 361 } 362 } else { 363 query->last_lineno = query->first_lineno; 364 } 365 } else { 366 pr_err("unknown keyword \"%s\"\n", words[i]); 367 return -EINVAL; 368 } 369 if (rc) 370 return rc; 371 } 372 vpr_info_dq(query, "parsed"); 373 return 0; 374 } 375 376 /* 377 * Parse `str' as a flags specification, format [-+=][p]+. 378 * Sets up *maskp and *flagsp to be used when changing the 379 * flags fields of matched _ddebug's. Returns 0 on success 380 * or <0 on error. 381 */ 382 static int ddebug_parse_flags(const char *str, unsigned int *flagsp, 383 unsigned int *maskp) 384 { 385 unsigned flags = 0; 386 int op = '=', i; 387 388 switch (*str) { 389 case '+': 390 case '-': 391 case '=': 392 op = *str++; 393 break; 394 default: 395 pr_err("bad flag-op %c, at start of %s\n", *str, str); 396 return -EINVAL; 397 } 398 vpr_info("op='%c'\n", op); 399 400 for (; *str ; ++str) { 401 for (i = ARRAY_SIZE(opt_array) - 1; i >= 0; i--) { 402 if (*str == opt_array[i].opt_char) { 403 flags |= opt_array[i].flag; 404 break; 405 } 406 } 407 if (i < 0) { 408 pr_err("unknown flag '%c' in \"%s\"\n", *str, str); 409 return -EINVAL; 410 } 411 } 412 vpr_info("flags=0x%x\n", flags); 413 414 /* calculate final *flagsp, *maskp according to mask and op */ 415 switch (op) { 416 case '=': 417 *maskp = 0; 418 *flagsp = flags; 419 break; 420 case '+': 421 *maskp = ~0U; 422 *flagsp = flags; 423 break; 424 case '-': 425 *maskp = ~flags; 426 *flagsp = 0; 427 break; 428 } 429 vpr_info("*flagsp=0x%x *maskp=0x%x\n", *flagsp, *maskp); 430 return 0; 431 } 432 433 static int ddebug_exec_query(char *query_string, const char *modname) 434 { 435 unsigned int flags = 0, mask = 0; 436 struct ddebug_query query; 437 #define MAXWORDS 9 438 int nwords, nfound; 439 char *words[MAXWORDS]; 440 441 nwords = ddebug_tokenize(query_string, words, MAXWORDS); 442 if (nwords <= 0) { 443 pr_err("tokenize failed\n"); 444 return -EINVAL; 445 } 446 /* check flags 1st (last arg) so query is pairs of spec,val */ 447 if (ddebug_parse_flags(words[nwords-1], &flags, &mask)) { 448 pr_err("flags parse failed\n"); 449 return -EINVAL; 450 } 451 if (ddebug_parse_query(words, nwords-1, &query, modname)) { 452 pr_err("query parse failed\n"); 453 return -EINVAL; 454 } 455 /* actually go and implement the change */ 456 nfound = ddebug_change(&query, flags, mask); 457 vpr_info_dq(&query, nfound ? "applied" : "no-match"); 458 459 return nfound; 460 } 461 462 /* handle multiple queries in query string, continue on error, return 463 last error or number of matching callsites. Module name is either 464 in param (for boot arg) or perhaps in query string. 465 */ 466 static int ddebug_exec_queries(char *query, const char *modname) 467 { 468 char *split; 469 int i, errs = 0, exitcode = 0, rc, nfound = 0; 470 471 for (i = 0; query; query = split) { 472 split = strpbrk(query, ";\n"); 473 if (split) 474 *split++ = '\0'; 475 476 query = skip_spaces(query); 477 if (!query || !*query || *query == '#') 478 continue; 479 480 vpr_info("query %d: \"%s\"\n", i, query); 481 482 rc = ddebug_exec_query(query, modname); 483 if (rc < 0) { 484 errs++; 485 exitcode = rc; 486 } else { 487 nfound += rc; 488 } 489 i++; 490 } 491 vpr_info("processed %d queries, with %d matches, %d errs\n", 492 i, nfound, errs); 493 494 if (exitcode) 495 return exitcode; 496 return nfound; 497 } 498 499 #define PREFIX_SIZE 64 500 501 static int remaining(int wrote) 502 { 503 if (PREFIX_SIZE - wrote > 0) 504 return PREFIX_SIZE - wrote; 505 return 0; 506 } 507 508 static char *dynamic_emit_prefix(const struct _ddebug *desc, char *buf) 509 { 510 int pos_after_tid; 511 int pos = 0; 512 513 *buf = '\0'; 514 515 if (desc->flags & _DPRINTK_FLAGS_INCL_TID) { 516 if (in_interrupt()) 517 pos += snprintf(buf + pos, remaining(pos), "<intr> "); 518 else 519 pos += snprintf(buf + pos, remaining(pos), "[%d] ", 520 task_pid_vnr(current)); 521 } 522 pos_after_tid = pos; 523 if (desc->flags & _DPRINTK_FLAGS_INCL_MODNAME) 524 pos += snprintf(buf + pos, remaining(pos), "%s:", 525 desc->modname); 526 if (desc->flags & _DPRINTK_FLAGS_INCL_FUNCNAME) 527 pos += snprintf(buf + pos, remaining(pos), "%s:", 528 desc->function); 529 if (desc->flags & _DPRINTK_FLAGS_INCL_LINENO) 530 pos += snprintf(buf + pos, remaining(pos), "%d:", 531 desc->lineno); 532 if (pos - pos_after_tid) 533 pos += snprintf(buf + pos, remaining(pos), " "); 534 if (pos >= PREFIX_SIZE) 535 buf[PREFIX_SIZE - 1] = '\0'; 536 537 return buf; 538 } 539 540 void __dynamic_pr_debug(struct _ddebug *descriptor, const char *fmt, ...) 541 { 542 va_list args; 543 struct va_format vaf; 544 char buf[PREFIX_SIZE]; 545 546 BUG_ON(!descriptor); 547 BUG_ON(!fmt); 548 549 va_start(args, fmt); 550 551 vaf.fmt = fmt; 552 vaf.va = &args; 553 554 printk(KERN_DEBUG "%s%pV", dynamic_emit_prefix(descriptor, buf), &vaf); 555 556 va_end(args); 557 } 558 EXPORT_SYMBOL(__dynamic_pr_debug); 559 560 void __dynamic_dev_dbg(struct _ddebug *descriptor, 561 const struct device *dev, const char *fmt, ...) 562 { 563 struct va_format vaf; 564 va_list args; 565 566 BUG_ON(!descriptor); 567 BUG_ON(!fmt); 568 569 va_start(args, fmt); 570 571 vaf.fmt = fmt; 572 vaf.va = &args; 573 574 if (!dev) { 575 printk(KERN_DEBUG "(NULL device *): %pV", &vaf); 576 } else { 577 char buf[PREFIX_SIZE]; 578 579 dev_printk_emit(LOGLEVEL_DEBUG, dev, "%s%s %s: %pV", 580 dynamic_emit_prefix(descriptor, buf), 581 dev_driver_string(dev), dev_name(dev), 582 &vaf); 583 } 584 585 va_end(args); 586 } 587 EXPORT_SYMBOL(__dynamic_dev_dbg); 588 589 #ifdef CONFIG_NET 590 591 void __dynamic_netdev_dbg(struct _ddebug *descriptor, 592 const struct net_device *dev, const char *fmt, ...) 593 { 594 struct va_format vaf; 595 va_list args; 596 597 BUG_ON(!descriptor); 598 BUG_ON(!fmt); 599 600 va_start(args, fmt); 601 602 vaf.fmt = fmt; 603 vaf.va = &args; 604 605 if (dev && dev->dev.parent) { 606 char buf[PREFIX_SIZE]; 607 608 dev_printk_emit(LOGLEVEL_DEBUG, dev->dev.parent, 609 "%s%s %s %s%s: %pV", 610 dynamic_emit_prefix(descriptor, buf), 611 dev_driver_string(dev->dev.parent), 612 dev_name(dev->dev.parent), 613 netdev_name(dev), netdev_reg_state(dev), 614 &vaf); 615 } else if (dev) { 616 printk(KERN_DEBUG "%s%s: %pV", netdev_name(dev), 617 netdev_reg_state(dev), &vaf); 618 } else { 619 printk(KERN_DEBUG "(NULL net_device): %pV", &vaf); 620 } 621 622 va_end(args); 623 } 624 EXPORT_SYMBOL(__dynamic_netdev_dbg); 625 626 #endif 627 628 #define DDEBUG_STRING_SIZE 1024 629 static __initdata char ddebug_setup_string[DDEBUG_STRING_SIZE]; 630 631 static __init int ddebug_setup_query(char *str) 632 { 633 if (strlen(str) >= DDEBUG_STRING_SIZE) { 634 pr_warn("ddebug boot param string too large\n"); 635 return 0; 636 } 637 strlcpy(ddebug_setup_string, str, DDEBUG_STRING_SIZE); 638 return 1; 639 } 640 641 __setup("ddebug_query=", ddebug_setup_query); 642 643 /* 644 * File_ops->write method for <debugfs>/dynamic_debug/conrol. Gathers the 645 * command text from userspace, parses and executes it. 646 */ 647 #define USER_BUF_PAGE 4096 648 static ssize_t ddebug_proc_write(struct file *file, const char __user *ubuf, 649 size_t len, loff_t *offp) 650 { 651 char *tmpbuf; 652 int ret; 653 654 if (len == 0) 655 return 0; 656 if (len > USER_BUF_PAGE - 1) { 657 pr_warn("expected <%d bytes into control\n", USER_BUF_PAGE); 658 return -E2BIG; 659 } 660 tmpbuf = kmalloc(len + 1, GFP_KERNEL); 661 if (!tmpbuf) 662 return -ENOMEM; 663 if (copy_from_user(tmpbuf, ubuf, len)) { 664 kfree(tmpbuf); 665 return -EFAULT; 666 } 667 tmpbuf[len] = '\0'; 668 vpr_info("read %d bytes from userspace\n", (int)len); 669 670 ret = ddebug_exec_queries(tmpbuf, NULL); 671 kfree(tmpbuf); 672 if (ret < 0) 673 return ret; 674 675 *offp += len; 676 return len; 677 } 678 679 /* 680 * Set the iterator to point to the first _ddebug object 681 * and return a pointer to that first object. Returns 682 * NULL if there are no _ddebugs at all. 683 */ 684 static struct _ddebug *ddebug_iter_first(struct ddebug_iter *iter) 685 { 686 if (list_empty(&ddebug_tables)) { 687 iter->table = NULL; 688 iter->idx = 0; 689 return NULL; 690 } 691 iter->table = list_entry(ddebug_tables.next, 692 struct ddebug_table, link); 693 iter->idx = 0; 694 return &iter->table->ddebugs[iter->idx]; 695 } 696 697 /* 698 * Advance the iterator to point to the next _ddebug 699 * object from the one the iterator currently points at, 700 * and returns a pointer to the new _ddebug. Returns 701 * NULL if the iterator has seen all the _ddebugs. 702 */ 703 static struct _ddebug *ddebug_iter_next(struct ddebug_iter *iter) 704 { 705 if (iter->table == NULL) 706 return NULL; 707 if (++iter->idx == iter->table->num_ddebugs) { 708 /* iterate to next table */ 709 iter->idx = 0; 710 if (list_is_last(&iter->table->link, &ddebug_tables)) { 711 iter->table = NULL; 712 return NULL; 713 } 714 iter->table = list_entry(iter->table->link.next, 715 struct ddebug_table, link); 716 } 717 return &iter->table->ddebugs[iter->idx]; 718 } 719 720 /* 721 * Seq_ops start method. Called at the start of every 722 * read() call from userspace. Takes the ddebug_lock and 723 * seeks the seq_file's iterator to the given position. 724 */ 725 static void *ddebug_proc_start(struct seq_file *m, loff_t *pos) 726 { 727 struct ddebug_iter *iter = m->private; 728 struct _ddebug *dp; 729 int n = *pos; 730 731 vpr_info("called m=%p *pos=%lld\n", m, (unsigned long long)*pos); 732 733 mutex_lock(&ddebug_lock); 734 735 if (!n) 736 return SEQ_START_TOKEN; 737 if (n < 0) 738 return NULL; 739 dp = ddebug_iter_first(iter); 740 while (dp != NULL && --n > 0) 741 dp = ddebug_iter_next(iter); 742 return dp; 743 } 744 745 /* 746 * Seq_ops next method. Called several times within a read() 747 * call from userspace, with ddebug_lock held. Walks to the 748 * next _ddebug object with a special case for the header line. 749 */ 750 static void *ddebug_proc_next(struct seq_file *m, void *p, loff_t *pos) 751 { 752 struct ddebug_iter *iter = m->private; 753 struct _ddebug *dp; 754 755 vpr_info("called m=%p p=%p *pos=%lld\n", 756 m, p, (unsigned long long)*pos); 757 758 if (p == SEQ_START_TOKEN) 759 dp = ddebug_iter_first(iter); 760 else 761 dp = ddebug_iter_next(iter); 762 ++*pos; 763 return dp; 764 } 765 766 /* 767 * Seq_ops show method. Called several times within a read() 768 * call from userspace, with ddebug_lock held. Formats the 769 * current _ddebug as a single human-readable line, with a 770 * special case for the header line. 771 */ 772 static int ddebug_proc_show(struct seq_file *m, void *p) 773 { 774 struct ddebug_iter *iter = m->private; 775 struct _ddebug *dp = p; 776 char flagsbuf[10]; 777 778 vpr_info("called m=%p p=%p\n", m, p); 779 780 if (p == SEQ_START_TOKEN) { 781 seq_puts(m, 782 "# filename:lineno [module]function flags format\n"); 783 return 0; 784 } 785 786 seq_printf(m, "%s:%u [%s]%s =%s \"", 787 trim_prefix(dp->filename), dp->lineno, 788 iter->table->mod_name, dp->function, 789 ddebug_describe_flags(dp, flagsbuf, sizeof(flagsbuf))); 790 seq_escape(m, dp->format, "\t\r\n\""); 791 seq_puts(m, "\"\n"); 792 793 return 0; 794 } 795 796 /* 797 * Seq_ops stop method. Called at the end of each read() 798 * call from userspace. Drops ddebug_lock. 799 */ 800 static void ddebug_proc_stop(struct seq_file *m, void *p) 801 { 802 vpr_info("called m=%p p=%p\n", m, p); 803 mutex_unlock(&ddebug_lock); 804 } 805 806 static const struct seq_operations ddebug_proc_seqops = { 807 .start = ddebug_proc_start, 808 .next = ddebug_proc_next, 809 .show = ddebug_proc_show, 810 .stop = ddebug_proc_stop 811 }; 812 813 /* 814 * File_ops->open method for <debugfs>/dynamic_debug/control. Does 815 * the seq_file setup dance, and also creates an iterator to walk the 816 * _ddebugs. Note that we create a seq_file always, even for O_WRONLY 817 * files where it's not needed, as doing so simplifies the ->release 818 * method. 819 */ 820 static int ddebug_proc_open(struct inode *inode, struct file *file) 821 { 822 vpr_info("called\n"); 823 return seq_open_private(file, &ddebug_proc_seqops, 824 sizeof(struct ddebug_iter)); 825 } 826 827 static const struct file_operations ddebug_proc_fops = { 828 .owner = THIS_MODULE, 829 .open = ddebug_proc_open, 830 .read = seq_read, 831 .llseek = seq_lseek, 832 .release = seq_release_private, 833 .write = ddebug_proc_write 834 }; 835 836 /* 837 * Allocate a new ddebug_table for the given module 838 * and add it to the global list. 839 */ 840 int ddebug_add_module(struct _ddebug *tab, unsigned int n, 841 const char *name) 842 { 843 struct ddebug_table *dt; 844 char *new_name; 845 846 dt = kzalloc(sizeof(*dt), GFP_KERNEL); 847 if (dt == NULL) 848 return -ENOMEM; 849 new_name = kstrdup(name, GFP_KERNEL); 850 if (new_name == NULL) { 851 kfree(dt); 852 return -ENOMEM; 853 } 854 dt->mod_name = new_name; 855 dt->num_ddebugs = n; 856 dt->ddebugs = tab; 857 858 mutex_lock(&ddebug_lock); 859 list_add_tail(&dt->link, &ddebug_tables); 860 mutex_unlock(&ddebug_lock); 861 862 vpr_info("%u debug prints in module %s\n", n, dt->mod_name); 863 return 0; 864 } 865 EXPORT_SYMBOL_GPL(ddebug_add_module); 866 867 /* helper for ddebug_dyndbg_(boot|module)_param_cb */ 868 static int ddebug_dyndbg_param_cb(char *param, char *val, 869 const char *modname, int on_err) 870 { 871 char *sep; 872 873 sep = strchr(param, '.'); 874 if (sep) { 875 /* needed only for ddebug_dyndbg_boot_param_cb */ 876 *sep = '\0'; 877 modname = param; 878 param = sep + 1; 879 } 880 if (strcmp(param, "dyndbg")) 881 return on_err; /* determined by caller */ 882 883 ddebug_exec_queries((val ? val : "+p"), modname); 884 885 return 0; /* query failure shouldnt stop module load */ 886 } 887 888 /* handle both dyndbg and $module.dyndbg params at boot */ 889 static int ddebug_dyndbg_boot_param_cb(char *param, char *val, 890 const char *unused) 891 { 892 vpr_info("%s=\"%s\"\n", param, val); 893 return ddebug_dyndbg_param_cb(param, val, NULL, 0); 894 } 895 896 /* 897 * modprobe foo finds foo.params in boot-args, strips "foo.", and 898 * passes them to load_module(). This callback gets unknown params, 899 * processes dyndbg params, rejects others. 900 */ 901 int ddebug_dyndbg_module_param_cb(char *param, char *val, const char *module) 902 { 903 vpr_info("module: %s %s=\"%s\"\n", module, param, val); 904 return ddebug_dyndbg_param_cb(param, val, module, -ENOENT); 905 } 906 907 static void ddebug_table_free(struct ddebug_table *dt) 908 { 909 list_del_init(&dt->link); 910 kfree(dt->mod_name); 911 kfree(dt); 912 } 913 914 /* 915 * Called in response to a module being unloaded. Removes 916 * any ddebug_table's which point at the module. 917 */ 918 int ddebug_remove_module(const char *mod_name) 919 { 920 struct ddebug_table *dt, *nextdt; 921 int ret = -ENOENT; 922 923 vpr_info("removing module \"%s\"\n", mod_name); 924 925 mutex_lock(&ddebug_lock); 926 list_for_each_entry_safe(dt, nextdt, &ddebug_tables, link) { 927 if (!strcmp(dt->mod_name, mod_name)) { 928 ddebug_table_free(dt); 929 ret = 0; 930 } 931 } 932 mutex_unlock(&ddebug_lock); 933 return ret; 934 } 935 EXPORT_SYMBOL_GPL(ddebug_remove_module); 936 937 static void ddebug_remove_all_tables(void) 938 { 939 mutex_lock(&ddebug_lock); 940 while (!list_empty(&ddebug_tables)) { 941 struct ddebug_table *dt = list_entry(ddebug_tables.next, 942 struct ddebug_table, 943 link); 944 ddebug_table_free(dt); 945 } 946 mutex_unlock(&ddebug_lock); 947 } 948 949 static __initdata int ddebug_init_success; 950 951 static int __init dynamic_debug_init_debugfs(void) 952 { 953 struct dentry *dir, *file; 954 955 if (!ddebug_init_success) 956 return -ENODEV; 957 958 dir = debugfs_create_dir("dynamic_debug", NULL); 959 if (!dir) 960 return -ENOMEM; 961 file = debugfs_create_file("control", 0644, dir, NULL, 962 &ddebug_proc_fops); 963 if (!file) { 964 debugfs_remove(dir); 965 return -ENOMEM; 966 } 967 return 0; 968 } 969 970 static int __init dynamic_debug_init(void) 971 { 972 struct _ddebug *iter, *iter_start; 973 const char *modname = NULL; 974 char *cmdline; 975 int ret = 0; 976 int n = 0, entries = 0, modct = 0; 977 int verbose_bytes = 0; 978 979 if (__start___verbose == __stop___verbose) { 980 pr_warn("_ddebug table is empty in a CONFIG_DYNAMIC_DEBUG build\n"); 981 return 1; 982 } 983 iter = __start___verbose; 984 modname = iter->modname; 985 iter_start = iter; 986 for (; iter < __stop___verbose; iter++) { 987 entries++; 988 verbose_bytes += strlen(iter->modname) + strlen(iter->function) 989 + strlen(iter->filename) + strlen(iter->format); 990 991 if (strcmp(modname, iter->modname)) { 992 modct++; 993 ret = ddebug_add_module(iter_start, n, modname); 994 if (ret) 995 goto out_err; 996 n = 0; 997 modname = iter->modname; 998 iter_start = iter; 999 } 1000 n++; 1001 } 1002 ret = ddebug_add_module(iter_start, n, modname); 1003 if (ret) 1004 goto out_err; 1005 1006 ddebug_init_success = 1; 1007 vpr_info("%d modules, %d entries and %d bytes in ddebug tables, %d bytes in (readonly) verbose section\n", 1008 modct, entries, (int)(modct * sizeof(struct ddebug_table)), 1009 verbose_bytes + (int)(__stop___verbose - __start___verbose)); 1010 1011 /* apply ddebug_query boot param, dont unload tables on err */ 1012 if (ddebug_setup_string[0] != '\0') { 1013 pr_warn("ddebug_query param name is deprecated, change it to dyndbg\n"); 1014 ret = ddebug_exec_queries(ddebug_setup_string, NULL); 1015 if (ret < 0) 1016 pr_warn("Invalid ddebug boot param %s\n", 1017 ddebug_setup_string); 1018 else 1019 pr_info("%d changes by ddebug_query\n", ret); 1020 } 1021 /* now that ddebug tables are loaded, process all boot args 1022 * again to find and activate queries given in dyndbg params. 1023 * While this has already been done for known boot params, it 1024 * ignored the unknown ones (dyndbg in particular). Reusing 1025 * parse_args avoids ad-hoc parsing. This will also attempt 1026 * to activate queries for not-yet-loaded modules, which is 1027 * slightly noisy if verbose, but harmless. 1028 */ 1029 cmdline = kstrdup(saved_command_line, GFP_KERNEL); 1030 parse_args("dyndbg params", cmdline, NULL, 1031 0, 0, 0, &ddebug_dyndbg_boot_param_cb); 1032 kfree(cmdline); 1033 return 0; 1034 1035 out_err: 1036 ddebug_remove_all_tables(); 1037 return 0; 1038 } 1039 /* Allow early initialization for boot messages via boot param */ 1040 early_initcall(dynamic_debug_init); 1041 1042 /* Debugfs setup must be done later */ 1043 fs_initcall(dynamic_debug_init_debugfs); 1044