io_u.c

   1 #include <unistd.h>
   2 #include <fcntl.h>
   3 #include <string.h>
   4 #include <signal.h>
   5 #include <time.h>
   6 #include <assert.h>
   7
   8 #include "fio.h"
   9
  10 /*
  11  * Change this define to play with the timeout handling
  12  */
  13 #undef FIO_USE_TIMEOUT
  14
  15 struct io_completion_data {
  16         int nr;                         /* input */
  17
  18         int error;                      /* output */
  19         unsigned long bytes_done[2];    /* output */
  20         struct timeval time;            /* output */
  21 };
  22
  23 /*
  24  * The ->file_map[] contains a map of blocks we have or have not done io
  25  * to yet. Used to make sure we cover the entire range in a fair fashion.
  26  */
  27 static int random_map_free(struct thread_data *td, struct fio_file *f,
  28                            unsigned long long block)
  29 {
  30         unsigned int idx = RAND_MAP_IDX(td, f, block);
  31         unsigned int bit = RAND_MAP_BIT(td, f, block);
  32
  33         return (f->file_map[idx] & (1UL << bit)) == 0;
  34 }
  35
  36 /*
  37  * Mark a given offset as used in the map.
  38  */
  39 static void mark_random_map(struct thread_data *td, struct io_u *io_u)
  40 {
  41         unsigned int min_bs = td->o.rw_min_bs;
  42         struct fio_file *f = io_u->file;
  43         unsigned long long block;
  44         unsigned int blocks;
  45         unsigned int nr_blocks;
  46
  47         block = io_u->offset / (unsigned long long) min_bs;
  48         blocks = 0;
  49         nr_blocks = (io_u->buflen + min_bs - 1) / min_bs;
  50
  51         while (blocks < nr_blocks) {
  52                 unsigned int idx, bit;
  53
  54                 /*
  55                  * If we have a mixed random workload, we may
  56                  * encounter blocks we already did IO to.
  57                  */
  58                 if (!td->o.ddir_nr == 1 && !random_map_free(td, f, block))
  59                         break;
  60
  61                 idx = RAND_MAP_IDX(td, f, block);
  62                 bit = RAND_MAP_BIT(td, f, block);
  63
  64                 fio_assert(td, idx < f->num_maps);
  65
  66                 f->file_map[idx] |= (1UL << bit);
  67                 block++;
  68                 blocks++;
  69         }
  70
  71         if ((blocks * min_bs) < io_u->buflen)
  72                 io_u->buflen = blocks * min_bs;
  73 }
  74
  75 /*
  76  * Return the next free block in the map.
  77  */
  78 static int get_next_free_block(struct thread_data *td, struct fio_file *f,
  79                                unsigned long long *b)
  80 {
  81         int i;
  82
  83         i = f->last_free_lookup;
  84         *b = (i * BLOCKS_PER_MAP);
  85         while ((*b) * td->o.rw_min_bs < f->real_file_size) {
  86                 if (f->file_map[i] != -1UL) {
  87                         *b += fio_ffz(f->file_map[i]);
  88                         f->last_free_lookup = i;
  89                         return 0;
  90                 }
  91
  92                 *b += BLOCKS_PER_MAP;
  93                 i++;
  94         }
  95
  96         return 1;
  97 }
  98
  99 static int get_next_rand_offset(struct thread_data *td, struct fio_file *f,
 100                                 int ddir, unsigned long long *b)
 101 {
 102         unsigned long long max_blocks = f->io_size / td->o.min_bs[ddir];
 103         unsigned long long r, rb;
 104         int loops = 5;
 105
 106         do {
 107                 r = os_random_long(&td->random_state);
 108                 if (!max_blocks)
 109                         *b = 0;
 110                 else
 111                         *b = ((max_blocks - 1) * r / (unsigned long long) (RAND_MAX+1.0));
 112                 /*
 113                  * if we are not maintaining a random map, we are done.
 114                  */
 115                 if (td->o.norandommap)
 116                         return 0;
 117
 118                 /*
 119                  * calculate map offset and chec if it's free
 120                  */
 121                 rb = *b;
 122                 if (random_map_free(td, f, rb))
 123                         return 0;
 124
 125         } while (--loops);
 126
 127         /*
 128          * we get here, if we didn't suceed in looking up a block. generate
 129          * a random start offset into the filemap, and find the first free
 130          * block from there.
 131          */
 132         loops = 10;
 133         do {
 134                 f->last_free_lookup = (f->num_maps - 1) * (r / (RAND_MAX+1.0));
 135                 if (!get_next_free_block(td, f, b))
 136                         return 0;
 137
 138                 r = os_random_long(&td->random_state);
 139         } while (--loops);
 140
 141         /*
 142          * that didn't work either, try exhaustive search from the start
 143          */
 144         f->last_free_lookup = 0;
 145         return get_next_free_block(td, f, b);
 146 }
 147
 148 /*
 149  * For random io, generate a random new block and see if it's used. Repeat
 150  * until we find a free one. For sequential io, just return the end of
 151  * the last io issued.
 152  */
 153 static int get_next_offset(struct thread_data *td, struct io_u *io_u)
 154 {
 155         struct fio_file *f = io_u->file;
 156         const int ddir = io_u->ddir;
 157         unsigned long long b;
 158
 159         if (td_random(td) && (td->o.ddir_nr && !--td->ddir_nr)) {
 160                 td->ddir_nr = td->o.ddir_nr;
 161
 162                 if (get_next_rand_offset(td, f, ddir, &b))
 163                         return 1;
 164         } else {
 165                 if (f->last_pos >= f->real_file_size) {
 166                         if (!td_random(td) || get_next_rand_offset(td, f, ddir, &b))
 167                                 return 1;
 168                 } else
 169                         b = (f->last_pos - f->file_offset) / td->o.min_bs[ddir];
 170         }
 171
 172         io_u->offset = (b * td->o.min_bs[ddir]) + f->file_offset;
 173         if (io_u->offset >= f->real_file_size)
 174                 return 1;
 175
 176         return 0;
 177 }
 178
 179 static unsigned int get_next_buflen(struct thread_data *td, struct io_u *io_u)
 180 {
 181         const int ddir = io_u->ddir;
 182         unsigned int buflen;
 183         long r;
 184
 185         if (td->o.min_bs[ddir] == td->o.max_bs[ddir])
 186                 buflen = td->o.min_bs[ddir];
 187         else {
 188                 r = os_random_long(&td->bsrange_state);
 189                 if (!td->o.bssplit_nr)
 190                         buflen = (unsigned int) (1 + (double) (td->o.max_bs[ddir] - 1) * r / (RAND_MAX + 1.0));
 191                 else {
 192                         long perc = 0;
 193                         unsigned int i;
 194
 195                         for (i = 0; i < td->o.bssplit_nr; i++) {
 196                                 struct bssplit *bsp = &td->o.bssplit[i];
 197
 198                                 buflen = bsp->bs;
 199                                 perc += bsp->perc;
 200                                 if (r <= ((LONG_MAX / 100L) * perc))
 201                                         break;
 202                         }
 203                 }
 204                 if (!td->o.bs_unaligned)
 205                         buflen = (buflen + td->o.min_bs[ddir] - 1) & ~(td->o.min_bs[ddir] - 1);
 206         }
 207
 208         if (io_u->offset + buflen > io_u->file->real_file_size)
 209                 buflen = td->o.min_bs[ddir];
 210
 211         return buflen;
 212 }
 213
 214 static void set_rwmix_bytes(struct thread_data *td)
 215 {
 216         unsigned long long rbytes;
 217         unsigned int diff;
 218
 219         /*
 220          * we do time or byte based switch. this is needed because
 221          * buffered writes may issue a lot quicker than they complete,
 222          * whereas reads do not.
 223          */
 224         rbytes = td->io_bytes[td->rwmix_ddir] - td->rwmix_bytes;
 225         diff = td->o.rwmix[td->rwmix_ddir ^ 1];
 226
 227         td->rwmix_bytes = td->io_bytes[td->rwmix_ddir] + (rbytes * ((100 - diff)) / diff);
 228 }
 229
 230 static inline enum fio_ddir get_rand_ddir(struct thread_data *td)
 231 {
 232         unsigned int v;
 233         long r;
 234
 235         r = os_random_long(&td->rwmix_state);
 236         v = 1 + (int) (100.0 * (r / (RAND_MAX + 1.0)));
 237         if (v < td->o.rwmix[DDIR_READ])
 238                 return DDIR_READ;
 239
 240         return DDIR_WRITE;
 241 }
 242
 243 /*
 244  * Return the data direction for the next io_u. If the job is a
 245  * mixed read/write workload, check the rwmix cycle and switch if
 246  * necessary.
 247  */
 248 static enum fio_ddir get_rw_ddir(struct thread_data *td)
 249 {
 250         if (td_rw(td)) {
 251                 struct timeval now;
 252                 unsigned long elapsed;
 253                 unsigned int cycle;
 254
 255                 fio_gettime(&now, NULL);
 256                 elapsed = mtime_since_now(&td->rwmix_switch);
 257
 258                 /*
 259                  * if this is the first cycle, make it shorter
 260                  */
 261                 cycle = td->o.rwmixcycle;
 262                 if (!td->rwmix_bytes)
 263                         cycle /= 10;
 264
 265                 /*
 266                  * Check if it's time to seed a new data direction.
 267                  */
 268                 if (elapsed >= cycle ||
 269                     td->io_bytes[td->rwmix_ddir] >= td->rwmix_bytes) {
 270                         unsigned long long max_bytes;
 271                         enum fio_ddir ddir;
 272
 273                         /*
 274                          * Put a top limit on how many bytes we do for
 275                          * one data direction, to avoid overflowing the
 276                          * ranges too much
 277                          */
 278                         ddir = get_rand_ddir(td);
 279                         max_bytes = td->this_io_bytes[ddir];
 280                         if (max_bytes >= (td->o.size * td->o.rwmix[ddir] / 100)) {
 281                                 if (!td->rw_end_set[ddir]) {
 282                                         td->rw_end_set[ddir] = 1;
 283                                         memcpy(&td->rw_end[ddir], &now, sizeof(now));
 284                                 }
 285                                 ddir ^= 1;
 286                         }
 287
 288                         if (ddir != td->rwmix_ddir)
 289                                 set_rwmix_bytes(td);
 290
 291                         td->rwmix_ddir = ddir;
 292                         memcpy(&td->rwmix_switch, &now, sizeof(now));
 293                 }
 294                 return td->rwmix_ddir;
 295         } else if (td_read(td))
 296                 return DDIR_READ;
 297         else
 298                 return DDIR_WRITE;
 299 }
 300
 301 void put_io_u(struct thread_data *td, struct io_u *io_u)
 302 {
 303         assert((io_u->flags & IO_U_F_FREE) == 0);
 304         io_u->flags |= IO_U_F_FREE;
 305
 306         if (io_u->file)
 307                 put_file(td, io_u->file);
 308
 309         io_u->file = NULL;
 310         list_del(&io_u->list);
 311         list_add(&io_u->list, &td->io_u_freelist);
 312         td->cur_depth--;
 313 }
 314
 315 void requeue_io_u(struct thread_data *td, struct io_u **io_u)
 316 {
 317         struct io_u *__io_u = *io_u;
 318
 319         __io_u->flags |= IO_U_F_FREE;
 320         __io_u->flags &= ~IO_U_F_FLIGHT;
 321
 322         list_del(&__io_u->list);
 323         list_add_tail(&__io_u->list, &td->io_u_requeues);
 324         td->cur_depth--;
 325         *io_u = NULL;
 326 }
 327
 328 static int fill_io_u(struct thread_data *td, struct io_u *io_u)
 329 {
 330         if (td->io_ops->flags & FIO_NOIO)
 331                 goto out;
 332
 333         /*
 334          * see if it's time to sync
 335          */
 336         if (td->o.fsync_blocks &&
 337            !(td->io_issues[DDIR_WRITE] % td->o.fsync_blocks) &&
 338              td->io_issues[DDIR_WRITE] && should_fsync(td)) {
 339                 io_u->ddir = DDIR_SYNC;
 340                 goto out;
 341         }
 342
 343         io_u->ddir = get_rw_ddir(td);
 344
 345         /*
 346          * See if it's time to switch to a new zone
 347          */
 348         if (td->zone_bytes >= td->o.zone_size) {
 349                 td->zone_bytes = 0;
 350                 io_u->file->last_pos += td->o.zone_skip;
 351                 td->io_skip_bytes += td->o.zone_skip;
 352         }
 353
 354         /*
 355          * No log, let the seq/rand engine retrieve the next buflen and
 356          * position.
 357          */
 358         if (get_next_offset(td, io_u))
 359                 return 1;
 360
 361         io_u->buflen = get_next_buflen(td, io_u);
 362         if (!io_u->buflen)
 363                 return 1;
 364
 365         if (io_u->offset + io_u->buflen > io_u->file->real_file_size)
 366                 return 1;
 367
 368         /*
 369          * mark entry before potentially trimming io_u
 370          */
 371         if (td_random(td) && !td->o.norandommap)
 372                 mark_random_map(td, io_u);
 373
 374         /*
 375          * If using a write iolog, store this entry.
 376          */
 377 out:
 378         td->zone_bytes += io_u->buflen;
 379         log_io_u(td, io_u);
 380         return 0;
 381 }
 382
 383 void io_u_mark_depth(struct thread_data *td, struct io_u *io_u)
 384 {
 385         int index = 0;
 386
 387         if (io_u->ddir == DDIR_SYNC)
 388                 return;
 389
 390         switch (td->cur_depth) {
 391         default:
 392                 index = 6;
 393                 break;
 394         case 32 ... 63:
 395                 index = 5;
 396                 break;
 397         case 16 ... 31:
 398                 index = 4;
 399                 break;
 400         case 8 ... 15:
 401                 index = 3;
 402                 break;
 403         case 4 ... 7:
 404                 index = 2;
 405                 break;
 406         case 2 ... 3:
 407                 index = 1;
 408         case 1:
 409                 break;
 410         }
 411
 412         td->ts.io_u_map[index]++;
 413         td->ts.total_io_u[io_u->ddir]++;
 414 }
 415
 416 static void io_u_mark_lat_usec(struct thread_data *td, unsigned long usec)
 417 {
 418         int index = 0;
 419
 420         assert(usec < 1000);
 421
 422         switch (usec) {
 423         case 750 ... 999:
 424                 index = 9;
 425                 break;
 426         case 500 ... 749:
 427                 index = 8;
 428                 break;
 429         case 250 ... 499:
 430                 index = 7;
 431                 break;
 432         case 100 ... 249:
 433                 index = 6;
 434                 break;
 435         case 50 ... 99:
 436                 index = 5;
 437                 break;
 438         case 20 ... 49:
 439                 index = 4;
 440                 break;
 441         case 10 ... 19:
 442                 index = 3;
 443                 break;
 444         case 4 ... 9:
 445                 index = 2;
 446                 break;
 447         case 2 ... 3:
 448                 index = 1;
 449         case 0 ... 1:
 450                 break;
 451         }
 452
 453         assert(index < FIO_IO_U_LAT_U_NR);
 454         td->ts.io_u_lat_u[index]++;
 455 }
 456
 457 static void io_u_mark_lat_msec(struct thread_data *td, unsigned long msec)
 458 {
 459         int index = 0;
 460
 461         switch (msec) {
 462         default:
 463                 index = 11;
 464                 break;
 465         case 1000 ... 1999:
 466                 index = 10;
 467                 break;
 468         case 750 ... 999:
 469                 index = 9;
 470                 break;
 471         case 500 ... 749:
 472                 index = 8;
 473                 break;
 474         case 250 ... 499:
 475                 index = 7;
 476                 break;
 477         case 100 ... 249:
 478                 index = 6;
 479                 break;
 480         case 50 ... 99:
 481                 index = 5;
 482                 break;
 483         case 20 ... 49:
 484                 index = 4;
 485                 break;
 486         case 10 ... 19:
 487                 index = 3;
 488                 break;
 489         case 4 ... 9:
 490                 index = 2;
 491                 break;
 492         case 2 ... 3:
 493                 index = 1;
 494         case 0 ... 1:
 495                 break;
 496         }
 497
 498         assert(index < FIO_IO_U_LAT_M_NR);
 499         td->ts.io_u_lat_m[index]++;
 500 }
 501
 502 static void io_u_mark_latency(struct thread_data *td, unsigned long usec)
 503 {
 504         if (usec < 1000)
 505                 io_u_mark_lat_usec(td, usec);
 506         else
 507                 io_u_mark_lat_msec(td, usec / 1000);
 508 }
 509
 510 /*
 511  * Get next file to service by choosing one at random
 512  */
 513 static struct fio_file *get_next_file_rand(struct thread_data *td, int goodf,
 514                                            int badf)
 515 {
 516         struct fio_file *f;
 517         int fno;
 518
 519         do {
 520                 long r = os_random_long(&td->next_file_state);
 521
 522                 fno = (unsigned int) ((double) td->o.nr_files * (r / (RAND_MAX + 1.0)));
 523                 f = &td->files[fno];
 524                 if (f->flags & FIO_FILE_DONE)
 525                         continue;
 526
 527                 if ((!goodf || (f->flags & goodf)) && !(f->flags & badf))
 528                         return f;
 529         } while (1);
 530 }
 531
 532 /*
 533  * Get next file to service by doing round robin between all available ones
 534  */
 535 static struct fio_file *get_next_file_rr(struct thread_data *td, int goodf,
 536                                          int badf)
 537 {
 538         unsigned int old_next_file = td->next_file;
 539         struct fio_file *f;
 540
 541         do {
 542                 f = &td->files[td->next_file];
 543
 544                 td->next_file++;
 545                 if (td->next_file >= td->o.nr_files)
 546                         td->next_file = 0;
 547
 548                 if (f->flags & FIO_FILE_DONE) {
 549                         f = NULL;
 550                         continue;
 551                 }
 552
 553                 if ((!goodf || (f->flags & goodf)) && !(f->flags & badf))
 554                         break;
 555
 556                 f = NULL;
 557         } while (td->next_file != old_next_file);
 558
 559         return f;
 560 }
 561
 562 static struct fio_file *get_next_file(struct thread_data *td)
 563 {
 564         struct fio_file *f;
 565
 566         assert(td->o.nr_files <= td->files_index);
 567
 568         if (!td->nr_open_files || td->nr_done_files >= td->o.nr_files)
 569                 return NULL;
 570
 571         f = td->file_service_file;
 572         if (f && (f->flags & FIO_FILE_OPEN) && td->file_service_left--)
 573                 return f;
 574
 575         if (td->o.file_service_type == FIO_FSERVICE_RR)
 576                 f = get_next_file_rr(td, FIO_FILE_OPEN, FIO_FILE_CLOSING);
 577         else
 578                 f = get_next_file_rand(td, FIO_FILE_OPEN, FIO_FILE_CLOSING);
 579
 580         td->file_service_file = f;
 581         td->file_service_left = td->file_service_nr - 1;
 582         return f;
 583 }
 584
 585 static struct fio_file *find_next_new_file(struct thread_data *td)
 586 {
 587         struct fio_file *f;
 588
 589         if (!td->nr_open_files || td->nr_done_files >= td->o.nr_files)
 590                 return NULL;
 591
 592         if (td->o.file_service_type == FIO_FSERVICE_RR)
 593                 f = get_next_file_rr(td, 0, FIO_FILE_OPEN);
 594         else
 595                 f = get_next_file_rand(td, 0, FIO_FILE_OPEN);
 596
 597         return f;
 598 }
 599
 600 static int set_io_u_file(struct thread_data *td, struct io_u *io_u)
 601 {
 602         struct fio_file *f;
 603
 604         do {
 605                 f = get_next_file(td);
 606                 if (!f)
 607                         return 1;
 608
 609 set_file:
 610                 io_u->file = f;
 611                 get_file(f);
 612
 613                 if (!fill_io_u(td, io_u))
 614                         break;
 615
 616                 /*
 617                  * td_io_close() does a put_file() as well, so no need to
 618                  * do that here.
 619                  */
 620                 io_u->file = NULL;
 621                 td_io_close_file(td, f);
 622                 f->flags |= FIO_FILE_DONE;
 623                 td->nr_done_files++;
 624
 625                 /*
 626                  * probably not the right place to do this, but see
 627                  * if we need to open a new file
 628                  */
 629                 if (td->nr_open_files < td->o.open_files &&
 630                     td->o.open_files != td->o.nr_files) {
 631                         f = find_next_new_file(td);
 632
 633                         if (!f || td_io_open_file(td, f))
 634                                 return 1;
 635
 636                         goto set_file;
 637                 }
 638         } while (1);
 639
 640         return 0;
 641 }
 642
 643
 644 struct io_u *__get_io_u(struct thread_data *td)
 645 {
 646         struct io_u *io_u = NULL;
 647
 648         if (!list_empty(&td->io_u_requeues))
 649                 io_u = list_entry(td->io_u_requeues.next, struct io_u, list);
 650         else if (!queue_full(td)) {
 651                 io_u = list_entry(td->io_u_freelist.next, struct io_u, list);
 652
 653                 io_u->buflen = 0;
 654                 io_u->resid = 0;
 655                 io_u->file = NULL;
 656                 io_u->end_io = NULL;
 657         }
 658
 659         if (io_u) {
 660                 assert(io_u->flags & IO_U_F_FREE);
 661                 io_u->flags &= ~IO_U_F_FREE;
 662
 663                 io_u->error = 0;
 664                 list_del(&io_u->list);
 665                 list_add(&io_u->list, &td->io_u_busylist);
 666                 td->cur_depth++;
 667         }
 668
 669         return io_u;
 670 }
 671
 672 /*
 673  * Return an io_u to be processed. Gets a buflen and offset, sets direction,
 674  * etc. The returned io_u is fully ready to be prepped and submitted.
 675  */
 676 struct io_u *get_io_u(struct thread_data *td)
 677 {
 678         struct fio_file *f;
 679         struct io_u *io_u;
 680
 681         io_u = __get_io_u(td);
 682         if (!io_u)
 683                 return NULL;
 684
 685         /*
 686          * from a requeue, io_u already setup
 687          */
 688         if (io_u->file)
 689                 goto out;
 690
 691         /*
 692          * If using an iolog, grab next piece if any available.
 693          */
 694         if (td->o.read_iolog_file) {
 695                 if (read_iolog_get(td, io_u))
 696                         goto err_put;
 697         } else if (set_io_u_file(td, io_u))
 698                 goto err_put;
 699
 700         f = io_u->file;
 701         assert(f->flags & FIO_FILE_OPEN);
 702
 703         if (io_u->ddir != DDIR_SYNC) {
 704                 if (!io_u->buflen)
 705                         goto err_put;
 706
 707                 f->last_pos = io_u->offset + io_u->buflen;
 708
 709                 if (td->o.verify != VERIFY_NONE)
 710                         populate_verify_io_u(td, io_u);
 711         }
 712
 713         /*
 714          * Set io data pointers.
 715          */
 716         io_u->endpos = io_u->offset + io_u->buflen;
 717 out:
 718         io_u->xfer_buf = io_u->buf;
 719         io_u->xfer_buflen = io_u->buflen;
 720
 721         if (!td_io_prep(td, io_u)) {
 722                 fio_gettime(&io_u->start_time, NULL);
 723                 return io_u;
 724         }
 725 err_put:
 726         put_io_u(td, io_u);
 727         return NULL;
 728 }
 729
 730 void io_u_log_error(struct thread_data *td, struct io_u *io_u)
 731 {
 732         const char *msg[] = { "read", "write", "sync" };
 733
 734         log_err("fio: io_u error");
 735
 736         if (io_u->file)
 737                 log_err(" on file %s", io_u->file->file_name);
 738
 739         log_err(": %s\n", strerror(io_u->error));
 740
 741         log_err("     %s offset=%llu, buflen=%lu\n", msg[io_u->ddir], io_u->offset, io_u->xfer_buflen);
 742
 743         if (!td->error)
 744                 td_verror(td, io_u->error, "io_u error");
 745 }
 746
 747 static void io_completed(struct thread_data *td, struct io_u *io_u,
 748                          struct io_completion_data *icd)
 749 {
 750         unsigned long usec;
 751
 752         assert(io_u->flags & IO_U_F_FLIGHT);
 753         io_u->flags &= ~IO_U_F_FLIGHT;
 754
 755         if (io_u->ddir == DDIR_SYNC) {
 756                 td->last_was_sync = 1;
 757                 return;
 758         }
 759
 760         td->last_was_sync = 0;
 761
 762         if (!io_u->error) {
 763                 unsigned int bytes = io_u->buflen - io_u->resid;
 764                 const enum fio_ddir idx = io_u->ddir;
 765                 int ret;
 766
 767                 td->io_blocks[idx]++;
 768                 td->io_bytes[idx] += bytes;
 769                 td->this_io_bytes[idx] += bytes;
 770
 771                 io_u->file->last_completed_pos = io_u->endpos;
 772
 773                 usec = utime_since(&io_u->issue_time, &icd->time);
 774
 775                 add_clat_sample(td, idx, usec);
 776                 add_bw_sample(td, idx, &icd->time);
 777                 io_u_mark_latency(td, usec);
 778
 779                 if (td_write(td) && idx == DDIR_WRITE &&
 780                     td->o.do_verify &&
 781                     td->o.verify != VERIFY_NONE)
 782                         log_io_piece(td, io_u);
 783
 784                 icd->bytes_done[idx] += bytes;
 785
 786                 if (io_u->end_io) {
 787                         ret = io_u->end_io(td, io_u);
 788                         if (ret && !icd->error)
 789                                 icd->error = ret;
 790                 }
 791         } else {
 792                 icd->error = io_u->error;
 793                 io_u_log_error(td, io_u);
 794         }
 795 }
 796
 797 static void init_icd(struct io_completion_data *icd, int nr)
 798 {
 799         fio_gettime(&icd->time, NULL);
 800
 801         icd->nr = nr;
 802
 803         icd->error = 0;
 804         icd->bytes_done[0] = icd->bytes_done[1] = 0;
 805 }
 806
 807 static void ios_completed(struct thread_data *td,
 808                           struct io_completion_data *icd)
 809 {
 810         struct io_u *io_u;
 811         int i;
 812
 813         for (i = 0; i < icd->nr; i++) {
 814                 io_u = td->io_ops->event(td, i);
 815
 816                 io_completed(td, io_u, icd);
 817                 put_io_u(td, io_u);
 818         }
 819 }
 820
 821 /*
 822  * Complete a single io_u for the sync engines.
 823  */
 824 long io_u_sync_complete(struct thread_data *td, struct io_u *io_u)
 825 {
 826         struct io_completion_data icd;
 827
 828         init_icd(&icd, 1);
 829         io_completed(td, io_u, &icd);
 830         put_io_u(td, io_u);
 831
 832         if (!icd.error)
 833                 return icd.bytes_done[0] + icd.bytes_done[1];
 834
 835         td_verror(td, icd.error, "io_u_sync_complete");
 836         return -1;
 837 }
 838
 839 /*
 840  * Called to complete min_events number of io for the async engines.
 841  */
 842 long io_u_queued_complete(struct thread_data *td, int min_events)
 843 {
 844         struct io_completion_data icd;
 845         struct timespec *tvp = NULL;
 846         int ret;
 847         struct timespec ts = { .tv_sec = 0, .tv_nsec = 0, };
 848
 849         if (!min_events)
 850                 tvp = &ts;
 851
 852         ret = td_io_getevents(td, min_events, td->cur_depth, tvp);
 853         if (ret < 0) {
 854                 td_verror(td, -ret, "td_io_getevents");
 855                 return ret;
 856         } else if (!ret)
 857                 return ret;
 858
 859         init_icd(&icd, ret);
 860         ios_completed(td, &icd);
 861         if (!icd.error)
 862                 return icd.bytes_done[0] + icd.bytes_done[1];
 863
 864         td_verror(td, icd.error, "io_u_queued_complete");
 865         return -1;
 866 }
 867
 868 /*
 869  * Call when io_u is really queued, to update the submission latency.
 870  */
 871 void io_u_queued(struct thread_data *td, struct io_u *io_u)
 872 {
 873         unsigned long slat_time;
 874
 875         slat_time = utime_since(&io_u->start_time, &io_u->issue_time);
 876         add_slat_sample(td, io_u->ddir, slat_time);
 877 }
 878
 879 #ifdef FIO_USE_TIMEOUT
 880 void io_u_set_timeout(struct thread_data *td)
 881 {
 882         assert(td->cur_depth);
 883
 884         td->timer.it_interval.tv_sec = 0;
 885         td->timer.it_interval.tv_usec = 0;
 886         td->timer.it_value.tv_sec = IO_U_TIMEOUT + IO_U_TIMEOUT_INC;
 887         td->timer.it_value.tv_usec = 0;
 888         setitimer(ITIMER_REAL, &td->timer, NULL);
 889         fio_gettime(&td->timeout_end, NULL);
 890 }
 891
 892 static void io_u_dump(struct io_u *io_u)
 893 {
 894         unsigned long t_start = mtime_since_now(&io_u->start_time);
 895         unsigned long t_issue = mtime_since_now(&io_u->issue_time);
 896
 897         log_err("io_u=%p, t_start=%lu, t_issue=%lu\n", io_u, t_start, t_issue);
 898         log_err("  buf=%p/%p, len=%lu/%lu, offset=%llu\n", io_u->buf, io_u->xfer_buf, io_u->buflen, io_u->xfer_buflen, io_u->offset);
 899         log_err("  ddir=%d, fname=%s\n", io_u->ddir, io_u->file->file_name);
 900 }
 901 #else
 902 void io_u_set_timeout(struct thread_data fio_unused *td)
 903 {
 904 }
 905 #endif
 906
 907 #ifdef FIO_USE_TIMEOUT
 908 static void io_u_timeout_handler(int fio_unused sig)
 909 {
 910         struct thread_data *td, *__td;
 911         pid_t pid = getpid();
 912         struct list_head *entry;
 913         struct io_u *io_u;
 914         int i;
 915
 916         log_err("fio: io_u timeout\n");
 917
 918         /*
 919          * TLS would be nice...
 920          */
 921         td = NULL;
 922         for_each_td(__td, i) {
 923                 if (__td->pid == pid) {
 924                         td = __td;
 925                         break;
 926                 }
 927         }
 928
 929         if (!td) {
 930                 log_err("fio: io_u timeout, can't find job\n");
 931                 exit(1);
 932         }
 933
 934         if (!td->cur_depth) {
 935                 log_err("fio: timeout without pending work?\n");
 936                 return;
 937         }
 938
 939         log_err("fio: io_u timeout: job=%s, pid=%d\n", td->o.name, td->pid);
 940
 941         list_for_each(entry, &td->io_u_busylist) {
 942                 io_u = list_entry(entry, struct io_u, list);
 943
 944                 io_u_dump(io_u);
 945         }
 946
 947         td_verror(td, ETIMEDOUT, "io_u timeout");
 948         exit(1);
 949 }
 950 #endif
 951
 952 void io_u_init_timeout(void)
 953 {
 954 #ifdef FIO_USE_TIMEOUT
 955         signal(SIGALRM, io_u_timeout_handler);
 956 #endif
 957 }