Received-SPF: pass (google.com: best guess record for domain of linux-ext4-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) client-ip=209.132.180.67;
Message-ID: <bb5d395fe47f033be0b8ed96cbebf8867d2416c4.camel@unipv.it>
Subject: Re: AW: Slow I/O on USB media after commit
 f664a3cc17b7d0a2bc3b3ab96181e1029b0ec0e6
From:   Andrea Vai <andrea.vai@unipv.it>
To:     "Theodore Y. Ts'o" <tytso@mit.edu>
Cc:     Ming Lei <ming.lei@redhat.com>,
        "Schmid, Carsten" <Carsten_Schmid@mentor.com>,
        Finn Thain <fthain@telegraphics.com.au>,
        Damien Le Moal <Damien.LeMoal@wdc.com>,
        Alan Stern <stern@rowland.harvard.edu>,
        Jens Axboe <axboe@kernel.dk>,
        Johannes Thumshirn <jthumshirn@suse.de>,
        USB list <linux-usb@vger.kernel.org>,
        SCSI development list <linux-scsi@vger.kernel.org>,
        Himanshu Madhani <himanshu.madhani@cavium.com>,
        Hannes Reinecke <hare@suse.com>,
        Omar Sandoval <osandov@fb.com>,
        "Martin K. Petersen" <martin.petersen@oracle.com>,
        Greg KH <gregkh@linuxfoundation.org>,
        Hans Holmberg <Hans.Holmberg@wdc.com>,
        Kernel development list <linux-kernel@vger.kernel.org>,
        linux-ext4@vger.kernel.org, linux-fsdevel@vger.kernel.org
Date:   Mon, 23 Dec 2019 19:45:57 +0100
In-Reply-To: <20191223172257.GB3282@mit.edu>
References: <20191211024137.GB61323@mit.edu>
         <20191211040058.GC6864@ming.t460p> <20191211160745.GA129186@mit.edu>
         <20191211213316.GA14983@ming.t460p>
         <f38db337cf26390f7c7488a0bc2076633737775b.camel@unipv.it>
         <20191218094830.GB30602@ming.t460p>
         <b1b6a0e9d690ecd9432025acd2db4ac09f834040.camel@unipv.it>
         <20191223130828.GA25948@ming.t460p> <20191223162619.GA3282@mit.edu>
         <4c85fd3f2ec58694cc1ff7ab5c88d6e11ab6efec.camel@unipv.it>
         <20191223172257.GB3282@mit.edu>
Content-Type: multipart/mixed; boundary="=-weAblMnQ5amPpzK4jcZ1"
User-Agent: Evolution 3.32.5 (3.32.5-1.fc30) 
MIME-Version: 1.0
Sender: linux-ext4-owner@vger.kernel.org
Precedence: bulk


--=-weAblMnQ5amPpzK4jcZ1
Content-Type: text/plain; charset="UTF-8"
Content-Transfer-Encoding: 7bit

Il giorno lun, 23/12/2019 alle 12.22 -0500, Theodore Y. Ts'o ha
scritto:
> On Mon, Dec 23, 2019 at 05:29:27PM +0100, Andrea Vai wrote:
> > I run the cp command from a bash script, or from a bash shell. I
> don't
> > know if this answer your question, otherwise feel free to tell me
> a
> > way to find the answer to give you.
> 
> What distro are you using, and/or what package is the cp command
> coming from, and what is the package name and version?

Fedora 30

$ rpm -qf `which cp`
coreutils-8.31-6.fc30.x86_64

> 
> Also, can you remind me what the bash script is and how many files
> you are copying?

basically, it's:

  mount UUID=$uuid /mnt/pendrive
  SECONDS=0
  cp $testfile /mnt/pendrive
  umount /mnt/pendrive
  tempo=$SECONDS

and it copies one file only. Anyway, you can find the whole script
attached.


> 
> Can you change the script so that the cp command is prefixed by:
> 
> "strace -tTf -o /tmp/st "
> 
> e.g.,
> 
> 	strace -tTf -o /tmp/st cp <args>
> 
> And then send me
btw, please tell me if "me" means only you or I cc: all the
recipients, as usual

>  the /tmp/st file.  This will significantly change the
> time, so don't do this for measuring performance.  I just want to
> see
> what the /bin/cp command is *doing*.

I will do it, but I have a doubt. Since the problem doesn't happen
every time, is it useful to give you a trace of a "fast" run? And, if
it's not, I think I should measure performance with the trace command
prefix, to identify a "slow" run to report you. Does it make sense?

Thanks,
Andrea

--=-weAblMnQ5amPpzK4jcZ1
Content-Type: application/x-shellscript; name="test"
Content-Disposition: attachment; filename="test"
Content-Transfer-Encoding: base64

