From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: from mail-vk0-f44.google.com ([209.85.213.44]:33660 "EHLO mail-vk0-f44.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S935666AbcLVHFm (ORCPT ); Thu, 22 Dec 2016 02:05:42 -0500 Received: by mail-vk0-f44.google.com with SMTP id 137so160809629vkl.0 for ; Wed, 21 Dec 2016 23:05:41 -0800 (PST) MIME-Version: 1.0 In-Reply-To: References: From: Sitsofe Wheeler Date: Thu, 22 Dec 2016 07:05:40 +0000 Message-ID: Subject: Re: FIO -- A few basic questions on Data Integrity. Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Sender: fio-owner@vger.kernel.org List-Id: fio@vger.kernel.org To: Saju Nair Cc: "fio@vger.kernel.org" Hi, Bear in mind I can't see your current test.fio (which must be different from the one you previously posted because fio appears to be searching for 0x99 whereas the previous job was searching for 0x33) so if you have extra options in there they may invalidate any analysis I make. On 22 December 2016 at 04:48, Saju Nair wrote: > Hi, > Thanks. Please find the stderr messages snippet. > We get the offsets where FIO observed failures, during the "verify" phase= . > The nvme**..received - is reported to contain 0. > > However, when we try a "dd" to access the location (offset) specified > - we do see proper data. > It might be an issue in our DUT, and we will investigate further. I'm guessing you didn't use iflag=3Dnocache or (iflag=3Ddirect + reading in aligned block sizes) on your dd - are you sure your dd wasn't just reading out of Linux's page cache? For example for an offset of 12288 you could use dd iflag=3Ddirect if=3D/dev/nvme0n1 bs=3D4k skip=3D3 count=3D= 1 | hexdump (bear in mind it is better to do this directly after the fio . Do you also get this same effect on disks you know to be good? This is all very suspicious. If the change above somehow returns the same data as fio I think you've got a problem on your hands. If the problem goes away when you add end_fsync=3D1 to the fio job file then that suggests someone has configured the NVMe devices for speed and has thrown away safety. > ************************************************************* > /root/demo/fio-2.12/bin/fio test.fio -eta=3Dalways --eta-newline=3D1 1 te= e This line seems garbled (" 1 tee"? Did you have to re-enter all output by hand?) but assuming the real command line is correct your tee will only save stdout to a file and not stderr. See http://stackoverflow.com/questions/692000/how-do-i-write-stderr-to-a-file-w= hile-using-tee-with-a-pipe for suggestions on also saving stderr while using tee... > fiol.log=E2=80=A2rite-and-verify: (g=3D0): rw=3Dread, bs=3D4K-4K/4K-4K/4K= -4K, > ioengine=3Dlibaio, iodepth=3D16 > =E2=80=A2rite-and-verify: (g=3D0): rw=3Dread, bs=3D4K-4K/4K-4K/4K-4K, > ioengine=3Dlibaio, iodepth=3D16 > fio-2.12 ^^^ Might be worth upgrading to the latest fio release (2.16) so you don't hit any fixed issues. > starting 1 process > fio: got pattern '00', wanted '99'. Bad bits 4 > fio: bad pattern block offset 0 ^^ Notice how this says the block offset, what it found and what it wanted. This should make working out where to look straight forward. > received data dumped as nvme0n1.12288.received > expected data dumped as nvme0n1.12288.expected > fio: verify type mismatch (0 media, 14 given) > fio: got pattern '00', wanted '99'. Bad bits 4 > fio: bad pattern block offset 0 > received data dumped as nvmeOn1.40960.received > expected data dumped as nvme0n1.40960.expected > fio: verify type mismatch (0 media, 14 given) > > > On Tue, Dec 20, 2016 at 6:56 PM, Sitsofe Wheeler wrot= e: >> Hi, >> >> On 20 December 2016 at 12:26, Saju Nair wrote: >>> >>> Thanks for your clarifications. >>> We ran with a --continue_on_error=3Dverify, >>> to let the FIO complete the full compare.. >>> >>> We tried to do a sequential write and compare, using the FIO config >>> file as below, and to bring in the complexity of "random" as a 2nd >>> step. >>> [write-and-verify] >>> rw=3Dwrite >>> bs=3D4k >>> direct=3D1 >>> ioengine=3Dlibaio >>> iodepth=3D16 >>> size=3D2m >>> verify=3Dpattern >>> verify_pattern=3D0x33333333 >>> continue_on_error=3Dverify >>> verify_dump=3D1 >>> filename=3D/dev/XXXX >>> >>> FIO reports errors and we see files of the following names created: >>> ..received >>> ..expected >>> >>> Wanted help in interpreting the result. >>> >>> We wrote 2MB worth of data, with blocksize =3D 4K. >>> So, ideally is it expected to do 2MB/4KB =3D 512 IO operations >>> >>> 1) The received/expected files: >>> Are they for each 4K offset that failed the comparison ? >> >> I bet you can deduce this from the size and names of the files... >> >>> Is the to be interpreted as the (num/bs)-th block that failed ? >>> For ex: if the num=3D438272, and bs=3D4096 =3D> 107th block failed ? >>> >>> It would be useful to know this information - so that we can debug furt= her, >>> FYI, if we try a "dd" command and check the disk, based on the above >>> calculation - the data is proper (as expected). >> >> You never answered my question about what you are doing with stderr. >> I'll repeat it here: >> >>>> Are you doing something like redirecting stdout to a file but not >>>> doing anything with stderr? It would help if you include the command >>>> line you are using to run fio in your reply. >> >> Can you answer this question and post the full command line you ran >> fio with? I think it might have relevance to your current question. >> >>> 2) What were the locations that were written to.. >>> Tried fio-verify-state <.state_file>, and get the below: >>> Version: 0x3 >>> Size: 408 >>> CRC: 0x70ca464a >>> Thread: 0 >>> Name: write-and-verify >>> Completions: 16 >>> Depth: 16 >>> Number IOs: 512 >>> Index: 0 >>> Completions: >>> (file=3D 0) 2031616 >>> (file=3D 0) 2035712 >>> (file=3D 0) 2039808 >>> (file=3D 0) 2043904 >>> (file=3D 0) 2048000 >>> (file=3D 0) 2052096 >>> (file=3D 0) 2056192 >>> (file=3D 0) 2060288 >>> (file=3D 0) 2064384 >>> (file=3D 0) 2068480 >>> (file=3D 0) 2072576 >>> (file=3D 0) 2076672 >>> (file=3D 0) 2080768 >>> (file=3D 0) 2084864 >>> (file=3D 0) 2088960 >>> (file=3D 0) 2093056 >>> >>> How do we interpret the above content to understand the locations of Wr= ites. >> >> Perhaps fio tracks how far through the sequence it got rather than >> individual locations written (this would be necessary to handle things >> like loops=3D)? I personally don't know the answer to this but you can >> always take a look at the source code. >> >> -- >> Sitsofe | http://sucs.org/~sits/ --=20 Sitsofe | http://sucs.org/~sits/