====================================== | make[1]: Leaving directory '/home/virtme/testing/wt-3/tools/testing/selftests/net' | make: Leaving directory '/home/virtme/testing/wt-3/tools/testing/selftests' | xx__-> echo $? | 0 | xx__-> [ 4546.850318][ T2342] sctp: Hash tables configured (bind 32/56) [ 4671.073782][ T44] INFO: task modprobe:2342 blocked for more than 122 seconds. [ 4671.074376][ T44] Not tainted 6.17.0-rc7-virtme #1 [ 4671.074625][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 4671.075013][ T44] task:modprobe state:D stack:25680 pid:2342 tgid:2342 ppid:11109 task_flags:0x400100 flags:0x00004002 [ 4671.075567][ T44] Call Trace: [ 4671.075743][ T44] [ 4671.075865][ T44] __schedule (kernel/sched/core.c:5357 kernel/sched/core.c:6961) [ 4671.076132][ T44] ? io_schedule_timeout (kernel/sched/core.c:6817) [ 4671.076370][ T44] ? schedule (kernel/sched/core.c:7024 kernel/sched/core.c:7057) [ 4671.076584][ T44] ? __lock_release (kernel/locking/lockdep.c:5536) [ 4671.076828][ T44] schedule (kernel/sched/core.c:7044 kernel/sched/core.c:7058) [ 4671.076997][ T44] schedule_preempt_disabled (kernel/sched/core.c:7116) [ 4671.077230][ T44] rwsem_down_write_slowpath (kernel/locking/rwsem.c:1187) [ 4671.077472][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237) [ 4671.077694][ T44] ? down_read (kernel/locking/rwsem.c:1112) [ 4671.077927][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751) [ 4671.078154][ T44] ? lock_acquire (./include/trace/events/lock.h:24 kernel/locking/lockdep.c:5831) [ 4671.078374][ T44] ? register_pernet_subsys (net/core/net_namespace.c:1432) [ 4671.078632][ T44] down_write (./include/linux/err.h:70 kernel/locking/rwsem.c:1317 kernel/locking/rwsem.c:1326 kernel/locking/rwsem.c:1591) [ 4671.078814][ T44] ? rwsem_down_write_slowpath (kernel/locking/rwsem.c:1588) [ 4671.079086][ T44] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 4671.079306][ T44] ? _raw_spin_unlock (./arch/x86/include/asm/preempt.h:104 ./include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186) [ 4671.079539][ T44] ? __register_sysctl_table (fs/proc/proc_sysctl.c:1413) [ 4671.079773][ T44] register_pernet_subsys (net/core/net_namespace.c:1432) [ 4671.079997][ T44] sctp_init (net/sctp/sm_statefuns.c:11 (discriminator 6)) sctp [ 4671.080293][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350) [ 4671.080559][ T44] ? can_changelink.cold (drivers/net/can/dev/skb.c:312 drivers/net/can/dev/skb.c:364) can_dev [ 4671.080842][ T44] do_one_initcall (init/main.c:1270) [ 4671.081473][ T44] ? trace_initcall_level (init/main.c:1260) [ 4671.081699][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751) [ 4671.081921][ T44] ? trace_kmalloc (./include/trace/events/kmem.h:54 (discriminator 21)) [ 4671.082148][ T44] ? __kmalloc_cache_noprof (mm/slub.c:4409) [ 4671.082366][ T44] ? debug_objects_oom (lib/debugobjects.c:1070) [ 4671.082614][ T44] ? kasan_unpoison (mm/kasan/shadow.c:156 mm/kasan/shadow.c:182) [ 4671.082849][ T44] ? __asan_register_globals (mm/kasan/generic.c:231 (discriminator 3)) [ 4671.083072][ T44] do_init_module (kernel/module/main.c:3039) [ 4671.083307][ T44] ? free_module (kernel/module/main.c:3011) [ 4671.083541][ T44] ? kfree (mm/slub.c:4695 mm/slub.c:4894) [ 4671.083710][ T44] ? find_vm_area (mm/vmalloc.c:3258) [ 4671.083949][ T44] load_module (kernel/module/main.c:3509) [ 4671.084182][ T44] ? layout_and_allocate.constprop.0 (kernel/module/main.c:3353) [ 4671.084494][ T44] ? kernel_read_file (fs/kernel_read_file.c:80 (discriminator 2)) [ 4671.084726][ T44] ? kernel_read_file (./arch/x86/include/asm/atomic.h:53 ./include/linux/atomic/atomic-arch-fallback.h:992 ./include/linux/atomic/atomic-instrumented.h:436 ./include/linux/fs.h:3204 fs/kernel_read_file.c:122) [ 4671.084964][ T44] ? __ia32_sys_fsconfig (fs/kernel_read_file.c:38) [ 4671.085193][ T44] ? init_module_from_file (kernel/module/main.c:3701) [ 4671.085424][ T44] init_module_from_file (kernel/module/main.c:3701) [ 4671.085649][ T44] ? __do_sys_init_module (kernel/module/main.c:3677) [ 4671.085885][ T44] ? idempotent_init_module (kernel/module/main.c:3713) [ 4671.086113][ T44] ? __lock_release (kernel/locking/lockdep.c:5536) [ 4671.086338][ T44] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 4671.086572][ T44] idempotent_init_module (kernel/module/main.c:3713) [ 4671.086798][ T44] ? init_module_from_file (kernel/module/main.c:3705) [ 4671.087031][ T44] ? cap_capable (security/commoncap.c:132) [ 4671.087263][ T44] __x64_sys_finit_module (./include/linux/file.h:62 ./include/linux/file.h:83 kernel/module/main.c:3736 kernel/module/main.c:3723 kernel/module/main.c:3723) [ 4671.087491][ T44] ? do_syscall_64 (./arch/x86/include/asm/irqflags.h:42 ./arch/x86/include/asm/irqflags.h:119 ./include/linux/entry-common.h:124 arch/x86/entry/syscall_64.c:90) [ 4671.087735][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 arch/x86/entry/syscall_64.c:94) [ 4671.087956][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 4671.088233][ T44] RIP: 0033:0x7feb68cc692d [ 4671.088491][ T44] RSP: 002b:00007ffcf316e318 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 4671.088839][ T44] RAX: ffffffffffffffda RBX: 000055c204415d40 RCX: 00007feb68cc692d [ 4671.089180][ T44] RDX: 0000000000000000 RSI: 000055c1fdbb9a2a RDI: 0000000000000000 [ 4671.089533][ T44] RBP: 0000000000040000 R08: 0000000000000000 R09: 00007ffcf316e450 [ 4671.089868][ T44] R10: 0000000000000000 R11: 0000000000000246 R12: 000055c1fdbb9a2a [ 4671.090199][ T44] R13: 000055c204415ce0 R14: 000055c204416060 R15: 000055c204415dad | [ 4671.099825][ T44] 1 lock held by modprobe/2342: | [ 4671.100035][ T44] #0: ffffffff98e70430 (pernet_ops_rwsem){++++}-{4:4}, at: register_pernet_subsys (net/core/net_namespace.c:1432) | [ 4671.100488][ T44] | [ 4671.100600][ T44] ============================================= | [ 4671.100600][ T44] [ 4793.953641][ T44] INFO: task modprobe:2342 blocked for more than 245 seconds. [ 4793.954186][ T44] Not tainted 6.17.0-rc7-virtme #1 [ 4793.954392][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 4793.954781][ T44] task:modprobe state:D stack:25680 pid:2342 tgid:2342 ppid:11109 task_flags:0x400100 flags:0x00004002 [ 4793.955268][ T44] Call Trace: [ 4793.955448][ T44] [ 4793.955565][ T44] __schedule (kernel/sched/core.c:5357 kernel/sched/core.c:6961) [ 4793.955810][ T44] ? io_schedule_timeout (kernel/sched/core.c:6817) [ 4793.956046][ T44] ? schedule (kernel/sched/core.c:7024 kernel/sched/core.c:7057) [ 4793.956211][ T44] ? __lock_release (kernel/locking/lockdep.c:5536) [ 4793.956538][ T44] schedule (kernel/sched/core.c:7044 kernel/sched/core.c:7058) [ 4793.956708][ T44] schedule_preempt_disabled (kernel/sched/core.c:7116) [ 4793.956927][ T44] rwsem_down_write_slowpath (kernel/locking/rwsem.c:1187) [ 4793.957147][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237) [ 4793.957373][ T44] ? down_read (kernel/locking/rwsem.c:1112) [ 4793.957629][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751) [ 4793.957851][ T44] ? lock_acquire (./include/trace/events/lock.h:24 kernel/locking/lockdep.c:5831) [ 4793.958067][ T44] ? register_pernet_subsys (net/core/net_namespace.c:1432) [ 4793.958296][ T44] down_write (./include/linux/err.h:70 kernel/locking/rwsem.c:1317 kernel/locking/rwsem.c:1326 kernel/locking/rwsem.c:1591) [ 4793.958474][ T44] ? rwsem_down_write_slowpath (kernel/locking/rwsem.c:1588) [ 4793.958744][ T44] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 4793.958968][ T44] ? _raw_spin_unlock (./arch/x86/include/asm/preempt.h:104 ./include/linux/spinlock_api_smp.h:143 kernel/locking/spinlock.c:186) [ 4793.959193][ T44] ? __register_sysctl_table (fs/proc/proc_sysctl.c:1413) [ 4793.959426][ T44] register_pernet_subsys (net/core/net_namespace.c:1432) [ 4793.959648][ T44] sctp_init (net/sctp/sm_statefuns.c:11 (discriminator 6)) sctp [ 4793.959897][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350) [ 4793.960119][ T44] ? can_changelink.cold (drivers/net/can/dev/skb.c:312 drivers/net/can/dev/skb.c:364) can_dev [ 4793.960395][ T44] do_one_initcall (init/main.c:1270) [ 4793.960630][ T44] ? trace_initcall_level (init/main.c:1260) [ 4793.960858][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 kernel/rcu/tree.c:751) [ 4793.961078][ T44] ? trace_kmalloc (./include/trace/events/kmem.h:54 (discriminator 21)) [ 4793.961295][ T44] ? __kmalloc_cache_noprof (mm/slub.c:4409) [ 4793.961523][ T44] ? debug_objects_oom (lib/debugobjects.c:1070) [ 4793.961744][ T44] ? kasan_unpoison (mm/kasan/shadow.c:156 mm/kasan/shadow.c:182) [ 4793.961968][ T44] ? __asan_register_globals (mm/kasan/generic.c:231 (discriminator 3)) [ 4793.962189][ T44] do_init_module (kernel/module/main.c:3039) [ 4793.962430][ T44] ? free_module (kernel/module/main.c:3011) [ 4793.962650][ T44] ? kfree (mm/slub.c:4695 mm/slub.c:4894) [ 4793.962814][ T44] ? find_vm_area (mm/vmalloc.c:3258) [ 4793.963039][ T44] load_module (kernel/module/main.c:3509) [ 4793.963268][ T44] ? layout_and_allocate.constprop.0 (kernel/module/main.c:3353) [ 4793.963554][ T44] ? kernel_read_file (fs/kernel_read_file.c:80 (discriminator 2)) [ 4793.963779][ T44] ? kernel_read_file (./arch/x86/include/asm/atomic.h:53 ./include/linux/atomic/atomic-arch-fallback.h:992 ./include/linux/atomic/atomic-instrumented.h:436 ./include/linux/fs.h:3204 fs/kernel_read_file.c:122) [ 4793.964001][ T44] ? __ia32_sys_fsconfig (fs/kernel_read_file.c:38) [ 4793.964244][ T44] ? init_module_from_file (kernel/module/main.c:3701) [ 4793.964472][ T44] init_module_from_file (kernel/module/main.c:3701) [ 4793.964693][ T44] ? __do_sys_init_module (kernel/module/main.c:3677) [ 4793.964929][ T44] ? idempotent_init_module (kernel/module/main.c:3713) [ 4793.965147][ T44] ? __lock_release (kernel/locking/lockdep.c:5536) [ 4793.965366][ T44] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 4793.965595][ T44] idempotent_init_module (kernel/module/main.c:3713) [ 4793.965823][ T44] ? init_module_from_file (kernel/module/main.c:3705) [ 4793.966054][ T44] ? cap_capable (security/commoncap.c:132) [ 4793.966277][ T44] __x64_sys_finit_module (./include/linux/file.h:62 ./include/linux/file.h:83 kernel/module/main.c:3736 kernel/module/main.c:3723 kernel/module/main.c:3723) [ 4793.966509][ T44] ? do_syscall_64 (./arch/x86/include/asm/irqflags.h:42 ./arch/x86/include/asm/irqflags.h:119 ./include/linux/entry-common.h:124 arch/x86/entry/syscall_64.c:90) [ 4793.966730][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 arch/x86/entry/syscall_64.c:94) [ 4793.966947][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 4793.967216][ T44] RIP: 0033:0x7feb68cc692d [ 4793.967457][ T44] RSP: 002b:00007ffcf316e318 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 4793.967791][ T44] RAX: ffffffffffffffda RBX: 000055c204415d40 RCX: 00007feb68cc692d [ 4793.968119][ T44] RDX: 0000000000000000 RSI: 000055c1fdbb9a2a RDI: 0000000000000000 [ 4793.968455][ T44] RBP: 0000000000040000 R08: 0000000000000000 R09: 00007ffcf316e450 [ 4793.968789][ T44] R10: 0000000000000000 R11: 0000000000000246 R12: 000055c1fdbb9a2a Finger prints: __schedule:schedule:schedule_preempt_disabled:rwsem_down_write_slowpath:down_write