IyEvYmluL2Jhc2gKCnRlc3RmaWxlPS9Ob0JhY2t1cC90ZXN0ZmlsZQpsb2dmaWxlPS9ob21lL2Fu
ZHJlYS90cm91Ymxlc2hvb3RpbmcvMjAxOTA0MThfbGVudGV6emFEYXIvMjAxOTA0MThfbGVudGV6
emFEYXIudHh0Cm5Ucmllcz0kMSAjIE51bWJlciBvZiB0cmllcyB3ZSBkbwoKIyB1dWlkPSI2YTlk
M2MwNS02NzU4LTQ5YzAtYTQ2ZS02Y2UyMjE0NzhlYjMiICNPREQKIyB1dWlkPSI2OGNiYzQxMi1l
N2MzLTQwN2MtODNjMS1jNzE4NTgwZTkzMGQiICNFVkVOCiMgdXVpZD0iNTcxNjM2ODAtYWI4NS00
YzQzLWE5ZGEtODYxMzMyNjJmODE1IiAjIEVWRU4gYnRyZnMKdXVpZD0iYWE3ZWVjNTItY2I5NS00
YWIzLTg1NTctZjBjZWNiYzFjMTBmIiAjIEVWRU4geGZzCiMgdXVpZD0iY2NiN2VlNmMtY2Y4ZC00
Yjg3LWFlOWYtYTJlMTNmNWMwMGU4IiAjIFNTRAojIHV1aWQ9ImY4NzU0MWYwLWZjNzItNDU0NC05
ZjFjLWUzZWU1MjEyZGFmOSIgI0czIGJpYW5jYQoKZWNobyAiU3RhcnRpbmcgJG5UcmllcyB0cmll
cyB3aXRoOiIgfCB0ZWUgLWEgJGxvZ2ZpbGUKdW5hbWUgLWEgfCB0ZWUgLWEgJGxvZ2ZpbGUKbHMg
LWxoICR0ZXN0ZmlsZSAyPiYxIHwgdGVlIC1hICRsb2dmaWxlCmJsa2lkIDI+JjEgfCB0ZWUgLWEg
JGxvZ2ZpbGUKZWNobyAidXVpZD0kdXVpZCIKZWNobyAtbiAiY2F0IC9zeXMvYmxvY2svc2RmL3F1
ZXVlL3NjaGVkdWxlciAtLT4gIiB8IHRlZSAtYSAkbG9nZmlsZQpjYXQgL3N5cy9ibG9jay9zZGYv
cXVldWUvc2NoZWR1bGVyIDI+JjEgfCB0ZWUgLWEgJGxvZ2ZpbGUKZm9yICgoIGs9MTsgazw9JG5U
cmllczsgaysrICkpOyBkbyAKICBlY2hvIC1uICJJbml6aW86ICIgfCB0ZWUgLWEgJGxvZ2ZpbGUK
ICBkYXRlIHwgdHIgLWQgIlxuIiB8IHRlZSAtYSAkbG9nZmlsZQogIHRvdWNoIGluaXppbyAyPiYx
IHx0ZWUgLWEgJGxvZ2ZpbGUKICBtb3VudCBVVUlEPSR1dWlkIC9tbnQvcGVuZHJpdmUgMj4mMSB8
dGVlIC1hICRsb2dmaWxlCiAgU0VDT05EUz0wCiAgY3AgJHRlc3RmaWxlIC9tbnQvcGVuZHJpdmUg
Mj4mMSB8dGVlIC1hICRsb2dmaWxlCiMgIGRkIGlmPSR0ZXN0ZmlsZSBvZj0vbW50L3BlbmRyaXZl
L3Rlc3RmaWxlIGJzPTFNIG9mbGFnPWRpcmVjdAojICBkZCBpZj0kdGVzdGZpbGUgb2Y9L21udC9w
ZW5kcml2ZS90ZXN0ZmlsZSBicz0xTQogIHVtb3VudCAvbW50L3BlbmRyaXZlIDI+JjEgfHRlZSAt
YSAkbG9nZmlsZQogIHRlbXBvPSRTRUNPTkRTCiAgdG91Y2ggZmluZSAyPiYxIHx0ZWUgLWEgJGxv
Z2ZpbGUKICBlY2hvIC1uICIuLi5maW5lOiAiIHwgdGVlIC1hICRsb2dmaWxlCiAgZGF0ZSB8IHRy
IC1kICJcbiIgfCB0ZWUgLWEgJGxvZ2ZpbGUKICBlY2hvICIgLS0+IGNpIGhvIG1lc3NvICR0ZW1w
byBzZWNvbmRpISIgfCB0ZWUgLWEgJGxvZ2ZpbGUKZG9uZQo=


--=-weAblMnQ5amPpzK4jcZ1--