[Bugs] [Bug 1478411] Directory listings on fuse mount are very slow due to small number of getdents () entries

Fri Aug 4 14:39:53 UTC 2017

https://bugzilla.redhat.com/show_bug.cgi?id=1478411

--- Comment #2 from nh2 <nh2-redhatbugzilla at deditus.de> ---
And some more patterns I observed stracing the `glusterfs` fuse process, using
`-e 'read,writev'`:

[pid 18266] 1501856999.667820 read(10, "\27\3\3\0\34", 5) = 5
[pid 18266] 1501856999.668085 read(10,
"\357U>\245\325n[t\3\277hq!Z\303\32\247\334\336\327N\311\317s\252\267\2\2", 28)
= 28
[pid 18266] 1501856999.668317 read(10, "\27\3\3\0000", 5) = 5
[pid 18266] 1501856999.668411 read(10,
"\357U>\245\325n[u8\340\250\214\305\7&/\331=\320\214\326\340\227\16\225 at c\252\307\213\211V"...,
48) = 48
[pid 18266] 1501856999.668549 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.668597 read(10,
"\357U>\245\325n[v\232\225\22/Jk\237\212\363b\215\212S\255\262K\227\347\6\275V-&E"...,
16408) = 16408
[pid 18266] 1501856999.668669 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.668719 read(10,
"\357U>\245\325n[wz\237\v\377\252\236'\356\265\37Z\341\241_m\341\2612\346+Dm\224\233"...,
16408) = 16408
[pid 18266] 1501856999.668810 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.668862 read(10,
"\357U>\245\325n[x\226\222\222\274\275\332D\304\3271\335M\340\300wq\210\200suU\372\326\17"...,
16408) = 16408
[pid 18266] 1501856999.668941 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.668988 read(10,
"\357U>\245\325n[y\216i$\276\237\vA1\33\31:\312\257g\323\221\227\r^\21R/\3713"...,
16408) = 16408
[pid 18266] 1501856999.669093 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.669140 read(10,
"\357U>\245\325n[z\205\224\361D\225V%\t\0tk\274K\3\2530U\202\311\222A\335G\266"...,
16408) = 16408
[pid 18266] 1501856999.669216 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.669265 read(10,
"\357U>\245\325n[{\204\276\253\272g\354\376\207hPe\22\300\3771\30\313\336,\2729pgn"...,
16408) = 16408
[pid 18266] 1501856999.669345 read(10, "\27\3\3:L", 5) = 5
[pid 18266] 1501856999.669392 read(10, "\357U>\245\325n[|4mQ\334\227\4\206\274
\273E<?mb\334\255\210Q/\350Z\351w"..., 14924) = 14924
[pid 18266] 1501856999.673053 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\333B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.673469 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\334B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.673802 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\335B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.674173 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\336B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.674528 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\337B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.674873 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\340B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.675237 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\341B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.675539 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\342B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.675887 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\343B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.676248 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\344B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.676576 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\345B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.676893 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\346B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677159 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\347B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677254 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\350B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677344 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\351B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677436 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\352B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677533 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\353B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677633 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\354B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677730 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\355B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677826 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\356B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.677940 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\357B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678049 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\360B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678152 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\361B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678244 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\362B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678338 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\363B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678432 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\364B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678532 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\365B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678630 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\366B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678726 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\367B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678817 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\370B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678912 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\371B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.678999 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\372B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.679099 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\373B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18266] 1501856999.936511 read(10, "\27\3\3\0\34", 5) = 5
[pid 18266] 1501856999.936797 read(10,
"\357U>\245\325n[}\343\35\272\266C\323\r\226_\362\275\372\355\1\275\367\177\221]\341",
28) = 28
[pid 18266] 1501856999.937045 read(10, "\27\3\3\0000", 5) = 5
[pid 18266] 1501856999.937188 read(10, "\357U>\245\325n[~]l\37\270\336
L\311~~p\t\260\200\242\275~\331%\310\26UX\210"..., 48) = 48
[pid 18266] 1501856999.937291 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.937342 read(10,
"\357U>\245\325n[\177\0U\331\214\236\344cy\10\276\266\322\3447h\2\2668\347\266\20\6JM"...,
16408) = 16408
[pid 18266] 1501856999.937401 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.937436 read(10,
"\357U>\245\325n[\200\250\372\274)\2\307\227\33_\221\3639\222\2059aI\340<r~\306rb"...,
16408) = 16408
[pid 18266] 1501856999.937498 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.937533 read(10,
"\357U>\245\325n[\2018F\0365\336D(O\211\3370!\v\235\271\0275v\231-\2339^\253"...,
16408) = 16408
[pid 18266] 1501856999.937594 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.937628 read(10,
"\357U>\245\325n[\202\353`\344\4\17-/\372\204[\277A\251\310n\2250\32S\276!|\361\333"...,
16408) = 16408
[pid 18266] 1501856999.937680 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.937715 read(10,
"\357U>\245\325n[\203qbev\336\305\3750O\307\221U\367
@\262\202[p1\347\231\305\2"..., 16408) = 16408
[pid 18266] 1501856999.937770 read(10, "\27\3\3@\30", 5) = 5
[pid 18266] 1501856999.937819 read(10,
"\357U>\245\325n[\204\242\245Y\177\302\251\316u\301\354zR>3{D\6gc\365\302\277un"...,
16408) = 16408
[pid 18266] 1501856999.937871 read(10, "\27\3\3:T", 5) = 5
[pid 18266] 1501856999.937905 read(10,
"\357U>\245\325n[\205y}X\3221\325\21\275\321\330\371\353\310\362\21\36}Q\352\203\321\350\1\373"...,
14932) = 14932
[pid 18266] 1501856999.940995 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\374B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.941429 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\375B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.941725 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\376B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.941968 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\377B\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.942312 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\0C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.942604 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\1C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.942850 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\2C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.943087 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\3C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.943352 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\4C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.943618 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\5C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.943896 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\6C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.944181 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\7C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.944434 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\10C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.944665 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\tC\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.944917 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\nC\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.945182 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\vC\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.945445 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\fC\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.945695 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\rC\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.945962 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\16C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.946222 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\17C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.946467 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\20C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.946713 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\21C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.946955 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\22C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.947218 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\23C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.947446 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\24C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.947674 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\25C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.947904 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\26C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.948156 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\27C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.948446 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\30C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.948694 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\31C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.948943 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\32C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.949196 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\33C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696
[pid 18224] 1501856999.949442 writev(8,
[{iov_base="p\16\0\0\0\0\0\0\34C\0\0\0\0\0\0", iov_len=16},
{iov_base="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
iov_len=3680}], 2) = 3696

The read() syscalls that get the file names over from the gluster server happen
in bursts, and the bursts are about 300 ms apart. (I'm using SSL so the file
names aren't visible in the read calls.) They happen in 16 KB buffers (but
here's some strange read()s of size 5 in between, not sure what those are for),
and looking at the timings they don't seem to be blocked on network roundtrips,
so that's good.

But the roughly 4K sized writev() syscalls each have a network roundtrip in
betweeen. That seems strange to me, given that we've just read() all the data
before in a batch. What's going on there?

-- 
You are receiving this mail because:
You are on the CC list for the bug.
You are the assignee for the bug.