)]}' { "log": [ { "commit": "b898cc70019ce1835bbf6c47bdf978adc36faa42", "tree": "9837f7a8677873eb44e25b841d4262cd474ee9f1", "parents": [ "755f0225e8347b23a33ee6e3fb14a35310f95766" ], "author": { "name": "Mel Gorman", "email": "mel@csn.ul.ie", "time": "Mon Aug 09 17:19:24 2010 -0700" }, "committer": { "name": "Linus Torvalds", "email": "torvalds@linux-foundation.org", "time": "Mon Aug 09 20:45:00 2010 -0700" }, "message": "vmscan: tracing: add a postprocessing script for reclaim-related ftrace events\n\nAdd a simple post-processing script for the reclaim-related trace events.\nIt can be used to give an indication of how much traffic there is on the\nLRU lists and how severe latencies due to reclaim are. Example output\nlooks like the following\n\nReclaim latencies expressed as order-latency_in_ms\nuname-3942 9-200.179000000004 9-98.7900000000373 9-99.8330000001006\nkswapd0-311 0-662.097999999998 0-2.79700000002049 \\\n\t0-149.100000000035 0-3295.73600000003 0-9806.31799999997 0-35528.833 \\\n\t0-10043.197 0-129740.979 0-3.50500000000466 0-3.54899999999907 \\\n\t0-9297.78999999992 0-3.48499999998603 0-3596.97999999998 0-3.92799999995623 \\\n\t0-3.35000000009313 0-16729.017 0-3.57799999997951 0-47435.0630000001 \\\n\t0-3.7819999998901 0-5864.06999999995 0-18635.334 0-10541.289 9-186011.565 \\\n\t9-3680.86300000001 9-1379.06499999994 9-958571.115 9-66215.474 \\\n\t9-6721.14699999988 9-1962.15299999993 9-1094806.125 9-2267.83199999994 \\\n\t9-47120.9029999999 9-427653.886 9-2.6359999999404 9-632.148999999976 \\\n\t9-476.753000000026 9-495.577000000048 9-8.45900000003166 9-6.6820000000298 \\\n\t9-1.30500000016764 9-251.746000000043 9-383.905000000028 9-80.1419999999925 \\\n\t9-281.160000000149 9-14.8780000000261 9-381.45299999998 9-512.07799999998 \\\n\t9-49.5519999999087 9-167.439000000013 9-183.820999999996 9-239.527999999933 \\\n\t9-19.9479999998584 9-148.747999999905 9-164.583000000101 9-16.9480000000913 \\\n\t9-192.376000000164 9-64.1010000000242 9-1.40800000005402 9-3.60800000000745 \\\n\t9-17.1359999999404 9-4.69500000006519 9-2.06400000001304 9-1582488.554 \\\n\t9-6244.19499999983 9-348153.812 9-2.0999999998603 9-0.987999999895692 \\\n\t0-32218.473 0-1.6140000000596 0-1.28100000019185 0-1.41300000017509 \\\n\t0-1.32299999985844 0-602.584000000032 0-1.34400000004098 0-1.6929999999702 \\\n\t1-22101.8190000001 9-174876.724 9-16.2420000000857 9-175.165999999736 \\\n\t9-15.8589999997057 9-0.604999999981374 9-3061.09000000032 9-479.277000000235 \\\n\t9-1.54499999992549 9-771.985000000335 9-4.88700000010431 9-15.0649999999441 \\\n\t9-0.879999999888241 9-252.01500000013 9-1381.03600000031 9-545.689999999944 \\\n\t9-3438.0129999998 9-3343.70099999988\nbench-stresshig-3942 9-7063.33900000004 9-129960.482 9-2062.27500000002 \\\n\t9-3845.59399999992 9-171.82799999998 9-16493.821 9-7615.23900000006 \\\n\t9-10217.848 9-983.138000000035 9-2698.39999999991 9-4016.1540000001 \\\n\t9-5522.37700000009 9-21630.429 \\\n\t9-15061.048 9-10327.953 9-542.69700000016 9-317.652000000002 \\\n\t9-8554.71699999995 9-1786.61599999992 9-1899.31499999994 9-2093.41899999999 \\\n\t9-4992.62400000007 9-942.648999999976 9-1923.98300000001 9-3.7980000001844 \\\n\t9-5.99899999983609 9-0.912000000011176 9-1603.67700000014 9-1.98300000000745 \\\n\t9-3.96500000008382 9-0.902999999932945 9-2802.72199999983 9-1078.24799999991 \\\n\t9-2155.82900000014 9-10.058999999892 9-1984.723 9-1687.97999999998 \\\n\t9-1136.05300000007 9-3183.61699999985 9-458.731000000145 9-6.48600000003353 \\\n\t9-1013.25200000009 9-8415.22799999989 9-10065.584 9-2076.79600000009 \\\n\t9-3792.65699999989 9-71.2010000001173 9-2560.96999999997 9-2260.68400000012 \\\n\t9-2862.65799999982 9-1255.81500000018 9-15.7440000001807 9-4.33499999996275 \\\n\t9-1446.63800000004 9-238.635000000009 9-60.1790000000037 9-4.38800000003539 \\\n\t9-639.567000000039 9-306.698000000091 9-31.4070000001229 9-74.997999999905 \\\n\t9-632.725999999791 9-1625.93200000003 9-931.266000000061 9-98.7749999999069 \\\n\t9-984.606999999844 9-225.638999999966 9-421.316000000108 9-653.744999999879 \\\n\t9-572.804000000004 9-769.158999999985 9-603.918000000063 9-4.28499999991618 \\\n\t9-626.21399999992 9-1721.25 9-0.854999999981374 9-572.39599999995 \\\n\t9-681.881999999983 9-1345.12599999993 9-363.666999999899 9-3823.31099999999 \\\n\t9-2991.28200000012 9-4.27099999994971 9-309.76500000013 9-3068.35700000008 \\\n\t9-788.25 9-3515.73999999999 9-2065.96100000013 9-286.719999999972 \\\n\t9-316.076000000117 9-344.151000000071 9-2.51000000000931 9-306.688000000082 \\\n\t9-1515.00099999993 9-336.528999999864 9-793.491999999853 9-457.348999999929 \\\n\t9-13620.155 9-119.933999999892 9-35.0670000000391 9-918.266999999993 \\\n\t9-828.569000000134 9-4863.81099999999 9-105.222000000067 9-894.23900000006 \\\n\t9-110.964999999851 9-0.662999999942258 9-12753.3150000002 9-12.6129999998957 \\\n\t9-13368.0899999999 9-12.4199999999255 9-1.00300000002608 9-1.41100000008009 \\\n\t9-10300.5290000001 9-16.502000000095 9-30.7949999999255 9-6283.0140000002 \\\n\t9-4320.53799999994 9-6826.27300000004 9-3.07299999985844 9-1497.26799999992 \\\n\t9-13.4040000000969 9-3.12999999988824 9-3.86100000003353 9-11.3539999998175 \\\n\t9-0.10799999977462 9-21.780999999959 9-209.695999999996 9-299.647000000114 \\\n\t9-6.01699999999255 9-20.8349999999627 9-22.5470000000205 9-5470.16800000006 \\\n\t9-7.60499999998137 9-0.821000000229105 9-1.56600000010803 9-14.1669999998994 \\\n\t9-0.209000000031665 9-1.82300000009127 9-1.70000000018626 9-19.9429999999702 \\\n\t9-124.266999999993 9-0.0389999998733401 9-6.71400000015274 9-16.7710000001825 \\\n\t9-31.0409999999683 9-0.516999999992549 9-115.888000000035 9-5.19900000002235 \\\n\t9-222.389999999898 9-11.2739999999758 9-80.9050000000279 9-8.14500000001863 \\\n\t9-4.44599999999627 9-0.218999999808148 9-0.715000000083819 9-0.233000000007451\n\\\n\t9-48.2630000000354 9-248.560999999987 9-374.96800000011 9-644.179000000004 \\\n\t9-0.835999999893829 9-79.0060000000522 9-128.447999999858 9-0.692000000039116 \\\n\t9-5.26500000013039 9-128.449000000022 9-2.04799999995157 9-12.0990000001621 \\\n\t9-8.39899999997579 9-10.3860000001732 9-11.9310000000987 9-53.4450000000652 \\\n\t9-0.46999999997206 9-2.96299999998882 9-17.9699999999721 9-0.776000000070781 \\\n\t9-25.2919999998994 9-33.1110000000335 9-0.434000000124797 9-0.641000000061467 \\\n\t9-0.505000000121072 9-1.12800000002608 9-149.222000000067 9-1.17599999997765 \\\n\t9-3247.33100000001 9-10.7439999999478 9-153.523000000045 9-1.38300000014715 \\\n\t9-794.762000000104 9-3.36199999996461 9-128.765999999829 9-181.543999999994 \\\n\t9-78149.8229999999 9-176.496999999974 9-89.9940000001807 9-9.12700000009499 \\\n\t9-250.827000000048 9-0.224999999860302 9-0.388999999966472 9-1.16700000036508 \\\n\t9-32.1740000001155 9-12.6800000001676 9-0.0720000001601875 9-0.274999999906868\n\\\n\t9-0.724000000394881 9-266.866000000387 9-45.5709999999963 9-4.54399999976158 \\\n\t9-8.27199999988079 9-4.38099999958649 9-0.512000000104308 9-0.0640000002458692\n\\\n\t9-5.20000000018626 9-0.0839999997988343 9-12.816000000108 9-0.503000000026077 \\\n\t9-0.507999999914318 9-6.23999999975786 9-3.35100000025705 9-18.8530000001192 \\\n\t9-25.2220000000671 9-68.2309999996796 9-98.9939999999478 9-0.441000000108033 \\\n\t9-4.24599999981001 9-261.702000000048 9-3.01599999982864 9-0.0749999997206032 \\\n\t9-0.0370000000111759 9-4.375 9-3.21800000034273 9-11.3960000001825 \\\n\t9-0.0540000000037253 9-0.286000000312924 9-0.865999999921769 \\\n\t9-0.294999999925494 9-6.45999999996275 9-4.31099999975413 9-128.248999999836 \\\n\t9-0.282999999821186 9-102.155000000261 9-0.0860000001266599 \\\n\t9-0.0540000000037253 9-0.935000000055879 9-0.0670000002719462 \\\n\t9-5.8640000000596 9-19.9860000000335 9-4.18699999991804 9-0.566000000108033 \\\n\t9-2.55099999997765 9-0.702000000048429 9-131.653999999631 9-0.638999999966472 \\\n\t9-14.3229999998584 9-183.398000000045 9-178.095999999903 9-3.22899999981746 \\\n\t9-7.31399999978021 9-22.2400000002235 9-11.7979999999516 9-108.10599999968 \\\n\t9-99.0159999998286 9-102.640999999829 9-38.414000000339\nProcess Direct Wokeup Pages Pages Pages\ndetails Rclms Kswapd Scanned Sync-IO ASync-IO\ncc1-30800 0 1 0 0 0 wakeup-0\u003d1\ncc1-24260 0 1 0 0 0 wakeup-0\u003d1\ncc1-24152 0 12 0 0 0 wakeup-0\u003d12\ncc1-8139 0 1 0 0 0 wakeup-0\u003d1\ncc1-4390 0 1 0 0 0 wakeup-0\u003d1\ncc1-4648 0 7 0 0 0 wakeup-0\u003d7\ncc1-4552 0 3 0 0 0 wakeup-0\u003d3\ndd-4550 0 31 0 0 0 wakeup-0\u003d31\ndate-4898 0 1 0 0 0 wakeup-0\u003d1\ncc1-6549 0 7 0 0 0 wakeup-0\u003d7\nas-22202 0 17 0 0 0 wakeup-0\u003d17\ncc1-6495 0 9 0 0 0 wakeup-0\u003d9\ncc1-8299 0 1 0 0 0 wakeup-0\u003d1\ncc1-6009 0 1 0 0 0 wakeup-0\u003d1\ncc1-2574 0 2 0 0 0 wakeup-0\u003d2\ncc1-30568 0 1 0 0 0 wakeup-0\u003d1\ncc1-2679 0 6 0 0 0 wakeup-0\u003d6\nsh-13747 0 12 0 0 0 wakeup-0\u003d12\ncc1-22193 0 18 0 0 0 wakeup-0\u003d18\ncc1-30725 0 2 0 0 0 wakeup-0\u003d2\nas-4392 0 2 0 0 0 wakeup-0\u003d2\ncc1-28180 0 14 0 0 0 wakeup-0\u003d14\ncc1-13697 0 2 0 0 0 wakeup-0\u003d2\ncc1-22207 0 8 0 0 0 wakeup-0\u003d8\ncc1-15270 0 179 0 0 0 wakeup-0\u003d179\ncc1-22011 0 82 0 0 0 wakeup-0\u003d82\ncp-14682 0 1 0 0 0 wakeup-0\u003d1\nas-11926 0 2 0 0 0 wakeup-0\u003d2\ncc1-6016 0 5 0 0 0 wakeup-0\u003d5\nmake-18554 0 13 0 0 0 wakeup-0\u003d13\ncc1-8292 0 12 0 0 0 wakeup-0\u003d12\nmake-24381 0 1 0 0 0 wakeup-1\u003d1\ndate-18681 0 33 0 0 0 wakeup-0\u003d33\ncc1-32276 0 1 0 0 0 wakeup-0\u003d1\ntimestamp-outpu-2809 0 253 0 0 0 wakeup-0\u003d240 wakeup-1\u003d13\ndate-18624 0 7 0 0 0 wakeup-0\u003d7\ncc1-30960 0 9 0 0 0 wakeup-0\u003d9\ncc1-4014 0 1 0 0 0 wakeup-0\u003d1\ncc1-30706 0 22 0 0 0 wakeup-0\u003d22\nuname-3942 4 1 306 0 17 direct-9\u003d4 wakeup-9\u003d1\ncc1-28207 0 1 0 0 0 wakeup-0\u003d1\ncc1-30563 0 9 0 0 0 wakeup-0\u003d9\ncc1-22214 0 10 0 0 0 wakeup-0\u003d10\ncc1-28221 0 11 0 0 0 wakeup-0\u003d11\ncc1-28123 0 6 0 0 0 wakeup-0\u003d6\nkswapd0-311 0 7 357302 0 34233 wakeup-0\u003d7\ncc1-5988 0 7 0 0 0 wakeup-0\u003d7\nas-30734 0 161 0 0 0 wakeup-0\u003d161\ncc1-22004 0 45 0 0 0 wakeup-0\u003d45\ndate-4590 0 4 0 0 0 wakeup-0\u003d4\ncc1-15279 0 213 0 0 0 wakeup-0\u003d213\ndate-30735 0 1 0 0 0 wakeup-0\u003d1\ncc1-30583 0 4 0 0 0 wakeup-0\u003d4\ncc1-32324 0 2 0 0 0 wakeup-0\u003d2\ncc1-23933 0 3 0 0 0 wakeup-0\u003d3\ncc1-22001 0 36 0 0 0 wakeup-0\u003d36\nbench-stresshig-3942 287 287 80186 6295 12196 direct-9\u003d287 wakeup-9\u003d287\ncc1-28170 0 7 0 0 0 wakeup-0\u003d7\ndate-7932 0 92 0 0 0 wakeup-0\u003d92\ncc1-22222 0 6 0 0 0 wakeup-0\u003d6\ncc1-32334 0 16 0 0 0 wakeup-0\u003d16\ncc1-2690 0 6 0 0 0 wakeup-0\u003d6\ncc1-30733 0 9 0 0 0 wakeup-0\u003d9\ncc1-32298 0 2 0 0 0 wakeup-0\u003d2\ncc1-13743 0 18 0 0 0 wakeup-0\u003d18\ncc1-22186 0 4 0 0 0 wakeup-0\u003d4\ncc1-28214 0 11 0 0 0 wakeup-0\u003d11\ncc1-13735 0 1 0 0 0 wakeup-0\u003d1\nupdatedb-8173 0 18 0 0 0 wakeup-0\u003d18\ncc1-13750 0 3 0 0 0 wakeup-0\u003d3\ncat-2808 0 2 0 0 0 wakeup-0\u003d2\ncc1-15277 0 169 0 0 0 wakeup-0\u003d169\ndate-18317 0 1 0 0 0 wakeup-0\u003d1\ncc1-15274 0 197 0 0 0 wakeup-0\u003d197\ncc1-30732 0 1 0 0 0 wakeup-0\u003d1\n\nKswapd Kswapd Order Pages Pages Pages\nInstance Wakeups Re-wakeup Scanned Sync-IO ASync-IO\nkswapd0-311 91 24 357302 0 34233 wake-0\u003d31 wake-1\u003d1 wake-9\u003d59 rewake-0\u003d10 rewake-1\u003d1 rewake-9\u003d13\n\nSummary\nDirect reclaims: \t\t291\nDirect reclaim pages scanned:\t437794\nDirect reclaim write sync I/O:\t6295\nDirect reclaim write async I/O:\t46446\nWake kswapd requests:\t\t2152\nTime stalled direct reclaim: \t519.163009000002 ms\n\nKswapd wakeups:\t\t\t91\nKswapd pages scanned:\t\t357302\nKswapd reclaim write sync I/O:\t0\nKswapd reclaim write async I/O:\t34233\nTime kswapd awake:\t\t5282.749757 ms\n\nSigned-off-by: Mel Gorman \u003cmel@csn.ul.ie\u003e\nAcked-by: Rik van Riel \u003criel@redhat.com\u003e\nAcked-by: Larry Woodman \u003clwoodman@redhat.com\u003e\nCc: Dave Chinner \u003cdavid@fromorbit.com\u003e\nCc: Chris Mason \u003cchris.mason@oracle.com\u003e\nCc: Nick Piggin \u003cnpiggin@suse.de\u003e\nCc: Rik van Riel \u003criel@redhat.com\u003e\nCc: Johannes Weiner \u003channes@cmpxchg.org\u003e\nCc: Christoph Hellwig \u003chch@infradead.org\u003e\nCc: KAMEZAWA Hiroyuki \u003ckamezawa.hiroyu@jp.fujitsu.com\u003e\nCc: KOSAKI Motohiro \u003ckosaki.motohiro@jp.fujitsu.com\u003e\nCc: Andrea Arcangeli \u003caarcange@redhat.com\u003e\nCc: Michael Rubin \u003cmrubin@google.com\u003e\nSigned-off-by: Andrew Morton \u003cakpm@linux-foundation.org\u003e\nSigned-off-by: Linus Torvalds \u003ctorvalds@linux-foundation.org\u003e\n" }, { "commit": "c9d05cfc001fef3d6d37651e19ab9227a32b71f5", "tree": "ac5f54c9fcf8336c7787fca63875b18621ee3fd1", "parents": [ "0d3d062a6e289e065bd0aa537a6806a1806bf8aa" ], "author": { "name": "Mel Gorman", "email": "mel@csn.ul.ie", "time": "Mon Sep 21 17:02:47 2009 -0700" }, "committer": { "name": "Linus Torvalds", "email": "torvalds@linux-foundation.org", "time": "Tue Sep 22 07:17:34 2009 -0700" }, "message": "tracing, page-allocator: add a postprocessing script for page-allocator-related ftrace events\n\nThis patch adds a simple post-processing script for the\npage-allocator-related trace events. It can be used to give an indication\nof who the most allocator-intensive processes are and how often the zone\nlock was taken during the tracing period. Example output looks like\n\nProcess Pages Pages Pages Pages PCPU PCPU PCPU Fragment Fragment MigType Fragment Fragment Unknown\ndetails allocd allocd freed freed pages drains refills Fallback Causing Changed Severe Moderate\n under lock direct pagevec drain\nswapper-0 0 0 2 0 0 0 0 0 0 0 0 0 0\nXorg-3770 10603 5952 3685 6978 5996 194 192 0 0 0 0 0 0\nmodprobe-21397 51 0 0 86 31 1 0 0 0 0 0 0 0\nxchat-5370 228 93 0 0 0 0 3 0 0 0 0 0 0\nawesome-4317 32 32 0 0 0 0 32 0 0 0 0 0 0\nthinkfan-3863 2 0 1 1 0 0 0 0 0 0 0 0 0\nhald-addon-stor-3935 2 0 0 0 0 0 0 0 0 0 0 0 0\nakregator-4506 1 1 0 0 0 0 1 0 0 0 0 0 0\nxmms-14888 0 0 1 0 0 0 0 0 0 0 0 0 0\nkhelper-12 1 0 0 0 0 0 0 0 0 0 0 0 0\n\nOptionally, the output can include information on the parent or aggregate\nbased on process name instead of aggregating based on each pid. Example output\nincluding parent information and stripped out the PID looks something like;\n\nProcess Pages Pages Pages Pages PCPU PCPU PCPU Fragment Fragment MigType Fragment Fragment Unknown\ndetails allocd allocd freed freed pages drains refills Fallback Causing Changed Severe Moderate\n under lock direct pagevec drain\ngdm-3756 :: Xorg-3770 3796 2976 99 3813 3224 104 98 0 0 0 0 0 0\ninit-1 :: hald-3892 1 0 0 0 0 0 0 0 0 0 0 0 0\ngit-21447 :: editor-21448 4 0 4 0 0 0 0 0 0 0 0 0 0\n\nThis says that Xorg allocated 3796 pages and it\u0027s parent process is gdm\nwith a PID of 3756;\n\nThe postprocessor parses the text output of tracing. While there is a\nbinary format, the expectation is that the binary output can be readily\ntranslated into text and post-processed offline. Obviously if the text\nformat changes, the parser will break but the regular expression parser is\nfairly rudimentary so should be readily adjustable.\n\nSigned-off-by: Mel Gorman \u003cmel@csn.ul.ie\u003e\nCc: Rik van Riel \u003criel@redhat.com\u003e\nReviewed-by: Ingo Molnar \u003cmingo@elte.hu\u003e\nCc: Larry Woodman \u003clwoodman@redhat.com\u003e\nCc: Peter Zijlstra \u003cpeterz@infradead.org\u003e\nCc: Li Ming Chun \u003cmacli@brc.ubc.ca\u003e\nSigned-off-by: Andrew Morton \u003cakpm@linux-foundation.org\u003e\nSigned-off-by: Linus Torvalds \u003ctorvalds@linux-foundation.org\u003e\n" } ] }