Re: [bug report] INFO: task mdX_resync:42168 blocked for more than 122 seconds

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



On Tue, May 21, 2024 at 5:17 PM Yu Kuai <yukuai1@xxxxxxxxxxxxxxx> wrote:
>
> Hi,
>
> 在 2024/05/21 12:28, Changhui Zhong 写道:
> > On Tue, May 21, 2024 at 9:09 AM Yu Kuai <yukuai1@xxxxxxxxxxxxxxx> wrote:
> >
> >>
> >> Thanks for the test! Since raid10 has the same problem as well, then the
> >> problem seems to be more common in raid. And related code to raid10 is
> >> more simpler, attached is a patch to add debuginfo to raid10.
> >>
> >> BTW, Xiao can reporduce the problem as well, and will lend a hand as
> >> well.
> >>
> >> Thanks,
> >> Kuai
> >
> >
> > Hi, Yu Kuai and Xiao
> >
> > thanks for  efforts on this issue,
> > after applying the debug patch, I got the following results, please check it
> >
> > [  597.491083] Create raid10
> > [  597.647987] device-mapper: raid: Superblocks created for new raid set
> > [  597.680540] md/raid10:mdX: not clean -- starting background reconstruction
> > [  597.680549] md/raid10:mdX: active with 4 out of 4 devices
> > [  597.683779] mdX: bitmap file is out of date, doing full recovery
> > [  597.692971] md: resync of RAID array mdX
> > [  597.753583] try_raise_barrier: resync depth exceed limit
> > [  597.759540] try_raise_barrier: resync depth exceed limit
> > [  597.765504] try_raise_barrier: resync depth exceed limit
> > [  597.771432] try_raise_barrier: resync depth exceed limit
> > [  597.779400] barrier_waiting: nr_waiting 1
> > [  597.783879] barrier_waiting: nr_waiting 1
> > [  597.788356] barrier_waiting: nr_waiting 1
> > [  597.792838] barrier_waiting: nr_waiting 1
> > [  597.797327] barrier_waiting: nr_waiting 1
> > [  597.801806] barrier_waiting: nr_waiting 1
> > [  597.806288] barrier_waiting: nr_waiting 1
> > [  597.810780] barrier_waiting: nr_waiting 1
> > [  597.815252] barrier_waiting: nr_waiting 1
> > [  597.819737] barrier_waiting: nr_waiting 1
> > [  597.824232] barrier_waiting: nr_waiting 1
> > [  597.828714] barrier_waiting: nr_waiting 1
> > [  597.833196] barrier_waiting: nr_waiting 1
> > [  597.837678] barrier_waiting: nr_waiting 1
> > [  597.842160] barrier_waiting: nr_waiting 1
> > [  597.846640] barrier_waiting: nr_waiting 1
> > [  597.851128] barrier_waiting: nr_waiting 1
> > [  597.855610] barrier_waiting: nr_waiting 1
> > [  597.860094] barrier_waiting: nr_waiting 1
> > [  597.864576] barrier_waiting: nr_waiting 1
> > [  597.869060] barrier_waiting: nr_waiting 1
> > [  597.873548] barrier_waiting: nr_waiting 1
> > [  597.878032] barrier_waiting: nr_waiting 1
> > [  597.882522] barrier_waiting: nr_waiting 1
> > [  597.883457] barrier_waiting: nr_waiting 1
> > [  597.891503] barrier_waiting: nr_waiting 1
> > [  597.895987] barrier_waiting: nr_waiting 1
> > [  597.900459] barrier_waiting: nr_waiting 1
> > [  597.904940] barrier_waiting: nr_waiting 1
> > [  597.909421] barrier_waiting: nr_waiting 1
> > [  597.913900] barrier_waiting: nr_waiting 1
> > [  597.918377] barrier_waiting: nr_waiting 1
> > [  597.922857] barrier_waiting: nr_waiting 1
> > [  597.927350] barrier_waiting: nr_waiting 1
> > [  597.931841] barrier_waiting: nr_waiting 1
> > [  597.936322] barrier_waiting: nr_waiting 1
> > [  597.940805] barrier_waiting: nr_waiting 1
> > [  597.945284] barrier_waiting: nr_waiting 1
> > [  597.949766] barrier_waiting: nr_waiting 1
> > [  597.954246] barrier_waiting: nr_waiting 1
> > [  597.958726] barrier_waiting: nr_waiting 1
> > [  597.963205] barrier_waiting: nr_waiting 1
> > [  597.967683] barrier_waiting: nr_waiting 1
> > [  597.972163] barrier_waiting: nr_waiting 1
> > [  597.976641] barrier_waiting: nr_waiting 1
> > [  597.981119] barrier_waiting: nr_waiting 1
> > [  597.985601] barrier_waiting: nr_waiting 1
> > [  597.990082] barrier_waiting: nr_waiting 1
> > [  597.994562] barrier_waiting: nr_waiting 1
> > [  597.999043] barrier_waiting: nr_waiting 1
> > [  598.003522] barrier_waiting: nr_waiting 1
> > [  598.008000] barrier_waiting: nr_waiting 1
> > [  598.012485] barrier_waiting: nr_waiting 1
> > [  598.016964] barrier_waiting: nr_waiting 1
> > [  598.021451] barrier_waiting: nr_waiting 1
> > [  598.025931] barrier_waiting: nr_waiting 1
> > [  598.030409] barrier_waiting: nr_waiting 1
> > [  598.034888] barrier_waiting: nr_waiting 1
> > [  598.039368] barrier_waiting: nr_waiting 1
> > [  598.043848] barrier_waiting: nr_waiting 1
> > [  598.048325] barrier_waiting: nr_waiting 1
> > [  598.052805] barrier_waiting: nr_waiting 1
> > [  598.057283] barrier_waiting: nr_waiting 1
> > [  598.061767] barrier_waiting: nr_waiting 1
> > [  598.066246] barrier_waiting: nr_waiting 1
> > [  598.070726] barrier_waiting: nr_waiting 1
> > [  598.075206] barrier_waiting: nr_waiting 1
> > [  598.079689] barrier_waiting: nr_waiting 1
> > [  598.084170] barrier_waiting: nr_waiting 1
> > [  598.088648] barrier_waiting: nr_waiting 1
> > [  598.093130] barrier_waiting: nr_waiting 1
> > [  598.097646] barrier_waiting: nr_waiting 1
> > [  598.102126] barrier_waiting: nr_waiting 1
> > [  598.106605] barrier_waiting: nr_waiting 1
> > [  598.111085] barrier_waiting: nr_waiting 1
> > [  598.115566] barrier_waiting: nr_waiting 1
> > [  598.120043] barrier_waiting: nr_waiting 1
> > [  598.124522] barrier_waiting: nr_waiting 1
> > [  598.129001] barrier_waiting: nr_waiting 1
> > [  598.133481] barrier_waiting: nr_waiting 1
> > [  598.137958] barrier_waiting: nr_waiting 1
> > [  598.142442] barrier_waiting: nr_waiting 1
> > [  598.146921] barrier_waiting: nr_waiting 1
> > [  598.151400] barrier_waiting: nr_waiting 1
> > [  598.155878] barrier_waiting: nr_waiting 1
> > [  598.160359] barrier_waiting: nr_waiting 1
> > [  598.164838] barrier_waiting: nr_waiting 1
> > [  598.169319] barrier_waiting: nr_waiting 1
> > [  598.173803] barrier_waiting: nr_waiting 1
> > [  598.178282] barrier_waiting: nr_waiting 1
> > [  598.182762] barrier_waiting: nr_waiting 1
> > [  598.187241] barrier_waiting: nr_waiting 1
> > [  598.191722] barrier_waiting: nr_waiting 1
> > [  598.196201] barrier_waiting: nr_waiting 1
> > [  598.200678] barrier_waiting: nr_waiting 1
> > [  598.205159] barrier_waiting: nr_waiting 1
> > [  598.209640] barrier_waiting: nr_waiting 1
> > [  598.214120] barrier_waiting: nr_waiting 1
> > [  598.218599] barrier_waiting: nr_waiting 1
> > [  598.223078] barrier_waiting: nr_waiting 1
> > [  598.227557] barrier_waiting: nr_waiting 1
> > [  598.232036] barrier_waiting: nr_waiting 1
> > [  598.236519] barrier_waiting: nr_waiting 1
> > [  598.240999] barrier_waiting: nr_waiting 1
> > [  598.245478] barrier_waiting: nr_waiting 1
> > [  598.249959] barrier_waiting: nr_waiting 1
> > [  598.254439] barrier_waiting: nr_waiting 1
> > [  598.258917] barrier_waiting: nr_waiting 1
> > [  598.263397] barrier_waiting: nr_waiting 1
> > [  598.267880] barrier_waiting: nr_waiting 1
> > [  598.272362] barrier_waiting: nr_waiting 1
> > [  598.276842] barrier_waiting: nr_waiting 1
> > [  598.281322] barrier_waiting: nr_waiting 1
> > [  598.285802] barrier_waiting: nr_waiting 1
> > [  598.290281] barrier_waiting: nr_waiting 1
> > [  598.294758] barrier_waiting: nr_waiting 1
> > [  598.299256] barrier_waiting: nr_waiting 1
> > [  598.303737] barrier_waiting: nr_waiting 1
> > [  598.308219] barrier_waiting: nr_waiting 1
> > [  598.312698] barrier_waiting: nr_waiting 1
> > [  598.317176] barrier_waiting: nr_waiting 1
> > [  598.321659] barrier_waiting: nr_waiting 1
> > [  598.326138] barrier_waiting: nr_waiting 1
> > [  598.330617] barrier_waiting: nr_waiting 1
> > [  598.335100] barrier_waiting: nr_waiting 1
> > [  598.339580] barrier_waiting: nr_waiting 1
> > [  598.344057] barrier_waiting: nr_waiting 1
> > [  598.348536] barrier_waiting: nr_waiting 1
> > [  598.353016] barrier_waiting: nr_waiting 1
> > [  598.357496] barrier_waiting: nr_waiting 1
> > [  598.361973] barrier_waiting: nr_waiting 1
> > [  598.366453] barrier_waiting: nr_waiting 1
> > [  598.370932] barrier_waiting: nr_waiting 1
> > [  598.375412] barrier_waiting: nr_waiting 1
> > [  598.379890] barrier_waiting: nr_waiting 1
> > [  598.384371] barrier_waiting: nr_waiting 1
> > [  598.388856] barrier_waiting: nr_waiting 1
> > [  598.393326] barrier_waiting: nr_waiting 1
> > [  598.397805] barrier_waiting: nr_waiting 1
> > [  598.402288] barrier_waiting: nr_waiting 1
> > [  598.406772] barrier_waiting: nr_waiting 1
> > [  598.411251] barrier_waiting: nr_waiting 1
> > [  598.415729] barrier_waiting: nr_waiting 1
> > [  598.420209] barrier_waiting: nr_waiting 1
> > [  598.424686] barrier_waiting: nr_waiting 1
> > [  598.429165] barrier_waiting: nr_waiting 1
> > [  598.433644] barrier_waiting: nr_waiting 1
> > [  598.438125] barrier_waiting: nr_waiting 1
> > [  598.442604] barrier_waiting: nr_waiting 1
> > [  598.447083] barrier_waiting: nr_waiting 1
> > [  598.451571] barrier_waiting: nr_waiting 1
> > [  598.456050] barrier_waiting: nr_waiting 1
> > [  598.460531] barrier_waiting: nr_waiting 1
> > [  598.465010] barrier_waiting: nr_waiting 1
> > [  598.469498] barrier_waiting: nr_waiting 1
> > [  598.473981] barrier_waiting: nr_waiting 1
> > [  598.478460] barrier_waiting: nr_waiting 1
> > [  598.482940] barrier_waiting: nr_waiting 1
> > [  598.487421] barrier_waiting: nr_waiting 1
> > [  598.491901] barrier_waiting: nr_waiting 1
> > [  598.496382] barrier_waiting: nr_waiting 1
> > [  598.500860] barrier_waiting: nr_waiting 1
> > [  598.505338] barrier_waiting: nr_waiting 1
> > [  598.509837] barrier_waiting: nr_waiting 1
> > [  598.514317] barrier_waiting: nr_waiting 1
> > [  598.518797] barrier_waiting: nr_waiting 1
> > [  598.523276] barrier_waiting: nr_waiting 1
> > [  598.527756] barrier_waiting: nr_waiting 1
> > [  598.532241] barrier_waiting: nr_waiting 1
> > [  598.536719] barrier_waiting: nr_waiting 1
> > [  598.541199] barrier_waiting: nr_waiting 1
> > [  598.545679] barrier_waiting: nr_waiting 1
> > [  598.550159] barrier_waiting: nr_waiting 1
> > [  598.554639] barrier_waiting: nr_waiting 1
> > [  598.559118] barrier_waiting: nr_waiting 1
> > [  598.563597] barrier_waiting: nr_waiting 1
> > [  598.568077] barrier_waiting: nr_waiting 1
> > [  598.572561] barrier_waiting: nr_waiting 1
> > [  598.577038] barrier_waiting: nr_waiting 1
> > [  598.581517] barrier_waiting: nr_waiting 1
> > [  598.585995] barrier_waiting: nr_waiting 1
> > [  598.590475] barrier_waiting: nr_waiting 1
> > [  598.594953] barrier_waiting: nr_waiting 1
> > [  598.599434] barrier_waiting: nr_waiting 1
> > [  598.603913] barrier_waiting: nr_waiting 1
> > [  598.608392] barrier_waiting: nr_waiting 1
> > [  598.612871] barrier_waiting: nr_waiting 1
> > [  598.617349] barrier_waiting: nr_waiting 1
> > [  598.621828] barrier_waiting: nr_waiting 1
> > [  598.626308] barrier_waiting: nr_waiting 1
> > [  598.630787] barrier_waiting: nr_waiting 1
> > [  598.635272] barrier_waiting: nr_waiting 1
> > [  598.639753] barrier_waiting: nr_waiting 1
> > [  598.644231] barrier_waiting: nr_waiting 1
> > [  598.648712] barrier_waiting: nr_waiting 1
> > [  598.653192] barrier_waiting: nr_waiting 1
> > [  598.657671] barrier_waiting: nr_waiting 1
> > [  598.662150] barrier_waiting: nr_waiting 1
> > [  598.666630] barrier_waiting: nr_waiting 1
> > [  598.671111] barrier_waiting: nr_waiting 1
> > [  598.675589] barrier_waiting: nr_waiting 1
> > [  598.680068] barrier_waiting: nr_waiting 1
> > [  598.684547] barrier_waiting: nr_waiting 1
> > [  598.689024] barrier_waiting: nr_waiting 1
> > [  598.693501] barrier_waiting: nr_waiting 1
> > [  598.697982] barrier_waiting: nr_waiting 1
> > [  598.702462] barrier_waiting: nr_waiting 1
> > [  598.706945] barrier_waiting: nr_waiting 1
> > [  598.711425] barrier_waiting: nr_waiting 1
> > [  598.715989] barrier_waiting: nr_waiting 1
> > [  598.720523] barrier_waiting: nr_waiting 1
> > [  598.725014] barrier_waiting: nr_waiting 1
> > [  598.729500] barrier_waiting: nr_waiting 1
> > [  598.733983] barrier_waiting: nr_waiting 1
> > [  598.738465] barrier_waiting: nr_waiting 1
> > [  598.742947] barrier_waiting: nr_waiting 1
> > [  598.747426] barrier_waiting: nr_waiting 1
> > [  598.751909] barrier_waiting: nr_waiting 1
> > [  598.756390] barrier_waiting: nr_waiting 1
> > [  598.760869] barrier_waiting: nr_waiting 1
> > [  598.765360] barrier_waiting: nr_waiting 1
> > [  598.769839] barrier_waiting: nr_waiting 1
> > [  598.774318] barrier_waiting: nr_waiting 1
> > [  598.778801] barrier_waiting: nr_waiting 1
> > [  598.783280] barrier_waiting: nr_waiting 1
> > [  598.787758] barrier_waiting: nr_waiting 1
> > [  598.792242] barrier_waiting: nr_waiting 1
> > [  598.796723] barrier_waiting: nr_waiting 1
> > [  598.801200] barrier_waiting: nr_waiting 1
> > [  598.805688] barrier_waiting: nr_waiting 1
> > [  598.810166] barrier_waiting: nr_waiting 1
> > [  598.814646] barrier_waiting: nr_waiting 1
> > [  598.819126] barrier_waiting: nr_waiting 1
> > [  598.823606] barrier_waiting: nr_waiting 1
> > [  598.828086] barrier_waiting: nr_waiting 1
> > [  598.832574] barrier_waiting: nr_waiting 1
> > [  598.837052] barrier_waiting: nr_waiting 1
> > [  598.841531] barrier_waiting: nr_waiting 1
> > [  598.846012] barrier_waiting: nr_waiting 1
> > [  598.850491] barrier_waiting: nr_waiting 1
> > [  598.854969] barrier_waiting: nr_waiting 1
> > [  598.859456] barrier_waiting: nr_waiting 1
> > [  598.863934] barrier_waiting: nr_waiting 1
> > [  598.868412] barrier_waiting: nr_waiting 1
> > [  598.872895] barrier_waiting: nr_waiting 1
> > [  598.877374] barrier_waiting: nr_waiting 1
> > [  598.881853] barrier_waiting: nr_waiting 1
> > [  598.886334] barrier_waiting: nr_waiting 1
> > [  598.890813] barrier_waiting: nr_waiting 1
> > [  598.895293] barrier_waiting: nr_waiting 1
> > [  598.899774] barrier_waiting: nr_waiting 1
> > [  598.904253] barrier_waiting: nr_waiting 1
> > [  598.908735] barrier_waiting: nr_waiting 1
> > [  598.913215] barrier_waiting: nr_waiting 1
> > [  598.917694] barrier_waiting: nr_waiting 1
> > [  598.922173] barrier_waiting: nr_waiting 1
> > [  598.926663] barrier_waiting: nr_waiting 1
> > [  598.931153] barrier_waiting: nr_waiting 1
> > [  598.935638] barrier_waiting: nr_waiting 1
> > [  598.940115] barrier_waiting: nr_waiting 1
> > [  598.944599] barrier_waiting: nr_waiting 1
> > [  598.949080] barrier_waiting: nr_waiting 1
> > [  598.953561] barrier_waiting: nr_waiting 1
> > [  598.958042] barrier_waiting: nr_waiting 1
> > [  598.962523] barrier_waiting: nr_waiting 1
> > [  598.967006] barrier_waiting: nr_waiting 1
> > [  598.971486] barrier_waiting: nr_waiting 1
> > [  598.975965] barrier_waiting: nr_waiting 1
> > [  598.980446] barrier_waiting: nr_waiting 1
> > [  598.984923] barrier_waiting: nr_waiting 1
> > [  598.989408] barrier_waiting: nr_waiting 1
> > [  598.993890] barrier_waiting: nr_waiting 1
> > [  598.998367] barrier_waiting: nr_waiting 1
> > [  599.002844] barrier_waiting: nr_waiting 1
> > [  599.007328] barrier_waiting: nr_waiting 1
> > [  599.011800] barrier_waiting: nr_waiting 1
> > [  599.016278] barrier_waiting: nr_waiting 1
> > [  599.020756] barrier_waiting: nr_waiting 1
> > [  599.025241] barrier_waiting: nr_waiting 1
> > [  599.029720] barrier_waiting: nr_waiting 1
> > [  599.034199] barrier_waiting: nr_waiting 1
> > [  599.038682] barrier_waiting: nr_waiting 1
> > [  599.043161] barrier_waiting: nr_waiting 1
> > [  599.047641] barrier_waiting: nr_waiting 1
> > [  599.052120] barrier_waiting: nr_waiting 1
> > [  599.056601] barrier_waiting: nr_waiting 1
> > [  599.061082] barrier_waiting: nr_waiting 1
> > [  599.065567] barrier_waiting: nr_waiting 1
> > [  599.070045] barrier_waiting: nr_waiting 1
> > [  599.074522] barrier_waiting: nr_waiting 1
> > [  599.079006] barrier_waiting: nr_waiting 1
> > [  599.083486] barrier_waiting: nr_waiting 1
> > [  599.087968] barrier_waiting: nr_waiting 1
> > [  599.092448] barrier_waiting: nr_waiting 1
> > [  599.096929] barrier_waiting: nr_waiting 1
> > [  599.101407] barrier_waiting: nr_waiting 1
> > [  599.105886] barrier_waiting: nr_waiting 1
> > [  599.110366] barrier_waiting: nr_waiting 1
> > [  599.114850] barrier_waiting: nr_waiting 1
> > [  599.119332] barrier_waiting: nr_waiting 1
> > [  599.123809] barrier_waiting: nr_waiting 1
> > [  599.128293] barrier_waiting: nr_waiting 1
> > [  599.132765] barrier_waiting: nr_waiting 1
> > [  599.137242] barrier_waiting: nr_waiting 1
> > [  599.141723] barrier_waiting: nr_waiting 1
> > [  599.146203] barrier_waiting: nr_waiting 1
> > [  599.150682] barrier_waiting: nr_waiting 1
> > [  599.155165] barrier_waiting: nr_waiting 1
> > [  599.159644] barrier_waiting: nr_waiting 1
> > [  599.164124] barrier_waiting: nr_waiting 1
> > [  599.168603] barrier_waiting: nr_waiting 1
> > [  599.173080] barrier_waiting: nr_waiting 1
> > [  599.177564] barrier_waiting: nr_waiting 1
> > [  599.182043] barrier_waiting: nr_waiting 1
> > [  599.186525] barrier_waiting: nr_waiting 1
> > [  599.191008] barrier_waiting: nr_waiting 1
> > [  599.195488] barrier_waiting: nr_waiting 1
> > [  599.199967] barrier_waiting: nr_waiting 1
> > [  599.204448] barrier_waiting: nr_waiting 1
> > [  599.208928] barrier_waiting: nr_waiting 1
> > [  599.213408] barrier_waiting: nr_waiting 1
> > [  599.217890] barrier_waiting: nr_waiting 1
> > [  599.222370] barrier_waiting: nr_waiting 1
> > [  599.226850] barrier_waiting: nr_waiting 1
> > [  599.231329] barrier_waiting: nr_waiting 1
> > [  599.235811] barrier_waiting: nr_waiting 1
> > [  599.240289] barrier_waiting: nr_waiting 1
> > [  599.244767] barrier_waiting: nr_waiting 1
> > [  599.249247] barrier_waiting: nr_waiting 1
> > [  599.253731] barrier_waiting: nr_waiting 1
> > [  599.258212] barrier_waiting: nr_waiting 1
> > [  599.262691] barrier_waiting: nr_waiting 1
> > [  599.267170] barrier_waiting: nr_waiting 1
> > [  599.271650] barrier_waiting: nr_waiting 1
> > [  599.276128] barrier_waiting: nr_waiting 1
> > [  599.280606] barrier_waiting: nr_waiting 1
> > [  599.285084] barrier_waiting: nr_waiting 1
> > [  599.289569] barrier_waiting: nr_waiting 1
> > [  599.294040] barrier_waiting: nr_waiting 1
> > [  599.298522] barrier_waiting: nr_waiting 1
> > [  599.303006] barrier_waiting: nr_waiting 1
> > [  599.307483] barrier_waiting: nr_waiting 1
> > [  599.311961] barrier_waiting: nr_waiting 1
> > [  599.316442] barrier_waiting: nr_waiting 1
> > [  599.320923] barrier_waiting: nr_waiting 1
> > [  599.325403] barrier_waiting: nr_waiting 1
> > [  599.329884] barrier_waiting: nr_waiting 1
> > [  599.334363] barrier_waiting: nr_waiting 1
> > [  599.338842] barrier_waiting: nr_waiting 1
> > [  599.343322] barrier_waiting: nr_waiting 1
> > [  599.347801] barrier_waiting: nr_waiting 1
> > [  599.352282] barrier_waiting: nr_waiting 1
> > [  599.356762] barrier_waiting: nr_waiting 1
> > [  599.361246] barrier_waiting: nr_waiting 1
> > [  599.365727] barrier_waiting: nr_waiting 1
> > [  599.370206] barrier_waiting: nr_waiting 1
> > [  599.374685] barrier_waiting: nr_waiting 1
> > [  599.379166] barrier_waiting: nr_waiting 1
> > [  599.383647] barrier_waiting: nr_waiting 1
> > [  599.388125] barrier_waiting: nr_waiting 1
> > [  599.392605] barrier_waiting: nr_waiting 1
> > [  599.397083] barrier_waiting: nr_waiting 1
> > [  599.401562] barrier_waiting: nr_waiting 1
> > [  599.406044] barrier_waiting: nr_waiting 1
> > [  599.410525] barrier_waiting: nr_waiting 1
> > [  599.415008] barrier_waiting: nr_waiting 1
> > [  599.419486] barrier_waiting: nr_waiting 1
> > [  599.423968] barrier_waiting: nr_waiting 1
> > [  599.428446] barrier_waiting: nr_waiting 1
> > [  599.432924] barrier_waiting: nr_waiting 1
> > [  599.437409] barrier_waiting: nr_waiting 1
> > [  599.441890] barrier_waiting: nr_waiting 1
> > [  599.446373] barrier_waiting: nr_waiting 1
> > [  599.450859] barrier_waiting: nr_waiting 1
> > [  599.455337] barrier_waiting: nr_waiting 1
> > [  599.459819] barrier_waiting: nr_waiting 1
> > [  599.464306] barrier_waiting: nr_waiting 1
> > [  599.468783] barrier_waiting: nr_waiting 1
> > [  599.473262] barrier_waiting: nr_waiting 1
> > [  599.477744] barrier_waiting: nr_waiting 1
> > [  599.482224] barrier_waiting: nr_waiting 1
> > [  599.486704] barrier_waiting: nr_waiting 1
> > [  599.491190] barrier_waiting: nr_waiting 1
> > [  599.495670] barrier_waiting: nr_waiting 1
> > [  599.500150] barrier_waiting: nr_waiting 1
> > [  599.504629] barrier_waiting: nr_waiting 1
> > [  599.509106] barrier_waiting: nr_waiting 1
> > [  599.513588] barrier_waiting: nr_waiting 1
> > [  599.518072] barrier_waiting: nr_waiting 1
> > [  599.522552] barrier_waiting: nr_waiting 1
> > [  599.527030] barrier_waiting: nr_waiting 1
> > [  599.531509] barrier_waiting: nr_waiting 1
> > [  599.535988] barrier_waiting: nr_waiting 1
> > [  599.540470] barrier_waiting: nr_waiting 1
> > [  599.544955] barrier_waiting: nr_waiting 1
> > [  599.549426] barrier_waiting: nr_waiting 1
> > [  599.553904] barrier_waiting: nr_waiting 1
> > [  599.558384] barrier_waiting: nr_waiting 1
> > [  599.562863] barrier_waiting: nr_waiting 1
> > [  599.567342] barrier_waiting: nr_waiting 1
> > [  599.571820] barrier_waiting: nr_waiting 1
> > [  599.576298] barrier_waiting: nr_waiting 1
> > [  599.580779] barrier_waiting: nr_waiting 1
> > [  599.585254] wait_barrier: nr_pending: 1
> > [  599.589540] try_raise_barrier: nr_pending 1
> > [  599.589547] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  599.594209] try_raise_barrier: nr_pending 1
> > [  599.605582] try_raise_barrier: nr_pending 1
> > [  599.605674] allow_barrier: nr_pending: 0
> > [  599.610620] wait_barrier: nr_pending: 1
> > [  599.614653] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  599.618935] try_raise_barrier: nr_pending 1
> > [  599.618938] try_raise_barrier: nr_pending 1
> > [  599.618965] raid10_read_request: r10_bio ff3b4134184a6100 start
> > [  599.641092] try_raise_barrier: nr_pending 1
> > [  599.641145] allow_barrier: nr_pending: 0
> > [  599.646251] wait_barrier: nr_pending: 1
> > [  599.650157] raid_end_bio_io: r10_bio ff3b4134184a6100 done
> > [  599.654437] try_raise_barrier: nr_pending 1
> > [  599.654446] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  599.654575] allow_barrier: nr_pending: 0
> > [  599.654583] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  599.682715] wait_barrier: nr_pending: 1
> > [  599.687000] try_raise_barrier: nr_pending 1
> > [  599.687012] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  599.691672] try_raise_barrier: nr_pending 1
> > [  599.703020] try_raise_barrier: nr_pending 1
> > [  599.703069] allow_barrier: nr_pending: 0
> > [  599.708037] wait_barrier: nr_pending: 1
> > [  599.712092] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  599.716368] try_raise_barrier: nr_pending 1
> > [  599.716372] try_raise_barrier: nr_pending 1
> > [  599.716377] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  599.738510] try_raise_barrier: nr_pending 1
> > [  599.738554] allow_barrier: nr_pending: 0
> > [  599.743663] wait_barrier: nr_pending: 1
> > [  599.747583] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  599.751853] try_raise_barrier: nr_pending 1
> > [  599.751857] try_raise_barrier: nr_pending 1
> > [  599.751864] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  599.773945] try_raise_barrier: nr_pending 1
> > [  599.774058] allow_barrier: nr_pending: 0
> > [  599.779116] wait_barrier: nr_pending: 1
> > [  599.783020] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  599.787298] try_raise_barrier: nr_pending 1
> > [  599.787307] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  599.787461] allow_barrier: nr_pending: 0
> > [  599.787469] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  599.815585] wait_barrier: nr_pending: 1
> > [  599.819872] try_raise_barrier: nr_pending 1
> > [  599.819883] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  599.824546] try_raise_barrier: nr_pending 1
> > [  599.835892] try_raise_barrier: nr_pending 1
> > [  599.835904] allow_barrier: nr_pending: 0
> > [  599.840922] wait_barrier: nr_pending: 1
> > [  599.844957] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  599.849235] try_raise_barrier: nr_pending 1
> > [  599.849239] try_raise_barrier: nr_pending 1
> > [  599.849244] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  599.871381] try_raise_barrier: nr_pending 1
> > [  599.871463] allow_barrier: nr_pending: 0
> > [  599.876542] wait_barrier: nr_pending: 1
> > [  599.880451] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  599.884730] try_raise_barrier: nr_pending 1
> > [  599.884735] try_raise_barrier: nr_pending 1
> > [  599.884740] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  599.884889] allow_barrier: nr_pending: 0
> > [  599.884897] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  599.917789] wait_barrier: nr_pending: 1
> > [  599.922088] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  599.922159] try_raise_barrier: nr_pending 1
> > [  599.928829] allow_barrier: nr_pending: 0
> > [  599.933736] wait_barrier: nr_pending: 1
> > [  599.937771] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  599.942045] try_raise_barrier: nr_pending 1
> > [  599.942049] try_raise_barrier: nr_pending 1
> > [  599.942058] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  599.964202] try_raise_barrier: nr_pending 1
> > [  599.964262] allow_barrier: nr_pending: 0
> > [  599.969461] wait_barrier: nr_pending: 1
> > [  599.973275] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  599.977553] try_raise_barrier: nr_pending 1
> > [  599.977559] try_raise_barrier: nr_pending 1
> > [  599.977562] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  599.977715] allow_barrier: nr_pending: 0
> > [  599.977723] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.010600] wait_barrier: nr_pending: 1
> > [  600.014887] try_raise_barrier: nr_pending 1
> > [  600.014898] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.019559] try_raise_barrier: nr_pending 1
> > [  600.030909] try_raise_barrier: nr_pending 1
> > [  600.030917] allow_barrier: nr_pending: 0
> > [  600.036049] wait_barrier: nr_pending: 1
> > [  600.039974] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.044253] try_raise_barrier: nr_pending 1
> > [  600.044257] try_raise_barrier: nr_pending 1
> > [  600.044263] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  600.066363] try_raise_barrier: nr_pending 1
> > [  600.066461] allow_barrier: nr_pending: 0
> > [  600.071440] wait_barrier: nr_pending: 1
> > [  600.075443] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  600.079722] try_raise_barrier: nr_pending 1
> > [  600.079727] try_raise_barrier: nr_pending 1
> > [  600.079731] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.079868] allow_barrier: nr_pending: 0
> > [  600.079875] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.112682] wait_barrier: nr_pending: 1
> > [  600.116967] try_raise_barrier: nr_pending 1
> > [  600.116978] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.121640] try_raise_barrier: nr_pending 1
> > [  600.132990] try_raise_barrier: nr_pending 1
> > [  600.133057] allow_barrier: nr_pending: 0
> > [  600.138070] wait_barrier: nr_pending: 1
> > [  600.142062] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.146337] try_raise_barrier: nr_pending 1
> > [  600.146342] try_raise_barrier: nr_pending 1
> > [  600.146348] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.168487] try_raise_barrier: nr_pending 1
> > [  600.168532] allow_barrier: nr_pending: 0
> > [  600.173662] wait_barrier: nr_pending: 1
> > [  600.177563] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.181840] try_raise_barrier: nr_pending 1
> > [  600.181845] try_raise_barrier: nr_pending 1
> > [  600.181849] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.181983] allow_barrier: nr_pending: 0
> > [  600.181991] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.214790] wait_barrier: nr_pending: 1
> > [  600.219075] try_raise_barrier: nr_pending 1
> > [  600.219087] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  600.223748] try_raise_barrier: nr_pending 1
> > [  600.235099] try_raise_barrier: nr_pending 1
> > [  600.235150] allow_barrier: nr_pending: 0
> > [  600.240130] wait_barrier: nr_pending: 1
> > [  600.244170] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  600.248446] try_raise_barrier: nr_pending 1
> > [  600.248450] try_raise_barrier: nr_pending 1
> > [  600.248456] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.270600] try_raise_barrier: nr_pending 1
> > [  600.270648] allow_barrier: nr_pending: 0
> > [  600.275752] wait_barrier: nr_pending: 1
> > [  600.279676] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.283952] try_raise_barrier: nr_pending 1
> > [  600.283956] try_raise_barrier: nr_pending 1
> > [  600.283961] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.284093] allow_barrier: nr_pending: 0
> > [  600.284100] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.316975] wait_barrier: nr_pending: 1
> > [  600.321262] try_raise_barrier: nr_pending 1
> > [  600.321273] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.325936] try_raise_barrier: nr_pending 1
> > [  600.337279] allow_barrier: nr_pending: 0
> > [  600.337649] wait_barrier: nr_pending: 1
> > [  600.341674] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.345947] try_raise_barrier: nr_pending 1
> > [  600.345951] try_raise_barrier: nr_pending 1
> > [  600.345958] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  600.368088] try_raise_barrier: nr_pending 1
> > [  600.368129] allow_barrier: nr_pending: 0
> > [  600.373070] wait_barrier: nr_pending: 1
> > [  600.377153] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  600.381430] try_raise_barrier: nr_pending 1
> > [  600.381434] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.381555] allow_barrier: nr_pending: 0
> > [  600.381562] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.409730] wait_barrier: nr_pending: 1
> > [  600.414012] try_raise_barrier: nr_pending 1
> > [  600.414015] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.418685] try_raise_barrier: nr_pending 1
> > [  600.430034] try_raise_barrier: nr_pending 1
> > [  600.430085] allow_barrier: nr_pending: 0
> > [  600.435126] wait_barrier: nr_pending: 1
> > [  600.439107] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.443388] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  600.443462] try_raise_barrier: nr_pending 1
> > [  600.443466] try_raise_barrier: nr_pending 1
> > [  600.465548] try_raise_barrier: nr_pending 1
> > [  600.465585] allow_barrier: nr_pending: 0
> > [  600.470613] wait_barrier: nr_pending: 1
> > [  600.474627] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  600.478903] try_raise_barrier: nr_pending 1
> > [  600.478910] try_raise_barrier: nr_pending 1
> > [  600.478912] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.479045] allow_barrier: nr_pending: 0
> > [  600.479053] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.511838] wait_barrier: nr_pending: 1
> > [  600.516124] try_raise_barrier: nr_pending 1
> > [  600.516135] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.520797] try_raise_barrier: nr_pending 1
> > [  600.532156] try_raise_barrier: nr_pending 1
> > [  600.532225] allow_barrier: nr_pending: 0
> > [  600.537288] wait_barrier: nr_pending: 1
> > [  600.541229] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.545505] try_raise_barrier: nr_pending 1
> > [  600.545509] try_raise_barrier: nr_pending 1
> > [  600.545515] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.567662] try_raise_barrier: nr_pending 1
> > [  600.567696] allow_barrier: nr_pending: 0
> > [  600.572778] wait_barrier: nr_pending: 1
> > [  600.576742] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.581017] try_raise_barrier: nr_pending 1
> > [  600.581023] try_raise_barrier: nr_pending 1
> > [  600.581028] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.581145] allow_barrier: nr_pending: 0
> > [  600.581152] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.613893] wait_barrier: nr_pending: 1
> > [  600.618178] try_raise_barrier: nr_pending 1
> > [  600.618188] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  600.622851] try_raise_barrier: nr_pending 1
> > [  600.634242] try_raise_barrier: nr_pending 1
> > [  600.634317] allow_barrier: nr_pending: 0
> > [  600.639159] wait_barrier: nr_pending: 1
> > [  600.643299] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  600.647575] try_raise_barrier: nr_pending 1
> > [  600.647579] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.647579] try_raise_barrier: nr_pending 1
> > [  600.647633] allow_barrier: nr_pending: 0
> > [  600.647637] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.680526] wait_barrier: nr_pending: 1
> > [  600.684819] try_raise_barrier: nr_pending 1
> > [  600.684841] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.689492] try_raise_barrier: nr_pending 1
> > [  600.700853] try_raise_barrier: nr_pending 1
> > [  600.700910] allow_barrier: nr_pending: 0
> > [  600.706030] wait_barrier: nr_pending: 1
> > [  600.709914] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.714193] try_raise_barrier: nr_pending 1
> > [  600.714197] try_raise_barrier: nr_pending 1
> > [  600.714205] raid10_read_request: r10_bio ff3b4134184a6100 start
> > [  600.714376] allow_barrier: nr_pending: 0
> > [  600.714383] raid_end_bio_io: r10_bio ff3b4134184a6100 done
> > [  600.747144] wait_barrier: nr_pending: 1
> > [  600.751430] try_raise_barrier: nr_pending 1
> > [  600.751442] raid10_read_request: r10_bio ff3b4134184a6b00 start
> > [  600.756102] try_raise_barrier: nr_pending 1
> > [  600.767448] try_raise_barrier: nr_pending 1
> > [  600.767537] allow_barrier: nr_pending: 0
> > [  600.772502] wait_barrier: nr_pending: 1
> > [  600.776516] raid_end_bio_io: r10_bio ff3b4134184a6b00 done
> > [  600.780795] try_raise_barrier: nr_pending 1
> > [  600.780799] try_raise_barrier: nr_pending 1
> > [  600.780808] raid10_read_request: r10_bio ff3b4134184a7f00 start
> > [  600.802876] try_raise_barrier: nr_pending 1
> > [  600.803016] allow_barrier: nr_pending: 0
> > [  600.808000] wait_barrier: nr_pending: 1
> > [  600.811943] raid_end_bio_io: r10_bio ff3b4134184a7f00 done
> > [  600.816225] try_raise_barrier: nr_pending 1
> > [  600.816229] try_raise_barrier: nr_pending 1
> > [  600.816245] raid10_read_request: r10_bio ff3b4134184a7400 start
> > [  600.838385] try_raise_barrier: nr_pending 1
> > [  600.838448] allow_barrier: nr_pending: 0
> > [  600.843556] wait_barrier: nr_pending: 1
> > [  600.847451] raid_end_bio_io: r10_bio ff3b4134184a7400 done
> > [  600.851722] try_raise_barrier: nr_pending 1
> > [  600.851726] try_raise_barrier: nr_pending 1
> > [  600.851732] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.851897] allow_barrier: nr_pending: 0
> > [  600.851904] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.884632] wait_barrier: nr_pending: 1
> > [  600.888917] try_raise_barrier: nr_pending 1
> > [  600.888929] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.893588] try_raise_barrier: nr_pending 1
> > [  600.904881] try_raise_barrier: nr_pending 1
> > [  600.905028] allow_barrier: nr_pending: 0
> > [  600.909930] wait_barrier: nr_pending: 1
> > [  600.913958] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  600.918233] try_raise_barrier: nr_pending 1
> > [  600.918237] try_raise_barrier: nr_pending 1
> > [  600.918245] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  600.940401] try_raise_barrier: nr_pending 1
> > [  600.940502] allow_barrier: nr_pending: 0
> > [  600.945589] wait_barrier: nr_pending: 1
> > [  600.949477] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  600.953755] try_raise_barrier: nr_pending 1
> > [  600.953760] try_raise_barrier: nr_pending 1
> > [  600.953765] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  600.953893] allow_barrier: nr_pending: 0
> > [  600.953901] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  600.986653] wait_barrier: nr_pending: 1
> > [  600.990939] try_raise_barrier: nr_pending 1
> > [  600.990949] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  600.995611] try_raise_barrier: nr_pending 1
> > [  601.006963] try_raise_barrier: nr_pending 1
> > [  601.007109] allow_barrier: nr_pending: 0
> > [  601.011808] wait_barrier: nr_pending: 1
> > [  601.016031] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  601.020309] try_raise_barrier: nr_pending 1
> > [  601.020313] try_raise_barrier: nr_pending 1
> > [  601.020319] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  601.042453] allow_barrier: nr_pending: 0
> > [  601.042803] wait_barrier: nr_pending: 1
> > [  601.046853] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  601.051120] try_raise_barrier: nr_pending 1
> > [  601.051125] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  601.051126] try_raise_barrier: nr_pending 1
> > [  601.051145] try_raise_barrier: nr_pending 1
> > [  601.051415] allow_barrier: nr_pending: 0
> > [  601.051422] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  601.088815] wait_barrier: nr_pending: 1
> > [  601.093099] try_raise_barrier: nr_pending 1
> > [  601.093111] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  601.097772] try_raise_barrier: nr_pending 1
> > [  601.109103] try_raise_barrier: nr_pending 1
> > [  601.109172] allow_barrier: nr_pending: 0
> > [  601.114259] wait_barrier: nr_pending: 1
> > [  601.118177] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  601.122446] try_raise_barrier: nr_pending 1
> > [  601.122450] try_raise_barrier: nr_pending 1
> > [  601.122459] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  601.144607] try_raise_barrier: nr_pending 1
> > [  601.144650] allow_barrier: nr_pending: 0
> > [  601.149688] wait_barrier: nr_pending: 1
> > [  601.153683] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  601.157960] try_raise_barrier: nr_pending 1
> > [  601.157964] try_raise_barrier: nr_pending 1
> > [  601.157970] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  601.180129] try_raise_barrier: nr_pending 1
> > [  601.180240] allow_barrier: nr_pending: 0
> > [  601.185207] wait_barrier: nr_pending: 1
> > [  601.189209] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  601.193485] try_raise_barrier: nr_pending 1
> > [  601.193497] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  601.193706] allow_barrier: nr_pending: 0
> > [  601.193714] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  601.221868] wait_barrier: nr_pending: 1
> > [  601.226153] try_raise_barrier: nr_pending 1
> > [  601.226164] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  601.230826] try_raise_barrier: nr_pending 1
> > [  601.242175] try_raise_barrier: nr_pending 1
> > [  601.242239] allow_barrier: nr_pending: 0
> > [  601.247321] wait_barrier: nr_pending: 1
> > [  601.251249] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  601.255526] try_raise_barrier: nr_pending 1
> > [  601.255530] try_raise_barrier: nr_pending 1
> > [  601.255536] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  601.277688] try_raise_barrier: nr_pending 1
> > [  601.277818] allow_barrier: nr_pending: 0
> > [  601.282730] wait_barrier: nr_pending: 1
> > [  601.286761] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  601.291037] try_raise_barrier: nr_pending 1
> > [  601.291043] try_raise_barrier: nr_pending 1
> > [  601.291047] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  601.313190] try_raise_barrier: nr_pending 1
> > [  601.313248] allow_barrier: nr_pending: 0
> > [  601.318267] wait_barrier: nr_pending: 1
> > [  601.322269] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  601.326544] try_raise_barrier: nr_pending 1
> > [  601.326551] try_raise_barrier: nr_pending 1
> > [  601.326556] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  601.326708] allow_barrier: nr_pending: 0
> > [  601.326716] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  601.359595] wait_barrier: nr_pending: 1
> > [  601.363882] try_raise_barrier: nr_pending 1
> > [  601.363893] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  601.368556] try_raise_barrier: nr_pending 1
> > [  601.379906] try_raise_barrier: nr_pending 1
> > [  601.379973] allow_barrier: nr_pending: 0
> > [  601.385040] wait_barrier: nr_pending: 1
> > [  601.388979] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  601.393255] try_raise_barrier: nr_pending 1
> > [  601.393260] try_raise_barrier: nr_pending 1
> > [  601.393268] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  601.415361] try_raise_barrier: nr_pending 1
> > [  601.415483] allow_barrier: nr_pending: 0
> > [  601.420443] wait_barrier: nr_pending: 1
> > [  601.424436] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  601.428713] try_raise_barrier: nr_pending 1
> > [  601.428716] try_raise_barrier: nr_pending 1
> > [  601.428723] raid10_read_request: r10_bio ff3b41340eb53600 start
> > [  601.450871] try_raise_barrier: nr_pending 1
> > [  601.450916] allow_barrier: nr_pending: 0
> > [  601.455878] wait_barrier: nr_pending: 1
> > [  601.459951] raid_end_bio_io: r10_bio ff3b41340eb53600 done
> > [  601.464227] try_raise_barrier: nr_pending 1
> > [  601.464231] raid10_read_request: r10_bio ff3b41340eb52d00 start
> > [  601.481634] try_raise_barrier: nr_pending 1
> > [  601.486439] allow_barrier: nr_pending: 0
> > [  601.486947] wait_barrier: nr_pending: 1
> > [  601.490841] raid_end_bio_io: r10_bio ff3b41340eb52d00 done
> > [  601.495112] try_raise_barrier: nr_pending 1
> > [  601.495116] try_raise_barrier: nr_pending 1
> > [  601.495122] raid10_read_request: r10_bio ff3b41340eb53900 start
> > [  601.517260] try_raise_barrier: nr_pending 1
> > [  601.517346] allow_barrier: nr_pending: 0
> > [  601.522456] wait_barrier: nr_pending: 1
> > [  601.526326] raid_end_bio_io: r10_bio ff3b41340eb53900 done
> > [  601.530603] try_raise_barrier: nr_pending 1
> > [  601.530608] try_raise_barrier: nr_pending 1
> > [  601.530612] raid10_write_request: r10_bio ff3b41340eb52d00 start
> > [  601.552782] try_raise_barrier: nr_pending 1
>
> Thanks for the test!
>
> Now the problem is clear. r10_bio is generated and never complete, while
> IO never issued to underlying loop device, and I can reporduce this
> problem as well now.
>
> The blamed commit from git bisect is correct, and there are two
> conditions for this problem:
>
> 1) plug is not used for caller;
> 2) for raid1/raid10, bio plug is enabled;
>
> __submit_bio_noacct
>   current->bio_list = ...;
>   blk_start_plug
>
>    dm_submit_bio
>     md_handle_request
>      raid10_write_request
>       -> generate new bio for underlying disks
>       raid1_add_bio_to_plug -> bio added to plug
>
>   blk_finish_plug
>    raid10_unplug
>     raid1_submit_write
>      submit_bio_noacct
>       if (current->bio_list)
>        -> bio_list is not empty
>        bio_list_add(&current->bio_list[0], bio)
>
>   current->bio_list = NULL
>   -> the bio is in bio_list, and it's dropped.
>
> Can you give the following patch a test? It should be a final test...

