====================================== | not ok 1 selftests: drivers/net: xdp.py # TIMEOUT 360 seconds | /srv/vmksft/testing/wt-22/tools/testing/selftests/kselftest/runner.sh: line 50: : No such file or directory | make: Leaving directory '/srv/vmksft/testing/wt-22/tools/testing/selftests' | xx__-> echo $? | 0 xx__-> [ 247.103644][ T44] INFO: task ip:256 blocked for more than 122 seconds. [ 247.103999][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 247.104146][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 247.104427][ T44] task:ip state:D stack:25520 pid:256 tgid:256 ppid:1 task_flags:0x400100 flags:0x00080002 [ 247.104809][ T44] Call Trace: [ 247.104923][ T44] [ 247.105006][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 247.105166][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 247.105296][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.105417][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.105542][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 247.105639][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 247.105760][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 247.105883][ T44] ? napi_enable (net/core/dev.c:7618) [ 247.106007][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 247.106129][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.106245][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 247.106373][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 247.106495][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 247.106621][ T44] ? napi_enable (net/core/dev.c:7618) [ 247.106736][ T44] napi_enable (net/core/dev.c:7618) [ 247.106824][ 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)) [ 247.106940][ 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:2559) [ 247.107062][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 247.107182][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 247.107306][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 247.107421][ T44] dev_xdp_install (net/core/dev.c:10314) [ 247.107536][ T44] ? netif_set_xps_queue (net/core/dev.c:10282) [ 247.107663][ T44] dev_xdp_attach (net/core/dev.c:10470) [ 247.107779][ T44] ? bpf_xdp_link_update (net/core/dev.c:10360) [ 247.108111][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2622) [ 247.108235][ T44] dev_change_xdp_fd (net/core/dev.c:10724) [ 247.108356][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 247.108479][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 247.108604][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4028 (discriminator 2) kernel/rcu/tree.c:4020 (discriminator 2)) [ 247.108752][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 247.108867][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 247.108983][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 247.109097][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 247.109215][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.109336][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.109453][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 247.109566][ T44] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 247.109692][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.109811][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.109925][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 247.110043][ T44] ? __mutex_lock (kernel/locking/mutex.c:624 (discriminator 3) kernel/locking/mutex.c:776 (discriminator 3)) [ 247.110159][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 247.110281][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 247.110399][ T44] ? nla_get_range_signed (lib/nlattr.c:396) [ 247.110518][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 247.110639][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 247.110755][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.110870][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 247.110987][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.111107][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.111226][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 247.111342][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 247.111458][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.111580][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 247.111697][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 247.111820][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 247.111936][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.112058][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.112173][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 247.112293][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 247.112409][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 247.112524][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 247.112646][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) ./include/net/netns/generic.h:48 (discriminator 1) net/netlink/af_netlink.c:333 (discriminator 1)) [ 247.112762][ 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)) [ 247.112879][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 247.112999][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 247.113113][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.113232][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.113351][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 247.113467][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 247.113584][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2592 (discriminator 4)) [ 247.113709][ T44] ? copy_msghdr_from_user (net/socket.c:2532) [ 247.113825][ T44] ? get_timestamp.constprop.0 (net/socket.c:2538) [ 247.113970][ T44] ? move_addr_to_kernel (net/socket.c:2518) [ 247.114087][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 247.114201][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 247.114352][ T44] ___sys_sendmsg (net/socket.c:2648) [ 247.114465][ 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:3121) [ 247.114613][ T44] ? copy_msghdr_from_user (net/socket.c:2635) [ 247.114739][ T44] __sys_sendmsg (net/socket.c:2678 (discriminator 1)) [ 247.114854][ T44] ? __sys_sendmsg_sock (net/socket.c:2663) [ 247.114968][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 247.115082][ 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:3144) [ 247.115234][ 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) [ 247.115352][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.115465][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 247.115581][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:131) [ 247.115739][ T44] RIP: 0033:0x7f7aa0550c5e [ 247.115862][ T44] RSP: 002b:00007ffcd19c8e80 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 247.116042][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7aa0550c5e [ 247.116216][ T44] RDX: 0000000000000000 RSI: 00007ffcd19c8f40 RDI: 0000000000000003 [ 247.116391][ T44] RBP: 00007ffcd19c8e90 R08: 0000000000000000 R09: 0000000000000000 [ 247.116564][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffcd19c9600 [ 247.116739][ T44] R13: 000000006950e4ac R14: 0000000000000000 R15: 0000000000499600 | [ 247.125284][ T44] 1 lock held by ip/321: | [ 247.125372][ T44] #0: ffffffffa3485768 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 247.125566][ T44] | [ 247.125637][ T44] ============================================= | [ 247.125637][ T44] [ 369.983618][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds. [ 369.983920][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 369.984078][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.984367][ T44] task:kworker/u16:0 state:D stack:27952 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 369.984682][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 369.984845][ T44] Call Trace: [ 369.984942][ T44] [ 369.985009][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 369.985142][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 369.985273][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.985402][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.985520][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 369.985618][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 369.985735][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 369.985855][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.985975][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 369.986097][ T44] ? process_one_work (kernel/workqueue.c:3233 (discriminator 1)) [ 369.986217][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.986338][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.986464][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.986577][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.986695][ T44] process_one_work (kernel/workqueue.c:3262) [ 369.986814][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3159) [ 369.986929][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.987045][ T44] ? assign_work (kernel/workqueue.c:1200) [ 369.987162][ T44] worker_thread (kernel/workqueue.c:3334 (discriminator 2) kernel/workqueue.c:3421 (discriminator 2)) [ 369.987281][ T44] ? process_one_work (kernel/workqueue.c:3367) [ 369.987399][ T44] kthread (kernel/kthread.c:463) [ 369.987485][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.987605][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.987721][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.987839][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.987953][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 369.988067][ T44] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 369.988214][ T44] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 369.988328][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.988447][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:256) | [ 369.988568][ T44] | [ 369.988675][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:256. [ 369.988870][ T44] INFO: task kworker/3:1:72 blocked for more than 122 seconds. [ 369.989031][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 369.989137][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.989321][ T44] task:kworker/3:1 state:D stack:28064 pid:72 tgid:72 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 369.989572][ T44] Workqueue: events xp_release_deferred [ 369.989692][ T44] Call Trace: [ 369.989777][ T44] [ 369.989838][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 369.989958][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 369.990073][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.990189][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 369.990276][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 369.990392][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 369.990507][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.990629][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 369.990747][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.990864][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.990976][ T44] ? process_one_work (kernel/workqueue.c:3233 (discriminator 1)) [ 369.991097][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.991212][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.991327][ T44] process_one_work (kernel/workqueue.c:3262) [ 369.991453][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3159) [ 369.991568][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.991690][ T44] ? assign_work (kernel/workqueue.c:1200) [ 369.991806][ T44] worker_thread (kernel/workqueue.c:3334 (discriminator 2) kernel/workqueue.c:3421 (discriminator 2)) [ 369.991926][ T44] ? process_one_work (kernel/workqueue.c:3367) [ 369.992039][ T44] kthread (kernel/kthread.c:463) [ 369.992126][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.992240][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.992361][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.992479][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.992595][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 369.992717][ T44] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 369.992859][ T44] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 369.992972][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.993086][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:256) | [ 369.993210][ T44] | [ 369.993302][ T44] INFO: task kworker/3:1:72 is blocked on a mutex likely owned by task ip:256. [ 369.993494][ T44] INFO: task ip:256 blocked for more than 245 seconds. [ 369.993636][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 369.993744][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.993927][ T44] task:ip state:D stack:25520 pid:256 tgid:256 ppid:1 task_flags:0x400100 flags:0x00080002 [ 369.994172][ T44] Call Trace: [ 369.994256][ T44] [ 369.994316][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 369.994433][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 369.994549][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.994665][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.994784][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 369.994870][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 369.994984][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 369.995101][ T44] ? napi_enable (net/core/dev.c:7618) [ 369.995219][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 369.995334][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.995452][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 369.995568][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 369.995690][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 369.995807][ T44] ? napi_enable (net/core/dev.c:7618) [ 369.995921][ T44] napi_enable (net/core/dev.c:7618) [ 369.996008][ 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.996122][ 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:2559) [ 369.996236][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 369.996352][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 369.996473][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 369.996585][ T44] dev_xdp_install (net/core/dev.c:10314) [ 369.996706][ T44] ? netif_set_xps_queue (net/core/dev.c:10282) [ 369.996824][ T44] dev_xdp_attach (net/core/dev.c:10470) [ 369.996943][ T44] ? bpf_xdp_link_update (net/core/dev.c:10360) [ 369.997057][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2622) [ 369.997172][ T44] dev_change_xdp_fd (net/core/dev.c:10724) [ 369.997288][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 369.997407][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 369.997520][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4028 (discriminator 2) kernel/rcu/tree.c:4020 (discriminator 2)) [ 369.997670][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 369.997783][ 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.997898][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 369.998010][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 369.998126][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.998240][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.998356][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.998469][ T44] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 369.998580][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.998695][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.998808][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 369.998926][ T44] ? __mutex_lock (kernel/locking/mutex.c:624 (discriminator 3) kernel/locking/mutex.c:776 (discriminator 3)) [ 369.999041][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.999157][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 369.999270][ T44] ? nla_get_range_signed (lib/nlattr.c:396) [ 369.999396][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 369.999513][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 369.999634][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.999748][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 369.999863][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.999977][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.000088][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.000204][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 370.000317][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.000432][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 370.000545][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 370.000664][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 370.000781][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.000897][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.001011][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.001126][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 370.001239][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 370.001354][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 370.001475][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) ./include/net/netns/generic.h:48 (discriminator 1) net/netlink/af_netlink.c:333 (discriminator 1)) [ 370.001591][ 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)) [ 370.001716][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 370.001833][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 370.001947][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.002060][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.002175][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 370.002294][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 370.002413][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2592 (discriminator 4)) [ 370.002530][ T44] ? copy_msghdr_from_user (net/socket.c:2532) [ 370.002649][ T44] ? get_timestamp.constprop.0 (net/socket.c:2538) [ 370.002789][ T44] ? move_addr_to_kernel (net/socket.c:2518) [ 370.002903][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 370.003017][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 370.003133][ T44] ___sys_sendmsg (net/socket.c:2648) [ 370.003250][ 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:3121) [ 370.003396][ T44] ? copy_msghdr_from_user (net/socket.c:2635) [ 370.003526][ T44] __sys_sendmsg (net/socket.c:2678 (discriminator 1)) [ 370.003642][ T44] ? __sys_sendmsg_sock (net/socket.c:2663) [ 370.003756][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 370.003867][ 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:3144) [ 370.004012][ 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.004127][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.004241][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.004359][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:131) [ 370.004498][ T44] RIP: 0033:0x7f7aa0550c5e [ 370.004624][ T44] RSP: 002b:00007ffcd19c8e80 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.004803][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7aa0550c5e [ 370.004980][ T44] RDX: 0000000000000000 RSI: 00007ffcd19c8f40 RDI: 0000000000000003 [ 370.005153][ T44] RBP: 00007ffcd19c8e90 R08: 0000000000000000 R09: 0000000000000000 [ 370.005324][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffcd19c9600 [ 370.005498][ T44] R13: 000000006950e4ac R14: 0000000000000000 R15: 0000000000499600 | [ 370.010664][ T44] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) | [ 370.010808][ T44] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) | [ 370.010921][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 370.011092][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:256) | [ 370.011215][ T44] [ 370.011308][ T44] INFO: task ip:321 blocked for more than 122 seconds. [ 370.011447][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 370.011607][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 370.011793][ T44] task:ip state:D stack:25624 pid:321 tgid:321 ppid:320 task_flags:0x400100 flags:0x00080000 [ 370.012094][ T44] Call Trace: [ 370.012182][ T44] [ 370.012242][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 370.012360][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 370.012476][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.012651][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.012769][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 370.012856][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 370.012973][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 370.013085][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.013199][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.013312][ T44] ? write_profile (kernel/stacktrace.c:83) [ 370.013435][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 370.013618][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.013739][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.013855][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.013971][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.014143][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 370.014256][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.014377][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.014490][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.014667][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 370.014783][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 370.014900][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 370.015018][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) ./include/net/netns/generic.h:48 (discriminator 1) net/netlink/af_netlink.c:333 (discriminator 1)) [ 370.015185][ 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)) [ 370.015300][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 370.015419][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 370.015534][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.015654][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 370.015769][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 370.015886][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2592 (discriminator 4)) [ 370.015999][ T44] ? copy_msghdr_from_user (net/socket.c:2532) [ 370.016113][ T44] ? get_timestamp.constprop.0 (net/socket.c:2538) [ 370.016256][ T44] ? move_addr_to_kernel (net/socket.c:2518) [ 370.016372][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 370.016487][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4028 (discriminator 2) kernel/rcu/tree.c:4020 (discriminator 2)) [ 370.016637][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 370.016751][ T44] ___sys_sendmsg (net/socket.c:2648) [ 370.016866][ T44] ? copy_msghdr_from_user (net/socket.c:2635) [ 370.016980][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.017100][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.017216][ T44] ? move_addr_to_user (net/socket.c:306 (discriminator 1)) [ 370.017329][ T44] ? do_getsockname (net/socket.c:2119) [ 370.017449][ T44] __sys_sendmsg (net/socket.c:2678 (discriminator 1)) [ 370.017563][ T44] ? __sys_sendmsg_sock (net/socket.c:2663) [ 370.017689][ T44] ? __sys_getsockname (./include/linux/file.h:62 (discriminator 1) ./include/linux/file.h:83 (discriminator 1) net/socket.c:2144 (discriminator 1)) [ 370.017805][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.017921][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.018038][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:131) [ 370.018181][ T44] RIP: 0033:0x7f04ee915c5e [ 370.018302][ T44] RSP: 002b:00007ffcc9760dd0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.018484][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f04ee915c5e [ 370.018664][ T44] RDX: 0000000000000000 RSI: 00007ffcc9760e90 RDI: 0000000000000004 [ 370.018840][ T44] RBP: 00007ffcc9760de0 R08: 0000000000000000 R09: 0000000000000000 [ 370.019013][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffcc976268d [ 370.019185][ T44] R13: 000000006950e57c R14: 000000000000000d R15: 00007ffcc9760f40 | [ 370.023486][ T44] 1 lock held by ip/321: | [ 370.023569][ T44] #0: ffffffffa3485768 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 370.023771][ T44] | [ 370.023827][ T44] ============================================= | [ 370.023827][ T44] [ 492.863619][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 492.863893][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 492.864027][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.864248][ T44] task:kworker/u16:0 state:D stack:27952 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.864552][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 492.864723][ T44] Call Trace: [ 492.864818][ T44] [ 492.864884][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 492.865019][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 492.865143][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.865265][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.865393][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 492.865492][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 492.865623][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 492.865742][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.865864][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 492.865986][ T44] ? process_one_work (kernel/workqueue.c:3233 (discriminator 1)) [ 492.866105][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.866221][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.866340][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.866461][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.866579][ T44] process_one_work (kernel/workqueue.c:3262) [ 492.866705][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3159) [ 492.866819][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.866935][ T44] ? assign_work (kernel/workqueue.c:1200) [ 492.867049][ T44] worker_thread (kernel/workqueue.c:3334 (discriminator 2) kernel/workqueue.c:3421 (discriminator 2)) [ 492.867166][ T44] ? process_one_work (kernel/workqueue.c:3367) [ 492.867279][ T44] kthread (kernel/kthread.c:463) [ 492.867365][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.867484][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.867605][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.867720][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.867835][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.867949][ T44] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 492.868092][ T44] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 492.868204][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.868317][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:256) | [ 492.868443][ T44] | [ 492.868534][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:256. [ 492.868737][ T44] INFO: task kworker/3:1:72 blocked for more than 245 seconds. [ 492.868896][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 492.869003][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.869190][ T44] task:kworker/3:1 state:D stack:28064 pid:72 tgid:72 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.869440][ T44] Workqueue: events xp_release_deferred [ 492.869555][ T44] Call Trace: [ 492.869646][ T44] [ 492.869705][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 492.869826][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 492.869943][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.870068][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 492.870155][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 492.870270][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 492.870386][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.870505][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 492.870626][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.870744][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.870858][ T44] ? process_one_work (kernel/workqueue.c:3233 (discriminator 1)) [ 492.870975][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.871090][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.871206][ T44] process_one_work (kernel/workqueue.c:3262) [ 492.871324][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3159) [ 492.871444][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.871561][ T44] ? assign_work (kernel/workqueue.c:1200) [ 492.871685][ T44] worker_thread (kernel/workqueue.c:3334 (discriminator 2) kernel/workqueue.c:3421 (discriminator 2)) [ 492.871804][ T44] ? process_one_work (kernel/workqueue.c:3367) [ 492.871918][ T44] kthread (kernel/kthread.c:463) [ 492.872005][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.872120][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.872236][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.872352][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.872470][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.872586][ T44] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 492.872740][ T44] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 492.872854][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.872971][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:256) | [ 492.873092][ T44] | [ 492.873182][ T44] INFO: task kworker/3:1:72 is blocked on a mutex likely owned by task ip:256. [ 492.873371][ T44] INFO: task ip:256 blocked for more than 368 seconds. [ 492.873511][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 492.873623][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.873811][ T44] task:ip state:D stack:25520 pid:256 tgid:256 ppid:1 task_flags:0x400100 flags:0x00080002 [ 492.874058][ T44] Call Trace: [ 492.874144][ T44] [ 492.874206][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 492.874328][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 492.874446][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.874562][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.874683][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 492.874772][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 492.874888][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 492.875009][ T44] ? napi_enable (net/core/dev.c:7618) [ 492.875128][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 492.875243][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.875356][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 492.875478][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 492.875594][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 492.875718][ T44] ? napi_enable (net/core/dev.c:7618) [ 492.875832][ T44] napi_enable (net/core/dev.c:7618) [ 492.875923][ 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.876036][ 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:2559) [ 492.876153][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 492.876270][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 492.876389][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 492.876508][ T44] dev_xdp_install (net/core/dev.c:10314) [ 492.876635][ T44] ? netif_set_xps_queue (net/core/dev.c:10282) [ 492.876756][ T44] dev_xdp_attach (net/core/dev.c:10470) [ 492.876875][ T44] ? bpf_xdp_link_update (net/core/dev.c:10360) [ 492.876990][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2622) [ 492.877113][ T44] dev_change_xdp_fd (net/core/dev.c:10724) [ 492.877227][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 492.877344][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 492.877464][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4028 (discriminator 2) kernel/rcu/tree.c:4020 (discriminator 2)) [ 492.877613][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.877727][ 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.877840][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 492.877961][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.878076][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.878192][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.878305][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.878424][ T44] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 492.878538][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.878657][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.878774][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 492.878888][ T44] ? __mutex_lock (kernel/locking/mutex.c:624 (discriminator 3) kernel/locking/mutex.c:776 (discriminator 3)) [ 492.879003][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.879119][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 492.879232][ T44] ? nla_get_range_signed (lib/nlattr.c:396) [ 492.879350][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 492.879471][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 492.879587][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.879703][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 492.879816][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.879929][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.880041][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.880156][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 492.880270][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.880382][ T44] ? rtnl_setlink (net/core/rtnetlink.c:3963) [ 492.880496][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 492.880619][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 492.880731][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.880845][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.880959][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.881078][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.881190][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 492.881305][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.881422][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) ./include/net/netns/generic.h:48 (discriminator 1) net/netlink/af_netlink.c:333 (discriminator 1)) [ 492.881537][ 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.881657][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.881775][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.881890][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.882003][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.882117][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.882236][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.882352][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2592 (discriminator 4)) [ 492.882469][ T44] ? copy_msghdr_from_user (net/socket.c:2532) [ 492.882582][ T44] ? get_timestamp.constprop.0 (net/socket.c:2538) [ 492.882729][ T44] ? move_addr_to_kernel (net/socket.c:2518) [ 492.882845][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.882957][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.883071][ T44] ___sys_sendmsg (net/socket.c:2648) [ 492.883184][ 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:3121) [ 492.883327][ T44] ? copy_msghdr_from_user (net/socket.c:2635) [ 492.883455][ T44] __sys_sendmsg (net/socket.c:2678 (discriminator 1)) [ 492.883570][ T44] ? __sys_sendmsg_sock (net/socket.c:2663) [ 492.883687][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 492.883800][ 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:3144) [ 492.883945][ 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.884059][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.884174][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.884287][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:131) [ 492.884435][ T44] RIP: 0033:0x7f7aa0550c5e [ 492.884553][ T44] RSP: 002b:00007ffcd19c8e80 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.884736][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7aa0550c5e [ 492.884906][ T44] RDX: 0000000000000000 RSI: 00007ffcd19c8f40 RDI: 0000000000000003 [ 492.885075][ T44] RBP: 00007ffcd19c8e90 R08: 0000000000000000 R09: 0000000000000000 [ 492.885247][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffcd19c9600 [ 492.885418][ T44] R13: 000000006950e4ac R14: 0000000000000000 R15: 0000000000499600 | [ 492.890141][ T44] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) | [ 492.890282][ T44] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) | [ 492.890454][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.890571][ T44] ? ret_from_fork_asm (arch/x86/entry/entry_64.S:256) | [ 492.890693][ T44] [ 492.890782][ T44] INFO: task ip:321 blocked for more than 245 seconds. [ 492.890963][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 492.891067][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.891246][ T44] task:ip state:D stack:25624 pid:321 tgid:321 ppid:320 task_flags:0x400100 flags:0x00080000 [ 492.891544][ T44] Call Trace: [ 492.891634][ T44] [ 492.891696][ T44] __schedule (kernel/sched/core.c:5259 kernel/sched/core.c:6863) [ 492.891868][ T44] ? io_schedule_timeout (kernel/sched/core.c:6719) [ 492.891981][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.892094][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.892207][ T44] schedule (kernel/sched/core.c:6946 kernel/sched/core.c:6960) [ 492.892292][ T44] schedule_preempt_disabled (kernel/sched/core.c:7018) [ 492.892466][ T44] __mutex_lock (kernel/locking/mutex.c:199 kernel/locking/mutex.c:694 kernel/locking/mutex.c:776) [ 492.892579][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.892702][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.892815][ T44] ? write_profile (kernel/stacktrace.c:83) [ 492.892985][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:775) [ 492.893102][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.893215][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.893332][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.893448][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.893564][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 492.893683][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.893796][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.893910][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.894025][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.894138][ T44] ? rtnl_fdb_dump (net/core/rtnetlink.c:6861) [ 492.894252][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.894368][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) ./include/net/netns/generic.h:48 (discriminator 1) net/netlink/af_netlink.c:333 (discriminator 1)) [ 492.894486][ 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.894606][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.894721][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.894836][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.894951][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.895064][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.895181][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2592 (discriminator 4)) [ 492.895296][ T44] ? copy_msghdr_from_user (net/socket.c:2532) [ 492.895414][ T44] ? get_timestamp.constprop.0 (net/socket.c:2538) [ 492.895556][ T44] ? move_addr_to_kernel (net/socket.c:2518) [ 492.895674][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.895789][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4028 (discriminator 2) kernel/rcu/tree.c:4020 (discriminator 2)) [ 492.895933][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.896045][ T44] ___sys_sendmsg (net/socket.c:2648) [ 492.896162][ T44] ? copy_msghdr_from_user (net/socket.c:2635) [ 492.896278][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.896395][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.896515][ T44] ? move_addr_to_user (net/socket.c:306 (discriminator 1)) [ 492.896639][ T44] ? do_getsockname (net/socket.c:2119) [ 492.896754][ T44] __sys_sendmsg (net/socket.c:2678 (discriminator 1)) [ 492.896867][ T44] ? __sys_sendmsg_sock (net/socket.c:2663) [ 492.896984][ T44] ? __sys_getsockname (./include/linux/file.h:62 (discriminator 1) ./include/linux/file.h:83 (discriminator 1) net/socket.c:2144 (discriminator 1)) [ 492.897102][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.897216][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.897336][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:131) [ 492.897487][ T44] RIP: 0033:0x7f04ee915c5e [ 492.897609][ T44] RSP: 002b:00007ffcc9760dd0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.897783][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f04ee915c5e [ 492.897955][ T44] RDX: 0000000000000000 RSI: 00007ffcc9760e90 RDI: 0000000000000004 [ 492.898124][ T44] RBP: 00007ffcc9760de0 R08: 0000000000000000 R09: 0000000000000000 [ 492.898294][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffcc976268d Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:napi_enable __schedule:schedule:schedule_preempt_disabled:__mutex_lock:rtnetlink_rcv_msg ret_from_fork_asm:__schedule:schedule:schedule_preempt_disabled:__mutex_lock __schedule:schedule:schedule_preempt_disabled:__mutex_lock:xp_release_deferred __schedule:schedule:schedule_preempt_disabled:__mutex_lock:addrconf_verify_work