X-Git-Url: https://git.kernel.dk/?p=fio.git;a=blobdiff_plain;f=stat.c;h=819a7c687da448ea87ef44dd3eca9e18c17061d5;hp=a9e87aa7cc35d32263d79965fa8ea94365d8e9d2;hb=73170f19408559ed7e318f93b21e5cbbf13725bd;hpb=4d9345ae968ca92ace3dab06c25a9b73159cb329 diff --git a/stat.c b/stat.c index a9e87aa7..819a7c68 100644 --- a/stat.c +++ b/stat.c @@ -12,6 +12,46 @@ static struct itimerval itimer; static struct list_head disk_list = LIST_HEAD_INIT(disk_list); +/* + * Cheasy number->string conversion, complete with carry rounding error. + */ +static char *num2str(unsigned long num, int maxlen, int base) +{ + /* + * could be passed in for 10^3 base, but every caller expects + * 2^10 base right now. + */ + const unsigned int thousand = 1024; + char postfix[] = { 'K', 'M', 'G', 'P', 'E' }; + char *buf; + int i; + + buf = malloc(128); + + for (i = 0; base > 1; i++) + base /= thousand; + + do { + int len, carry = 0; + + len = sprintf(buf, "%'lu", num); + if (len <= maxlen) { + buf[len] = postfix[i]; + buf[len + 1] = '\0'; + return buf; + } + + if ((num % thousand) >= (thousand / 2)) + carry = 1; + + num /= thousand; + num += carry; + i++; + } while (i <= 5); + + return buf; +} + static int get_io_ticks(struct disk_util *du, struct disk_util_stat *dus) { unsigned in_flight; @@ -303,12 +343,28 @@ static int calc_lat(struct io_stat *is, unsigned long *min, unsigned long *max, static void show_group_stats(struct group_run_stats *rs, int id) { + char *p1, *p2, *p3, *p4; + const char *ddir_str[] = { " READ", " WRITE" }; + int i; + fprintf(f_out, "\nRun status group %d (all jobs):\n", id); - if (rs->max_run[DDIR_READ]) - fprintf(f_out, " READ: io=%lluMiB, aggrb=%llu, minb=%llu, maxb=%llu, mint=%llumsec, maxt=%llumsec\n", rs->io_kb[0] >> 10, rs->agg[0], rs->min_bw[0], rs->max_bw[0], rs->min_run[0], rs->max_run[0]); - if (rs->max_run[DDIR_WRITE]) - fprintf(f_out, " WRITE: io=%lluMiB, aggrb=%llu, minb=%llu, maxb=%llu, mint=%llumsec, maxt=%llumsec\n", rs->io_kb[1] >> 10, rs->agg[1], rs->min_bw[1], rs->max_bw[1], rs->min_run[1], rs->max_run[1]); + for (i = 0; i <= DDIR_WRITE; i++) { + if (!rs->max_run[i]) + continue; + + p1 = num2str(rs->io_kb[i], 6, 1); + p2 = num2str(rs->agg[i], 6, 1); + p3 = num2str(rs->min_bw[i], 6, 1); + p4 = num2str(rs->max_bw[i], 6, 1); + + fprintf(f_out, "%s: io=%siB, aggrb=%siB/s, minb=%siB/s, maxb=%siB/s, mint=%llumsec, maxt=%llumsec\n", ddir_str[i], p1, p2, p3, p4, rs->min_run[0], rs->max_run[0]); + + free(p1); + free(p2); + free(p3); + free(p4); + } } static void show_disk_util(void) @@ -349,12 +405,19 @@ static void show_ddir_status(struct thread_data *td, struct group_run_stats *rs, unsigned long min, max; unsigned long long bw; double mean, dev; + char *io_p, *bw_p; if (!td->runtime[ddir]) return; bw = td->io_bytes[ddir] / td->runtime[ddir]; - fprintf(f_out, " %s: io=%6lluMiB, bw=%6lluKiB/s, runt=%6lumsec\n", ddir_str[ddir], td->io_bytes[ddir] >> 20, bw, td->runtime[ddir]); + io_p = num2str(td->io_bytes[ddir] >> 10, 6, 1); + bw_p = num2str(bw, 6, 1); + + fprintf(f_out, " %s: io=%siB, bw=%siB/s, runt=%6lumsec\n", ddir_str[ddir], io_p, bw_p, td->runtime[ddir]); + + free(io_p); + free(bw_p); if (calc_lat(&td->slat_stat[ddir], &min, &max, &mean, &dev)) fprintf(f_out, " slat (msec): min=%5lu, max=%5lu, avg=%5.02f, stdev=%5.02f\n", min, max, mean, dev); @@ -376,12 +439,16 @@ static void show_thread_status(struct thread_data *td, double usr_cpu, sys_cpu; unsigned long runtime; double io_u_dist[FIO_IO_U_MAP_NR]; + double io_u_lat[FIO_IO_U_LAT_NR]; int i; - if (!(td->io_bytes[0] + td->io_bytes[1]) && !td->error) + if (!(td->io_bytes[0] + td->io_bytes[1])) return; - fprintf(f_out, "%s: (groupid=%d): err=%2d: pid=%d\n",td->name, td->groupid, td->error, td->pid); + if (!td->error) + fprintf(f_out, "%s: (groupid=%d): err=%2d: pid=%d\n",td->name, td->groupid, td->error, td->pid); + else + fprintf(f_out, "%s: (groupid=%d): err=%2d (%s): pid=%d\n",td->name, td->groupid, td->error, td->verror, td->pid); show_ddir_status(td, rs, td->ddir); if (td->io_bytes[td->ddir ^ 1]) @@ -410,6 +477,17 @@ static void show_thread_status(struct thread_data *td, fprintf(f_out, " IO depths : 1=%3.1f%%, 2=%3.1f%%, 4=%3.1f%%, 8=%3.1f%%, 16=%3.1f%%, 32=%3.1f%%, >=64=%3.1f%%\n", io_u_dist[0], io_u_dist[1], io_u_dist[2], io_u_dist[3], io_u_dist[4], io_u_dist[5], io_u_dist[6]); + /* + * Do latency distribution calculations + */ + for (i = 0; i < FIO_IO_U_LAT_NR; i++) { + io_u_lat[i] = (double) td->io_u_lat[i] / (double) td->total_io_u; + io_u_lat[i] *= 100.0; + } + + fprintf(f_out, " lat (msec): 2=%3.1f%%, 4=%3.1f%%, 8=%3.1f%%, 16=%3.1f%%, 32=%3.1f%%, 64=%3.1f%%, 128=%3.1f%%\n", io_u_lat[0], io_u_lat[1], io_u_lat[2], io_u_lat[3], io_u_lat[4], io_u_lat[5], io_u_lat[6]); + fprintf(f_out, " lat (msec): 256=%3.1f%%, 512=%3.1f%%, 1024=%3.1f%%, >=2048=%3.1f%%\n", io_u_lat[7], io_u_lat[8], io_u_lat[9], io_u_lat[10]); + if (td->description) fprintf(f_out, "%s\n", td->description); } @@ -490,11 +568,6 @@ void show_run_stats(void) for_each_td(td, i) { unsigned long long rbw, wbw; - if (td->error) { - fprintf(f_out, "%s: %s\n", td->name, td->verror); - continue; - } - rs = &runstats[td->groupid]; if (td->runtime[0] < rs->min_run[0] || !rs->min_run[0])