Skip to content
This repository has been archived by the owner on Nov 1, 2023. It is now read-only.

Add total duration column to stats #71

Open
wants to merge 2 commits into
base: master
Choose a base branch
from
Open

Conversation

milianw
Copy link
Contributor

@milianw milianw commented Jul 11, 2016

Implements #67

Example output for io:

Syscalls latency statistics (usec):
Type                    Count            Min        Average            Max          Stdev          Total
--------------------------------------------------------------------------------------------------------
Open                      730          3.072         19.220       1308.384         69.425      14030.816
Read                      173          0.768        383.774       8908.736        917.306      66392.832
Write                     130          0.992          8.207         72.960          7.149       1066.880
Sync                        0          0.000          0.000          0.000              ?          0.000

Disk latency statistics (usec):
Name                    Count            Min        Average            Max          Stdev          Total
--------------------------------------------------------------------------------------------------------
sda                         1        163.264        163.264        163.264              ?        163.264

For syscalls:

Per-TID syscalls statistics (usec)
sh (2964, TID: 2964)                            Count            Min        Average          Max      Stdev          Total  Return values 
 - openat                                         576          3.168         22.459     1615.712    104.527       12936.48  {'success': 172, 'ENOENT': 406}
 - mmap                                           292           2.24          8.742        81.12       6.24       2552.768  {'success': 293}
 - ioctl                                          239          0.576        296.328    62666.752   4052.624      70822.464  {'success': 239, 'ENOTTY': 2}
 - newfstat                                       165          0.512          1.339        3.424      0.486        220.864  {'success': 166}
 - read                                           161            0.8        474.111     20462.88   2066.455      76331.808  {'success': 162}
 - close                                          161          0.576          1.257        3.232      0.465          202.4  {'success': 162}
 - newfstatat                                     140          2.752         81.307     5750.816    519.782       11383.04  {'success': 125, 'ENOENT': 17}
 - mprotect                                        87          3.968          9.173       26.816      3.111        798.016  {'success': 88}
 - munmap                                          77           5.12         11.322       34.272      4.666        871.776  {'success': 78}
 - write                                           45          1.184          6.599       16.512      3.625         296.96  {'success': 46}
 - sched_yield                                     43          1.856         15.195       79.232      27.13        653.376  {'success': 44}
 - readlinkat                                      24          6.432         14.176       23.456      4.803        340.224  {'success': 17, 'EINVAL': 9}
 - rt_sigprocmask                                  22          0.544          1.129        2.688      0.732         24.832  {'success': 23}
 - fcntl                                           20           1.28          1.704        2.272      0.305          34.08  {'success': 21}
 - futex                                           19          0.864       2897.145    35267.488   8229.159       55045.76  {'success': 20}
 - brk                                             18           1.28          5.205        12.96      2.512         93.696  {'success': 19}
 - faccessat                                       14          4.864          9.088        20.32      4.985        127.232  {'success': 6, 'ENOENT': 10}
 - rt_sigaction                                    12           0.64          1.299        2.944      0.738         15.584  {'success': 13}
 - getdents64                                      12          0.928        171.123      1002.08    357.085       2053.472  {'success': 13}
 - geteuid                                          8          0.384          0.804         1.44      0.388          6.432  {'success': 9}
 - getuid                                           8          0.352          0.792        1.376      0.331          6.336  {'success': 9}
 - getgid                                           6           0.32          0.528        0.672      0.126          3.168  {'success': 7}
 - clock_gettime                                    6          0.512          1.488        2.112      0.745          8.928  {'success': 7}
 - clone                                            6         19.264         28.453       33.344      5.235         170.72  {'success': 7}
 - getegid                                          6           0.32          0.677        1.024      0.284          4.064  {'success': 7}
 - epoll_ctl                                        5          3.904          4.339        4.992      0.475         21.696  {'success': 6}
 - newuname                                         3            0.8          2.069        2.784      1.102          6.208  {'success': 4}
 - statfs                                           3          7.168          7.765         8.32      0.577         23.296  {'success': 4}
 - getrlimit                                        3            1.6           1.76         2.08      0.277           5.28  {'success': 4}
 - eventfd2                                         2          6.304          8.176       10.048          ?         16.352  {'success': 3}
 - sched_getaffinity                                2          1.824          2.256        2.688          ?          4.512  {'success': 3}
 - setsockopt                                       2          1.248         12.656       24.064          ?         25.312  {'success': 3}
 - set_tid_address                                  1           1.92           1.92         1.92          ?           1.92  {'success': 2}
 - clock_getres                                     1          2.144          2.144        2.144          ?          2.144  {'success': 2}
 - set_robust_list                                  1          1.216          1.216        1.216          ?          1.216  {'success': 2}
 - getpid                                           1          1.408          1.408        1.408          ?          1.408  {'success': 2}
 - bind                                             1          7.232          7.232        7.232          ?          7.232  {'success': 2}
 - execve                                           1       3874.912       3874.912     3874.912          ?       3874.912  {'success': 2}
 - getsockname                                      1          1.376          1.376        1.376          ?          1.376  {'success': 2}
 - nanosleep                                        1        318.016        318.016      318.016          ?        318.016  {'success': 2}
 - socket                                           1         12.992         12.992       12.992          ?         12.992  {'success': 2}
 - lseek                                            1          1.888          1.888        1.888          ?          1.888  {'success': 2}
 - epoll_create1                                    1          6.912          6.912        6.912          ?          6.912  {'success': 2}
 - socketpair                                       1          23.84          23.84        23.84          ?          23.84  {'success': 2}
 - epoll_pwait                                      1          3.616          3.616        3.616          ?          3.616  {'success': 2}
 - timerfd_create                                   1          5.824          5.824        5.824          ?          5.824  {'success': 2}
Total:                                           2201                                                           239370.432                
-----------------------------------------------------------------------------------------------------------------

Total syscalls: 2201

Total duration: 239370.432000

@milianw milianw changed the title Add total latency duration column to io stats. Add total duration column to stats Jul 11, 2016
@jdesfossez
Copy link
Contributor

Looks good, just for the "Per-TID syscalls statistics" table, it should be right aligned like the other fields.

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

2 participants