Hi,Kuai

yeah, I would like to testing the fix patch,but I hit the patching
issue with new patch:
```
patching file block/blk-core.c
patch: **** malformed patch at line 6: blk_check_zone_append(struct
request_queue *q,
```
I don’t know if it is caused by a format error.
please add the patch as an attachment, just like the debuginfo patch
you gave me this morning.

Thanks,
Changhui


>
> Thanks,
> Kuai
>
> diff --git a/block/blk-core.c b/block/blk-core.c
> index 01186333c88e..1e9208024e47 100644
> --- a/block/blk-core.c
> +++ b/block/blk-core.c
> @@ -613,9 +613,13 @@ static inline blk_status_t
> blk_check_zone_append(struct request_queue *q,
>
>   static void __submit_bio(struct bio *bio)
>   {
> +       struct blk_plug plug;
> +
>          if (unlikely(!blk_crypto_bio_prep(&bio)))
>                  return;
>
> +       blk_start_plug(&plug);
> +
>          if (!bio->bi_bdev->bd_has_submit_bio) {
>                  blk_mq_submit_bio(bio);
>          } else if (likely(bio_queue_enter(bio) == 0)) {
> @@ -624,6 +628,8 @@ static void __submit_bio(struct bio *bio)
>                  disk->fops->submit_bio(bio);
>                  blk_queue_exit(disk->queue);
>          }
> +
> +       blk_finish_plug(&plug);
>   }
>
>   /*
> @@ -648,13 +654,11 @@ static void __submit_bio(struct bio *bio)
>   static void __submit_bio_noacct(struct bio *bio)
>   {
>          struct bio_list bio_list_on_stack[2];
> -       struct blk_plug plug;
>
>          BUG_ON(bio->bi_next);
>
>          bio_list_init(&bio_list_on_stack[0]);
>          current->bio_list = bio_list_on_stack;
> -       blk_start_plug(&plug);
>
>          do {
>                  struct request_queue *q = bdev_get_queue(bio->bi_bdev);
> @@ -688,23 +692,19 @@ static void __submit_bio_noacct(struct bio *bio)
>                  bio_list_merge(&bio_list_on_stack[0],
> &bio_list_on_stack[1]);
>          } while ((bio = bio_list_pop(&bio_list_on_stack[0])));
>
> -       blk_finish_plug(&plug);
>          current->bio_list = NULL;
>   }
>
>   static void __submit_bio_noacct_mq(struct bio *bio)
>   {
>          struct bio_list bio_list[2] = { };
> -       struct blk_plug plug;
>
>          current->bio_list = bio_list;
> -       blk_start_plug(&plug);
>
>          do {
>                  __submit_bio(bio);
>          } while ((bio = bio_list_pop(&bio_list[0])));
>
> -       blk_finish_plug(&plug);
>          current->bio_list = NULL;
>   }
>
> > [  737.970751] INFO: task mdX_resync:3115 blocked for more than 122 seconds.
> > [  737.978361]       Not tainted 6.9.0+ #1
> > [  737.982654] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"
> > disables this message.
> > [  737.991398] task:mdX_resync      state:D stack:0     pid:3115
> > tgid:3115  ppid:2      flags:0x00004000
> > [  737.991407] Call Trace:
> > [  737.991410]  <TASK>
> > [  737.991414]  __schedule+0x222/0x670
> > [  737.991426]  schedule+0x2c/0xb0
> > [  737.991434]  raise_barrier+0xca/0x1a0 [raid10]
> > [  737.991450]  ? __pfx_autoremove_wake_function+0x10/0x10
> > [  737.991459]  raid10_sync_request+0x2c3/0x19d0 [raid10]
> > [  737.991472]  ? __switch_to_asm+0x39/0x70
> > [  737.991478]  ? finish_task_switch.isra.0+0x8e/0x2a0
> > [  737.991487]  ? __schedule+0x22a/0x670
> > [  737.991491]  ? prepare_to_wait_event+0x5f/0x190
> > [  737.991498]  md_do_sync+0x660/0x1040
> > [  737.991508]  ? __pfx_autoremove_wake_function+0x10/0x10
> > [  737.991517]  md_thread+0xad/0x160
> > [  737.991521]  ? __pfx_md_thread+0x10/0x10
> > [  737.991524]  kthread+0xdc/0x110
> > [  737.991531]  ? __pfx_kthread+0x10/0x10
> > [  737.991535]  ret_from_fork+0x2d/0x50
> > [  737.991544]  ? __pfx_kthread+0x10/0x10
> > [  737.991547]  ret_from_fork_asm+0x1a/0x30
> > [  737.991553]  </TASK>
> > [  860.850998] INFO: task mdX_resync:3115 blocked for more than 245 seconds.
> > [  860.858606]       Not tainted 6.9.0+ #1
> > [  860.862902] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"
> > disables this message.
> > [  860.871649] task:mdX_resync      state:D stack:0     pid:3115
> > tgid:3115  ppid:2      flags:0x00004000
> > [  860.871658] Call Trace:
> > [  860.871660]  <TASK>
> > [  860.871664]  __schedule+0x222/0x670
> > [  860.871674]  schedule+0x2c/0xb0
> > [  860.871681]  raise_barrier+0xca/0x1a0 [raid10]
> > [  860.871696]  ? __pfx_autoremove_wake_function+0x10/0x10
> > [  860.871704]  raid10_sync_request+0x2c3/0x19d0 [raid10]
> > [  860.871717]  ? __switch_to_asm+0x39/0x70
> > [  860.871722]  ? finish_task_switch.isra.0+0x8e/0x2a0
> > [  860.871729]  ? __schedule+0x22a/0x670
> > [  860.871733]  ? prepare_to_wait_event+0x5f/0x190
> > [  860.871740]  md_do_sync+0x660/0x1040
> > [  860.871748]  ? __pfx_autoremove_wake_function+0x10/0x10
> > [  860.871756]  md_thread+0xad/0x160
> > [  860.871761]  ? __pfx_md_thread+0x10/0x10
> > [  860.871765]  kthread+0xdc/0x110
> > [  860.871770]  ? __pfx_kthread+0x10/0x10
> > [  860.871774]  ret_from_fork+0x2d/0x50
> > [  860.871781]  ? __pfx_kthread+0x10/0x10
> > [  860.871785]  ret_from_fork_asm+0x1a/0x30
> > [  860.871790]  </TASK>
> >
> > Thanks,
> > Changhui
> >
> > .
> >
>


-- 

Changhui  Zhong

Quality Engineer,Kernel QE

Red Hat

Red Hat Beijing - Raycom






[Index of Archives]     [Linux RAID Wiki]     [ATA RAID]     [Linux SCSI Target Infrastructure]     [Linux Block]     [Linux IDE]     [Linux SCSI]     [Linux Hams]     [Device Mapper]     [Device Mapper Cryptographics]     [Kernel]     [Linux Admin]     [Linux Net]     [GFS]     [RPM]     [git]     [Yosemite Forum]


  Powered by Linux