Linux XFS filesystem development
 help / color / mirror / Atom feed
From: Shin'ichiro Kawasaki <shinichiro.kawasaki@wdc.com>
To: John Garry <john.garry@linux.dev>
Cc: "linux-xfs@vger.kernel.org" <linux-xfs@vger.kernel.org>,
	 "Darrick J. Wong" <djwong@kernel.org>
Subject: Re: [bug report] fstests generic/774 hang again
Date: Wed, 16 Sep 2026 11:53:41 +0900	[thread overview]
Message-ID: <aqoEOImeqWI9HG1F@shinmob> (raw)
In-Reply-To: <aqkv-2opTlWD6bzU@shinmob>

On Sep 15, 2026 / 20:48, Shin'ichiro Kawasaki wrote:
> On Sep 15, 2026 / 11:00, John Garry wrote:
> > On 9/15/26 10:34, Shin'ichiro Kawasaki wrote:
> > > I observe the fstests test case generic/774 hangs, when I run it for xfs on 8GiB
> > > TCMU fileio devices. Actually I once reported this hang symptom in last October,
> > > and Darrick and John kindly took some actions [1]. Since then, the hang
> > > disappeared and I have not observed the hang almost one year. However, my test
> > > system started reporting the hang again last week.
> > > 
> > > [1] https://lore.kernel.org/linux-xfs/cmk52aqexackyz65phxgme55a3tdrermo3o4skr4lo4pwvvvcp@jmcblnfikbp2/#t
> > 
> > This was the series to resolve, I think:
> > https://lore.kernel.org/fstests/176279908967.605950.2192923313361120314.stgit@frogsfrogsfrogs/T/#t
> > 
> > As an experiment, can you reduce the file size further, like:
> > 
> > --- a/tests/generic/774
> > +++ b/tests/generic/774
> > @@ -29,7 +29,7 @@ aw_bsize=$(_max "$awu_min_write" "$((awu_max_write/4))")
> >  fsbsize=$(_get_block_size $SCRATCH_MNT)
> > 
> >  threads=$(_min "$(($(nproc) * 2 * LOAD_FACTOR))" "100")
> > -filesize=$((aw_bsize * threads * 10))
> > +filesize=$((aw_bsize * threads))
> >  depth=$threads
> >  aw_io_size=$((filesize / threads))
> >  aw_io_inc=$aw_io_size
> 
> Thanks for the response. I repeated the test case 100 times with the change
> above, and I did not observe the hang. The change looks avoiding the hang.
> 
> > 
> > > 
> > > FYI, here I attache the kernel message [2].
> > 
> > Is mainline baseline hanging, i.e. v7.3-rc2?
> 
> I will try this out tomorrow.

I observed the hang with the mainline v7.3-rc2 kernel also:

