[linus:master] [dmaengine] 2a93f5747d: INFO:task_blocked_for_more_than#seconds

[linus:master] [dmaengine] 2a93f5747d: INFO:task_blocked_for_more_than#seconds

[kernel test robot]

Hello,

kernel test robot noticed "INFO:task_blocked_for_more_than#seconds" on:

commit: 2a93f5747d0eef89a3158c91d185d37d0bca2491 ("dmaengine: idxd: Flush all pending descriptors") https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master

[test failed on linux-next/master 2efb7a11f1aa4d2dc285fe2680cca22cb9f72f64]

in testcase: lkvs
version: lkvs-x86_64-388e0c1-1_20260521
with following parameters:

	test: dma

config: x86_64-rhel-9.4-func
compiler: gcc-14
test machine: 256 threads 2 sockets GENUINE INTEL(R) XEON(R) (Sierra Forest) with 128G memory

(please refer to attached dmesg/kmsg for entire log/backtrace)

If you fix the issue in a separate patch/commit (i.e. not just a new version of the same patch/commit), kindly add following tags
| Reported-by: kernel test robot <yi1.lai@intel.com>
| Closes: https://lore.kernel.org/oe-lkp/202611021447.f9ab47b7-lkp@intel.com


kern  :err   : [ 5423.292137] [   T1658] INFO: task modprobe:11531 blocked for more than 4915 seconds.
kern  :err   : [ 5423.301474] [   T1658]       Not tainted 7.0.0-rc1+ #1
kern  :err   : [ 5423.307296] [   T1658] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kern  :info  : [ 5423.320648] [   T1658] task:modprobe        state:D stack:0     pid:11531 tgid:11531 ppid:11511  task_flags:0x400100 flags:0x00080800
kern  :info  : [ 5423.334425] [   T1658] Call Trace:
kern  :info  : [ 5423.338277] [   T1658]  <TASK>
kern  :info  : [ 5423.345059] [   T1658]  __schedule+0x720/0x10b0
kern  :info  : [ 5423.350188] [   T1658]  ? _printk+0xb1/0xf0
kern  :info  : [ 5423.355121] [   T1658]  ? __pfx___schedule+0x10/0x10
kern  :info  : [ 5423.360748] [   T1658]  ? mutex_unlock+0x81/0xf0
kern  :info  : [ 5423.365968] [   T1658]  ? prepare_to_wait_event+0x8e/0x730
kern  :info  : [ 5423.373937] [   T1658]  schedule+0x6b/0x1b0
kern  :info  : [ 5423.379636] [   T1658]  dmatest_init+0xf5/0xff0 [dmatest]
kern  :info  : [ 5423.385782] [   T1658]  ? __pfx_dmatest_init+0x10/0x10 [dmatest]
kern  :info  : [ 5423.392794] [   T1658]  ? __pfx_autoremove_wake_function+0x10/0x10
kern  :info  : [ 5423.399783] [   T1658]  ? ktime_get+0x61/0x170
kern  :info  : [ 5423.404977] [   T1658]  ? __pfx_dmatest_init+0x10/0x10 [dmatest]
kern  :info  : [ 5423.411769] [   T1658]  ? trace_initcall_start_cb+0x5b/0x90
kern  :info  : [ 5423.421348] [   T1658]  ? __pfx_dmatest_init+0x10/0x10 [dmatest]
kern  :info  : [ 5423.428106] [   T1658]  do_one_initcall+0x8d/0x3f0
kern  :info  : [ 5423.436782] [   T1658]  ? __pfx_do_one_initcall+0x10/0x10
kern  :info  : [ 5423.442848] [   T1658]  ? kasan_unpoison+0x40/0x70
kern  :info  : [ 5423.448390] [   T1658]  ? __kasan_slab_alloc+0x2f/0x70
kern  :info  : [ 5423.454178] [   T1658]  ? kasan_unpoison+0x40/0x70
kern  :info  : [ 5423.462863] [   T1658]  do_init_module+0x281/0x830
kern  :info  : [ 5423.468228] [   T1658]  ? __pfx_do_init_module+0x10/0x10
kern  :info  : [ 5423.477456] [   T1658]  ? kfree+0x195/0x430
kern  :info  : [ 5423.482122] [   T1658]  ? klp_module_coming+0x210/0x2f0
kern  :info  : [ 5423.488589] [   T1658]  load_module+0x173d/0x2070
kern  :info  : [ 5423.493917] [   T1658]  ? ima_post_read_file+0x18f/0x230
kern  :info  : [ 5423.499863] [   T1658]  ? __pfx_load_module+0x10/0x10
kern  :info  : [ 5423.508681] [   T1658]  ? security_kernel_post_read_file+0x35/0xf0
kern  :info  : [ 5423.516645] [   T1658]  ? kernel_read_file+0x3d6/0x870
kern  :info  : [ 5423.522401] [   T1658]  ? __pfx_kernel_read_file+0x10/0x10
kern  :info  : [ 5423.529212] [   T1658]  ? init_module_from_file+0x157/0x1b0
kern  :info  : [ 5423.535536] [   T1658]  init_module_from_file+0x157/0x1b0
kern  :info  : [ 5423.544935] [   T1658]  ? __pfx_init_module_from_file+0x10/0x10
kern  :info  : [ 5423.552162] [   T1658]  ? fdget+0x54/0x3b0
kern  :info  : [ 5423.556754] [   T1658]  ? __pfx___x64_sys_openat+0x10/0x10
kern  :info  : [ 5423.566190] [   T1658]  ? _raw_spin_lock+0x80/0xf0
kern  :info  : [ 5423.574838] [   T1658]  ? __pfx__raw_spin_lock+0x10/0x10
kern  :info  : [ 5423.580774] [   T1658]  ? do_syscall_64+0x140/0x5b0
kern  :info  : [ 5423.586317] [   T1658]  idempotent_init_module+0x21c/0x770
kern  :info  : [ 5423.592478] [   T1658]  ? __pfx_idempotent_init_module+0x10/0x10
kern  :info  : [ 5423.599828] [   T1658]  ? fdget+0x54/0x3b0
kern  :info  : [ 5423.604386] [   T1658]  ? security_capable+0x35/0xf0
kern  :info  : [ 5423.613239] [   T1658]  __x64_sys_finit_module+0xca/0x170
kern  :info  : [ 5423.619267] [   T1658]  do_syscall_64+0x108/0x5b0
kern  :info  : [ 5423.624907] [   T1658]  ? do_syscall_64+0x140/0x5b0
kern  :info  : [ 5423.630418] [   T1658]  ? irqentry_exit+0x76/0x4f0
kern  :info  : [ 5423.635766] [   T1658]  entry_SYSCALL_64_after_hwframe+0x76/0x7e
kern  :info  : [ 5423.645649] [   T1658] RIP: 0033:0x7f3663edd7b9
kern  :info  : [ 5423.650732] [   T1658] RSP: 002b:00007fffe974f718 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
kern  :info  : [ 5423.660773] [   T1658] RAX: ffffffffffffffda RBX: 00005555acf52ac0 RCX: 00007f3663edd7b9
kern  :info  : [ 5423.670099] [   T1658] RDX: 0000000000000000 RSI: 00005555acf52c40 RDI: 0000000000000004
kern  :info  : [ 5423.679369] [   T1658] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
kern  :info  : [ 5423.692029] [   T1658] R10: 0000000000000000 R11: 0000000000000246 R12: 00005555acf52c40
kern  :info  : [ 5423.701338] [   T1658] R13: 0000000000040000 R14: 00005555acf52be0 R15: 0000000000000000
kern  :info  : [ 5423.710800] [   T1658]  </TASK>
kern  :info  : [ 5423.714370] [   T1658] Future hung task reports are suppressed, see sysctl kernel.hung_task_warnings


The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20261102/202611021447.f9ab47b7-lkp@intel.com


--
0-DAY CI Kernel Test Service
https://github.com/intel/lkp-tests/wiki