====================================== | # | not ok 1 selftests: drivers/net: ping.py # TIMEOUT 360 seconds | make: Leaving directory '/srv/vmksft/testing/wt-22/tools/testing/selftests' | xx__-> echo $? | 0 xx__-> [ 369.983552][ T44] INFO: task ip:977 blocked for more than 122 seconds. [ 369.984009][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 369.984227][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.984572][ T44] task:ip state:D stack:25592 pid:977 tgid:977 ppid:1 task_flags:0x400100 flags:0x00080003 [ 369.984950][ T44] Call Trace: [ 369.985103][ T44] [ 369.985250][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.985468][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.985671][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.985884][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.986068][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.986279][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.986423][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.986631][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.986799][ T44] ? napi_enable (net/core/dev.c:7616) [ 369.986997][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 369.987225][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.987394][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 369.987594][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 369.987762][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 369.987955][ T44] ? napi_enable (net/core/dev.c:7616) [ 369.988120][ T44] napi_enable (net/core/dev.c:7616) [ 369.988289][ T44] __virtnet_rx_resume (./include/linux/bottom_half.h:20 (discriminator 1) drivers/net/virtio_net.c:2894 (discriminator 1) drivers/net/virtio_net.c:2904 (discriminator 1) drivers/net/virtio_net.c:3481 (discriminator 1)) [ 369.988452][ T44] ? queue_delayed_work_on (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/workqueue.c:2565) [ 369.988655][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 369.988828][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 369.989026][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 369.989199][ T44] dev_xdp_install (net/core/dev.c:10312) [ 369.989389][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 369.989837][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 369.990012][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 369.990215][ T44] ? mutex_is_locked (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/locking/mutex.h:47 kernel/locking/mutex.c:67) [ 369.990382][ T44] ? rtnl_is_locked (net/core/rtnetlink.c:169 (discriminator 1)) [ 369.990576][ T44] ? dev_change_xdp_fd (net/core/dev.c:10703 (discriminator 2)) [ 369.990742][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 369.990934][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 369.991099][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 369.991326][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 369.991493][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 369.991690][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 369.991856][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 369.992047][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.992224][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.992412][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 369.992604][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 369.992770][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.992958][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.993123][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.993312][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 369.993477][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.993667][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 369.993836][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.994025][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 369.994202][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 369.994398][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 369.994597][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.994774][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.994965][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 369.995131][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.995329][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.995500][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.995696][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 369.995916][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 369.996082][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.996278][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.996444][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 369.996640][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 369.996808][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 369.997002][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 369.997176][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 369.997378][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 369.997571][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 369.997737][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.997931][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 369.998098][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 369.998293][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 369.998461][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 369.998663][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 369.998828][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 369.999042][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 369.999211][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 369.999398][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 369.999593][ T44] ___sys_sendmsg (net/socket.c:2686) [ 369.999758][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:127 kernel/rcu/tree.c:3125) [ 369.999982][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 370.000159][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 370.000350][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 370.000545][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 370.000708][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/rcu/tree.c:3148) [ 370.000925][ 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) [ 370.001091][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.001290][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.001457][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 370.001678][ T44] RIP: 0033:0x7f4d27ecec5e [ 370.001852][ T44] RSP: 002b:00007ffc557866d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.002106][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f4d27ecec5e [ 370.002355][ T44] RDX: 0000000000000000 RSI: 00007ffc55786790 RDI: 0000000000000003 [ 370.002612][ T44] RBP: 00007ffc557866e0 R08: 0000000000000000 R09: 0000000000000000 [ 370.002860][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc55786e50 [ 370.003106][ T44] R13: 00000000692f0ea5 R14: 0000000000000000 R15: 0000000000499600 | [ 370.016255][ T44] 1 lock held by ip/1041: | [ 370.016386][ T44] #0: ffffffffbc6925e8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 370.016669][ T44] | [ 370.016773][ T44] ============================================= | [ 370.016773][ T44] [ 492.863532][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds. [ 492.863964][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.864187][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.864487][ T44] task:kworker/u16:0 state:D stack:28040 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.864901][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 492.865149][ T44] Call Trace: [ 492.865302][ T44] [ 492.865442][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.865665][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.865851][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.866057][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.866275][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.866465][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.866666][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.866849][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.867041][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.867219][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.867416][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 492.867622][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.867788][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.867980][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.868143][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.868331][ T44] process_one_work (kernel/workqueue.c:3268) [ 492.868502][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 492.868697][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.868885][ T44] ? assign_work (kernel/workqueue.c:1206) [ 492.869062][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 492.869262][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.869428][ T44] kthread (kernel/kthread.c:463) [ 492.869597][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.869765][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.869956][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.870122][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.870325][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.870492][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.870691][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.870865][ T44] | [ 492.871047][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:977. [ 492.871330][ T44] INFO: task kworker/3:1:71 blocked for more than 122 seconds. [ 492.871569][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.871732][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.871992][ T44] task:kworker/3:1 state:D stack:28904 pid:71 tgid:71 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.872319][ T44] Workqueue: events xp_release_deferred [ 492.872487][ T44] Call Trace: [ 492.872649][ T44] [ 492.872757][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.872955][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.873123][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.873319][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.873501][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.873667][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.873856][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.874022][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.874224][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.874389][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.874586][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.874750][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 492.874942][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.875106][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.875300][ T44] process_one_work (kernel/workqueue.c:3268) [ 492.875474][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 492.875669][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.875837][ T44] ? assign_work (kernel/workqueue.c:1206) [ 492.876029][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 492.876203][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.876391][ T44] ? __kthread_parkme (./arch/x86/include/asm/bitops.h:202 (discriminator 1) ./arch/x86/include/asm/bitops.h:232 (discriminator 1) ./include/asm-generic/bitops/instrumented-non-atomic.h:142 (discriminator 1) kernel/kthread.c:290 (discriminator 1)) [ 492.876587][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.876772][ T44] kthread (kernel/kthread.c:463) [ 492.876933][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.877120][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.877292][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.877480][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.877672][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.877836][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.878025][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.878206][ T44] | [ 492.878367][ T44] INFO: task kworker/3:1:71 is blocked on a mutex likely owned by task ip:977. [ 492.878638][ T44] INFO: task ip:977 blocked for more than 245 seconds. [ 492.878820][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.879000][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.879265][ T44] task:ip state:D stack:25592 pid:977 tgid:977 ppid:1 task_flags:0x400100 flags:0x00080003 [ 492.879598][ T44] Call Trace: [ 492.879731][ T44] [ 492.879860][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.880027][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.880224][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.880392][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.880592][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.880758][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.880920][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.881082][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.881273][ T44] ? napi_enable (net/core/dev.c:7616) [ 492.881440][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 492.881666][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.881831][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 492.882026][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 492.882198][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 492.882389][ T44] ? napi_enable (net/core/dev.c:7616) [ 492.882583][ T44] napi_enable (net/core/dev.c:7616) [ 492.882721][ T44] __virtnet_rx_resume (./include/linux/bottom_half.h:20 (discriminator 1) drivers/net/virtio_net.c:2894 (discriminator 1) drivers/net/virtio_net.c:2904 (discriminator 1) drivers/net/virtio_net.c:3481 (discriminator 1)) [ 492.882908][ T44] ? queue_delayed_work_on (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/workqueue.c:2565) [ 492.883075][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 492.883273][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 492.883445][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 492.883638][ T44] dev_xdp_install (net/core/dev.c:10312) [ 492.883805][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 492.883997][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 492.884165][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 492.884360][ T44] ? mutex_is_locked (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/locking/mutex.h:47 kernel/locking/mutex.c:67) [ 492.884563][ T44] ? rtnl_is_locked (net/core/rtnetlink.c:169 (discriminator 1)) [ 492.884729][ T44] ? dev_change_xdp_fd (net/core/dev.c:10703 (discriminator 2)) [ 492.884921][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 492.885090][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 492.885288][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 492.885516][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.885679][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 492.885873][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 492.886037][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.886235][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.886406][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.886599][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 492.886764][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 492.886949][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.887111][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.887311][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.887478][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 492.887671][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.887836][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 492.888026][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.888195][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 492.888384][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 492.888587][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 492.888754][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.888946][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.889110][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.889306][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.889470][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.889664][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.889828][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 492.890024][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.890194][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.890387][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.890579][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.890744][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.890934][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.891099][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.891300][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 492.891471][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.891668][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.891835][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.892026][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.892197][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.892386][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.892584][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 492.892753][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 492.892946][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 492.893159][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 492.893328][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.893531][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 492.893698][ T44] ___sys_sendmsg (net/socket.c:2686) [ 492.893890][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:127 kernel/rcu/tree.c:3125) [ 492.894111][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 492.894290][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 492.894475][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 492.894662][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 492.894824][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/rcu/tree.c:3148) [ 492.895040][ 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) [ 492.895210][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.895404][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.895598][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 492.895814][ T44] RIP: 0033:0x7f4d27ecec5e [ 492.895984][ T44] RSP: 002b:00007ffc557866d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.896237][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f4d27ecec5e [ 492.896477][ T44] RDX: 0000000000000000 RSI: 00007ffc55786790 RDI: 0000000000000003 [ 492.896726][ T44] RBP: 00007ffc557866e0 R08: 0000000000000000 R09: 0000000000000000 [ 492.896970][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc55786e50 [ 492.897219][ T44] R13: 00000000692f0ea5 R14: 0000000000000000 R15: 0000000000499600 | [ 492.904959][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.905124][ T44] ret_from_fork (arch/x86/kernel/process.c:164) | [ 492.905315][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.905480][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.905685][ T44] [ 492.905828][ T44] INFO: task ip:1041 blocked for more than 122 seconds. [ 492.906033][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.906196][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.906520][ T44] task:ip state:D stack:25744 pid:1041 tgid:1041 ppid:1040 task_flags:0x400100 flags:0x00080001 [ 492.906898][ T44] Call Trace: [ 492.907028][ T44] [ 492.907160][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.907336][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.907537][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.907781][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.907943][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.908130][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.908277][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.908527][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.908708][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.908872][ T44] ? write_profile (kernel/stacktrace.c:83) [ 492.909064][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.909239][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.909484][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.909688][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.909851][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.910091][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.910283][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.910451][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.910645][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.910810][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.911056][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.911235][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.911430][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 492.911685][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.911852][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.912041][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.912213][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.912451][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.912647][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.912812][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 492.913002][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 492.913164][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 492.913439][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 492.913632][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 492.913848][ T44] ___sys_sendmsg (net/socket.c:2686) [ 492.914090][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 492.914265][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 492.914472][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.914658][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.914906][ T44] ? _copy_to_user (./arch/x86/include/asm/smap.h:35 ./arch/x86/include/asm/uaccess_64.h:121 ./arch/x86/include/asm/uaccess_64.h:147 ./include/linux/uaccess.h:197 lib/usercopy.c:26) [ 492.915072][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 492.915266][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 492.915433][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.915692][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.915859][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 492.916072][ T44] RIP: 0033:0x7f0812501c5e [ 492.916246][ T44] RSP: 002b:00007fffde73daa0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.916555][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f0812501c5e [ 492.916796][ T44] RDX: 0000000000000000 RSI: 00007fffde73db60 RDI: 0000000000000004 [ 492.917101][ T44] RBP: 00007fffde73dab0 R08: 0000000000000000 R09: 0000000000000000 [ 492.917344][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffde73f6bd [ 492.917589][ T44] R13: 00000000692f0f75 R14: 000000000000000d R15: 00007fffde73dc10 | [ 492.923289][ T44] 1 lock held by ip/1041: | [ 492.923418][ T44] #0: ffffffffbc6925e8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 492.923747][ T44] | [ 492.923850][ T44] ============================================= | [ 492.923850][ T44] [ 615.743532][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 615.743958][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 615.744180][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 615.744481][ T44] task:kworker/u16:0 state:D stack:28040 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 615.744900][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 615.745150][ T44] Call Trace: [ 615.745308][ T44] [ 615.745456][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 615.745684][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 615.745897][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.746071][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.746278][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.746448][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 615.746620][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 615.746787][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 615.746982][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 615.747150][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.747352][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 615.747556][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 615.747721][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 615.747916][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 615.748078][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 615.748273][ T44] process_one_work (kernel/workqueue.c:3268) [ 615.748443][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 615.748637][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.748809][ T44] ? assign_work (kernel/workqueue.c:1206) [ 615.749001][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 615.749178][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 615.749364][ T44] kthread (kernel/kthread.c:463) [ 615.749502][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 615.749693][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.749879][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.750044][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 615.750247][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 615.750413][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 615.750607][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 615.750779][ T44] | [ 615.750960][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:977. [ 615.751247][ T44] INFO: task kworker/3:1:71 blocked for more than 245 seconds. [ 615.751480][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 615.751661][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 615.751915][ T44] task:kworker/3:1 state:D stack:28904 pid:71 tgid:71 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 615.752251][ T44] Workqueue: events xp_release_deferred [ 615.752416][ T44] Call Trace: [ 615.752577][ T44] [ 615.752685][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 615.752885][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 615.753053][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.753252][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.753420][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 615.753586][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 615.753750][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 615.753938][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 615.754112][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.754310][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.754478][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.754671][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 615.754841][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 615.755029][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 615.755204][ T44] process_one_work (kernel/workqueue.c:3268) [ 615.755404][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 615.755595][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.755762][ T44] ? assign_work (kernel/workqueue.c:1206) [ 615.755953][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 615.756121][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 615.756313][ T44] ? __kthread_parkme (./arch/x86/include/asm/bitops.h:202 (discriminator 1) ./arch/x86/include/asm/bitops.h:232 (discriminator 1) ./include/asm-generic/bitops/instrumented-non-atomic.h:142 (discriminator 1) kernel/kthread.c:290 (discriminator 1)) [ 615.756479][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 615.756692][ T44] kthread (kernel/kthread.c:463) [ 615.756828][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 615.757019][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.757193][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.757381][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 615.757572][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 615.757736][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 615.757923][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 615.758098][ T44] | [ 615.758269][ T44] INFO: task kworker/3:1:71 is blocked on a mutex likely owned by task ip:977. [ 615.758548][ T44] INFO: task ip:977 blocked for more than 368 seconds. [ 615.758730][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 615.758909][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 615.759169][ T44] task:ip state:D stack:25592 pid:977 tgid:977 ppid:1 task_flags:0x400100 flags:0x00080003 [ 615.759499][ T44] Call Trace: [ 615.759644][ T44] [ 615.759776][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 615.759943][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 615.760134][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.760306][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.760498][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.760676][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 615.760839][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 615.761002][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 615.761200][ T44] ? napi_enable (net/core/dev.c:7616) [ 615.761371][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 615.761598][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.761769][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 615.761961][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 615.762128][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 615.762326][ T44] ? napi_enable (net/core/dev.c:7616) [ 615.762492][ T44] napi_enable (net/core/dev.c:7616) [ 615.762660][ T44] __virtnet_rx_resume (./include/linux/bottom_half.h:20 (discriminator 1) drivers/net/virtio_net.c:2894 (discriminator 1) drivers/net/virtio_net.c:2904 (discriminator 1) drivers/net/virtio_net.c:3481 (discriminator 1)) [ 615.762824][ T44] ? queue_delayed_work_on (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/workqueue.c:2565) [ 615.763014][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 615.763193][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 615.763385][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 615.763573][ T44] dev_xdp_install (net/core/dev.c:10312) [ 615.763741][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 615.763936][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 615.764104][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 615.764302][ T44] ? mutex_is_locked (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/locking/mutex.h:47 kernel/locking/mutex.c:67) [ 615.764477][ T44] ? rtnl_is_locked (net/core/rtnetlink.c:169 (discriminator 1)) [ 615.764672][ T44] ? dev_change_xdp_fd (net/core/dev.c:10703 (discriminator 2)) [ 615.764840][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 615.765036][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 615.765204][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 615.765425][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 615.765617][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 615.765790][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 615.765980][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 615.766146][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.766345][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 615.766536][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 615.766701][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 615.766885][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 615.767053][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.767250][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.767417][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 615.767610][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 615.767778][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 615.767974][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.768140][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 615.768335][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 615.768534][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 615.768704][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 615.768899][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.769064][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.769256][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 615.769423][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.769619][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 615.769786][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 615.769986][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 615.770147][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.770347][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.770538][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.770708][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 615.770902][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 615.771069][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 615.771276][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 615.771452][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 615.771647][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 615.771813][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.772006][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 615.772178][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 615.772367][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 615.772564][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 615.772736][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 615.772925][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 615.773140][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 615.773313][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 615.773514][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 615.773681][ T44] ___sys_sendmsg (net/socket.c:2686) [ 615.773869][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:127 kernel/rcu/tree.c:3125) [ 615.774087][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 615.774273][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 615.774464][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 615.774655][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 615.774819][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/rcu/tree.c:3148) [ 615.775037][ 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) [ 615.775204][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.775399][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 615.775594][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 615.775809][ T44] RIP: 0033:0x7f4d27ecec5e [ 615.775982][ T44] RSP: 002b:00007ffc557866d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 615.776239][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f4d27ecec5e [ 615.776481][ T44] RDX: 0000000000000000 RSI: 00007ffc55786790 RDI: 0000000000000003 [ 615.776734][ T44] RBP: 00007ffc557866e0 R08: 0000000000000000 R09: 0000000000000000 [ 615.776975][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc55786e50 [ 615.777223][ T44] R13: 00000000692f0ea5 R14: 0000000000000000 R15: 0000000000499600 | [ 615.784899][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 615.785086][ T44] ret_from_fork (arch/x86/kernel/process.c:164) | [ 615.785258][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 615.785495][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 615.785695][ T44] [ 615.785838][ T44] INFO: task ip:1041 blocked for more than 245 seconds. [ 615.786046][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 615.786204][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 615.786531][ T44] task:ip state:D stack:25744 pid:1041 tgid:1041 ppid:1040 task_flags:0x400100 flags:0x00080001 [ 615.786912][ T44] Call Trace: [ 615.787045][ T44] [ 615.787185][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 615.787355][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 615.787561][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.787805][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.787970][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.788171][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 615.788309][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 615.788560][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 615.788743][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 615.788908][ T44] ? write_profile (kernel/stacktrace.c:83) [ 615.789100][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.789277][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.789537][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.789705][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 615.789898][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 615.790062][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 615.790313][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.790477][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.790666][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.790830][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 615.791075][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 615.791251][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 615.791441][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 615.791688][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 615.791853][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 615.792042][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.792209][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 615.792447][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 615.792642][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 615.792806][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 615.792990][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 615.793152][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 615.793428][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 615.793627][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 615.793840][ T44] ___sys_sendmsg (net/socket.c:2686) [ 615.794081][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 615.794252][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 615.794445][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.794635][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 615.794883][ T44] ? _copy_to_user (./arch/x86/include/asm/smap.h:35 ./arch/x86/include/asm/uaccess_64.h:121 ./arch/x86/include/asm/uaccess_64.h:147 ./include/linux/uaccess.h:197 lib/usercopy.c:26) [ 615.795051][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 615.795246][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 615.795413][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.795611][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 615.795777][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 615.795989][ T44] RIP: 0033:0x7f0812501c5e [ 615.796158][ T44] RSP: 002b:00007fffde73daa0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 615.796465][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f0812501c5e [ 615.796708][ T44] RDX: 0000000000000000 RSI: 00007fffde73db60 RDI: 0000000000000004 [ 615.797008][ T44] RBP: 00007fffde73dab0 R08: 0000000000000000 R09: 0000000000000000 [ 615.797256][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffde73f6bd Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:napi_enable ret_from_fork:ret_from_fork_asm:__schedule:schedule:schedule_preempt_disabled __schedule:schedule:schedule_preempt_disabled:__mutex_lock:addrconf_verify_work __schedule:schedule:schedule_preempt_disabled:__mutex_lock:xp_release_deferred