[  516.678848] [   T5360] run fstests generic/774 at 2026-09-16 11:01:26
[  516.808855] [   T2710] MODE SENSE: unimplemented page/subpage: 0x0a/0x05
[  519.197067] [   T2825] MODE SENSE: unimplemented page/subpage: 0x0a/0x05
[  519.325438] [   T6378] XFS (sdh): Mounting V5 Filesystem f004c5a8-b5fd-4f05-9ea1-977c32c9fc76
[  519.342073] [   T6378] XFS (sdh): Ending clean mount
[  519.704393] [   T6429] XFS (sdh): Unmounting Filesystem f004c5a8-b5fd-4f05-9ea1-977c32c9fc76
[  520.341237] [   T2904] MODE SENSE: unimplemented page/subpage: 0x0a/0x05
[  520.461538] [   T6477] XFS (sdh): Mounting V5 Filesystem dcd73d62-bc80-42a1-9893-7815befb6fd1
[  520.480790] [   T6477] XFS (sdh): Ending clean mount
[  862.484216] [    T169] INFO: task kworker/0:0:9 blocked for more than 122 seconds.
[  862.486738] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.488497] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.491457] [    T169] task:kworker/0:0     state:D stack:0     pid:9     tgid:9     ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.493590] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.494696] [    T169] Call Trace:
[  862.496681] [    T169]  <TASK>
[  862.497741] [    T169]  __schedule+0xc86/0x1b10
[  862.499020] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  862.500434] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.501999] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.503638] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  862.505095] [    T169]  ? lock_acquire+0x11a/0x140
[  862.506540] [    T169]  schedule+0xe5/0x2e0
[  862.507546] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.508858] [    T169]  schedule_preempt_disabled+0x16/0x30
[  862.510463] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  862.511857] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  862.513526] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.514807] [    T169]  ? lock_acquire+0x11a/0x140
[  862.516272] [    T169]  down_write_nested+0x1c0/0x1f0
[  862.517706] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  862.519465] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  862.522491] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  862.525468] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.528537] [    T169]  ? lock_acquire+0x11a/0x140
[  862.529870] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.531028] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.533879] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.536645] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.537895] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.539424] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.540711] [    T169]  process_one_work+0x947/0x1760
[  862.542425] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.543881] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.545586] [    T169]  worker_thread+0x601/0xff0
[  862.547505] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.548953] [    T169]  kthread+0x361/0x460
[  862.550636] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.552067] [    T169]  ret_from_fork+0x560/0x860
[  862.598716] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.599886] [    T169]  ? __switch_to+0x473/0xd50
[  862.601344] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.602570] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.604391] [    T169]  </TASK>
[  862.605720] [    T169] INFO: task kworker/0:0:9 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  862.608060] [    T169] INFO: task kworker/10:0:95 blocked for more than 123 seconds.
[  862.610611] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.612670] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.615074] [    T169] task:kworker/10:0    state:D stack:0     pid:95    tgid:95    ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.617510] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.618863] [    T169] Call Trace:
[  862.619984] [    T169]  <TASK>
[  862.621425] [    T169]  __schedule+0xc86/0x1b10
[  862.622635] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  862.623900] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.625384] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.626539] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  862.627851] [    T169]  ? rcu_is_watching+0x69/0x90
[  862.629309] [    T169]  ? lock_acquire+0x11a/0x140
[  862.630501] [    T169]  schedule+0xe5/0x2e0
[  862.631786] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.633410] [    T169]  schedule_preempt_disabled+0x16/0x30
[  862.634482] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  862.635829] [    T169]  ? __kasan_slab_alloc+0x7f/0x90
[  862.637088] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  862.638545] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.639768] [    T169]  ? lock_acquire+0x11a/0x140
[  862.641378] [    T169]  down_write_nested+0x1c0/0x1f0
[  862.642616] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  862.644347] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  862.646648] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  862.649368] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.651640] [    T169]  ? update_load_avg+0xb65/0x2c70
[  862.652721] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.653736] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.656196] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.658537] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.659475] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.660451] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.661510] [    T169]  process_one_work+0x947/0x1760
[  862.662631] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.663652] [    T169]  ? __try_to_del_timer_sync+0xd3/0x130
[  862.664757] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.665845] [    T169]  worker_thread+0x601/0xff0
[  862.666850] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.667903] [    T169]  kthread+0x361/0x460
[  862.669351] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.670628] [    T169]  ret_from_fork+0x560/0x860
[  862.671393] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.672180] [    T169]  ? __switch_to+0x473/0xd50
[  862.673196] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.674012] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.675087] [    T169]  </TASK>
[  862.675904] [    T169] INFO: task kworker/10:0:95 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  862.677484] [    T169] INFO: task kworker/13:0:107 blocked for more than 123 seconds.
[  862.678751] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.679934] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.681454] [    T169] task:kworker/13:0    state:D stack:0     pid:107   tgid:107   ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.683148] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.684174] [    T169] Call Trace:
[  862.685025] [    T169]  <TASK>
[  862.685742] [    T169]  __schedule+0xc86/0x1b10
[  862.686690] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  862.687637] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.688543] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.689410] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  862.690380] [    T169]  ? lock_acquire+0x11a/0x140
[  862.691570] [    T169]  schedule+0xe5/0x2e0
[  862.692351] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.693301] [    T169]  schedule_preempt_disabled+0x16/0x30
[  862.694317] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  862.695571] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  862.696636] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.697620] [    T169]  ? lock_acquire+0x11a/0x140
[  862.698603] [    T169]  down_write_nested+0x1c0/0x1f0
[  862.699567] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  862.700843] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  862.702991] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  862.705330] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.707139] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.708286] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.709873] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.711607] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.712622] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.713758] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.714854] [    T169]  process_one_work+0x947/0x1760
[  862.715809] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.716900] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.718142] [    T169]  worker_thread+0x601/0xff0
[  862.719263] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.720613] [    T169]  kthread+0x361/0x460
[  862.721568] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.722681] [    T169]  ret_from_fork+0x560/0x860
[  862.723567] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.724692] [    T169]  ? __switch_to+0x473/0xd50
[  862.725643] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.726494] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.727727] [    T169]  </TASK>
[  862.728590] [    T169] INFO: task kworker/13:0:107 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  862.730308] [    T169] INFO: task kworker/18:0:131 blocked for more than 123 seconds.
[  862.731761] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.732954] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.734431] [    T169] task:kworker/18:0    state:D stack:0     pid:131   tgid:131   ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.735987] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.737180] [    T169] Call Trace:
[  862.737922] [    T169]  <TASK>
[  862.738784] [    T169]  __schedule+0xc86/0x1b10
[  862.739699] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  862.740958] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.742223] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.743837] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  862.745556] [    T169]  ? lock_acquire+0x11a/0x140
[  862.747573] [    T169]  schedule+0xe5/0x2e0
[  862.749001] [    T169]  xlog_grant_head_wait+0x175/0xac0 [xfs]
[  862.751614] [    T169]  xlog_grant_head_check+0x312/0x3f0 [xfs]
[  862.754331] [    T169]  ? __pfx_xlog_grant_head_check+0x10/0x10 [xfs]
[  862.757018] [    T169]  xfs_log_reserve+0x2b2/0x7a0 [xfs]
[  862.759361] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.760571] [    T169]  ? __pfx_xfs_log_reserve+0x10/0x10 [xfs]
[  862.763313] [    T169]  ? xfs_dec_freecounter+0x81/0x520 [xfs]
[  862.765660] [    T169]  xfs_trans_alloc+0x1a4/0x820 [xfs]
[  862.767935] [    T169]  xfs_reflink_end_atomic_cow+0x1b1/0x560 [xfs]
[  862.770604] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.773762] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.774868] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.777326] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.779795] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.780989] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.782460] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.783667] [    T169]  process_one_work+0x947/0x1760
[  862.784759] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.786260] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.787550] [    T169]  worker_thread+0x601/0xff0
[  862.788602] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.789757] [    T169]  kthread+0x361/0x460
[  862.790931] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.791965] [    T169]  ret_from_fork+0x560/0x860
[  862.793177] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.794419] [    T169]  ? __switch_to+0x473/0xd50
[  862.795543] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.796560] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.797661] [    T169]  </TASK>
[  862.798604] [    T169] INFO: task kworker/21:0:149 blocked for more than 123 seconds.
[  862.800419] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.801700] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.803425] [    T169] task:kworker/21:0    state:D stack:0     pid:149   tgid:149   ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.805354] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.806351] [    T169] Call Trace:
[  862.807571] [    T169]  <TASK>
[  862.808374] [    T169]  __schedule+0xc86/0x1b10
[  862.809575] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  862.810650] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.811595] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.812602] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  862.813639] [    T169]  ? rcu_is_watching+0x69/0x90
[  862.814471] [    T169]  ? lock_acquire+0x11a/0x140
[  862.815458] [    T169]  schedule+0xe5/0x2e0
[  862.816473] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.817491] [    T169]  schedule_preempt_disabled+0x16/0x30
[  862.818527] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  862.819664] [    T169]  ? __kasan_slab_alloc+0x7f/0x90
[  862.820690] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  862.821863] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.823035] [    T169]  ? lock_acquire+0x11a/0x140
[  862.882304] [    T169]  down_write_nested+0x1c0/0x1f0
[  862.882992] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  862.884022] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  862.885942] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  862.888021] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.890047] [    T169]  ? update_load_avg+0xb65/0x2c70
[  862.890723] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.891859] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.893613] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.895520] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.896394] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.897155] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.898492] [    T169]  process_one_work+0x947/0x1760
[  862.899478] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.900184] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.901237] [    T169]  worker_thread+0x601/0xff0
[  862.901968] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.903572] [    T169]  kthread+0x361/0x460
[  862.904365] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.905281] [    T169]  ret_from_fork+0x560/0x860
[  862.906378] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.907247] [    T169]  ? __switch_to+0x473/0xd50
[  862.908264] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.909171] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.910168] [    T169]  </TASK>
[  862.910906] [    T169] INFO: task kworker/21:0:149 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  862.912626] [    T169] INFO: task kworker/10:1:182 blocked for more than 123 seconds.
[  862.913741] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.914683] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.915828] [    T169] task:kworker/10:1    state:D stack:0     pid:182   tgid:182   ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.917294] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.918366] [    T169] Call Trace:
[  862.918970] [    T169]  <TASK>
[  862.919592] [    T169]  __schedule+0xc86/0x1b10
[  862.920361] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  862.921220] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.922009] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.922876] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  862.923772] [    T169]  ? lock_acquire+0x11a/0x140
[  862.924586] [    T169]  schedule+0xe5/0x2e0
[  862.925449] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.926194] [    T169]  schedule_preempt_disabled+0x16/0x30
[  862.927011] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  862.927988] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  862.928985] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.930050] [    T169]  ? lock_acquire+0x11a/0x140
[  862.930852] [    T169]  down_write_nested+0x1c0/0x1f0
[  862.931837] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  862.932707] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  862.934501] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  862.936477] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.938135] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.939145] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.940733] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.942374] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.943029] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.943836] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.944511] [    T169]  process_one_work+0x947/0x1760
[  862.945264] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.945902] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.946883] [    T169]  worker_thread+0x601/0xff0
[  862.947501] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.948411] [    T169]  ? __kthread_parkme+0xbd/0x210
[  862.949411] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.950258] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.950981] [    T169]  kthread+0x361/0x460
[  862.951742] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.952475] [    T169]  ret_from_fork+0x560/0x860
[  862.953085] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.953768] [    T169]  ? __switch_to+0x473/0xd50
[  862.954462] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.955329] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.956135] [    T169]  </TASK>
[  862.956743] [    T169] INFO: task kworker/10:1:182 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  862.958496] [    T169] INFO: task kworker/4:1:192 blocked for more than 123 seconds.
[  862.959780] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  862.960649] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  862.961646] [    T169] task:kworker/4:1     state:D stack:0     pid:192   tgid:192   ppid:2      task_flags:0x4248060 flags:0x00080000
[  862.962802] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  862.963656] [    T169] Call Trace:
[  862.964239] [    T169]  <TASK>
[  862.964876] [    T169]  __schedule+0xc86/0x1b10
[  862.965650] [    T169]  ? __pfx___schedule+0x10/0x10
[  862.966357] [    T169]  ? rwsem_optimistic_spin+0x1f0/0x480
[  862.967116] [    T169]  ? wq_worker_sleeping+0x65/0x280
[  862.967818] [    T169]  ? lock_acquire+0x11a/0x140
[  862.968455] [    T169]  schedule+0xe5/0x2e0
[  862.969236] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  862.969956] [    T169]  schedule_preempt_disabled+0x16/0x30
[  862.970745] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  862.971466] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  862.972318] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  862.973018] [    T169]  ? lock_acquire+0x11a/0x140
[  862.973929] [    T169]  down_write_nested+0x1c0/0x1f0
[  862.974668] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  862.975517] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  862.977132] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  862.978753] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  862.980434] [    T169]  ? lock_acquire+0x11a/0x140
[  862.981088] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  862.981891] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  862.983313] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  862.984866] [    T169]  iomap_dio_complete+0x140/0xb20
[  862.985470] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  862.986145] [    T169]  iomap_dio_complete_work+0x58/0x90
[  862.987165] [    T169]  process_one_work+0x947/0x1760
[  862.987782] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  862.988614] [    T169]  ? __try_to_del_timer_sync+0xd3/0x130
[  862.989478] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  862.990329] [    T169]  worker_thread+0x601/0xff0
[  862.991073] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  862.991879] [    T169]  kthread+0x361/0x460
[  862.992366] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.992943] [    T169]  ret_from_fork+0x560/0x860
[  862.993616] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  862.994429] [    T169]  ? __switch_to+0x473/0xd50
[  862.995061] [    T169]  ? __pfx_kthread+0x10/0x10
[  862.995764] [    T169]  ret_from_fork_asm+0x1a/0x30
[  862.996514] [    T169]  </TASK>
[  862.997177] [    T169] INFO: task kworker/4:1:192 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  862.998650] [    T169] INFO: task kworker/13:1:203 blocked for more than 123 seconds.
[  862.999569] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  863.000412] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  863.001516] [    T169] task:kworker/13:1    state:D stack:0     pid:203   tgid:203   ppid:2      task_flags:0x4248060 flags:0x00080000
[  863.002727] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  863.003433] [    T169] Call Trace:
[  863.003999] [    T169]  <TASK>
[  863.004720] [    T169]  __schedule+0xc86/0x1b10
[  863.005341] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  863.005926] [    T169]  ? __pfx___schedule+0x10/0x10
[  863.006767] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  863.007384] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  863.008172] [    T169]  ? rcu_is_watching+0x69/0x90
[  863.008798] [    T169]  ? lock_acquire+0x11a/0x140
[  863.009533] [    T169]  schedule+0xe5/0x2e0
[  863.010175] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  863.010753] [    T169]  schedule_preempt_disabled+0x16/0x30
[  863.011389] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  863.012000] [    T169]  ? __kasan_slab_alloc+0x7f/0x90
[  863.012699] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  863.013432] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  863.014201] [    T169]  ? lock_acquire+0x11a/0x140
[  863.014754] [    T169]  down_write_nested+0x1c0/0x1f0
[  863.015577] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  863.016221] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  863.017869] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  863.019128] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  863.020502] [    T169]  ? update_load_avg+0xb65/0x2c70
[  863.021124] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  863.021694] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  863.022983] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  863.024392] [    T169]  iomap_dio_complete+0x140/0xb20
[  863.024936] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  863.025750] [    T169]  iomap_dio_complete_work+0x58/0x90
[  863.026539] [    T169]  process_one_work+0x947/0x1760
[  863.027125] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  863.027748] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  863.028469] [    T169]  worker_thread+0x601/0xff0
[  863.029048] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  863.029602] [    T169]  ? __kthread_parkme+0xbd/0x210
[  863.030330] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  863.031083] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  863.031679] [    T169]  kthread+0x361/0x460
[  863.032432] [    T169]  ? __pfx_kthread+0x10/0x10
[  863.033138] [    T169]  ret_from_fork+0x560/0x860
[  863.033773] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  863.034384] [    T169]  ? __switch_to+0x473/0xd50
[  863.034950] [    T169]  ? __pfx_kthread+0x10/0x10
[  863.046680] [    T169]  ret_from_fork_asm+0x1a/0x30
[  863.047257] [    T169]  </TASK>
[  863.047797] [    T169] INFO: task kworker/13:1:203 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  863.048786] [    T169] INFO: task kworker/7:1:267 blocked for more than 123 seconds.
[  863.049651] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  863.050339] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  863.051394] [    T169] task:kworker/7:1     state:D stack:0     pid:267   tgid:267   ppid:2      task_flags:0x4248060 flags:0x00080000
[  863.052474] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  863.053233] [    T169] Call Trace:
[  863.053879] [    T169]  <TASK>
[  863.054380] [    T169]  __schedule+0xc86/0x1b10
[  863.055017] [    T169]  ? trace_hardirqs_on+0x18/0x1a0
[  863.055705] [    T169]  ? __pfx___schedule+0x10/0x10
[  863.056191] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  863.056776] [    T169]  ? wq_worker_sleeping+0x213/0x280
[  863.057382] [    T169]  ? rcu_is_watching+0x69/0x90
[  863.057888] [    T169]  ? lock_acquire+0x11a/0x140
[  863.058510] [    T169]  schedule+0xe5/0x2e0
[  863.059152] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  863.059634] [    T169]  schedule_preempt_disabled+0x16/0x30
[  863.060191] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  863.060660] [    T169]  ? __kasan_slab_alloc+0x7f/0x90
[  863.061305] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  863.061975] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  863.062852] [    T169]  ? lock_acquire+0x11a/0x140
[  863.063494] [    T169]  down_write_nested+0x1c0/0x1f0
[  863.063987] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  863.064651] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  863.065744] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  863.066867] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  863.068171] [    T169]  ? lock_acquire+0x11a/0x140
[  863.068608] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  863.069209] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  863.070280] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  863.071520] [    T169]  iomap_dio_complete+0x140/0xb20
[  863.072007] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  863.072614] [    T169]  iomap_dio_complete_work+0x58/0x90
[  863.073410] [    T169]  process_one_work+0x947/0x1760
[  863.073943] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  863.074647] [    T169]  ? __try_to_del_timer_sync+0xd3/0x130
[  863.075263] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  863.075717] [    T169]  worker_thread+0x601/0xff0
[  863.076457] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  863.076864] [    T169]  kthread+0x361/0x460
[  863.077206] [    T169]  ? __pfx_kthread+0x10/0x10
[  863.077635] [    T169]  ret_from_fork+0x560/0x860
[  863.077979] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  863.078467] [    T169]  ? __switch_to+0x473/0xd50
[  863.079013] [    T169]  ? __pfx_kthread+0x10/0x10
[  863.079724] [    T169]  ret_from_fork_asm+0x1a/0x30
[  863.080357] [    T169]  </TASK>
[  863.080782] [    T169] INFO: task kworker/7:1:267 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  863.081659] [    T169] INFO: task kworker/18:1:273 blocked for more than 123 seconds.
[  863.082544] [    T169]       Tainted: G        W           7.3.0-rc2-kts-xfs+ #3
[  863.083261] [    T169] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  863.084177] [    T169] task:kworker/18:1    state:D stack:0     pid:273   tgid:273   ppid:2      task_flags:0x4248060 flags:0x00080000
[  863.085081] [    T169] Workqueue: dio/sdh iomap_dio_complete_work
[  863.085709] [    T169] Call Trace:
[  863.086190] [    T169]  <TASK>
[  863.086664] [    T169]  __schedule+0xc86/0x1b10
[  863.087350] [    T169]  ? __pfx___schedule+0x10/0x10
[  863.088018] [    T169]  ? rwsem_optimistic_spin+0x1f0/0x480
[  863.088839] [    T169]  ? wq_worker_sleeping+0x65/0x280
[  863.089320] [    T169]  ? lock_acquire+0x11a/0x140
[  863.089716] [    T169]  schedule+0xe5/0x2e0
[  863.090107] [    T169]  ? _raw_spin_unlock_irq+0x28/0x50
[  863.090475] [    T169]  schedule_preempt_disabled+0x16/0x30
[  863.090998] [    T169]  rwsem_down_write_slowpath+0x4b4/0x1460
[  863.091593] [    T169]  ? __pfx_rwsem_down_write_slowpath+0x10/0x10
[  863.092182] [    T169]  ? percpu_counter_add_batch+0x80/0x220
[  863.092592] [    T169]  ? lock_acquire+0x11a/0x140
[  863.092928] [    T169]  down_write_nested+0x1c0/0x1f0
[  863.093339] [    T169]  ? __pfx_down_write_nested+0x10/0x10
[  863.093878] [    T169]  ? xfs_ilock+0x1e7/0x310 [xfs]
[  863.094891] [    T169]  xfs_reflink_end_atomic_cow+0x2f3/0x560 [xfs]
[  863.095987] [    T169]  ? __pfx_xfs_reflink_end_atomic_cow+0x10/0x10 [xfs]
[  863.097206] [    T169]  ? lock_acquire+0x11a/0x140
[  863.097778] [    T169]  ? update_cfs_rq_load_avg+0x4b/0x660
[  863.098326] [    T169]  xfs_dio_write_end_io+0x4b7/0x650 [xfs]
[  863.099445] [    T169]  ? __pfx_xfs_dio_write_end_io+0x10/0x10 [xfs]
[  863.100619] [    T169]  iomap_dio_complete+0x140/0xb20
[  863.101449] [    T169]  ? __pfx_aio_complete_rw+0x10/0x10
[  863.102004] [    T169]  iomap_dio_complete_work+0x58/0x90
[  863.102595] [    T169]  process_one_work+0x947/0x1760
[  863.103268] [    T169]  ? __pfx_process_one_work+0x10/0x10
[  863.103864] [    T169]  ? __pfx_do_raw_spin_lock+0x10/0x10
[  863.104356] [    T169]  worker_thread+0x601/0xff0
[  863.104893] [    T169]  ? __pfx_worker_thread+0x10/0x10
[  863.105480] [    T169]  kthread+0x361/0x460
[  863.105995] [    T169]  ? __pfx_kthread+0x10/0x10
[  863.106607] [    T169]  ret_from_fork+0x560/0x860
[  863.107270] [    T169]  ? __pfx_ret_from_fork+0x10/0x10
[  863.107794] [    T169]  ? __switch_to+0x473/0xd50
[  863.108317] [    T169]  ? __pfx_kthread+0x10/0x10
[  863.108847] [    T169]  ret_from_fork_asm+0x1a/0x30
[  863.109354] [    T169]  </TASK>
[  863.109815] [    T169] INFO: task kworker/18:1:273 <writer> blocked on an rw-semaphore likely owned by task kworker/14:8:2880 <writer>
[  863.110690] [    T169] Future hung task reports are suppressed, see sysctl kernel.hung_task_warnings
[  863.111555] [    T169] INFO: lockdep is turned off.

  parent reply	other threads:[~2026-09-16  2:53 UTC|newest]

