X-Git-Url: https://git.kernel.dk/?p=fio.git;a=blobdiff_plain;f=verify.c;h=c450e88cfc37bdf84835d7145ea75c7c9b337a2d;hp=bb0aba77f96400f66e7729a202773a905c944d2c;hb=afcf77584a39461d81ff8b5c3c86fb7583172020;hpb=32c17adf7f75da1f0957d4691633fea60259910f diff --git a/verify.c b/verify.c index bb0aba77..c450e88c 100644 --- a/verify.c +++ b/verify.c @@ -6,10 +6,13 @@ #include #include #include +#include #include "fio.h" #include "verify.h" #include "smalloc.h" +#include "trim.h" +#include "lib/rand.h" #include "crc/md5.h" #include "crc/crc64.h" @@ -21,44 +24,53 @@ #include "crc/sha512.h" #include "crc/sha1.h" -static void fill_random_bytes(struct thread_data *td, void *p, unsigned int len) -{ - unsigned int todo; - int r; - - while (len) { - r = os_random_long(&td->verify_state); - - /* - * lrand48_r seems to be broken and only fill the bottom - * 32-bits, even on 64-bit archs with 64-bit longs - */ - todo = sizeof(r); - if (todo > len) - todo = len; +static void populate_hdr(struct thread_data *td, struct io_u *io_u, + struct verify_header *hdr, unsigned int header_num, + unsigned int header_len); - memcpy(p, &r, todo); - - len -= todo; - p += todo; - } -} - -static void fill_pattern(struct thread_data *td, void *p, unsigned int len) +void fill_pattern(struct thread_data *td, void *p, unsigned int len, struct io_u *io_u, unsigned long seed, int use_seed) { switch (td->o.verify_pattern_bytes) { case 0: dprint(FD_VERIFY, "fill random bytes len=%u\n", len); - fill_random_bytes(td, p, len); + if (use_seed) + __fill_random_buf(p, len, seed); + else + io_u->rand_seed = fill_random_buf(&td->buf_state, p, len); break; case 1: + /* + * See below write barrier comment + */ +#if 0 + read_barrier(); + if (io_u->buf_filled_len >= len) { + dprint(FD_VERIFY, "using already filled verify pattern b=0 len=%u\n", len); + return; + } +#endif dprint(FD_VERIFY, "fill verify pattern b=0 len=%u\n", len); memset(p, td->o.verify_pattern[0], len); + /* + * We need to ensure that the pattern stores are seen before + * the fill length store, or we could observe headers that + * aren't valid to the extent notified by the fill length + */ + write_barrier(); + io_u->buf_filled_len = len; break; default: { unsigned int i = 0, size = 0; unsigned char *b = p; +#if 0 + read_barrier(); + if (io_u->buf_filled_len >= len) { + dprint(FD_VERIFY, "using already filled verify pattern b=%d len=%u\n", + td->o.verify_pattern_bytes, len); + return; + } +#endif dprint(FD_VERIFY, "fill verify pattern b=%d len=%u\n", td->o.verify_pattern_bytes, len); @@ -69,11 +81,42 @@ static void fill_pattern(struct thread_data *td, void *p, unsigned int len) memcpy(b+i, td->o.verify_pattern, size); i += size; } + write_barrier(); + io_u->buf_filled_len = len; break; } } } +static unsigned int get_hdr_inc(struct thread_data *td, struct io_u *io_u) +{ + unsigned int hdr_inc; + + hdr_inc = io_u->buflen; + if (td->o.verify_interval) + hdr_inc = td->o.verify_interval; + + return hdr_inc; +} + +static void fill_pattern_headers(struct thread_data *td, struct io_u *io_u, + unsigned long seed, int use_seed) +{ + unsigned int hdr_inc, header_num; + struct verify_header *hdr; + void *p = io_u->buf; + + fill_pattern(td, p, io_u->buflen, io_u, seed, use_seed); + + hdr_inc = get_hdr_inc(td, io_u); + header_num = 0; + for (; p < io_u->buf + io_u->buflen; p += hdr_inc) { + hdr = p; + populate_hdr(td, io_u, hdr, header_num, hdr_inc); + header_num++; + } +} + static void memswp(void *buf1, void *buf2, unsigned int len) { char swap[200]; @@ -100,7 +143,7 @@ static void hexdump(void *buffer, int len) */ static inline unsigned int __hdr_size(int verify_type) { - unsigned int len = len; + unsigned int len = 0; switch (verify_type) { case VERIFY_NONE: @@ -136,6 +179,9 @@ static inline unsigned int __hdr_size(int verify_type) case VERIFY_SHA1: len = sizeof(struct vhdr_sha1); break; + case VERIFY_PATTERN: + len = 0; + break; default: log_err("fio: unknown verify header!\n"); assert(0); @@ -166,6 +212,7 @@ struct vcont { */ struct io_u *io_u; unsigned int hdr_num; + struct thread_data *td; /* * Output, only valid in case of error @@ -176,6 +223,76 @@ struct vcont { unsigned int crc_len; }; +static void dump_buf(char *buf, unsigned int len, unsigned long long offset, + const char *type, struct fio_file *f) +{ + char *ptr, fname[256]; + int ret, fd; + + ptr = strdup(f->file_name); + strcpy(fname, basename(ptr)); + + sprintf(fname + strlen(fname), ".%llu.%s", offset, type); + + fd = open(fname, O_CREAT | O_TRUNC | O_WRONLY, 0644); + if (fd < 0) { + perror("open verify buf file"); + return; + } + + while (len) { + ret = write(fd, buf, len); + if (!ret) + break; + else if (ret < 0) { + perror("write verify buf file"); + break; + } + len -= ret; + buf += ret; + } + + close(fd); + log_err(" %s data dumped as %s\n", type, fname); + free(ptr); +} + +/* + * Dump the contents of the read block and re-generate the correct data + * and dump that too. + */ +static void dump_verify_buffers(struct verify_header *hdr, struct vcont *vc) +{ + struct thread_data *td = vc->td; + struct io_u *io_u = vc->io_u; + unsigned long hdr_offset; + struct io_u dummy; + void *buf; + + /* + * Dump the contents we just read off disk + */ + hdr_offset = vc->hdr_num * hdr->len; + + dump_buf(io_u->buf + hdr_offset, hdr->len, io_u->offset + hdr_offset, + "received", vc->io_u->file); + + /* + * Allocate a new buf and re-generate the original data + */ + buf = malloc(io_u->buflen); + dummy = *io_u; + dummy.buf = buf; + dummy.rand_seed = hdr->rand_seed; + dummy.buf_filled_len = 0; + + fill_pattern_headers(td, &dummy, hdr->rand_seed, 1); + + dump_buf(buf + hdr_offset, hdr->len, io_u->offset + hdr_offset, + "expected", vc->io_u->file); + free(buf); +} + static void log_verify_failure(struct verify_header *hdr, struct vcont *vc) { unsigned long long offset; @@ -191,6 +308,8 @@ static void log_verify_failure(struct verify_header *hdr, struct vcont *vc) log_err(" Received CRC: "); hexdump(vc->bad_crc, vc->crc_len); } + + dump_verify_buffers(hdr, vc); } /* @@ -201,20 +320,67 @@ static inline void *io_u_verify_off(struct verify_header *hdr, struct vcont *vc) return vc->io_u->buf + vc->hdr_num * hdr->len + hdr_size(hdr); } -static int verify_io_u_meta(struct verify_header *hdr, struct thread_data *td, - struct vcont *vc) +static unsigned int hweight8(unsigned int w) +{ + unsigned int res = w - ((w >> 1) & 0x55); + + res = (res & 0x33) + ((res >> 2) & 0x33); + return (res + (res >> 4)) & 0x0F; +} + +static int verify_io_u_pattern(struct verify_header *hdr, struct vcont *vc) +{ + struct thread_data *td = vc->td; + struct io_u *io_u = vc->io_u; + char *buf, *pattern; + unsigned int header_size = __hdr_size(td->o.verify); + unsigned int len, mod, i; + + pattern = td->o.verify_pattern; + buf = (void *) hdr + header_size; + len = get_hdr_inc(td, io_u) - header_size; + mod = header_size % td->o.verify_pattern_bytes; + + for (i = 0; i < len; i++) { + if (buf[i] != pattern[mod]) { + unsigned int bits; + + bits = hweight8(buf[i] ^ pattern[mod]); + log_err("fio: got pattern %x, wanted %x. Bad bits %d\n", + buf[i], pattern[mod], bits); + log_err("fio: bad pattern block offset %u\n", i); + dump_verify_buffers(hdr, vc); + return EILSEQ; + } + mod++; + if (mod == td->o.verify_pattern_bytes) + mod = 0; + } + + return 0; +} + +static int verify_io_u_meta(struct verify_header *hdr, struct vcont *vc) { + struct thread_data *td = vc->td; struct vhdr_meta *vh = hdr_priv(hdr); struct io_u *io_u = vc->io_u; + int ret = EILSEQ; dprint(FD_VERIFY, "meta verify io_u %p, len %u\n", io_u, hdr->len); if (vh->offset == io_u->offset + vc->hdr_num * td->o.verify_interval) + ret = 0; + + if (td->o.verify_pattern_bytes) + ret |= verify_io_u_pattern(hdr, vc); + + if (!ret) return 0; vc->name = "meta"; log_verify_failure(hdr, vc); - return EILSEQ; + return ret; } static int verify_io_u_sha512(struct verify_header *hdr, struct vcont *vc) @@ -425,37 +591,6 @@ static int verify_io_u_md5(struct verify_header *hdr, struct vcont *vc) return EILSEQ; } -static unsigned int hweight8(unsigned int w) -{ - unsigned int res = w - ((w >> 1) & 0x55); - - res = (res & 0x33) + ((res >> 2) & 0x33); - return (res + (res >> 4)) & 0x0F; -} - -int verify_io_u_pattern(char *pattern, unsigned long pattern_size, - char *buf, unsigned int len, unsigned int mod) -{ - unsigned int i; - - for (i = 0; i < len; i++) { - if (buf[i] != pattern[mod]) { - unsigned int bits; - - bits = hweight8(buf[i] ^ pattern[mod]); - log_err("fio: got pattern %x, wanted %x. Bad bits %d\n", - buf[i], pattern[mod], bits); - log_err("fio: bad pattern block offset %u\n", i); - return EILSEQ; - } - mod++; - if (mod == pattern_size) - mod = 0; - } - - return 0; -} - /* * Push IO verification to a separate thread */ @@ -481,19 +616,55 @@ int verify_io_u_async(struct thread_data *td, struct io_u *io_u) return 0; } +static int verify_trimmed_io_u(struct thread_data *td, struct io_u *io_u) +{ + static char zero_buf[1024]; + unsigned int this_len, len; + int ret = 0; + void *p; + + if (!td->o.trim_zero) + return 0; + + len = io_u->buflen; + p = io_u->buf; + do { + this_len = sizeof(zero_buf); + if (this_len > len) + this_len = len; + if (memcmp(p, zero_buf, this_len)) { + ret = EILSEQ; + break; + } + len -= this_len; + p += this_len; + } while (len); + + if (!ret) + return 0; + + log_err("trim: verify failed at file %s offset %llu, length %lu" + ", block offset %lu\n", + io_u->file->file_name, io_u->offset, io_u->buflen, + (unsigned long) (p - io_u->buf)); + return ret; +} + int verify_io_u(struct thread_data *td, struct io_u *io_u) { struct verify_header *hdr; - unsigned int hdr_size, hdr_inc, hdr_num = 0; + unsigned int header_size, hdr_inc, hdr_num = 0; void *p; int ret; if (td->o.verify == VERIFY_NULL || io_u->ddir != DDIR_READ) return 0; + if (io_u->flags & IO_U_F_TRIMMED) { + ret = verify_trimmed_io_u(td, io_u); + goto done; + } - hdr_inc = io_u->buflen; - if (td->o.verify_interval) - hdr_inc = td->o.verify_interval; + hdr_inc = get_hdr_inc(td, io_u); ret = 0; for (p = io_u->buf; p < io_u->buf + io_u->buflen; @@ -501,45 +672,25 @@ int verify_io_u(struct thread_data *td, struct io_u *io_u) struct vcont vc = { .io_u = io_u, .hdr_num = hdr_num, + .td = td, }; - if (ret && td->o.verify_fatal) { - td->terminate = 1; + if (ret && td->o.verify_fatal) break; - } - hdr_size = __hdr_size(td->o.verify); + + header_size = __hdr_size(td->o.verify); if (td->o.verify_offset) - memswp(p, p + td->o.verify_offset, hdr_size); + memswp(p, p + td->o.verify_offset, header_size); hdr = p; if (hdr->fio_magic != FIO_HDR_MAGIC) { - log_err("Bad verify header %x at %llu\n", - hdr->fio_magic, - io_u->offset + hdr_num * hdr->len); + log_err("verify: bad magic header %x, wanted %x at file %s offset %llu, length %u\n", + hdr->fio_magic, FIO_HDR_MAGIC, + io_u->file->file_name, + io_u->offset + hdr_num * hdr->len, hdr->len); return EILSEQ; } - if (td->o.verify_pattern_bytes) { - dprint(FD_VERIFY, "pattern verify io_u %p, len %u\n", - io_u, hdr->len); - ret = verify_io_u_pattern(td->o.verify_pattern, - td->o.verify_pattern_bytes, - p + hdr_size, - hdr_inc - hdr_size, - hdr_size % td->o.verify_pattern_bytes); - /* - * Also verify the meta data, if applicable - */ - if (hdr->verify_type == VERIFY_META) - ret |= verify_io_u_meta(hdr, td, &vc); - - if (ret) - log_err("fio: verify failed at %llu/%u\n", - io_u->offset + hdr_num * hdr->len, - hdr->len); - continue; - } - switch (hdr->verify_type) { case VERIFY_MD5: ret = verify_io_u_md5(hdr, &vc); @@ -567,17 +718,24 @@ int verify_io_u(struct thread_data *td, struct io_u *io_u) ret = verify_io_u_sha512(hdr, &vc); break; case VERIFY_META: - ret = verify_io_u_meta(hdr, td, &vc); + ret = verify_io_u_meta(hdr, &vc); break; case VERIFY_SHA1: ret = verify_io_u_sha1(hdr, &vc); break; + case VERIFY_PATTERN: + ret = verify_io_u_pattern(hdr, &vc); + break; default: log_err("Bad verify type %u\n", hdr->verify_type); ret = EINVAL; } } +done: + if (ret && td->o.verify_fatal) + td->terminate = 1; + return ret; } @@ -678,94 +836,95 @@ static void fill_md5(struct verify_header *hdr, void *p, unsigned int len) md5_update(&md5_ctx, p, len); } +static void populate_hdr(struct thread_data *td, struct io_u *io_u, + struct verify_header *hdr, unsigned int header_num, + unsigned int header_len) +{ + unsigned int data_len; + void *data, *p; + + p = (void *) hdr; + + hdr->fio_magic = FIO_HDR_MAGIC; + hdr->len = header_len; + hdr->verify_type = td->o.verify; + hdr->rand_seed = io_u->rand_seed; + data_len = header_len - hdr_size(hdr); + + data = p + hdr_size(hdr); + switch (td->o.verify) { + case VERIFY_MD5: + dprint(FD_VERIFY, "fill md5 io_u %p, len %u\n", + io_u, hdr->len); + fill_md5(hdr, data, data_len); + break; + case VERIFY_CRC64: + dprint(FD_VERIFY, "fill crc64 io_u %p, len %u\n", + io_u, hdr->len); + fill_crc64(hdr, data, data_len); + break; + case VERIFY_CRC32C: + case VERIFY_CRC32C_INTEL: + dprint(FD_VERIFY, "fill crc32c io_u %p, len %u\n", + io_u, hdr->len); + fill_crc32c(hdr, data, data_len); + break; + case VERIFY_CRC32: + dprint(FD_VERIFY, "fill crc32 io_u %p, len %u\n", + io_u, hdr->len); + fill_crc32(hdr, data, data_len); + break; + case VERIFY_CRC16: + dprint(FD_VERIFY, "fill crc16 io_u %p, len %u\n", + io_u, hdr->len); + fill_crc16(hdr, data, data_len); + break; + case VERIFY_CRC7: + dprint(FD_VERIFY, "fill crc7 io_u %p, len %u\n", + io_u, hdr->len); + fill_crc7(hdr, data, data_len); + break; + case VERIFY_SHA256: + dprint(FD_VERIFY, "fill sha256 io_u %p, len %u\n", + io_u, hdr->len); + fill_sha256(hdr, data, data_len); + break; + case VERIFY_SHA512: + dprint(FD_VERIFY, "fill sha512 io_u %p, len %u\n", + io_u, hdr->len); + fill_sha512(hdr, data, data_len); + break; + case VERIFY_META: + dprint(FD_VERIFY, "fill meta io_u %p, len %u\n", + io_u, hdr->len); + fill_meta(hdr, td, io_u, header_num); + break; + case VERIFY_SHA1: + dprint(FD_VERIFY, "fill sha1 io_u %p, len %u\n", + io_u, hdr->len); + fill_sha1(hdr, data, data_len); + break; + case VERIFY_PATTERN: + /* nothing to do here */ + break; + default: + log_err("fio: bad verify type: %d\n", td->o.verify); + assert(0); + } + if (td->o.verify_offset) + memswp(p, p + td->o.verify_offset, hdr_size(hdr)); +} + /* * fill body of io_u->buf with random data and add a header with the - * crc32 or md5 sum of that data. + * checksum of choice */ void populate_verify_io_u(struct thread_data *td, struct io_u *io_u) { - struct verify_header *hdr; - void *p = io_u->buf, *data; - unsigned int hdr_inc, data_len, header_num = 0; - if (td->o.verify == VERIFY_NULL) return; - fill_pattern(td, p, io_u->buflen); - - hdr_inc = io_u->buflen; - if (td->o.verify_interval) - hdr_inc = td->o.verify_interval; - - for (; p < io_u->buf + io_u->buflen; p += hdr_inc) { - hdr = p; - - hdr->fio_magic = FIO_HDR_MAGIC; - hdr->verify_type = td->o.verify; - hdr->len = hdr_inc; - data_len = hdr_inc - hdr_size(hdr); - - data = p + hdr_size(hdr); - switch (td->o.verify) { - case VERIFY_MD5: - dprint(FD_VERIFY, "fill md5 io_u %p, len %u\n", - io_u, hdr->len); - fill_md5(hdr, data, data_len); - break; - case VERIFY_CRC64: - dprint(FD_VERIFY, "fill crc64 io_u %p, len %u\n", - io_u, hdr->len); - fill_crc64(hdr, data, data_len); - break; - case VERIFY_CRC32C: - case VERIFY_CRC32C_INTEL: - dprint(FD_VERIFY, "fill crc32c io_u %p, len %u\n", - io_u, hdr->len); - fill_crc32c(hdr, data, data_len); - break; - case VERIFY_CRC32: - dprint(FD_VERIFY, "fill crc32 io_u %p, len %u\n", - io_u, hdr->len); - fill_crc32(hdr, data, data_len); - break; - case VERIFY_CRC16: - dprint(FD_VERIFY, "fill crc16 io_u %p, len %u\n", - io_u, hdr->len); - fill_crc16(hdr, data, data_len); - break; - case VERIFY_CRC7: - dprint(FD_VERIFY, "fill crc7 io_u %p, len %u\n", - io_u, hdr->len); - fill_crc7(hdr, data, data_len); - break; - case VERIFY_SHA256: - dprint(FD_VERIFY, "fill sha256 io_u %p, len %u\n", - io_u, hdr->len); - fill_sha256(hdr, data, data_len); - break; - case VERIFY_SHA512: - dprint(FD_VERIFY, "fill sha512 io_u %p, len %u\n", - io_u, hdr->len); - fill_sha512(hdr, data, data_len); - break; - case VERIFY_META: - dprint(FD_VERIFY, "fill meta io_u %p, len %u\n", - io_u, hdr->len); - fill_meta(hdr, td, io_u, header_num); - break; - case VERIFY_SHA1: - dprint(FD_VERIFY, "fill sha1 io_u %p, len %u\n", - io_u, hdr->len); - fill_sha1(hdr, data, data_len); - break; - default: - log_err("fio: bad verify type: %d\n", td->o.verify); - assert(0); - } - if (td->o.verify_offset) - memswp(p, p + td->o.verify_offset, hdr_size(hdr)); - header_num++; - } + fill_pattern_headers(td, io_u, 0, 0); } int get_next_verify(struct thread_data *td, struct io_u *io_u) @@ -783,18 +942,25 @@ int get_next_verify(struct thread_data *td, struct io_u *io_u) ipo = rb_entry(n, struct io_piece, rb_node); rb_erase(n, &td->io_hist_tree); - td->io_hist_len--; + assert(ipo->flags & IP_F_ONRB); + ipo->flags &= ~IP_F_ONRB; } else if (!flist_empty(&td->io_hist_list)) { ipo = flist_entry(td->io_hist_list.next, struct io_piece, list); - td->io_hist_len--; flist_del(&ipo->list); + assert(ipo->flags & IP_F_ONLIST); + ipo->flags &= ~IP_F_ONLIST; } if (ipo) { + td->io_hist_len--; + io_u->offset = ipo->offset; io_u->buflen = ipo->len; io_u->file = ipo->file; + if (ipo->flags & IP_F_TRIMMED) + io_u->flags |= IO_U_F_TRIMMED; + if (!fio_file_open(io_u->file)) { int r = td_io_open_file(td, io_u->file); @@ -810,6 +976,8 @@ int get_next_verify(struct thread_data *td, struct io_u *io_u) io_u->ddir = DDIR_READ; io_u->xfer_buf = io_u->buf; io_u->xfer_buflen = io_u->buflen; + + remove_trim_entry(td, ipo); free(ipo); dprint(FD_VERIFY, "get_next_verify: ret io_u %p\n", io_u); return 0; @@ -875,7 +1043,8 @@ static void *verify_async_thread(void *data) if (ret) { td_verror(td, ret, "async_verify"); - td->terminate = 1; + if (td->o.verify_fatal) + td->terminate = 1; } done: @@ -890,12 +1059,16 @@ done: int verify_async_init(struct thread_data *td) { int i, ret; + pthread_attr_t attr; + + pthread_attr_init(&attr); + pthread_attr_setstacksize(&attr, PTHREAD_STACK_MIN); td->verify_thread_exit = 0; td->verify_threads = malloc(sizeof(pthread_t) * td->o.verify_async); for (i = 0; i < td->o.verify_async; i++) { - ret = pthread_create(&td->verify_threads[i], NULL, + ret = pthread_create(&td->verify_threads[i], &attr, verify_async_thread, td); if (ret) { log_err("fio: async verify creation failed: %s\n", @@ -911,6 +1084,8 @@ int verify_async_init(struct thread_data *td) td->nr_verify_threads++; } + pthread_attr_destroy(&attr); + if (i != td->o.verify_async) { log_err("fio: only %d verify threads started, exiting\n", i); td->verify_thread_exit = 1;