1 #!/bin/bash 2 # 3 # Analyze a given results directory for rcuperf performance measurements, 4 # looking for ftrace data. Exits with 0 if data was found, analyzed, and 5 # printed. Intended to be invoked from kvm-recheck-rcuperf.sh after 6 # argument checking. 7 # 8 # Usage: kvm-recheck-rcuperf-ftrace.sh resdir 9 # 10 # This program is free software; you can redistribute it and/or modify 11 # it under the terms of the GNU General Public License as published by 12 # the Free Software Foundation; either version 2 of the License, or 13 # (at your option) any later version. 14 # 15 # This program is distributed in the hope that it will be useful, 16 # but WITHOUT ANY WARRANTY; without even the implied warranty of 17 # MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the 18 # GNU General Public License for more details. 19 # 20 # You should have received a copy of the GNU General Public License 21 # along with this program; if not, you can access it online at 22 # http://www.gnu.org/licenses/gpl-2.0.html. 23 # 24 # Copyright (C) IBM Corporation, 2016 25 # 26 # Authors: Paul E. McKenney <paulmck (at] linux.vnet.ibm.com> 27 28 i="$1" 29 . tools/testing/selftests/rcutorture/bin/functions.sh 30 31 if test "`grep -c 'rcu_exp_grace_period.*start' < $i/console.log`" -lt 100 32 then 33 exit 10 34 fi 35 36 sed -e 's/^\[[^]]*]//' < $i/console.log | 37 grep 'us : rcu_exp_grace_period' | 38 sed -e 's/us : / : /' | 39 tr -d '\015' | 40 awk ' 41 $8 == "start" { 42 if (starttask != "") 43 nlost++; 44 starttask = $1; 45 starttime = $3; 46 startseq = $7; 47 } 48 49 $8 == "end" { 50 if (starttask == $1 && startseq == $7) { 51 curgpdur = $3 - starttime; 52 gptimes[++n] = curgpdur; 53 gptaskcnt[starttask]++; 54 sum += curgpdur; 55 if (curgpdur > 1000) 56 print "Long GP " starttime "us to " $3 "us (" curgpdur "us)"; 57 starttask = ""; 58 } else { 59 # Lost a message or some such, reset. 60 starttask = ""; 61 nlost++; 62 } 63 } 64 65 $8 == "done" { 66 piggybackcnt[$1]++; 67 } 68 69 END { 70 newNR = asort(gptimes); 71 if (newNR <= 0) { 72 print "No ftrace records found???" 73 exit 10; 74 } 75 pct50 = int(newNR * 50 / 100); 76 if (pct50 < 1) 77 pct50 = 1; 78 pct90 = int(newNR * 90 / 100); 79 if (pct90 < 1) 80 pct90 = 1; 81 pct99 = int(newNR * 99 / 100); 82 if (pct99 < 1) 83 pct99 = 1; 84 div = 10 ** int(log(gptimes[pct90]) / log(10) + .5) / 100; 85 print "Histogram bucket size: " div; 86 last = gptimes[1] - 10; 87 count = 0; 88 for (i = 1; i <= newNR; i++) { 89 current = div * int(gptimes[i] / div); 90 if (last == current) { 91 count++; 92 } else { 93 if (count > 0) 94 print last, count; 95 count = 1; 96 last = current; 97 } 98 } 99 if (count > 0) 100 print last, count; 101 print "Distribution of grace periods across tasks:"; 102 for (i in gptaskcnt) { 103 print "\t" i, gptaskcnt[i]; 104 nbatches += gptaskcnt[i]; 105 } 106 ngps = nbatches; 107 print "Distribution of piggybacking across tasks:"; 108 for (i in piggybackcnt) { 109 print "\t" i, piggybackcnt[i]; 110 ngps += piggybackcnt[i]; 111 } 112 print "Average grace-period duration: " sum / newNR " microseconds"; 113 print "Minimum grace-period duration: " gptimes[1]; 114 print "50th percentile grace-period duration: " gptimes[pct50]; 115 print "90th percentile grace-period duration: " gptimes[pct90]; 116 print "99th percentile grace-period duration: " gptimes[pct99]; 117 print "Maximum grace-period duration: " gptimes[newNR]; 118 print "Grace periods: " ngps + 0 " Batches: " nbatches + 0 " Ratio: " ngps / nbatches " Lost: " nlost + 0; 119 print "Computed from ftrace data."; 120 }' 121 exit 0 122