| 1 | #include <stdint.h>
|
|---|
| 2 | #include <stdlib.hfa>
|
|---|
| 3 |
|
|---|
| 4 | #include <unistd.h> // STDERR_FILENO
|
|---|
| 5 | #include <inttypes.h>
|
|---|
| 6 | #include "bits/debug.hfa"
|
|---|
| 7 | #include "bits/locks.hfa"
|
|---|
| 8 | #include "stats.hfa"
|
|---|
| 9 | #include "strstream.hfa"
|
|---|
| 10 |
|
|---|
| 11 | #if !defined(__CFA_NO_STATISTICS__)
|
|---|
| 12 | void __init_stats( struct __stats_t * stats ) {
|
|---|
| 13 | stats->ready.push.local.attempt = 0;
|
|---|
| 14 | stats->ready.push.local.success = 0;
|
|---|
| 15 | stats->ready.push.share.attempt = 0;
|
|---|
| 16 | stats->ready.push.share.success = 0;
|
|---|
| 17 | stats->ready.push.extrn.attempt = 0;
|
|---|
| 18 | stats->ready.push.extrn.success = 0;
|
|---|
| 19 | stats->ready.pop.local .attempt = 0;
|
|---|
| 20 | stats->ready.pop.local .success = 0;
|
|---|
| 21 | stats->ready.pop.help .attempt = 0;
|
|---|
| 22 | stats->ready.pop.help .success = 0;
|
|---|
| 23 | stats->ready.pop.steal .attempt = 0;
|
|---|
| 24 | stats->ready.pop.steal .success = 0;
|
|---|
| 25 | stats->ready.pop.search.attempt = 0;
|
|---|
| 26 | stats->ready.pop.search.success = 0;
|
|---|
| 27 | stats->ready.threads.migration = 0;
|
|---|
| 28 | stats->ready.threads.extunpark = 0;
|
|---|
| 29 | stats->ready.threads.threads = 0;
|
|---|
| 30 | stats->ready.threads.cthreads = 0;
|
|---|
| 31 | stats->ready.sleep.halts = 0;
|
|---|
| 32 | stats->ready.sleep.cancels = 0;
|
|---|
| 33 | stats->ready.sleep.early = 0;
|
|---|
| 34 | stats->ready.sleep.wakes = 0;
|
|---|
| 35 | stats->ready.sleep.seen = 0;
|
|---|
| 36 | stats->ready.sleep.exits = 0;
|
|---|
| 37 |
|
|---|
| 38 | #if defined(CFA_HAVE_LINUX_IO_URING_H)
|
|---|
| 39 | stats->io.alloc.fast = 0;
|
|---|
| 40 | stats->io.alloc.slow = 0;
|
|---|
| 41 | stats->io.alloc.fail = 0;
|
|---|
| 42 | stats->io.alloc.revoke = 0;
|
|---|
| 43 | stats->io.alloc.block = 0;
|
|---|
| 44 | stats->io.submit.fast = 0;
|
|---|
| 45 | stats->io.submit.slow = 0;
|
|---|
| 46 | stats->io.flush.external = 0;
|
|---|
| 47 | stats->io.flush.dirty = 0;
|
|---|
| 48 | stats->io.flush.full = 0;
|
|---|
| 49 | stats->io.flush.idle = 0;
|
|---|
| 50 | stats->io.flush.eager = 0;
|
|---|
| 51 | stats->io.calls.flush = 0;
|
|---|
| 52 | stats->io.calls.submitted = 0;
|
|---|
| 53 | stats->io.calls.drain = 0;
|
|---|
| 54 | stats->io.calls.completed = 0;
|
|---|
| 55 | stats->io.calls.errors.busy = 0;
|
|---|
| 56 | stats->io.ops.sockread = 0;
|
|---|
| 57 | stats->io.ops.epllread = 0;
|
|---|
| 58 | stats->io.ops.sockwrite = 0;
|
|---|
| 59 | stats->io.ops.epllwrite = 0;
|
|---|
| 60 | #endif
|
|---|
| 61 |
|
|---|
| 62 | #if defined(CFA_STATS_ARRAY)
|
|---|
| 63 | stats->array.values = alloc(CFA_STATS_ARRAY);
|
|---|
| 64 | stats->array.cnt = 0;
|
|---|
| 65 | #endif
|
|---|
| 66 | }
|
|---|
| 67 |
|
|---|
| 68 | static inline void tally_one( volatile uint64_t * agg, volatile uint64_t * val) {
|
|---|
| 69 | uint64_t add = __atomic_exchange_n(val, 0_l64u, __ATOMIC_RELAXED);
|
|---|
| 70 | __atomic_fetch_add(agg, add, __ATOMIC_RELAXED);
|
|---|
| 71 | }
|
|---|
| 72 |
|
|---|
| 73 | static inline void tally_one( volatile int64_t * agg, volatile int64_t * val) {
|
|---|
| 74 | int64_t add = __atomic_exchange_n(val, 0_l64, __ATOMIC_RELAXED);
|
|---|
| 75 | __atomic_fetch_add(agg, add, __ATOMIC_RELAXED);
|
|---|
| 76 | }
|
|---|
| 77 |
|
|---|
| 78 | void __tally_stats( struct __stats_t * cltr, struct __stats_t * proc ) {
|
|---|
| 79 | tally_one( &cltr->ready.push.local.attempt, &proc->ready.push.local.attempt );
|
|---|
| 80 | tally_one( &cltr->ready.push.local.success, &proc->ready.push.local.success );
|
|---|
| 81 | tally_one( &cltr->ready.push.share.attempt, &proc->ready.push.share.attempt );
|
|---|
| 82 | tally_one( &cltr->ready.push.share.success, &proc->ready.push.share.success );
|
|---|
| 83 | tally_one( &cltr->ready.push.extrn.attempt, &proc->ready.push.extrn.attempt );
|
|---|
| 84 | tally_one( &cltr->ready.push.extrn.success, &proc->ready.push.extrn.success );
|
|---|
| 85 | tally_one( &cltr->ready.pop.local .attempt, &proc->ready.pop.local .attempt );
|
|---|
| 86 | tally_one( &cltr->ready.pop.local .success, &proc->ready.pop.local .success );
|
|---|
| 87 | tally_one( &cltr->ready.pop.help .attempt, &proc->ready.pop.help .attempt );
|
|---|
| 88 | tally_one( &cltr->ready.pop.help .success, &proc->ready.pop.help .success );
|
|---|
| 89 | tally_one( &cltr->ready.pop.steal .attempt, &proc->ready.pop.steal .attempt );
|
|---|
| 90 | tally_one( &cltr->ready.pop.steal .success, &proc->ready.pop.steal .success );
|
|---|
| 91 | tally_one( &cltr->ready.pop.search.attempt, &proc->ready.pop.search.attempt );
|
|---|
| 92 | tally_one( &cltr->ready.pop.search.success, &proc->ready.pop.search.success );
|
|---|
| 93 | tally_one( &cltr->ready.threads.migration , &proc->ready.threads.migration );
|
|---|
| 94 | tally_one( &cltr->ready.threads.extunpark , &proc->ready.threads.extunpark );
|
|---|
| 95 | tally_one( &cltr->ready.threads.threads , &proc->ready.threads.threads );
|
|---|
| 96 | tally_one( &cltr->ready.threads.cthreads , &proc->ready.threads.cthreads );
|
|---|
| 97 | tally_one( &cltr->ready.sleep.halts , &proc->ready.sleep.halts );
|
|---|
| 98 | tally_one( &cltr->ready.sleep.cancels , &proc->ready.sleep.cancels );
|
|---|
| 99 | tally_one( &cltr->ready.sleep.early , &proc->ready.sleep.early );
|
|---|
| 100 | tally_one( &cltr->ready.sleep.wakes , &proc->ready.sleep.wakes );
|
|---|
| 101 | tally_one( &cltr->ready.sleep.seen , &proc->ready.sleep.wakes );
|
|---|
| 102 | tally_one( &cltr->ready.sleep.exits , &proc->ready.sleep.exits );
|
|---|
| 103 |
|
|---|
| 104 | #if defined(CFA_HAVE_LINUX_IO_URING_H)
|
|---|
| 105 | tally_one( &cltr->io.alloc.fast , &proc->io.alloc.fast );
|
|---|
| 106 | tally_one( &cltr->io.alloc.slow , &proc->io.alloc.slow );
|
|---|
| 107 | tally_one( &cltr->io.alloc.fail , &proc->io.alloc.fail );
|
|---|
| 108 | tally_one( &cltr->io.alloc.revoke , &proc->io.alloc.revoke );
|
|---|
| 109 | tally_one( &cltr->io.alloc.block , &proc->io.alloc.block );
|
|---|
| 110 | tally_one( &cltr->io.submit.fast , &proc->io.submit.fast );
|
|---|
| 111 | tally_one( &cltr->io.submit.slow , &proc->io.submit.slow );
|
|---|
| 112 | tally_one( &cltr->io.flush.external , &proc->io.flush.external );
|
|---|
| 113 | tally_one( &cltr->io.flush.dirty , &proc->io.flush.dirty );
|
|---|
| 114 | tally_one( &cltr->io.flush.full , &proc->io.flush.full );
|
|---|
| 115 | tally_one( &cltr->io.flush.idle , &proc->io.flush.idle );
|
|---|
| 116 | tally_one( &cltr->io.flush.eager , &proc->io.flush.eager );
|
|---|
| 117 | tally_one( &cltr->io.calls.flush , &proc->io.calls.flush );
|
|---|
| 118 | tally_one( &cltr->io.calls.submitted , &proc->io.calls.submitted );
|
|---|
| 119 | tally_one( &cltr->io.calls.drain , &proc->io.calls.drain );
|
|---|
| 120 | tally_one( &cltr->io.calls.completed , &proc->io.calls.completed );
|
|---|
| 121 | tally_one( &cltr->io.calls.errors.busy, &proc->io.calls.errors.busy );
|
|---|
| 122 | tally_one( &cltr->io.ops.sockread , &proc->io.ops.sockread );
|
|---|
| 123 | tally_one( &cltr->io.ops.epllread , &proc->io.ops.epllread );
|
|---|
| 124 | tally_one( &cltr->io.ops.sockwrite , &proc->io.ops.sockwrite );
|
|---|
| 125 | tally_one( &cltr->io.ops.epllwrite , &proc->io.ops.epllwrite );
|
|---|
| 126 | #endif
|
|---|
| 127 | }
|
|---|
| 128 |
|
|---|
| 129 | #define eng3(X) (ws(3, 3, unit(eng( X ))))
|
|---|
| 130 |
|
|---|
| 131 | void __print_stats( struct __stats_t * stats, int flags, const char * type, const char * name, void * id ) with( *stats ) {
|
|---|
| 132 |
|
|---|
| 133 | char buf[1024];
|
|---|
| 134 | ostrstream sstr = { buf, 1024 };
|
|---|
| 135 |
|
|---|
| 136 | if( flags & CFA_STATS_READY_Q ) {
|
|---|
| 137 |
|
|---|
| 138 | sstr | "----- " | type | " \"" | name | "\" (" | "" | id | "" | ") - Ready Q Stats -----";
|
|---|
| 139 |
|
|---|
| 140 | uint64_t totalR = ready.pop.local.success + ready.pop.help.success + ready.pop.steal.success + ready.pop.search.success;
|
|---|
| 141 | uint64_t totalS = ready.push.local.success + ready.push.share.success + ready.push.extrn.success;
|
|---|
| 142 | sstr | "- totals : " | eng3(totalR) | "run," | eng3(totalS) | "schd (" | eng3(ready.push.extrn.success) | "ext,"
|
|---|
| 143 | | eng3(ready.threads.migration) | "mig," | eng3(ready.threads.extunpark) | " eupk," | ready.threads.threads | " t," | ready.threads.cthreads | " cthr)";
|
|---|
| 144 |
|
|---|
| 145 | double push_len = ((double)ready.push.local.attempt + ready.push.share.attempt + ready.push.extrn.attempt) / totalS;
|
|---|
| 146 | double sLcl_len = ready.push.local.success ? ((double)ready.push.local.attempt) / ready.push.local.success : 0;
|
|---|
| 147 | double sOth_len = ready.push.share.success ? ((double)ready.push.share.attempt) / ready.push.share.success : 0;
|
|---|
| 148 | double sExt_len = ready.push.extrn.success ? ((double)ready.push.extrn.attempt) / ready.push.extrn.success : 0;
|
|---|
| 149 | sstr | "- push avg : " | ws(3, 3, push_len)
|
|---|
| 150 | | "- l: " | eng3(ready.push.local.attempt) | " (" | ws(3, 3, sLcl_len) | ")"
|
|---|
| 151 | | ", s: " | eng3(ready.push.share.attempt) | " (" | ws(3, 3, sOth_len) | ")"
|
|---|
| 152 | | ", e: " | eng3(ready.push.extrn.attempt) | " (" | ws(3, 3, sExt_len) | ")";
|
|---|
| 153 |
|
|---|
| 154 | double rLcl_pc = (100.0 * (double)ready.pop.local .success) / totalR;
|
|---|
| 155 | sstr | "- local : " | eng3(ready.pop.local .success) | "-"| ws(3, 3, rLcl_pc) | '%'
|
|---|
| 156 | | " (" | eng3(ready.pop.local .attempt) | " try)";
|
|---|
| 157 | double rHlp_pc = (100.0 * (double)ready.pop.help .success) / totalR;
|
|---|
| 158 | sstr | "- help : " | eng3(ready.pop.help .success) | "-"| ws(3, 3, rHlp_pc) | '%'
|
|---|
| 159 | | " (" | eng3(ready.pop.help .attempt) | " try)";
|
|---|
| 160 | double rStl_pc = (100.0 * (double)ready.pop.steal .success) / totalR;
|
|---|
| 161 | sstr | "- steal : " | eng3(ready.pop.steal .success) | "-"| ws(3, 3, rStl_pc) | '%'
|
|---|
| 162 | | " (" | eng3(ready.pop.steal .attempt) | " try)";
|
|---|
| 163 | double rSch_pc = (100.0 * (double)ready.pop.search.success) / totalR;
|
|---|
| 164 | sstr | "- search : " | eng3(ready.pop.search.success) | "-"| ws(3, 3, rSch_pc) | '%'
|
|---|
| 165 | | " (" | eng3(ready.pop.search.attempt) | " try)";
|
|---|
| 166 |
|
|---|
| 167 | sstr | "- Idle Slp : " | eng3(ready.sleep.halts) | "halt," | eng3(ready.sleep.cancels) | "cancel,"
|
|---|
| 168 | | eng3(ready.sleep.wakes + ready.sleep.early) | '(' | eng3(ready.sleep.early) | ',' | eng3(ready.sleep.seen) | ')' | " wake(early, seen),"
|
|---|
| 169 | | eng3(ready.sleep.exits) | "exit";
|
|---|
| 170 | sstr | nl;
|
|---|
| 171 | }
|
|---|
| 172 |
|
|---|
| 173 | #if defined(CFA_HAVE_LINUX_IO_URING_H)
|
|---|
| 174 | if( flags & CFA_STATS_IO ) {
|
|---|
| 175 | sstr | "----- " | type | " \"" | name | "\" (" | "" | id | "" | ") - I/O Stats -----";
|
|---|
| 176 |
|
|---|
| 177 | uint64_t total_allocs = io.alloc.fast + io.alloc.slow;
|
|---|
| 178 |
|
|---|
| 179 | uint64_t total_submits = io.submit.fast + io.submit.slow;
|
|---|
| 180 | sstr | "- totals : allc" | eng3(io.alloc .fast) | nonl;
|
|---|
| 181 | if(io.alloc.slow) {
|
|---|
| 182 | double avgfasta = (100.0 * (double)io.alloc.fast) / total_allocs;
|
|---|
| 183 | sstr | "fast," | eng3(io.alloc .slow) | "slow (" | ws(3, 3, avgfasta) | "%)" | nonl;
|
|---|
| 184 | }
|
|---|
| 185 | sstr | " - subm" | eng3(io.submit.fast) | nonl;
|
|---|
| 186 | if(io.alloc.slow) {
|
|---|
| 187 | double avgfasts = (100.0 * (double)io.submit.fast) / total_submits;
|
|---|
| 188 | sstr | "fast," | eng3(io.submit.slow) | "slow (" | ws(3, 3, avgfasts) | "%)" | nonl;
|
|---|
| 189 | }
|
|---|
| 190 | sstr | nl;
|
|---|
| 191 |
|
|---|
| 192 | if(io.alloc.fail || io.alloc.revoke || io.alloc.block)
|
|---|
| 193 | sstr | "- failures : " | eng3(io.alloc.fail) | "oom, " | eng3(io.alloc.revoke) | "rvk, " | eng3(io.alloc.block) | "blk";
|
|---|
| 194 | // if(io.flush.external)
|
|---|
| 195 | // sstr | "- flush external : " | eng3(io.flush.external);
|
|---|
| 196 |
|
|---|
| 197 | double avgsubs = ((double)io.calls.submitted) / io.calls.flush;
|
|---|
| 198 | double avgcomp = ((double)io.calls.completed) / io.calls.drain;
|
|---|
| 199 | sstr | "- syscll : "
|
|---|
| 200 | | " sub " | eng3(io.calls.submitted) | "/" | eng3(io.calls.flush) | "(" | ws(3, 3, avgsubs) | "/flush)"
|
|---|
| 201 | | " - cmp " | eng3(io.calls.completed) | "/" | eng3(io.calls.drain) | "(" | ws(3, 3, avgcomp) | "/drain)"
|
|---|
| 202 | | " - " | eng3(io.calls.errors.busy) | " EBUSY";
|
|---|
| 203 | sstr | " - sub: " | eng3(io.flush.full) | "full, " | eng3(io.flush.dirty) | "drty, " | eng3(io.flush.idle) | "idle, " | eng3(io.flush.eager) | "eagr, " | eng3(io.flush.external) | "ext";
|
|---|
| 204 | sstr | "- ops blk: "
|
|---|
| 205 | | " sk rd: " | eng3(io.ops.sockread) | "epll: " | eng3(io.ops.epllread)
|
|---|
| 206 | | " sk wr: " | eng3(io.ops.sockwrite) | "epll: " | eng3(io.ops.epllwrite);
|
|---|
| 207 | sstr | nl;
|
|---|
| 208 | }
|
|---|
| 209 | #endif
|
|---|
| 210 |
|
|---|
| 211 | if(flags) write( sstr, stdout );
|
|---|
| 212 | }
|
|---|
| 213 |
|
|---|
| 214 | #if defined(CFA_STATS_ARRAY)
|
|---|
| 215 | extern "C" {
|
|---|
| 216 | #include <stdio.h>
|
|---|
| 217 | #include <errno.h>
|
|---|
| 218 | #include <sys/stat.h>
|
|---|
| 219 | #include <fcntl.h>
|
|---|
| 220 | }
|
|---|
| 221 |
|
|---|
| 222 | void __flush_stat( struct __stats_t * this, const char * name, void * handle) {
|
|---|
| 223 | int ret = mkdir(".cfadata", 0755);
|
|---|
| 224 | if(ret < 0 && errno != EEXIST) abort("Failed to create directory .cfadata: %d\n", errno);
|
|---|
| 225 |
|
|---|
| 226 | char filename[100];
|
|---|
| 227 | snprintf(filename, 100, ".cfadata/%s%p.data", name, handle);
|
|---|
| 228 |
|
|---|
| 229 | int fd = open(filename, O_WRONLY | O_APPEND | O_CREAT, 0644);
|
|---|
| 230 | if(fd < 0) abort("Failed to create file %s: %d\n", filename, errno);
|
|---|
| 231 |
|
|---|
| 232 | for(i; this->array.cnt) {
|
|---|
| 233 | char line[100];
|
|---|
| 234 | size_t n = snprintf(line, 100, "%llu, %lld\n", this->array.values[i].ts, this->array.values[i].value);
|
|---|
| 235 | write(fd, line, n);
|
|---|
| 236 | }
|
|---|
| 237 |
|
|---|
| 238 | this->array.cnt = 0;
|
|---|
| 239 | close(fd);
|
|---|
| 240 | }
|
|---|
| 241 |
|
|---|
| 242 | static __spinlock_t stats_lock;
|
|---|
| 243 |
|
|---|
| 244 | void __push_stat( struct __stats_t * this, int64_t value, bool external, const char * name, void * handle ) {
|
|---|
| 245 | if(external) lock(stats_lock __cfaabi_dbg_ctx2);
|
|---|
| 246 |
|
|---|
| 247 | if( this->array.cnt >= CFA_STATS_ARRAY ) __flush_stat( this, name, handle );
|
|---|
| 248 |
|
|---|
| 249 | size_t idx = this->array.cnt;
|
|---|
| 250 | this->array.cnt++;
|
|---|
| 251 |
|
|---|
| 252 | if(external) unlock(stats_lock);
|
|---|
| 253 |
|
|---|
| 254 | this->array.values[idx].ts = rdtscl();
|
|---|
| 255 | this->array.values[idx].value = value;
|
|---|
| 256 | }
|
|---|
| 257 | #endif
|
|---|
| 258 | #endif
|
|---|
