builtin-kwork.c 63 KB

123456789101112131415161718192021222324252627282930313233343536373839404142434445464748495051525354555657585960616263646566676869707172737475767778798081828384858687888990919293949596979899100101102103104105106107108109110111112113114115116117118119120121122123124125126127128129130131132133134135136137138139140141142143144145146147148149150151152153154155156157158159160161162163164165166167168169170171172173174175176177178179180181182183184185186187188189190191192193194195196197198199200201202203204205206207208209210211212213214215216217218219220221222223224225226227228229230231232233234235236237238239240241242243244245246247248249250251252253254255256257258259260261262263264265266267268269270271272273274275276277278279280281282283284285286287288289290291292293294295296297298299300301302303304305306307308309310311312313314315316317318319320321322323324325326327328329330331332333334335336337338339340341342343344345346347348349350351352353354355356357358359360361362363364365366367368369370371372373374375376377378379380381382383384385386387388389390391392393394395396397398399400401402403404405406407408409410411412413414415416417418419420421422423424425426427428429430431432433434435436437438439440441442443444445446447448449450451452453454455456457458459460461462463464465466467468469470471472473474475476477478479480481482483484485486487488489490491492493494495496497498499500501502503504505506507508509510511512513514515516517518519520521522523524525526527528529530531532533534535536537538539540541542543544545546547548549550551552553554555556557558559560561562563564565566567568569570571572573574575576577578579580581582583584585586587588589590591592593594595596597598599600601602603604605606607608609610611612613614615616617618619620621622623624625626627628629630631632633634635636637638639640641642643644645646647648649650651652653654655656657658659660661662663664665666667668669670671672673674675676677678679680681682683684685686687688689690691692693694695696697698699700701702703704705706707708709710711712713714715716717718719720721722723724725726727728729730731732733734735736737738739740741742743744745746747748749750751752753754755756757758759760761762763764765766767768769770771772773774775776777778779780781782783784785786787788789790791792793794795796797798799800801802803804805806807808809810811812813814815816817818819820821822823824825826827828829830831832833834835836837838839840841842843844845846847848849850851852853854855856857858859860861862863864865866867868869870871872873874875876877878879880881882883884885886887888889890891892893894895896897898899900901902903904905906907908909910911912913914915916917918919920921922923924925926927928929930931932933934935936937938939940941942943944945946947948949950951952953954955956957958959960961962963964965966967968969970971972973974975976977978979980981982983984985986987988989990991992993994995996997998999100010011002100310041005100610071008100910101011101210131014101510161017101810191020102110221023102410251026102710281029103010311032103310341035103610371038103910401041104210431044104510461047104810491050105110521053105410551056105710581059106010611062106310641065106610671068106910701071107210731074107510761077107810791080108110821083108410851086108710881089109010911092109310941095109610971098109911001101110211031104110511061107110811091110111111121113111411151116111711181119112011211122112311241125112611271128112911301131113211331134113511361137113811391140114111421143114411451146114711481149115011511152115311541155115611571158115911601161116211631164116511661167116811691170117111721173117411751176117711781179118011811182118311841185118611871188118911901191119211931194119511961197119811991200120112021203120412051206120712081209121012111212121312141215121612171218121912201221122212231224122512261227122812291230123112321233123412351236123712381239124012411242124312441245124612471248124912501251125212531254125512561257125812591260126112621263126412651266126712681269127012711272127312741275127612771278127912801281128212831284128512861287128812891290129112921293129412951296129712981299130013011302130313041305130613071308130913101311131213131314131513161317131813191320132113221323132413251326132713281329133013311332133313341335133613371338133913401341134213431344134513461347134813491350135113521353135413551356135713581359136013611362136313641365136613671368136913701371137213731374137513761377137813791380138113821383138413851386138713881389139013911392139313941395139613971398139914001401140214031404140514061407140814091410141114121413141414151416141714181419142014211422142314241425142614271428142914301431143214331434143514361437143814391440144114421443144414451446144714481449145014511452145314541455145614571458145914601461146214631464146514661467146814691470147114721473147414751476147714781479148014811482148314841485148614871488148914901491149214931494149514961497149814991500150115021503150415051506150715081509151015111512151315141515151615171518151915201521152215231524152515261527152815291530153115321533153415351536153715381539154015411542154315441545154615471548154915501551155215531554155515561557155815591560156115621563156415651566156715681569157015711572157315741575157615771578157915801581158215831584158515861587158815891590159115921593159415951596159715981599160016011602160316041605160616071608160916101611161216131614161516161617161816191620162116221623162416251626162716281629163016311632163316341635163616371638163916401641164216431644164516461647164816491650165116521653165416551656165716581659166016611662166316641665166616671668166916701671167216731674167516761677167816791680168116821683168416851686168716881689169016911692169316941695169616971698169917001701170217031704170517061707170817091710171117121713171417151716171717181719172017211722172317241725172617271728172917301731173217331734173517361737173817391740174117421743174417451746174717481749175017511752175317541755175617571758175917601761176217631764176517661767176817691770177117721773177417751776177717781779178017811782178317841785178617871788178917901791179217931794179517961797179817991800180118021803180418051806180718081809181018111812181318141815181618171818181918201821182218231824182518261827182818291830183118321833183418351836183718381839184018411842184318441845184618471848184918501851185218531854185518561857185818591860186118621863186418651866186718681869187018711872187318741875187618771878187918801881188218831884188518861887188818891890189118921893189418951896189718981899190019011902190319041905190619071908190919101911191219131914191519161917191819191920192119221923192419251926192719281929193019311932193319341935193619371938193919401941194219431944194519461947194819491950195119521953195419551956195719581959196019611962196319641965196619671968196919701971197219731974197519761977197819791980198119821983198419851986198719881989199019911992199319941995199619971998199920002001200220032004200520062007200820092010201120122013201420152016201720182019202020212022202320242025202620272028202920302031203220332034203520362037203820392040204120422043204420452046204720482049205020512052205320542055205620572058205920602061206220632064206520662067206820692070207120722073207420752076207720782079208020812082208320842085208620872088208920902091209220932094209520962097209820992100210121022103210421052106210721082109211021112112211321142115211621172118211921202121212221232124212521262127212821292130213121322133213421352136213721382139214021412142214321442145214621472148214921502151215221532154215521562157215821592160216121622163216421652166216721682169217021712172217321742175217621772178217921802181218221832184218521862187218821892190219121922193219421952196219721982199220022012202220322042205220622072208220922102211221222132214221522162217221822192220222122222223222422252226222722282229223022312232223322342235223622372238223922402241224222432244224522462247224822492250225122522253225422552256225722582259226022612262226322642265226622672268226922702271227222732274227522762277227822792280228122822283228422852286228722882289229022912292229322942295229622972298229923002301230223032304230523062307230823092310231123122313231423152316231723182319232023212322232323242325232623272328232923302331233223332334233523362337233823392340234123422343234423452346234723482349235023512352235323542355235623572358235923602361236223632364236523662367236823692370237123722373237423752376237723782379238023812382238323842385238623872388238923902391239223932394239523962397239823992400240124022403240424052406240724082409241024112412241324142415241624172418241924202421242224232424242524262427242824292430243124322433243424352436243724382439244024412442244324442445244624472448244924502451245224532454245524562457245824592460246124622463246424652466246724682469247024712472247324742475247624772478247924802481248224832484248524862487248824892490249124922493249424952496249724982499250025012502250325042505250625072508250925102511251225132514251525162517251825192520252125222523252425252526
  1. // SPDX-License-Identifier: GPL-2.0
  2. /*
  3. * builtin-kwork.c
  4. *
  5. * Copyright (c) 2022 Huawei Inc, Yang Jihong <yangjihong1@huawei.com>
  6. */
  7. #include "builtin.h"
  8. #include "util/data.h"
  9. #include "util/evlist.h"
  10. #include "util/evsel.h"
  11. #include "util/header.h"
  12. #include "util/kwork.h"
  13. #include "util/debug.h"
  14. #include "util/session.h"
  15. #include "util/symbol.h"
  16. #include "util/thread.h"
  17. #include "util/string2.h"
  18. #include "util/callchain.h"
  19. #include "util/evsel_fprintf.h"
  20. #include "util/util.h"
  21. #include <subcmd/pager.h>
  22. #include <subcmd/parse-options.h>
  23. #include <traceevent/event-parse.h>
  24. #include <errno.h>
  25. #include <inttypes.h>
  26. #include <signal.h>
  27. #include <linux/err.h>
  28. #include <linux/time64.h>
  29. #include <linux/zalloc.h>
  30. /*
  31. * report header elements width
  32. */
  33. #define PRINT_CPU_WIDTH 4
  34. #define PRINT_COUNT_WIDTH 9
  35. #define PRINT_RUNTIME_WIDTH 10
  36. #define PRINT_LATENCY_WIDTH 10
  37. #define PRINT_TIMESTAMP_WIDTH 17
  38. #define PRINT_KWORK_NAME_WIDTH 30
  39. #define RPINT_DECIMAL_WIDTH 3
  40. #define PRINT_BRACKETPAIR_WIDTH 2
  41. #define PRINT_TIME_UNIT_SEC_WIDTH 2
  42. #define PRINT_TIME_UNIT_MESC_WIDTH 3
  43. #define PRINT_PID_WIDTH 7
  44. #define PRINT_TASK_NAME_WIDTH 16
  45. #define PRINT_CPU_USAGE_WIDTH 6
  46. #define PRINT_CPU_USAGE_DECIMAL_WIDTH 2
  47. #define PRINT_CPU_USAGE_HIST_WIDTH 30
  48. #define PRINT_RUNTIME_HEADER_WIDTH (PRINT_RUNTIME_WIDTH + PRINT_TIME_UNIT_MESC_WIDTH)
  49. #define PRINT_LATENCY_HEADER_WIDTH (PRINT_LATENCY_WIDTH + PRINT_TIME_UNIT_MESC_WIDTH)
  50. #define PRINT_TIMEHIST_CPU_WIDTH (PRINT_CPU_WIDTH + PRINT_BRACKETPAIR_WIDTH)
  51. #define PRINT_TIMESTAMP_HEADER_WIDTH (PRINT_TIMESTAMP_WIDTH + PRINT_TIME_UNIT_SEC_WIDTH)
  52. struct sort_dimension {
  53. const char *name;
  54. int (*cmp)(struct kwork_work *l, struct kwork_work *r);
  55. struct list_head list;
  56. };
  57. static int id_cmp(struct kwork_work *l, struct kwork_work *r)
  58. {
  59. if (l->cpu > r->cpu)
  60. return 1;
  61. if (l->cpu < r->cpu)
  62. return -1;
  63. if (l->id > r->id)
  64. return 1;
  65. if (l->id < r->id)
  66. return -1;
  67. return 0;
  68. }
  69. static int count_cmp(struct kwork_work *l, struct kwork_work *r)
  70. {
  71. if (l->nr_atoms > r->nr_atoms)
  72. return 1;
  73. if (l->nr_atoms < r->nr_atoms)
  74. return -1;
  75. return 0;
  76. }
  77. static int runtime_cmp(struct kwork_work *l, struct kwork_work *r)
  78. {
  79. if (l->total_runtime > r->total_runtime)
  80. return 1;
  81. if (l->total_runtime < r->total_runtime)
  82. return -1;
  83. return 0;
  84. }
  85. static int max_runtime_cmp(struct kwork_work *l, struct kwork_work *r)
  86. {
  87. if (l->max_runtime > r->max_runtime)
  88. return 1;
  89. if (l->max_runtime < r->max_runtime)
  90. return -1;
  91. return 0;
  92. }
  93. static int avg_latency_cmp(struct kwork_work *l, struct kwork_work *r)
  94. {
  95. u64 avgl, avgr;
  96. if (!r->nr_atoms)
  97. return 1;
  98. if (!l->nr_atoms)
  99. return -1;
  100. avgl = l->total_latency / l->nr_atoms;
  101. avgr = r->total_latency / r->nr_atoms;
  102. if (avgl > avgr)
  103. return 1;
  104. if (avgl < avgr)
  105. return -1;
  106. return 0;
  107. }
  108. static int max_latency_cmp(struct kwork_work *l, struct kwork_work *r)
  109. {
  110. if (l->max_latency > r->max_latency)
  111. return 1;
  112. if (l->max_latency < r->max_latency)
  113. return -1;
  114. return 0;
  115. }
  116. static int cpu_usage_cmp(struct kwork_work *l, struct kwork_work *r)
  117. {
  118. if (l->cpu_usage > r->cpu_usage)
  119. return 1;
  120. if (l->cpu_usage < r->cpu_usage)
  121. return -1;
  122. return 0;
  123. }
  124. static int id_or_cpu_r_cmp(struct kwork_work *l, struct kwork_work *r)
  125. {
  126. if (l->id < r->id)
  127. return 1;
  128. if (l->id > r->id)
  129. return -1;
  130. if (l->id != 0)
  131. return 0;
  132. if (l->cpu < r->cpu)
  133. return 1;
  134. if (l->cpu > r->cpu)
  135. return -1;
  136. return 0;
  137. }
  138. static int sort_dimension__add(struct perf_kwork *kwork __maybe_unused,
  139. const char *tok, struct list_head *list)
  140. {
  141. size_t i;
  142. static struct sort_dimension max_sort_dimension = {
  143. .name = "max",
  144. .cmp = max_runtime_cmp,
  145. };
  146. static struct sort_dimension id_sort_dimension = {
  147. .name = "id",
  148. .cmp = id_cmp,
  149. };
  150. static struct sort_dimension runtime_sort_dimension = {
  151. .name = "runtime",
  152. .cmp = runtime_cmp,
  153. };
  154. static struct sort_dimension count_sort_dimension = {
  155. .name = "count",
  156. .cmp = count_cmp,
  157. };
  158. static struct sort_dimension avg_sort_dimension = {
  159. .name = "avg",
  160. .cmp = avg_latency_cmp,
  161. };
  162. static struct sort_dimension rate_sort_dimension = {
  163. .name = "rate",
  164. .cmp = cpu_usage_cmp,
  165. };
  166. static struct sort_dimension tid_sort_dimension = {
  167. .name = "tid",
  168. .cmp = id_or_cpu_r_cmp,
  169. };
  170. struct sort_dimension *available_sorts[] = {
  171. &id_sort_dimension,
  172. &max_sort_dimension,
  173. &count_sort_dimension,
  174. &runtime_sort_dimension,
  175. &avg_sort_dimension,
  176. &rate_sort_dimension,
  177. &tid_sort_dimension,
  178. };
  179. if (kwork->report == KWORK_REPORT_LATENCY)
  180. max_sort_dimension.cmp = max_latency_cmp;
  181. for (i = 0; i < ARRAY_SIZE(available_sorts); i++) {
  182. if (!strcmp(available_sorts[i]->name, tok)) {
  183. list_add_tail(&available_sorts[i]->list, list);
  184. return 0;
  185. }
  186. }
  187. return -1;
  188. }
  189. static void setup_sorting(struct perf_kwork *kwork,
  190. const struct option *options,
  191. const char * const usage_msg[])
  192. {
  193. char *tmp, *tok, *str = strdup(kwork->sort_order);
  194. for (tok = strtok_r(str, ", ", &tmp);
  195. tok; tok = strtok_r(NULL, ", ", &tmp)) {
  196. if (sort_dimension__add(kwork, tok, &kwork->sort_list) < 0)
  197. usage_with_options_msg(usage_msg, options,
  198. "Unknown --sort key: `%s'", tok);
  199. }
  200. pr_debug("Sort order: %s\n", kwork->sort_order);
  201. free(str);
  202. }
  203. static struct kwork_atom *atom_new(struct perf_kwork *kwork,
  204. struct perf_sample *sample)
  205. {
  206. unsigned long i;
  207. struct kwork_atom_page *page;
  208. struct kwork_atom *atom = NULL;
  209. list_for_each_entry(page, &kwork->atom_page_list, list) {
  210. if (!bitmap_full(page->bitmap, NR_ATOM_PER_PAGE)) {
  211. i = find_first_zero_bit(page->bitmap, NR_ATOM_PER_PAGE);
  212. BUG_ON(i >= NR_ATOM_PER_PAGE);
  213. atom = &page->atoms[i];
  214. goto found_atom;
  215. }
  216. }
  217. /*
  218. * new page
  219. */
  220. page = zalloc(sizeof(*page));
  221. if (page == NULL) {
  222. pr_err("Failed to zalloc kwork atom page\n");
  223. return NULL;
  224. }
  225. i = 0;
  226. atom = &page->atoms[0];
  227. list_add_tail(&page->list, &kwork->atom_page_list);
  228. found_atom:
  229. __set_bit(i, page->bitmap);
  230. atom->time = sample->time;
  231. atom->prev = NULL;
  232. atom->page_addr = page;
  233. atom->bit_inpage = i;
  234. return atom;
  235. }
  236. static void atom_free(struct kwork_atom *atom)
  237. {
  238. if (atom->prev != NULL)
  239. atom_free(atom->prev);
  240. __clear_bit(atom->bit_inpage,
  241. ((struct kwork_atom_page *)atom->page_addr)->bitmap);
  242. }
  243. static void atom_del(struct kwork_atom *atom)
  244. {
  245. list_del(&atom->list);
  246. atom_free(atom);
  247. }
  248. static int work_cmp(struct list_head *list,
  249. struct kwork_work *l, struct kwork_work *r)
  250. {
  251. int ret = 0;
  252. struct sort_dimension *sort;
  253. BUG_ON(list_empty(list));
  254. list_for_each_entry(sort, list, list) {
  255. ret = sort->cmp(l, r);
  256. if (ret)
  257. return ret;
  258. }
  259. return ret;
  260. }
  261. static struct kwork_work *work_search(struct rb_root_cached *root,
  262. struct kwork_work *key,
  263. struct list_head *sort_list)
  264. {
  265. int cmp;
  266. struct kwork_work *work;
  267. struct rb_node *node = root->rb_root.rb_node;
  268. while (node) {
  269. work = container_of(node, struct kwork_work, node);
  270. cmp = work_cmp(sort_list, key, work);
  271. if (cmp > 0)
  272. node = node->rb_left;
  273. else if (cmp < 0)
  274. node = node->rb_right;
  275. else {
  276. if (work->name == NULL)
  277. work->name = key->name;
  278. return work;
  279. }
  280. }
  281. return NULL;
  282. }
  283. static void work_insert(struct rb_root_cached *root,
  284. struct kwork_work *key, struct list_head *sort_list)
  285. {
  286. int cmp;
  287. bool leftmost = true;
  288. struct kwork_work *cur;
  289. struct rb_node **new = &(root->rb_root.rb_node), *parent = NULL;
  290. while (*new) {
  291. cur = container_of(*new, struct kwork_work, node);
  292. parent = *new;
  293. cmp = work_cmp(sort_list, key, cur);
  294. if (cmp > 0)
  295. new = &((*new)->rb_left);
  296. else {
  297. new = &((*new)->rb_right);
  298. leftmost = false;
  299. }
  300. }
  301. rb_link_node(&key->node, parent, new);
  302. rb_insert_color_cached(&key->node, root, leftmost);
  303. }
  304. static struct kwork_work *work_new(struct kwork_work *key)
  305. {
  306. int i;
  307. struct kwork_work *work = zalloc(sizeof(*work));
  308. if (work == NULL) {
  309. pr_err("Failed to zalloc kwork work\n");
  310. return NULL;
  311. }
  312. for (i = 0; i < KWORK_TRACE_MAX; i++)
  313. INIT_LIST_HEAD(&work->atom_list[i]);
  314. work->id = key->id;
  315. work->cpu = key->cpu;
  316. work->name = key->name;
  317. work->class = key->class;
  318. return work;
  319. }
  320. static struct kwork_work *work_findnew(struct rb_root_cached *root,
  321. struct kwork_work *key,
  322. struct list_head *sort_list)
  323. {
  324. struct kwork_work *work = work_search(root, key, sort_list);
  325. if (work != NULL)
  326. return work;
  327. work = work_new(key);
  328. if (work)
  329. work_insert(root, work, sort_list);
  330. return work;
  331. }
  332. static void profile_update_timespan(struct perf_kwork *kwork,
  333. struct perf_sample *sample)
  334. {
  335. if (!kwork->summary)
  336. return;
  337. if ((kwork->timestart == 0) || (kwork->timestart > sample->time))
  338. kwork->timestart = sample->time;
  339. if (kwork->timeend < sample->time)
  340. kwork->timeend = sample->time;
  341. }
  342. static bool profile_name_match(struct perf_kwork *kwork,
  343. struct kwork_work *work)
  344. {
  345. if (kwork->profile_name && work->name &&
  346. (strcmp(work->name, kwork->profile_name) != 0)) {
  347. return false;
  348. }
  349. return true;
  350. }
  351. static bool profile_event_match(struct perf_kwork *kwork,
  352. struct kwork_work *work,
  353. struct perf_sample *sample)
  354. {
  355. int cpu = work->cpu;
  356. u64 time = sample->time;
  357. struct perf_time_interval *ptime = &kwork->ptime;
  358. if ((kwork->cpu_list != NULL) && !test_bit(cpu, kwork->cpu_bitmap))
  359. return false;
  360. if (((ptime->start != 0) && (ptime->start > time)) ||
  361. ((ptime->end != 0) && (ptime->end < time)))
  362. return false;
  363. /*
  364. * report top needs to collect the runtime of all tasks to
  365. * calculate the load of each core.
  366. */
  367. if ((kwork->report != KWORK_REPORT_TOP) &&
  368. !profile_name_match(kwork, work)) {
  369. return false;
  370. }
  371. profile_update_timespan(kwork, sample);
  372. return true;
  373. }
  374. static int work_push_atom(struct perf_kwork *kwork,
  375. struct kwork_class *class,
  376. enum kwork_trace_type src_type,
  377. enum kwork_trace_type dst_type,
  378. struct evsel *evsel,
  379. struct perf_sample *sample,
  380. struct machine *machine,
  381. struct kwork_work **ret_work,
  382. bool overwrite)
  383. {
  384. struct kwork_atom *atom, *dst_atom, *last_atom;
  385. struct kwork_work *work, key;
  386. BUG_ON(class->work_init == NULL);
  387. class->work_init(kwork, class, &key, src_type, evsel, sample, machine);
  388. atom = atom_new(kwork, sample);
  389. if (atom == NULL)
  390. return -1;
  391. work = work_findnew(&class->work_root, &key, &kwork->cmp_id);
  392. if (work == NULL) {
  393. atom_free(atom);
  394. return -1;
  395. }
  396. if (!profile_event_match(kwork, work, sample)) {
  397. atom_free(atom);
  398. return 0;
  399. }
  400. if (dst_type < KWORK_TRACE_MAX) {
  401. dst_atom = list_last_entry_or_null(&work->atom_list[dst_type],
  402. struct kwork_atom, list);
  403. if (dst_atom != NULL) {
  404. atom->prev = dst_atom;
  405. list_del(&dst_atom->list);
  406. }
  407. }
  408. if (ret_work != NULL)
  409. *ret_work = work;
  410. if (overwrite) {
  411. last_atom = list_last_entry_or_null(&work->atom_list[src_type],
  412. struct kwork_atom, list);
  413. if (last_atom) {
  414. atom_del(last_atom);
  415. kwork->nr_skipped_events[src_type]++;
  416. kwork->nr_skipped_events[KWORK_TRACE_MAX]++;
  417. }
  418. }
  419. list_add_tail(&atom->list, &work->atom_list[src_type]);
  420. return 0;
  421. }
  422. static struct kwork_atom *work_pop_atom(struct perf_kwork *kwork,
  423. struct kwork_class *class,
  424. enum kwork_trace_type src_type,
  425. enum kwork_trace_type dst_type,
  426. struct evsel *evsel,
  427. struct perf_sample *sample,
  428. struct machine *machine,
  429. struct kwork_work **ret_work)
  430. {
  431. struct kwork_atom *atom, *src_atom;
  432. struct kwork_work *work, key;
  433. BUG_ON(class->work_init == NULL);
  434. class->work_init(kwork, class, &key, src_type, evsel, sample, machine);
  435. work = work_findnew(&class->work_root, &key, &kwork->cmp_id);
  436. if (ret_work != NULL)
  437. *ret_work = work;
  438. if (work == NULL)
  439. return NULL;
  440. if (!profile_event_match(kwork, work, sample))
  441. return NULL;
  442. atom = list_last_entry_or_null(&work->atom_list[dst_type],
  443. struct kwork_atom, list);
  444. if (atom != NULL)
  445. return atom;
  446. src_atom = atom_new(kwork, sample);
  447. if (src_atom != NULL)
  448. list_add_tail(&src_atom->list, &work->atom_list[src_type]);
  449. else {
  450. if (ret_work != NULL)
  451. *ret_work = NULL;
  452. }
  453. return NULL;
  454. }
  455. static struct kwork_work *find_work_by_id(struct rb_root_cached *root,
  456. u64 id, int cpu)
  457. {
  458. struct rb_node *next;
  459. struct kwork_work *work;
  460. next = rb_first_cached(root);
  461. while (next) {
  462. work = rb_entry(next, struct kwork_work, node);
  463. if ((cpu != -1 && work->id == id && work->cpu == cpu) ||
  464. (cpu == -1 && work->id == id))
  465. return work;
  466. next = rb_next(next);
  467. }
  468. return NULL;
  469. }
  470. static struct kwork_class *get_kwork_class(struct perf_kwork *kwork,
  471. enum kwork_class_type type)
  472. {
  473. struct kwork_class *class;
  474. list_for_each_entry(class, &kwork->class_list, list) {
  475. if (class->type == type)
  476. return class;
  477. }
  478. return NULL;
  479. }
  480. static void report_update_exit_event(struct kwork_work *work,
  481. struct kwork_atom *atom,
  482. struct perf_sample *sample)
  483. {
  484. u64 delta;
  485. u64 exit_time = sample->time;
  486. u64 entry_time = atom->time;
  487. if ((entry_time != 0) && (exit_time >= entry_time)) {
  488. delta = exit_time - entry_time;
  489. if ((delta > work->max_runtime) ||
  490. (work->max_runtime == 0)) {
  491. work->max_runtime = delta;
  492. work->max_runtime_start = entry_time;
  493. work->max_runtime_end = exit_time;
  494. }
  495. work->total_runtime += delta;
  496. work->nr_atoms++;
  497. }
  498. }
  499. static int report_entry_event(struct perf_kwork *kwork,
  500. struct kwork_class *class,
  501. struct evsel *evsel,
  502. struct perf_sample *sample,
  503. struct machine *machine)
  504. {
  505. return work_push_atom(kwork, class, KWORK_TRACE_ENTRY,
  506. KWORK_TRACE_MAX, evsel, sample,
  507. machine, NULL, true);
  508. }
  509. static int report_exit_event(struct perf_kwork *kwork,
  510. struct kwork_class *class,
  511. struct evsel *evsel,
  512. struct perf_sample *sample,
  513. struct machine *machine)
  514. {
  515. struct kwork_atom *atom = NULL;
  516. struct kwork_work *work = NULL;
  517. atom = work_pop_atom(kwork, class, KWORK_TRACE_EXIT,
  518. KWORK_TRACE_ENTRY, evsel, sample,
  519. machine, &work);
  520. if (work == NULL)
  521. return -1;
  522. if (atom != NULL) {
  523. report_update_exit_event(work, atom, sample);
  524. atom_del(atom);
  525. }
  526. return 0;
  527. }
  528. static void latency_update_entry_event(struct kwork_work *work,
  529. struct kwork_atom *atom,
  530. struct perf_sample *sample)
  531. {
  532. u64 delta;
  533. u64 entry_time = sample->time;
  534. u64 raise_time = atom->time;
  535. if ((raise_time != 0) && (entry_time >= raise_time)) {
  536. delta = entry_time - raise_time;
  537. if ((delta > work->max_latency) ||
  538. (work->max_latency == 0)) {
  539. work->max_latency = delta;
  540. work->max_latency_start = raise_time;
  541. work->max_latency_end = entry_time;
  542. }
  543. work->total_latency += delta;
  544. work->nr_atoms++;
  545. }
  546. }
  547. static int latency_raise_event(struct perf_kwork *kwork,
  548. struct kwork_class *class,
  549. struct evsel *evsel,
  550. struct perf_sample *sample,
  551. struct machine *machine)
  552. {
  553. return work_push_atom(kwork, class, KWORK_TRACE_RAISE,
  554. KWORK_TRACE_MAX, evsel, sample,
  555. machine, NULL, true);
  556. }
  557. static int latency_entry_event(struct perf_kwork *kwork,
  558. struct kwork_class *class,
  559. struct evsel *evsel,
  560. struct perf_sample *sample,
  561. struct machine *machine)
  562. {
  563. struct kwork_atom *atom = NULL;
  564. struct kwork_work *work = NULL;
  565. atom = work_pop_atom(kwork, class, KWORK_TRACE_ENTRY,
  566. KWORK_TRACE_RAISE, evsel, sample,
  567. machine, &work);
  568. if (work == NULL)
  569. return -1;
  570. if (atom != NULL) {
  571. latency_update_entry_event(work, atom, sample);
  572. atom_del(atom);
  573. }
  574. return 0;
  575. }
  576. static void timehist_save_callchain(struct perf_kwork *kwork,
  577. struct perf_sample *sample,
  578. struct evsel *evsel,
  579. struct machine *machine)
  580. {
  581. struct symbol *sym;
  582. struct thread *thread;
  583. struct callchain_cursor_node *node;
  584. struct callchain_cursor *cursor;
  585. if (!kwork->show_callchain || sample->callchain == NULL)
  586. return;
  587. /* want main thread for process - has maps */
  588. thread = machine__findnew_thread(machine, sample->pid, sample->pid);
  589. if (thread == NULL) {
  590. pr_debug("Failed to get thread for pid %d\n", sample->pid);
  591. return;
  592. }
  593. cursor = get_tls_callchain_cursor();
  594. if (thread__resolve_callchain(thread, cursor, evsel, sample,
  595. NULL, NULL, kwork->max_stack + 2) != 0) {
  596. pr_debug("Failed to resolve callchain, skipping\n");
  597. goto out_put;
  598. }
  599. callchain_cursor_commit(cursor);
  600. while (true) {
  601. node = callchain_cursor_current(cursor);
  602. if (node == NULL)
  603. break;
  604. sym = node->ms.sym;
  605. if (sym) {
  606. if (!strcmp(sym->name, "__softirqentry_text_start") ||
  607. !strcmp(sym->name, "__do_softirq"))
  608. sym->ignore = 1;
  609. }
  610. callchain_cursor_advance(cursor);
  611. }
  612. out_put:
  613. thread__put(thread);
  614. }
  615. static void timehist_print_event(struct perf_kwork *kwork,
  616. struct kwork_work *work,
  617. struct kwork_atom *atom,
  618. struct perf_sample *sample,
  619. struct addr_location *al)
  620. {
  621. char entrytime[32], exittime[32];
  622. char kwork_name[PRINT_KWORK_NAME_WIDTH];
  623. /*
  624. * runtime start
  625. */
  626. timestamp__scnprintf_usec(atom->time,
  627. entrytime, sizeof(entrytime));
  628. printf(" %*s ", PRINT_TIMESTAMP_WIDTH, entrytime);
  629. /*
  630. * runtime end
  631. */
  632. timestamp__scnprintf_usec(sample->time,
  633. exittime, sizeof(exittime));
  634. printf(" %*s ", PRINT_TIMESTAMP_WIDTH, exittime);
  635. /*
  636. * cpu
  637. */
  638. printf(" [%0*d] ", PRINT_CPU_WIDTH, work->cpu);
  639. /*
  640. * kwork name
  641. */
  642. if (work->class && work->class->work_name) {
  643. work->class->work_name(work, kwork_name,
  644. PRINT_KWORK_NAME_WIDTH);
  645. printf(" %-*s ", PRINT_KWORK_NAME_WIDTH, kwork_name);
  646. } else
  647. printf(" %-*s ", PRINT_KWORK_NAME_WIDTH, "");
  648. /*
  649. *runtime
  650. */
  651. printf(" %*.*f ",
  652. PRINT_RUNTIME_WIDTH, RPINT_DECIMAL_WIDTH,
  653. (double)(sample->time - atom->time) / NSEC_PER_MSEC);
  654. /*
  655. * delaytime
  656. */
  657. if (atom->prev != NULL)
  658. printf(" %*.*f ", PRINT_LATENCY_WIDTH, RPINT_DECIMAL_WIDTH,
  659. (double)(atom->time - atom->prev->time) / NSEC_PER_MSEC);
  660. else
  661. printf(" %*s ", PRINT_LATENCY_WIDTH, " ");
  662. /*
  663. * callchain
  664. */
  665. if (kwork->show_callchain) {
  666. struct callchain_cursor *cursor = get_tls_callchain_cursor();
  667. if (cursor == NULL)
  668. return;
  669. printf(" ");
  670. sample__fprintf_sym(sample, al, 0,
  671. EVSEL__PRINT_SYM | EVSEL__PRINT_ONELINE |
  672. EVSEL__PRINT_CALLCHAIN_ARROW |
  673. EVSEL__PRINT_SKIP_IGNORED,
  674. cursor, symbol_conf.bt_stop_list,
  675. stdout);
  676. }
  677. printf("\n");
  678. }
  679. static int timehist_raise_event(struct perf_kwork *kwork,
  680. struct kwork_class *class,
  681. struct evsel *evsel,
  682. struct perf_sample *sample,
  683. struct machine *machine)
  684. {
  685. return work_push_atom(kwork, class, KWORK_TRACE_RAISE,
  686. KWORK_TRACE_MAX, evsel, sample,
  687. machine, NULL, true);
  688. }
  689. static int timehist_entry_event(struct perf_kwork *kwork,
  690. struct kwork_class *class,
  691. struct evsel *evsel,
  692. struct perf_sample *sample,
  693. struct machine *machine)
  694. {
  695. int ret;
  696. struct kwork_work *work = NULL;
  697. ret = work_push_atom(kwork, class, KWORK_TRACE_ENTRY,
  698. KWORK_TRACE_RAISE, evsel, sample,
  699. machine, &work, true);
  700. if (ret)
  701. return ret;
  702. if (work != NULL)
  703. timehist_save_callchain(kwork, sample, evsel, machine);
  704. return 0;
  705. }
  706. static int timehist_exit_event(struct perf_kwork *kwork,
  707. struct kwork_class *class,
  708. struct evsel *evsel,
  709. struct perf_sample *sample,
  710. struct machine *machine)
  711. {
  712. struct kwork_atom *atom = NULL;
  713. struct kwork_work *work = NULL;
  714. struct addr_location al;
  715. int ret = 0;
  716. addr_location__init(&al);
  717. if (machine__resolve(machine, &al, sample) < 0) {
  718. pr_debug("Problem processing event, skipping it\n");
  719. ret = -1;
  720. goto out;
  721. }
  722. atom = work_pop_atom(kwork, class, KWORK_TRACE_EXIT,
  723. KWORK_TRACE_ENTRY, evsel, sample,
  724. machine, &work);
  725. if (work == NULL) {
  726. ret = -1;
  727. goto out;
  728. }
  729. if (atom != NULL) {
  730. work->nr_atoms++;
  731. timehist_print_event(kwork, work, atom, sample, &al);
  732. atom_del(atom);
  733. }
  734. out:
  735. addr_location__exit(&al);
  736. return ret;
  737. }
  738. static void top_update_runtime(struct kwork_work *work,
  739. struct kwork_atom *atom,
  740. struct perf_sample *sample)
  741. {
  742. u64 delta;
  743. u64 exit_time = sample->time;
  744. u64 entry_time = atom->time;
  745. if ((entry_time != 0) && (exit_time >= entry_time)) {
  746. delta = exit_time - entry_time;
  747. work->total_runtime += delta;
  748. }
  749. }
  750. static int top_entry_event(struct perf_kwork *kwork,
  751. struct kwork_class *class,
  752. struct evsel *evsel,
  753. struct perf_sample *sample,
  754. struct machine *machine)
  755. {
  756. return work_push_atom(kwork, class, KWORK_TRACE_ENTRY,
  757. KWORK_TRACE_MAX, evsel, sample,
  758. machine, NULL, true);
  759. }
  760. static int top_exit_event(struct perf_kwork *kwork,
  761. struct kwork_class *class,
  762. struct evsel *evsel,
  763. struct perf_sample *sample,
  764. struct machine *machine)
  765. {
  766. struct kwork_work *work, *sched_work;
  767. struct kwork_class *sched_class;
  768. struct kwork_atom *atom;
  769. atom = work_pop_atom(kwork, class, KWORK_TRACE_EXIT,
  770. KWORK_TRACE_ENTRY, evsel, sample,
  771. machine, &work);
  772. if (!work)
  773. return -1;
  774. if (atom) {
  775. sched_class = get_kwork_class(kwork, KWORK_CLASS_SCHED);
  776. if (sched_class) {
  777. sched_work = find_work_by_id(&sched_class->work_root,
  778. work->id, work->cpu);
  779. if (sched_work)
  780. top_update_runtime(work, atom, sample);
  781. }
  782. atom_del(atom);
  783. }
  784. return 0;
  785. }
  786. static int top_sched_switch_event(struct perf_kwork *kwork,
  787. struct kwork_class *class,
  788. struct evsel *evsel,
  789. struct perf_sample *sample,
  790. struct machine *machine)
  791. {
  792. struct kwork_atom *atom;
  793. struct kwork_work *work;
  794. atom = work_pop_atom(kwork, class, KWORK_TRACE_EXIT,
  795. KWORK_TRACE_ENTRY, evsel, sample,
  796. machine, &work);
  797. if (!work)
  798. return -1;
  799. if (atom) {
  800. top_update_runtime(work, atom, sample);
  801. atom_del(atom);
  802. }
  803. return top_entry_event(kwork, class, evsel, sample, machine);
  804. }
  805. static struct kwork_class kwork_irq;
  806. static int process_irq_handler_entry_event(const struct perf_tool *tool,
  807. struct evsel *evsel,
  808. struct perf_sample *sample,
  809. struct machine *machine)
  810. {
  811. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  812. if (kwork->tp_handler->entry_event)
  813. return kwork->tp_handler->entry_event(kwork, &kwork_irq,
  814. evsel, sample, machine);
  815. return 0;
  816. }
  817. static int process_irq_handler_exit_event(const struct perf_tool *tool,
  818. struct evsel *evsel,
  819. struct perf_sample *sample,
  820. struct machine *machine)
  821. {
  822. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  823. if (kwork->tp_handler->exit_event)
  824. return kwork->tp_handler->exit_event(kwork, &kwork_irq,
  825. evsel, sample, machine);
  826. return 0;
  827. }
  828. const struct evsel_str_handler irq_tp_handlers[] = {
  829. { "irq:irq_handler_entry", process_irq_handler_entry_event, },
  830. { "irq:irq_handler_exit", process_irq_handler_exit_event, },
  831. };
  832. static int irq_class_init(struct kwork_class *class,
  833. struct perf_session *session)
  834. {
  835. if (perf_session__set_tracepoints_handlers(session, irq_tp_handlers)) {
  836. pr_err("Failed to set irq tracepoints handlers\n");
  837. return -1;
  838. }
  839. class->work_root = RB_ROOT_CACHED;
  840. return 0;
  841. }
  842. static void irq_work_init(struct perf_kwork *kwork,
  843. struct kwork_class *class,
  844. struct kwork_work *work,
  845. enum kwork_trace_type src_type __maybe_unused,
  846. struct evsel *evsel,
  847. struct perf_sample *sample,
  848. struct machine *machine __maybe_unused)
  849. {
  850. work->class = class;
  851. work->cpu = sample->cpu;
  852. if (kwork->report == KWORK_REPORT_TOP) {
  853. work->id = evsel__intval_common(evsel, sample, "common_pid");
  854. work->name = NULL;
  855. } else {
  856. work->id = evsel__intval(evsel, sample, "irq");
  857. work->name = evsel__strval(evsel, sample, "name");
  858. }
  859. }
  860. static void irq_work_name(struct kwork_work *work, char *buf, int len)
  861. {
  862. snprintf(buf, len, "%s:%" PRIu64 "", work->name, work->id);
  863. }
  864. static struct kwork_class kwork_irq = {
  865. .name = "irq",
  866. .type = KWORK_CLASS_IRQ,
  867. .nr_tracepoints = 2,
  868. .tp_handlers = irq_tp_handlers,
  869. .class_init = irq_class_init,
  870. .work_init = irq_work_init,
  871. .work_name = irq_work_name,
  872. };
  873. static struct kwork_class kwork_softirq;
  874. static int process_softirq_raise_event(const struct perf_tool *tool,
  875. struct evsel *evsel,
  876. struct perf_sample *sample,
  877. struct machine *machine)
  878. {
  879. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  880. if (kwork->tp_handler->raise_event)
  881. return kwork->tp_handler->raise_event(kwork, &kwork_softirq,
  882. evsel, sample, machine);
  883. return 0;
  884. }
  885. static int process_softirq_entry_event(const struct perf_tool *tool,
  886. struct evsel *evsel,
  887. struct perf_sample *sample,
  888. struct machine *machine)
  889. {
  890. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  891. if (kwork->tp_handler->entry_event)
  892. return kwork->tp_handler->entry_event(kwork, &kwork_softirq,
  893. evsel, sample, machine);
  894. return 0;
  895. }
  896. static int process_softirq_exit_event(const struct perf_tool *tool,
  897. struct evsel *evsel,
  898. struct perf_sample *sample,
  899. struct machine *machine)
  900. {
  901. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  902. if (kwork->tp_handler->exit_event)
  903. return kwork->tp_handler->exit_event(kwork, &kwork_softirq,
  904. evsel, sample, machine);
  905. return 0;
  906. }
  907. const struct evsel_str_handler softirq_tp_handlers[] = {
  908. { "irq:softirq_raise", process_softirq_raise_event, },
  909. { "irq:softirq_entry", process_softirq_entry_event, },
  910. { "irq:softirq_exit", process_softirq_exit_event, },
  911. };
  912. static int softirq_class_init(struct kwork_class *class,
  913. struct perf_session *session)
  914. {
  915. if (perf_session__set_tracepoints_handlers(session,
  916. softirq_tp_handlers)) {
  917. pr_err("Failed to set softirq tracepoints handlers\n");
  918. return -1;
  919. }
  920. class->work_root = RB_ROOT_CACHED;
  921. return 0;
  922. }
  923. static char *evsel__softirq_name(struct evsel *evsel, u64 num)
  924. {
  925. char *name = NULL;
  926. bool found = false;
  927. struct tep_print_flag_sym *sym = NULL;
  928. struct tep_print_arg *args = evsel->tp_format->print_fmt.args;
  929. if ((args == NULL) || (args->next == NULL))
  930. return NULL;
  931. /* skip softirq field: "REC->vec" */
  932. for (sym = args->next->symbol.symbols; sym != NULL; sym = sym->next) {
  933. if ((eval_flag(sym->value) == (unsigned long long)num) &&
  934. (strlen(sym->str) != 0)) {
  935. found = true;
  936. break;
  937. }
  938. }
  939. if (!found)
  940. return NULL;
  941. name = strdup(sym->str);
  942. if (name == NULL) {
  943. pr_err("Failed to copy symbol name\n");
  944. return NULL;
  945. }
  946. return name;
  947. }
  948. static void softirq_work_init(struct perf_kwork *kwork,
  949. struct kwork_class *class,
  950. struct kwork_work *work,
  951. enum kwork_trace_type src_type __maybe_unused,
  952. struct evsel *evsel,
  953. struct perf_sample *sample,
  954. struct machine *machine __maybe_unused)
  955. {
  956. u64 num;
  957. work->class = class;
  958. work->cpu = sample->cpu;
  959. if (kwork->report == KWORK_REPORT_TOP) {
  960. work->id = evsel__intval_common(evsel, sample, "common_pid");
  961. work->name = NULL;
  962. } else {
  963. num = evsel__intval(evsel, sample, "vec");
  964. work->id = num;
  965. work->name = evsel__softirq_name(evsel, num);
  966. }
  967. }
  968. static void softirq_work_name(struct kwork_work *work, char *buf, int len)
  969. {
  970. snprintf(buf, len, "(s)%s:%" PRIu64 "", work->name, work->id);
  971. }
  972. static struct kwork_class kwork_softirq = {
  973. .name = "softirq",
  974. .type = KWORK_CLASS_SOFTIRQ,
  975. .nr_tracepoints = 3,
  976. .tp_handlers = softirq_tp_handlers,
  977. .class_init = softirq_class_init,
  978. .work_init = softirq_work_init,
  979. .work_name = softirq_work_name,
  980. };
  981. static struct kwork_class kwork_workqueue;
  982. static int process_workqueue_activate_work_event(const struct perf_tool *tool,
  983. struct evsel *evsel,
  984. struct perf_sample *sample,
  985. struct machine *machine)
  986. {
  987. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  988. if (kwork->tp_handler->raise_event)
  989. return kwork->tp_handler->raise_event(kwork, &kwork_workqueue,
  990. evsel, sample, machine);
  991. return 0;
  992. }
  993. static int process_workqueue_execute_start_event(const struct perf_tool *tool,
  994. struct evsel *evsel,
  995. struct perf_sample *sample,
  996. struct machine *machine)
  997. {
  998. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  999. if (kwork->tp_handler->entry_event)
  1000. return kwork->tp_handler->entry_event(kwork, &kwork_workqueue,
  1001. evsel, sample, machine);
  1002. return 0;
  1003. }
  1004. static int process_workqueue_execute_end_event(const struct perf_tool *tool,
  1005. struct evsel *evsel,
  1006. struct perf_sample *sample,
  1007. struct machine *machine)
  1008. {
  1009. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  1010. if (kwork->tp_handler->exit_event)
  1011. return kwork->tp_handler->exit_event(kwork, &kwork_workqueue,
  1012. evsel, sample, machine);
  1013. return 0;
  1014. }
  1015. const struct evsel_str_handler workqueue_tp_handlers[] = {
  1016. { "workqueue:workqueue_activate_work", process_workqueue_activate_work_event, },
  1017. { "workqueue:workqueue_execute_start", process_workqueue_execute_start_event, },
  1018. { "workqueue:workqueue_execute_end", process_workqueue_execute_end_event, },
  1019. };
  1020. static int workqueue_class_init(struct kwork_class *class,
  1021. struct perf_session *session)
  1022. {
  1023. if (perf_session__set_tracepoints_handlers(session,
  1024. workqueue_tp_handlers)) {
  1025. pr_err("Failed to set workqueue tracepoints handlers\n");
  1026. return -1;
  1027. }
  1028. class->work_root = RB_ROOT_CACHED;
  1029. return 0;
  1030. }
  1031. static void workqueue_work_init(struct perf_kwork *kwork __maybe_unused,
  1032. struct kwork_class *class,
  1033. struct kwork_work *work,
  1034. enum kwork_trace_type src_type __maybe_unused,
  1035. struct evsel *evsel,
  1036. struct perf_sample *sample,
  1037. struct machine *machine)
  1038. {
  1039. char *modp = NULL;
  1040. unsigned long long function_addr = evsel__intval(evsel,
  1041. sample, "function");
  1042. work->class = class;
  1043. work->cpu = sample->cpu;
  1044. work->id = evsel__intval(evsel, sample, "work");
  1045. work->name = function_addr == 0 ? NULL :
  1046. machine__resolve_kernel_addr(machine, &function_addr, &modp);
  1047. }
  1048. static void workqueue_work_name(struct kwork_work *work, char *buf, int len)
  1049. {
  1050. if (work->name != NULL)
  1051. snprintf(buf, len, "(w)%s", work->name);
  1052. else
  1053. snprintf(buf, len, "(w)0x%" PRIx64, work->id);
  1054. }
  1055. static struct kwork_class kwork_workqueue = {
  1056. .name = "workqueue",
  1057. .type = KWORK_CLASS_WORKQUEUE,
  1058. .nr_tracepoints = 3,
  1059. .tp_handlers = workqueue_tp_handlers,
  1060. .class_init = workqueue_class_init,
  1061. .work_init = workqueue_work_init,
  1062. .work_name = workqueue_work_name,
  1063. };
  1064. static struct kwork_class kwork_sched;
  1065. static int process_sched_switch_event(const struct perf_tool *tool,
  1066. struct evsel *evsel,
  1067. struct perf_sample *sample,
  1068. struct machine *machine)
  1069. {
  1070. struct perf_kwork *kwork = container_of(tool, struct perf_kwork, tool);
  1071. if (kwork->tp_handler->sched_switch_event)
  1072. return kwork->tp_handler->sched_switch_event(kwork, &kwork_sched,
  1073. evsel, sample, machine);
  1074. return 0;
  1075. }
  1076. const struct evsel_str_handler sched_tp_handlers[] = {
  1077. { "sched:sched_switch", process_sched_switch_event, },
  1078. };
  1079. static int sched_class_init(struct kwork_class *class,
  1080. struct perf_session *session)
  1081. {
  1082. if (perf_session__set_tracepoints_handlers(session,
  1083. sched_tp_handlers)) {
  1084. pr_err("Failed to set sched tracepoints handlers\n");
  1085. return -1;
  1086. }
  1087. class->work_root = RB_ROOT_CACHED;
  1088. return 0;
  1089. }
  1090. static void sched_work_init(struct perf_kwork *kwork __maybe_unused,
  1091. struct kwork_class *class,
  1092. struct kwork_work *work,
  1093. enum kwork_trace_type src_type,
  1094. struct evsel *evsel,
  1095. struct perf_sample *sample,
  1096. struct machine *machine __maybe_unused)
  1097. {
  1098. work->class = class;
  1099. work->cpu = sample->cpu;
  1100. if (src_type == KWORK_TRACE_EXIT) {
  1101. work->id = evsel__intval(evsel, sample, "prev_pid");
  1102. work->name = strdup(evsel__strval(evsel, sample, "prev_comm"));
  1103. } else if (src_type == KWORK_TRACE_ENTRY) {
  1104. work->id = evsel__intval(evsel, sample, "next_pid");
  1105. work->name = strdup(evsel__strval(evsel, sample, "next_comm"));
  1106. }
  1107. }
  1108. static void sched_work_name(struct kwork_work *work, char *buf, int len)
  1109. {
  1110. snprintf(buf, len, "%s", work->name);
  1111. }
  1112. static struct kwork_class kwork_sched = {
  1113. .name = "sched",
  1114. .type = KWORK_CLASS_SCHED,
  1115. .nr_tracepoints = ARRAY_SIZE(sched_tp_handlers),
  1116. .tp_handlers = sched_tp_handlers,
  1117. .class_init = sched_class_init,
  1118. .work_init = sched_work_init,
  1119. .work_name = sched_work_name,
  1120. };
  1121. static struct kwork_class *kwork_class_supported_list[KWORK_CLASS_MAX] = {
  1122. [KWORK_CLASS_IRQ] = &kwork_irq,
  1123. [KWORK_CLASS_SOFTIRQ] = &kwork_softirq,
  1124. [KWORK_CLASS_WORKQUEUE] = &kwork_workqueue,
  1125. [KWORK_CLASS_SCHED] = &kwork_sched,
  1126. };
  1127. static void print_separator(int len)
  1128. {
  1129. printf(" %.*s\n", len, graph_dotted_line);
  1130. }
  1131. static int report_print_work(struct perf_kwork *kwork, struct kwork_work *work)
  1132. {
  1133. int ret = 0;
  1134. char kwork_name[PRINT_KWORK_NAME_WIDTH];
  1135. char max_runtime_start[32], max_runtime_end[32];
  1136. char max_latency_start[32], max_latency_end[32];
  1137. printf(" ");
  1138. /*
  1139. * kwork name
  1140. */
  1141. if (work->class && work->class->work_name) {
  1142. work->class->work_name(work, kwork_name,
  1143. PRINT_KWORK_NAME_WIDTH);
  1144. ret += printf(" %-*s |", PRINT_KWORK_NAME_WIDTH, kwork_name);
  1145. } else {
  1146. ret += printf(" %-*s |", PRINT_KWORK_NAME_WIDTH, "");
  1147. }
  1148. /*
  1149. * cpu
  1150. */
  1151. ret += printf(" %0*d |", PRINT_CPU_WIDTH, work->cpu);
  1152. /*
  1153. * total runtime
  1154. */
  1155. if (kwork->report == KWORK_REPORT_RUNTIME) {
  1156. ret += printf(" %*.*f ms |",
  1157. PRINT_RUNTIME_WIDTH, RPINT_DECIMAL_WIDTH,
  1158. (double)work->total_runtime / NSEC_PER_MSEC);
  1159. } else if (kwork->report == KWORK_REPORT_LATENCY) { // avg delay
  1160. ret += printf(" %*.*f ms |",
  1161. PRINT_LATENCY_WIDTH, RPINT_DECIMAL_WIDTH,
  1162. (double)work->total_latency /
  1163. work->nr_atoms / NSEC_PER_MSEC);
  1164. }
  1165. /*
  1166. * count
  1167. */
  1168. ret += printf(" %*" PRIu64 " |", PRINT_COUNT_WIDTH, work->nr_atoms);
  1169. /*
  1170. * max runtime, max runtime start, max runtime end
  1171. */
  1172. if (kwork->report == KWORK_REPORT_RUNTIME) {
  1173. timestamp__scnprintf_usec(work->max_runtime_start,
  1174. max_runtime_start,
  1175. sizeof(max_runtime_start));
  1176. timestamp__scnprintf_usec(work->max_runtime_end,
  1177. max_runtime_end,
  1178. sizeof(max_runtime_end));
  1179. ret += printf(" %*.*f ms | %*s s | %*s s |",
  1180. PRINT_RUNTIME_WIDTH, RPINT_DECIMAL_WIDTH,
  1181. (double)work->max_runtime / NSEC_PER_MSEC,
  1182. PRINT_TIMESTAMP_WIDTH, max_runtime_start,
  1183. PRINT_TIMESTAMP_WIDTH, max_runtime_end);
  1184. }
  1185. /*
  1186. * max delay, max delay start, max delay end
  1187. */
  1188. else if (kwork->report == KWORK_REPORT_LATENCY) {
  1189. timestamp__scnprintf_usec(work->max_latency_start,
  1190. max_latency_start,
  1191. sizeof(max_latency_start));
  1192. timestamp__scnprintf_usec(work->max_latency_end,
  1193. max_latency_end,
  1194. sizeof(max_latency_end));
  1195. ret += printf(" %*.*f ms | %*s s | %*s s |",
  1196. PRINT_LATENCY_WIDTH, RPINT_DECIMAL_WIDTH,
  1197. (double)work->max_latency / NSEC_PER_MSEC,
  1198. PRINT_TIMESTAMP_WIDTH, max_latency_start,
  1199. PRINT_TIMESTAMP_WIDTH, max_latency_end);
  1200. }
  1201. printf("\n");
  1202. return ret;
  1203. }
  1204. static int report_print_header(struct perf_kwork *kwork)
  1205. {
  1206. int ret;
  1207. printf("\n ");
  1208. ret = printf(" %-*s | %-*s |",
  1209. PRINT_KWORK_NAME_WIDTH, "Kwork Name",
  1210. PRINT_CPU_WIDTH, "Cpu");
  1211. if (kwork->report == KWORK_REPORT_RUNTIME) {
  1212. ret += printf(" %-*s |",
  1213. PRINT_RUNTIME_HEADER_WIDTH, "Total Runtime");
  1214. } else if (kwork->report == KWORK_REPORT_LATENCY) {
  1215. ret += printf(" %-*s |",
  1216. PRINT_LATENCY_HEADER_WIDTH, "Avg delay");
  1217. }
  1218. ret += printf(" %-*s |", PRINT_COUNT_WIDTH, "Count");
  1219. if (kwork->report == KWORK_REPORT_RUNTIME) {
  1220. ret += printf(" %-*s | %-*s | %-*s |",
  1221. PRINT_RUNTIME_HEADER_WIDTH, "Max runtime",
  1222. PRINT_TIMESTAMP_HEADER_WIDTH, "Max runtime start",
  1223. PRINT_TIMESTAMP_HEADER_WIDTH, "Max runtime end");
  1224. } else if (kwork->report == KWORK_REPORT_LATENCY) {
  1225. ret += printf(" %-*s | %-*s | %-*s |",
  1226. PRINT_LATENCY_HEADER_WIDTH, "Max delay",
  1227. PRINT_TIMESTAMP_HEADER_WIDTH, "Max delay start",
  1228. PRINT_TIMESTAMP_HEADER_WIDTH, "Max delay end");
  1229. }
  1230. printf("\n");
  1231. print_separator(ret);
  1232. return ret;
  1233. }
  1234. static void timehist_print_header(void)
  1235. {
  1236. /*
  1237. * header row
  1238. */
  1239. printf(" %-*s %-*s %-*s %-*s %-*s %-*s\n",
  1240. PRINT_TIMESTAMP_WIDTH, "Runtime start",
  1241. PRINT_TIMESTAMP_WIDTH, "Runtime end",
  1242. PRINT_TIMEHIST_CPU_WIDTH, "Cpu",
  1243. PRINT_KWORK_NAME_WIDTH, "Kwork name",
  1244. PRINT_RUNTIME_WIDTH, "Runtime",
  1245. PRINT_RUNTIME_WIDTH, "Delaytime");
  1246. /*
  1247. * units row
  1248. */
  1249. printf(" %-*s %-*s %-*s %-*s %-*s %-*s\n",
  1250. PRINT_TIMESTAMP_WIDTH, "",
  1251. PRINT_TIMESTAMP_WIDTH, "",
  1252. PRINT_TIMEHIST_CPU_WIDTH, "",
  1253. PRINT_KWORK_NAME_WIDTH, "(TYPE)NAME:NUM",
  1254. PRINT_RUNTIME_WIDTH, "(msec)",
  1255. PRINT_RUNTIME_WIDTH, "(msec)");
  1256. /*
  1257. * separator
  1258. */
  1259. printf(" %.*s %.*s %.*s %.*s %.*s %.*s\n",
  1260. PRINT_TIMESTAMP_WIDTH, graph_dotted_line,
  1261. PRINT_TIMESTAMP_WIDTH, graph_dotted_line,
  1262. PRINT_TIMEHIST_CPU_WIDTH, graph_dotted_line,
  1263. PRINT_KWORK_NAME_WIDTH, graph_dotted_line,
  1264. PRINT_RUNTIME_WIDTH, graph_dotted_line,
  1265. PRINT_RUNTIME_WIDTH, graph_dotted_line);
  1266. }
  1267. static void print_summary(struct perf_kwork *kwork)
  1268. {
  1269. u64 time = kwork->timeend - kwork->timestart;
  1270. printf(" Total count : %9" PRIu64 "\n", kwork->all_count);
  1271. printf(" Total runtime (msec) : %9.3f (%.3f%% load average)\n",
  1272. (double)kwork->all_runtime / NSEC_PER_MSEC,
  1273. time == 0 ? 0 : (double)kwork->all_runtime / time);
  1274. printf(" Total time span (msec) : %9.3f\n",
  1275. (double)time / NSEC_PER_MSEC);
  1276. }
  1277. static unsigned long long nr_list_entry(struct list_head *head)
  1278. {
  1279. struct list_head *pos;
  1280. unsigned long long n = 0;
  1281. list_for_each(pos, head)
  1282. n++;
  1283. return n;
  1284. }
  1285. static void print_skipped_events(struct perf_kwork *kwork)
  1286. {
  1287. int i;
  1288. const char *const kwork_event_str[] = {
  1289. [KWORK_TRACE_RAISE] = "raise",
  1290. [KWORK_TRACE_ENTRY] = "entry",
  1291. [KWORK_TRACE_EXIT] = "exit",
  1292. };
  1293. if ((kwork->nr_skipped_events[KWORK_TRACE_MAX] != 0) &&
  1294. (kwork->nr_events != 0)) {
  1295. printf(" INFO: %.3f%% skipped events (%" PRIu64 " including ",
  1296. (double)kwork->nr_skipped_events[KWORK_TRACE_MAX] /
  1297. (double)kwork->nr_events * 100.0,
  1298. kwork->nr_skipped_events[KWORK_TRACE_MAX]);
  1299. for (i = 0; i < KWORK_TRACE_MAX; i++) {
  1300. printf("%" PRIu64 " %s%s",
  1301. kwork->nr_skipped_events[i],
  1302. kwork_event_str[i],
  1303. (i == KWORK_TRACE_MAX - 1) ? ")\n" : ", ");
  1304. }
  1305. }
  1306. if (verbose > 0)
  1307. printf(" INFO: use %lld atom pages\n",
  1308. nr_list_entry(&kwork->atom_page_list));
  1309. }
  1310. static void print_bad_events(struct perf_kwork *kwork)
  1311. {
  1312. if ((kwork->nr_lost_events != 0) && (kwork->nr_events != 0)) {
  1313. printf(" INFO: %.3f%% lost events (%ld out of %ld, in %ld chunks)\n",
  1314. (double)kwork->nr_lost_events /
  1315. (double)kwork->nr_events * 100.0,
  1316. kwork->nr_lost_events, kwork->nr_events,
  1317. kwork->nr_lost_chunks);
  1318. }
  1319. }
  1320. const char *graph_load = "||||||||||||||||||||||||||||||||||||||||||||||||";
  1321. const char *graph_idle = " ";
  1322. static void top_print_per_cpu_load(struct perf_kwork *kwork)
  1323. {
  1324. int i, load_width;
  1325. u64 total, load, load_ratio;
  1326. struct kwork_top_stat *stat = &kwork->top_stat;
  1327. for (i = 0; i < MAX_NR_CPUS; i++) {
  1328. total = stat->cpus_runtime[i].total;
  1329. load = stat->cpus_runtime[i].load;
  1330. if (test_bit(i, stat->all_cpus_bitmap) && total) {
  1331. load_ratio = load * 10000 / total;
  1332. load_width = PRINT_CPU_USAGE_HIST_WIDTH *
  1333. load_ratio / 10000;
  1334. printf("%%Cpu%-*d[%.*s%.*s %*.*f%%]\n",
  1335. PRINT_CPU_WIDTH, i,
  1336. load_width, graph_load,
  1337. PRINT_CPU_USAGE_HIST_WIDTH - load_width,
  1338. graph_idle,
  1339. PRINT_CPU_USAGE_WIDTH,
  1340. PRINT_CPU_USAGE_DECIMAL_WIDTH,
  1341. (double)load_ratio / 100);
  1342. }
  1343. }
  1344. }
  1345. static void top_print_cpu_usage(struct perf_kwork *kwork)
  1346. {
  1347. struct kwork_top_stat *stat = &kwork->top_stat;
  1348. u64 idle_time = stat->cpus_runtime[MAX_NR_CPUS].idle;
  1349. u64 hardirq_time = stat->cpus_runtime[MAX_NR_CPUS].irq;
  1350. u64 softirq_time = stat->cpus_runtime[MAX_NR_CPUS].softirq;
  1351. int cpus_nr = bitmap_weight(stat->all_cpus_bitmap, MAX_NR_CPUS);
  1352. u64 cpus_total_time = stat->cpus_runtime[MAX_NR_CPUS].total;
  1353. printf("Total : %*.*f ms, %d cpus\n",
  1354. PRINT_RUNTIME_WIDTH, RPINT_DECIMAL_WIDTH,
  1355. (double)cpus_total_time / NSEC_PER_MSEC,
  1356. cpus_nr);
  1357. printf("%%Cpu(s): %*.*f%% id, %*.*f%% hi, %*.*f%% si\n",
  1358. PRINT_CPU_USAGE_WIDTH, PRINT_CPU_USAGE_DECIMAL_WIDTH,
  1359. cpus_total_time ? (double)idle_time * 100 / cpus_total_time : 0,
  1360. PRINT_CPU_USAGE_WIDTH, PRINT_CPU_USAGE_DECIMAL_WIDTH,
  1361. cpus_total_time ? (double)hardirq_time * 100 / cpus_total_time : 0,
  1362. PRINT_CPU_USAGE_WIDTH, PRINT_CPU_USAGE_DECIMAL_WIDTH,
  1363. cpus_total_time ? (double)softirq_time * 100 / cpus_total_time : 0);
  1364. top_print_per_cpu_load(kwork);
  1365. }
  1366. static void top_print_header(struct perf_kwork *kwork __maybe_unused)
  1367. {
  1368. int ret;
  1369. printf("\n ");
  1370. ret = printf(" %*s %s%*s%s %*s %*s %-*s",
  1371. PRINT_PID_WIDTH, "PID",
  1372. kwork->use_bpf ? " " : "",
  1373. kwork->use_bpf ? PRINT_PID_WIDTH : 0,
  1374. kwork->use_bpf ? "SPID" : "",
  1375. kwork->use_bpf ? " " : "",
  1376. PRINT_CPU_USAGE_WIDTH, "%CPU",
  1377. PRINT_RUNTIME_HEADER_WIDTH + RPINT_DECIMAL_WIDTH, "RUNTIME",
  1378. PRINT_TASK_NAME_WIDTH, "COMMAND");
  1379. printf("\n ");
  1380. print_separator(ret);
  1381. }
  1382. static int top_print_work(struct perf_kwork *kwork __maybe_unused, struct kwork_work *work)
  1383. {
  1384. int ret = 0;
  1385. printf(" ");
  1386. /*
  1387. * pid
  1388. */
  1389. ret += printf(" %*" PRIu64 " ", PRINT_PID_WIDTH, work->id);
  1390. /*
  1391. * tgid
  1392. */
  1393. if (kwork->use_bpf)
  1394. ret += printf(" %*d ", PRINT_PID_WIDTH, work->tgid);
  1395. /*
  1396. * cpu usage
  1397. */
  1398. ret += printf(" %*.*f ",
  1399. PRINT_CPU_USAGE_WIDTH, PRINT_CPU_USAGE_DECIMAL_WIDTH,
  1400. (double)work->cpu_usage / 100);
  1401. /*
  1402. * total runtime
  1403. */
  1404. ret += printf(" %*.*f ms ",
  1405. PRINT_RUNTIME_WIDTH + RPINT_DECIMAL_WIDTH, RPINT_DECIMAL_WIDTH,
  1406. (double)work->total_runtime / NSEC_PER_MSEC);
  1407. /*
  1408. * command
  1409. */
  1410. if (kwork->use_bpf)
  1411. ret += printf(" %s%s%s",
  1412. work->is_kthread ? "[" : "",
  1413. work->name,
  1414. work->is_kthread ? "]" : "");
  1415. else
  1416. ret += printf(" %-*s", PRINT_TASK_NAME_WIDTH, work->name);
  1417. printf("\n");
  1418. return ret;
  1419. }
  1420. static void work_sort(struct perf_kwork *kwork,
  1421. struct kwork_class *class, struct rb_root_cached *root)
  1422. {
  1423. struct rb_node *node;
  1424. struct kwork_work *data;
  1425. pr_debug("Sorting %s ...\n", class->name);
  1426. for (;;) {
  1427. node = rb_first_cached(root);
  1428. if (!node)
  1429. break;
  1430. rb_erase_cached(node, root);
  1431. data = rb_entry(node, struct kwork_work, node);
  1432. work_insert(&kwork->sorted_work_root,
  1433. data, &kwork->sort_list);
  1434. }
  1435. }
  1436. static void perf_kwork__sort(struct perf_kwork *kwork)
  1437. {
  1438. struct kwork_class *class;
  1439. list_for_each_entry(class, &kwork->class_list, list)
  1440. work_sort(kwork, class, &class->work_root);
  1441. }
  1442. static int perf_kwork__check_config(struct perf_kwork *kwork,
  1443. struct perf_session *session)
  1444. {
  1445. int ret;
  1446. struct evsel *evsel;
  1447. struct kwork_class *class;
  1448. static struct trace_kwork_handler report_ops = {
  1449. .entry_event = report_entry_event,
  1450. .exit_event = report_exit_event,
  1451. };
  1452. static struct trace_kwork_handler latency_ops = {
  1453. .raise_event = latency_raise_event,
  1454. .entry_event = latency_entry_event,
  1455. };
  1456. static struct trace_kwork_handler timehist_ops = {
  1457. .raise_event = timehist_raise_event,
  1458. .entry_event = timehist_entry_event,
  1459. .exit_event = timehist_exit_event,
  1460. };
  1461. static struct trace_kwork_handler top_ops = {
  1462. .entry_event = timehist_entry_event,
  1463. .exit_event = top_exit_event,
  1464. .sched_switch_event = top_sched_switch_event,
  1465. };
  1466. switch (kwork->report) {
  1467. case KWORK_REPORT_RUNTIME:
  1468. kwork->tp_handler = &report_ops;
  1469. break;
  1470. case KWORK_REPORT_LATENCY:
  1471. kwork->tp_handler = &latency_ops;
  1472. break;
  1473. case KWORK_REPORT_TIMEHIST:
  1474. kwork->tp_handler = &timehist_ops;
  1475. break;
  1476. case KWORK_REPORT_TOP:
  1477. kwork->tp_handler = &top_ops;
  1478. break;
  1479. default:
  1480. pr_debug("Invalid report type %d\n", kwork->report);
  1481. return -1;
  1482. }
  1483. list_for_each_entry(class, &kwork->class_list, list)
  1484. if ((class->class_init != NULL) &&
  1485. (class->class_init(class, session) != 0))
  1486. return -1;
  1487. if (kwork->cpu_list != NULL) {
  1488. ret = perf_session__cpu_bitmap(session,
  1489. kwork->cpu_list,
  1490. kwork->cpu_bitmap);
  1491. if (ret < 0) {
  1492. pr_err("Invalid cpu bitmap\n");
  1493. return -1;
  1494. }
  1495. }
  1496. if (kwork->time_str != NULL) {
  1497. ret = perf_time__parse_str(&kwork->ptime, kwork->time_str);
  1498. if (ret != 0) {
  1499. pr_err("Invalid time span\n");
  1500. return -1;
  1501. }
  1502. }
  1503. list_for_each_entry(evsel, &session->evlist->core.entries, core.node) {
  1504. if (kwork->show_callchain && !evsel__has_callchain(evsel)) {
  1505. pr_debug("Samples do not have callchains\n");
  1506. kwork->show_callchain = 0;
  1507. symbol_conf.use_callchain = 0;
  1508. }
  1509. }
  1510. return 0;
  1511. }
  1512. static int perf_kwork__read_events(struct perf_kwork *kwork)
  1513. {
  1514. int ret = -1;
  1515. struct perf_session *session = NULL;
  1516. struct perf_data data = {
  1517. .path = input_name,
  1518. .mode = PERF_DATA_MODE_READ,
  1519. .force = kwork->force,
  1520. };
  1521. session = perf_session__new(&data, &kwork->tool);
  1522. if (IS_ERR(session)) {
  1523. pr_debug("Error creating perf session\n");
  1524. return PTR_ERR(session);
  1525. }
  1526. symbol__init(&session->header.env);
  1527. if (perf_kwork__check_config(kwork, session) != 0)
  1528. goto out_delete;
  1529. if (session->tevent.pevent &&
  1530. tep_set_function_resolver(session->tevent.pevent,
  1531. machine__resolve_kernel_addr,
  1532. &session->machines.host) < 0) {
  1533. pr_err("Failed to set libtraceevent function resolver\n");
  1534. goto out_delete;
  1535. }
  1536. if (kwork->report == KWORK_REPORT_TIMEHIST)
  1537. timehist_print_header();
  1538. ret = perf_session__process_events(session);
  1539. if (ret) {
  1540. pr_debug("Failed to process events, error %d\n", ret);
  1541. goto out_delete;
  1542. }
  1543. kwork->nr_events = session->evlist->stats.nr_events[0];
  1544. kwork->nr_lost_events = session->evlist->stats.total_lost;
  1545. kwork->nr_lost_chunks = session->evlist->stats.nr_events[PERF_RECORD_LOST];
  1546. out_delete:
  1547. perf_session__delete(session);
  1548. return ret;
  1549. }
  1550. static void process_skipped_events(struct perf_kwork *kwork,
  1551. struct kwork_work *work)
  1552. {
  1553. int i;
  1554. unsigned long long count;
  1555. for (i = 0; i < KWORK_TRACE_MAX; i++) {
  1556. count = nr_list_entry(&work->atom_list[i]);
  1557. kwork->nr_skipped_events[i] += count;
  1558. kwork->nr_skipped_events[KWORK_TRACE_MAX] += count;
  1559. }
  1560. }
  1561. struct kwork_work *perf_kwork_add_work(struct perf_kwork *kwork,
  1562. struct kwork_class *class,
  1563. struct kwork_work *key)
  1564. {
  1565. struct kwork_work *work = NULL;
  1566. work = work_new(key);
  1567. if (work == NULL)
  1568. return NULL;
  1569. work_insert(&class->work_root, work, &kwork->cmp_id);
  1570. return work;
  1571. }
  1572. static void sig_handler(int sig)
  1573. {
  1574. /*
  1575. * Simply capture termination signal so that
  1576. * the program can continue after pause returns
  1577. */
  1578. pr_debug("Capture signal %d\n", sig);
  1579. }
  1580. static int perf_kwork__report_bpf(struct perf_kwork *kwork)
  1581. {
  1582. int ret;
  1583. signal(SIGINT, sig_handler);
  1584. signal(SIGTERM, sig_handler);
  1585. ret = perf_kwork__trace_prepare_bpf(kwork);
  1586. if (ret)
  1587. return -1;
  1588. printf("Starting trace, Hit <Ctrl+C> to stop and report\n");
  1589. perf_kwork__trace_start();
  1590. /*
  1591. * a simple pause, wait here for stop signal
  1592. */
  1593. pause();
  1594. perf_kwork__trace_finish();
  1595. perf_kwork__report_read_bpf(kwork);
  1596. perf_kwork__report_cleanup_bpf();
  1597. return 0;
  1598. }
  1599. static int perf_kwork__report(struct perf_kwork *kwork)
  1600. {
  1601. int ret;
  1602. struct rb_node *next;
  1603. struct kwork_work *work;
  1604. if (kwork->use_bpf)
  1605. ret = perf_kwork__report_bpf(kwork);
  1606. else
  1607. ret = perf_kwork__read_events(kwork);
  1608. if (ret != 0)
  1609. return -1;
  1610. perf_kwork__sort(kwork);
  1611. setup_pager();
  1612. ret = report_print_header(kwork);
  1613. next = rb_first_cached(&kwork->sorted_work_root);
  1614. while (next) {
  1615. work = rb_entry(next, struct kwork_work, node);
  1616. process_skipped_events(kwork, work);
  1617. if (work->nr_atoms != 0) {
  1618. report_print_work(kwork, work);
  1619. if (kwork->summary) {
  1620. kwork->all_runtime += work->total_runtime;
  1621. kwork->all_count += work->nr_atoms;
  1622. }
  1623. }
  1624. next = rb_next(next);
  1625. }
  1626. print_separator(ret);
  1627. if (kwork->summary) {
  1628. print_summary(kwork);
  1629. print_separator(ret);
  1630. }
  1631. print_bad_events(kwork);
  1632. print_skipped_events(kwork);
  1633. printf("\n");
  1634. return 0;
  1635. }
  1636. typedef int (*tracepoint_handler)(const struct perf_tool *tool,
  1637. struct evsel *evsel,
  1638. struct perf_sample *sample,
  1639. struct machine *machine);
  1640. static int perf_kwork__process_tracepoint_sample(const struct perf_tool *tool,
  1641. union perf_event *event __maybe_unused,
  1642. struct perf_sample *sample,
  1643. struct evsel *evsel,
  1644. struct machine *machine)
  1645. {
  1646. int err = 0;
  1647. if (evsel->handler != NULL) {
  1648. tracepoint_handler f = evsel->handler;
  1649. err = f(tool, evsel, sample, machine);
  1650. }
  1651. return err;
  1652. }
  1653. static int perf_kwork__timehist(struct perf_kwork *kwork)
  1654. {
  1655. /*
  1656. * event handlers for timehist option
  1657. */
  1658. kwork->tool.comm = perf_event__process_comm;
  1659. kwork->tool.exit = perf_event__process_exit;
  1660. kwork->tool.fork = perf_event__process_fork;
  1661. kwork->tool.attr = perf_event__process_attr;
  1662. kwork->tool.tracing_data = perf_event__process_tracing_data;
  1663. kwork->tool.build_id = perf_event__process_build_id;
  1664. kwork->tool.ordered_events = true;
  1665. kwork->tool.ordering_requires_timestamps = true;
  1666. symbol_conf.use_callchain = kwork->show_callchain;
  1667. if (symbol__validate_sym_arguments()) {
  1668. pr_err("Failed to validate sym arguments\n");
  1669. return -1;
  1670. }
  1671. setup_pager();
  1672. return perf_kwork__read_events(kwork);
  1673. }
  1674. static void top_calc_total_runtime(struct perf_kwork *kwork)
  1675. {
  1676. struct kwork_class *class;
  1677. struct kwork_work *work;
  1678. struct rb_node *next;
  1679. struct kwork_top_stat *stat = &kwork->top_stat;
  1680. class = get_kwork_class(kwork, KWORK_CLASS_SCHED);
  1681. if (!class)
  1682. return;
  1683. next = rb_first_cached(&class->work_root);
  1684. while (next) {
  1685. work = rb_entry(next, struct kwork_work, node);
  1686. BUG_ON(work->cpu >= MAX_NR_CPUS);
  1687. stat->cpus_runtime[work->cpu].total += work->total_runtime;
  1688. stat->cpus_runtime[MAX_NR_CPUS].total += work->total_runtime;
  1689. next = rb_next(next);
  1690. }
  1691. }
  1692. static void top_calc_idle_time(struct perf_kwork *kwork,
  1693. struct kwork_work *work)
  1694. {
  1695. struct kwork_top_stat *stat = &kwork->top_stat;
  1696. if (work->id == 0) {
  1697. stat->cpus_runtime[work->cpu].idle += work->total_runtime;
  1698. stat->cpus_runtime[MAX_NR_CPUS].idle += work->total_runtime;
  1699. }
  1700. }
  1701. static void top_calc_irq_runtime(struct perf_kwork *kwork,
  1702. enum kwork_class_type type,
  1703. struct kwork_work *work)
  1704. {
  1705. struct kwork_top_stat *stat = &kwork->top_stat;
  1706. if (type == KWORK_CLASS_IRQ) {
  1707. stat->cpus_runtime[work->cpu].irq += work->total_runtime;
  1708. stat->cpus_runtime[MAX_NR_CPUS].irq += work->total_runtime;
  1709. } else if (type == KWORK_CLASS_SOFTIRQ) {
  1710. stat->cpus_runtime[work->cpu].softirq += work->total_runtime;
  1711. stat->cpus_runtime[MAX_NR_CPUS].softirq += work->total_runtime;
  1712. }
  1713. }
  1714. static void top_subtract_irq_runtime(struct perf_kwork *kwork,
  1715. struct kwork_work *work)
  1716. {
  1717. struct kwork_class *class;
  1718. struct kwork_work *data;
  1719. unsigned int i;
  1720. int irq_class_list[] = {KWORK_CLASS_IRQ, KWORK_CLASS_SOFTIRQ};
  1721. for (i = 0; i < ARRAY_SIZE(irq_class_list); i++) {
  1722. class = get_kwork_class(kwork, irq_class_list[i]);
  1723. if (!class)
  1724. continue;
  1725. data = find_work_by_id(&class->work_root,
  1726. work->id, work->cpu);
  1727. if (!data)
  1728. continue;
  1729. if (work->total_runtime > data->total_runtime) {
  1730. work->total_runtime -= data->total_runtime;
  1731. top_calc_irq_runtime(kwork, irq_class_list[i], data);
  1732. }
  1733. }
  1734. }
  1735. static void top_calc_cpu_usage(struct perf_kwork *kwork)
  1736. {
  1737. struct kwork_class *class;
  1738. struct kwork_work *work;
  1739. struct rb_node *next;
  1740. struct kwork_top_stat *stat = &kwork->top_stat;
  1741. class = get_kwork_class(kwork, KWORK_CLASS_SCHED);
  1742. if (!class)
  1743. return;
  1744. next = rb_first_cached(&class->work_root);
  1745. while (next) {
  1746. work = rb_entry(next, struct kwork_work, node);
  1747. if (work->total_runtime == 0)
  1748. goto next;
  1749. __set_bit(work->cpu, stat->all_cpus_bitmap);
  1750. top_subtract_irq_runtime(kwork, work);
  1751. work->cpu_usage = work->total_runtime * 10000 /
  1752. stat->cpus_runtime[work->cpu].total;
  1753. top_calc_idle_time(kwork, work);
  1754. next:
  1755. next = rb_next(next);
  1756. }
  1757. }
  1758. static void top_calc_load_runtime(struct perf_kwork *kwork,
  1759. struct kwork_work *work)
  1760. {
  1761. struct kwork_top_stat *stat = &kwork->top_stat;
  1762. if (work->id != 0) {
  1763. stat->cpus_runtime[work->cpu].load += work->total_runtime;
  1764. stat->cpus_runtime[MAX_NR_CPUS].load += work->total_runtime;
  1765. }
  1766. }
  1767. static void top_merge_tasks(struct perf_kwork *kwork)
  1768. {
  1769. struct kwork_work *merged_work, *data;
  1770. struct kwork_class *class;
  1771. struct rb_node *node;
  1772. int cpu;
  1773. struct rb_root_cached merged_root = RB_ROOT_CACHED;
  1774. class = get_kwork_class(kwork, KWORK_CLASS_SCHED);
  1775. if (!class)
  1776. return;
  1777. for (;;) {
  1778. node = rb_first_cached(&class->work_root);
  1779. if (!node)
  1780. break;
  1781. rb_erase_cached(node, &class->work_root);
  1782. data = rb_entry(node, struct kwork_work, node);
  1783. if (!profile_name_match(kwork, data))
  1784. continue;
  1785. cpu = data->cpu;
  1786. merged_work = find_work_by_id(&merged_root, data->id,
  1787. data->id == 0 ? cpu : -1);
  1788. if (!merged_work) {
  1789. work_insert(&merged_root, data, &kwork->cmp_id);
  1790. } else {
  1791. merged_work->total_runtime += data->total_runtime;
  1792. merged_work->cpu_usage += data->cpu_usage;
  1793. }
  1794. top_calc_load_runtime(kwork, data);
  1795. }
  1796. work_sort(kwork, class, &merged_root);
  1797. }
  1798. static void perf_kwork__top_report(struct perf_kwork *kwork)
  1799. {
  1800. struct kwork_work *work;
  1801. struct rb_node *next;
  1802. printf("\n");
  1803. top_print_cpu_usage(kwork);
  1804. top_print_header(kwork);
  1805. next = rb_first_cached(&kwork->sorted_work_root);
  1806. while (next) {
  1807. work = rb_entry(next, struct kwork_work, node);
  1808. process_skipped_events(kwork, work);
  1809. if (work->total_runtime == 0)
  1810. goto next;
  1811. top_print_work(kwork, work);
  1812. next:
  1813. next = rb_next(next);
  1814. }
  1815. printf("\n");
  1816. }
  1817. static int perf_kwork__top_bpf(struct perf_kwork *kwork)
  1818. {
  1819. int ret;
  1820. signal(SIGINT, sig_handler);
  1821. signal(SIGTERM, sig_handler);
  1822. ret = perf_kwork__top_prepare_bpf(kwork);
  1823. if (ret)
  1824. return -1;
  1825. printf("Starting trace, Hit <Ctrl+C> to stop and report\n");
  1826. perf_kwork__top_start();
  1827. /*
  1828. * a simple pause, wait here for stop signal
  1829. */
  1830. pause();
  1831. perf_kwork__top_finish();
  1832. perf_kwork__top_read_bpf(kwork);
  1833. perf_kwork__top_cleanup_bpf();
  1834. return 0;
  1835. }
  1836. static int perf_kwork__top(struct perf_kwork *kwork)
  1837. {
  1838. struct __top_cpus_runtime *cpus_runtime;
  1839. int ret = 0;
  1840. cpus_runtime = zalloc(sizeof(struct __top_cpus_runtime) * (MAX_NR_CPUS + 1));
  1841. if (!cpus_runtime)
  1842. return -1;
  1843. kwork->top_stat.cpus_runtime = cpus_runtime;
  1844. bitmap_zero(kwork->top_stat.all_cpus_bitmap, MAX_NR_CPUS);
  1845. if (kwork->use_bpf)
  1846. ret = perf_kwork__top_bpf(kwork);
  1847. else
  1848. ret = perf_kwork__read_events(kwork);
  1849. if (ret)
  1850. goto out;
  1851. top_calc_total_runtime(kwork);
  1852. top_calc_cpu_usage(kwork);
  1853. top_merge_tasks(kwork);
  1854. setup_pager();
  1855. perf_kwork__top_report(kwork);
  1856. out:
  1857. zfree(&kwork->top_stat.cpus_runtime);
  1858. return ret;
  1859. }
  1860. static void setup_event_list(struct perf_kwork *kwork,
  1861. const struct option *options,
  1862. const char * const usage_msg[])
  1863. {
  1864. int i;
  1865. struct kwork_class *class;
  1866. char *tmp, *tok, *str;
  1867. /*
  1868. * set default events list if not specified
  1869. */
  1870. if (kwork->event_list_str == NULL)
  1871. kwork->event_list_str = "irq, softirq, workqueue";
  1872. str = strdup(kwork->event_list_str);
  1873. for (tok = strtok_r(str, ", ", &tmp);
  1874. tok; tok = strtok_r(NULL, ", ", &tmp)) {
  1875. for (i = 0; i < KWORK_CLASS_MAX; i++) {
  1876. class = kwork_class_supported_list[i];
  1877. if (strcmp(tok, class->name) == 0) {
  1878. list_add_tail(&class->list, &kwork->class_list);
  1879. break;
  1880. }
  1881. }
  1882. if (i == KWORK_CLASS_MAX) {
  1883. usage_with_options_msg(usage_msg, options,
  1884. "Unknown --event key: `%s'", tok);
  1885. }
  1886. }
  1887. free(str);
  1888. pr_debug("Config event list:");
  1889. list_for_each_entry(class, &kwork->class_list, list)
  1890. pr_debug(" %s", class->name);
  1891. pr_debug("\n");
  1892. }
  1893. static int perf_kwork__record(struct perf_kwork *kwork,
  1894. int argc, const char **argv)
  1895. {
  1896. const char **rec_argv;
  1897. unsigned int rec_argc, i, j;
  1898. struct kwork_class *class;
  1899. const char *const record_args[] = {
  1900. "record",
  1901. "-a",
  1902. "-R",
  1903. "-m", "1024",
  1904. "-c", "1",
  1905. };
  1906. rec_argc = ARRAY_SIZE(record_args) + argc - 1;
  1907. list_for_each_entry(class, &kwork->class_list, list)
  1908. rec_argc += 2 * class->nr_tracepoints;
  1909. rec_argv = calloc(rec_argc + 1, sizeof(char *));
  1910. if (rec_argv == NULL)
  1911. return -ENOMEM;
  1912. for (i = 0; i < ARRAY_SIZE(record_args); i++)
  1913. rec_argv[i] = strdup(record_args[i]);
  1914. list_for_each_entry(class, &kwork->class_list, list) {
  1915. for (j = 0; j < class->nr_tracepoints; j++) {
  1916. rec_argv[i++] = strdup("-e");
  1917. rec_argv[i++] = strdup(class->tp_handlers[j].name);
  1918. }
  1919. }
  1920. for (j = 1; j < (unsigned int)argc; j++, i++)
  1921. rec_argv[i] = argv[j];
  1922. BUG_ON(i != rec_argc);
  1923. pr_debug("record comm: ");
  1924. for (j = 0; j < rec_argc; j++)
  1925. pr_debug("%s ", rec_argv[j]);
  1926. pr_debug("\n");
  1927. return cmd_record(i, rec_argv);
  1928. }
  1929. int cmd_kwork(int argc, const char **argv)
  1930. {
  1931. static struct perf_kwork kwork = {
  1932. .class_list = LIST_HEAD_INIT(kwork.class_list),
  1933. .atom_page_list = LIST_HEAD_INIT(kwork.atom_page_list),
  1934. .sort_list = LIST_HEAD_INIT(kwork.sort_list),
  1935. .cmp_id = LIST_HEAD_INIT(kwork.cmp_id),
  1936. .sorted_work_root = RB_ROOT_CACHED,
  1937. .tp_handler = NULL,
  1938. .profile_name = NULL,
  1939. .cpu_list = NULL,
  1940. .time_str = NULL,
  1941. .force = false,
  1942. .event_list_str = NULL,
  1943. .summary = false,
  1944. .sort_order = NULL,
  1945. .show_callchain = false,
  1946. .max_stack = 5,
  1947. .timestart = 0,
  1948. .timeend = 0,
  1949. .nr_events = 0,
  1950. .nr_lost_chunks = 0,
  1951. .nr_lost_events = 0,
  1952. .all_runtime = 0,
  1953. .all_count = 0,
  1954. .nr_skipped_events = { 0 },
  1955. };
  1956. static const char default_report_sort_order[] = "runtime, max, count";
  1957. static const char default_latency_sort_order[] = "avg, max, count";
  1958. static const char default_top_sort_order[] = "rate, runtime";
  1959. const struct option kwork_options[] = {
  1960. OPT_INCR('v', "verbose", &verbose,
  1961. "be more verbose (show symbol address, etc)"),
  1962. OPT_BOOLEAN('D', "dump-raw-trace", &dump_trace,
  1963. "dump raw trace in ASCII"),
  1964. OPT_STRING('k', "kwork", &kwork.event_list_str, "kwork",
  1965. "list of kwork to profile (irq, softirq, workqueue, sched, etc)"),
  1966. OPT_BOOLEAN('f', "force", &kwork.force, "don't complain, do it"),
  1967. OPT_END()
  1968. };
  1969. const struct option report_options[] = {
  1970. OPT_STRING('s', "sort", &kwork.sort_order, "key[,key2...]",
  1971. "sort by key(s): runtime, max, count"),
  1972. OPT_STRING('C', "cpu", &kwork.cpu_list, "cpu",
  1973. "list of cpus to profile"),
  1974. OPT_STRING('n', "name", &kwork.profile_name, "name",
  1975. "event name to profile"),
  1976. OPT_STRING(0, "time", &kwork.time_str, "str",
  1977. "Time span for analysis (start,stop)"),
  1978. OPT_STRING('i', "input", &input_name, "file",
  1979. "input file name"),
  1980. OPT_BOOLEAN('S', "with-summary", &kwork.summary,
  1981. "Show summary with statistics"),
  1982. #ifdef HAVE_BPF_SKEL
  1983. OPT_BOOLEAN('b', "use-bpf", &kwork.use_bpf,
  1984. "Use BPF to measure kwork runtime"),
  1985. #endif
  1986. OPT_PARENT(kwork_options)
  1987. };
  1988. const struct option latency_options[] = {
  1989. OPT_STRING('s', "sort", &kwork.sort_order, "key[,key2...]",
  1990. "sort by key(s): avg, max, count"),
  1991. OPT_STRING('C', "cpu", &kwork.cpu_list, "cpu",
  1992. "list of cpus to profile"),
  1993. OPT_STRING('n', "name", &kwork.profile_name, "name",
  1994. "event name to profile"),
  1995. OPT_STRING(0, "time", &kwork.time_str, "str",
  1996. "Time span for analysis (start,stop)"),
  1997. OPT_STRING('i', "input", &input_name, "file",
  1998. "input file name"),
  1999. #ifdef HAVE_BPF_SKEL
  2000. OPT_BOOLEAN('b', "use-bpf", &kwork.use_bpf,
  2001. "Use BPF to measure kwork latency"),
  2002. #endif
  2003. OPT_PARENT(kwork_options)
  2004. };
  2005. const struct option timehist_options[] = {
  2006. OPT_STRING('k', "vmlinux", &symbol_conf.vmlinux_name,
  2007. "file", "vmlinux pathname"),
  2008. OPT_STRING(0, "kallsyms", &symbol_conf.kallsyms_name,
  2009. "file", "kallsyms pathname"),
  2010. OPT_BOOLEAN('g', "call-graph", &kwork.show_callchain,
  2011. "Display call chains if present"),
  2012. OPT_UINTEGER(0, "max-stack", &kwork.max_stack,
  2013. "Maximum number of functions to display backtrace."),
  2014. OPT_STRING(0, "symfs", &symbol_conf.symfs, "directory",
  2015. "Look for files with symbols relative to this directory"),
  2016. OPT_STRING(0, "time", &kwork.time_str, "str",
  2017. "Time span for analysis (start,stop)"),
  2018. OPT_STRING('C', "cpu", &kwork.cpu_list, "cpu",
  2019. "list of cpus to profile"),
  2020. OPT_STRING('n', "name", &kwork.profile_name, "name",
  2021. "event name to profile"),
  2022. OPT_STRING('i', "input", &input_name, "file",
  2023. "input file name"),
  2024. OPT_PARENT(kwork_options)
  2025. };
  2026. const struct option top_options[] = {
  2027. OPT_STRING('s', "sort", &kwork.sort_order, "key[,key2...]",
  2028. "sort by key(s): rate, runtime, tid"),
  2029. OPT_STRING('C', "cpu", &kwork.cpu_list, "cpu",
  2030. "list of cpus to profile"),
  2031. OPT_STRING('n', "name", &kwork.profile_name, "name",
  2032. "event name to profile"),
  2033. OPT_STRING(0, "time", &kwork.time_str, "str",
  2034. "Time span for analysis (start,stop)"),
  2035. OPT_STRING('i', "input", &input_name, "file",
  2036. "input file name"),
  2037. #ifdef HAVE_BPF_SKEL
  2038. OPT_BOOLEAN('b', "use-bpf", &kwork.use_bpf,
  2039. "Use BPF to measure task cpu usage"),
  2040. #endif
  2041. OPT_PARENT(kwork_options)
  2042. };
  2043. const char *kwork_usage[] = {
  2044. NULL,
  2045. NULL
  2046. };
  2047. const char * const report_usage[] = {
  2048. "perf kwork report [<options>]",
  2049. NULL
  2050. };
  2051. const char * const latency_usage[] = {
  2052. "perf kwork latency [<options>]",
  2053. NULL
  2054. };
  2055. const char * const timehist_usage[] = {
  2056. "perf kwork timehist [<options>]",
  2057. NULL
  2058. };
  2059. const char * const top_usage[] = {
  2060. "perf kwork top [<options>]",
  2061. NULL
  2062. };
  2063. const char *const kwork_subcommands[] = {
  2064. "record", "report", "latency", "timehist", "top", NULL
  2065. };
  2066. perf_tool__init(&kwork.tool, /*ordered_events=*/true);
  2067. kwork.tool.mmap = perf_event__process_mmap;
  2068. kwork.tool.mmap2 = perf_event__process_mmap2;
  2069. kwork.tool.sample = perf_kwork__process_tracepoint_sample;
  2070. argc = parse_options_subcommand(argc, argv, kwork_options,
  2071. kwork_subcommands, kwork_usage,
  2072. PARSE_OPT_STOP_AT_NON_OPTION);
  2073. if (!argc)
  2074. usage_with_options(kwork_usage, kwork_options);
  2075. sort_dimension__add(&kwork, "id", &kwork.cmp_id);
  2076. if (strlen(argv[0]) > 2 && strstarts("record", argv[0])) {
  2077. setup_event_list(&kwork, kwork_options, kwork_usage);
  2078. return perf_kwork__record(&kwork, argc, argv);
  2079. } else if (strlen(argv[0]) > 2 && strstarts("report", argv[0])) {
  2080. kwork.sort_order = default_report_sort_order;
  2081. if (argc > 1) {
  2082. argc = parse_options(argc, argv, report_options, report_usage, 0);
  2083. if (argc)
  2084. usage_with_options(report_usage, report_options);
  2085. }
  2086. kwork.report = KWORK_REPORT_RUNTIME;
  2087. setup_sorting(&kwork, report_options, report_usage);
  2088. setup_event_list(&kwork, kwork_options, kwork_usage);
  2089. return perf_kwork__report(&kwork);
  2090. } else if (strlen(argv[0]) > 2 && strstarts("latency", argv[0])) {
  2091. kwork.sort_order = default_latency_sort_order;
  2092. if (argc > 1) {
  2093. argc = parse_options(argc, argv, latency_options, latency_usage, 0);
  2094. if (argc)
  2095. usage_with_options(latency_usage, latency_options);
  2096. }
  2097. kwork.report = KWORK_REPORT_LATENCY;
  2098. setup_sorting(&kwork, latency_options, latency_usage);
  2099. setup_event_list(&kwork, kwork_options, kwork_usage);
  2100. return perf_kwork__report(&kwork);
  2101. } else if (strlen(argv[0]) > 2 && strstarts("timehist", argv[0])) {
  2102. if (argc > 1) {
  2103. argc = parse_options(argc, argv, timehist_options, timehist_usage, 0);
  2104. if (argc)
  2105. usage_with_options(timehist_usage, timehist_options);
  2106. }
  2107. kwork.report = KWORK_REPORT_TIMEHIST;
  2108. setup_event_list(&kwork, kwork_options, kwork_usage);
  2109. return perf_kwork__timehist(&kwork);
  2110. } else if (strlen(argv[0]) > 2 && strstarts("top", argv[0])) {
  2111. kwork.sort_order = default_top_sort_order;
  2112. if (argc > 1) {
  2113. argc = parse_options(argc, argv, top_options, top_usage, 0);
  2114. if (argc)
  2115. usage_with_options(top_usage, top_options);
  2116. }
  2117. kwork.report = KWORK_REPORT_TOP;
  2118. if (!kwork.event_list_str)
  2119. kwork.event_list_str = "sched, irq, softirq";
  2120. setup_event_list(&kwork, kwork_options, kwork_usage);
  2121. setup_sorting(&kwork, top_options, top_usage);
  2122. return perf_kwork__top(&kwork);
  2123. } else
  2124. usage_with_options(kwork_usage, kwork_options);
  2125. /* free usage string allocated by parse_options_subcommand */
  2126. free((void *)kwork_usage[0]);
  2127. return 0;
  2128. }