Thread overview: 24+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2026-09-15  9:34 [bug report] fstests generic/774 hang again Shin'ichiro Kawasaki
2026-09-15 10:00 ` John Garry
2026-09-15 11:48   ` Shin'ichiro Kawasaki
2026-09-15 14:48     ` John Garry
2026-09-15 14:50       ` Darrick J. Wong
2026-09-15 15:41         ` John Garry
2026-09-16 10:23           ` John Garry
2026-09-16 22:23             ` Dave Chinner
2026-09-17  8:28               ` John Garry
2026-09-17 21:20                 ` Dave Chinner
2026-09-17  6:30             ` Shin'ichiro Kawasaki
2026-09-16  2:53     ` Shin'ichiro Kawasaki [this message]
2026-09-16 21:45 ` Dave Chinner
2026-09-17  6:52   ` Shin'ichiro Kawasaki
2026-09-17 10:45     ` Shin'ichiro Kawasaki
2026-09-17 21:24       ` Dave Chinner
2026-09-19 11:53         ` Shin'ichiro Kawasaki
2026-09-21 22:05           ` Dave Chinner
2026-09-25  1:32             ` Shin'ichiro Kawasaki
2026-09-27 21:30               ` Dave Chinner
2026-09-28  2:45                 ` Darrick J. Wong
2026-09-22  0:28   ` Darrick J. Wong
2026-09-25  1:38     ` Shin'ichiro Kawasaki
2026-09-25 23:03       ` Darrick J. Wong

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=aqoEOImeqWI9HG1F@shinmob \
    --to=shinichiro.kawasaki@wdc.com \
    --cc=djwong@kernel.org \
    --cc=john.garry@linux.dev \
    --cc=linux-xfs@vger.kernel.org \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox