====================================== | # | not ok 1 selftests: drivers/net: xdp.py # TIMEOUT 360 seconds | make: Leaving directory '/srv/vmksft/testing/wt-22/tools/testing/selftests' | xx__-> echo $? | 0 xx__-> [ 247.105619][ T44] INFO: task ip:252 blocked for more than 122 seconds. [ 247.106015][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 247.106154][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 247.106390][ T44] task:ip state:D stack:24672 pid:252 tgid:252 ppid:1 task_flags:0x400100 flags:0x00080003 [ 247.106729][ T44] Call Trace: [ 247.106867][ T44] [ 247.106945][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 247.107088][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 247.107211][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.107339][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.107459][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.107587][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 247.107676][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 247.107798][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 247.107917][ T44] ? napi_enable (net/core/dev.c:7611) [ 247.108034][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 247.108181][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 247.108299][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 247.108432][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 247.108551][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 247.108689][ T44] ? napi_enable (net/core/dev.c:7611) [ 247.108805][ T44] napi_enable (net/core/dev.c:7611) [ 247.108893][ 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.109000][ 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) [ 247.109107][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 247.109218][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 247.109327][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 247.109431][ T44] dev_xdp_install (net/core/dev.c:10307) [ 247.109536][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10275) [ 247.109655][ T44] dev_xdp_attach (net/core/dev.c:10463) [ 247.109996][ T44] ? bpf_xdp_link_update (net/core/dev.c:10353) [ 247.110103][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 247.110212][ T44] dev_change_xdp_fd (net/core/dev.c:10717) [ 247.110321][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 247.110429][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 247.110534][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 247.110677][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 247.110783][ 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.110888][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 247.110998][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 247.111106][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.111214][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 247.111321][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 247.111427][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 247.111535][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 247.111644][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.111748][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.111856][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 247.111965][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 247.112070][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 247.112179][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 247.112286][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 247.112396][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 247.112505][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 247.112631][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 247.112741][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.112848][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 247.112953][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 247.113059][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.113171][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 247.113280][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 247.113387][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 247.113493][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.113610][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.113719][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 247.113828][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 247.113936][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 247.114047][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 247.114157][ 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.114265][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 247.114372][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 247.114478][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.114591][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 247.114697][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 247.114803][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 247.114909][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 247.115023][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 247.115127][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 247.115264][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 247.115399][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 247.115503][ 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.115614][ T44] ___sys_sendmsg (net/socket.c:2686) [ 247.115719][ 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) [ 247.115850][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 247.115970][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 247.116078][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 247.116186][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 247.116292][ 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) [ 247.116429][ 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.116535][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.116652][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 247.116761][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 247.116891][ T44] RIP: 0033:0x7f5599a72c5e [ 247.117013][ T44] RSP: 002b:00007ffc7063ea50 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 247.117178][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f5599a72c5e [ 247.117337][ T44] RDX: 0000000000000000 RSI: 00007ffc7063eb10 RDI: 0000000000000003 [ 247.117495][ T44] RBP: 00007ffc7063ea60 R08: 0000000000000000 R09: 0000000000000000 [ 247.117663][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc7063f1d0 [ 247.117821][ T44] R13: 0000000069280640 R14: 0000000000000000 R15: 0000000000499600 | [ 247.126084][ T44] 1 lock held by ip/319: | [ 247.126157][ T44] #0: ffffffffa0a92428 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 247.126331][ T44] | [ 247.126384][ T44] ============================================= | [ 247.126384][ T44] [ 369.984607][ T44] INFO: task kworker/2:2:67 blocked for more than 122 seconds. [ 369.984938][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 369.985077][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.985315][ T44] task:kworker/2:2 state:D stack:29280 pid:67 tgid:67 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 369.985648][ T44] Workqueue: events xp_release_deferred [ 369.985793][ T44] Call Trace: [ 369.985898][ T44] [ 369.985978][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.986126][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.986258][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 369.986380][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.986505][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.986605][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.986728][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.986847][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.986971][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.987089][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.987203][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.987323][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 369.987440][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.987556][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.987689][ T44] process_one_work (kernel/workqueue.c:3268) [ 369.987808][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 369.987919][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.988046][ T44] ? assign_work (kernel/workqueue.c:1206) [ 369.988154][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 369.988265][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.988369][ 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)) [ 369.988475][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.988588][ T44] kthread (kernel/kthread.c:463) [ 369.988668][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.988776][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.988881][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.988986][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.989091][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 369.989195][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.989311][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 369.989420][ T44] | [ 369.989505][ T44] INFO: task kworker/2:2:67 is blocked on a mutex likely owned by task ip:252. [ 369.989683][ T44] INFO: task kworker/u16:1:71 blocked for more than 122 seconds. [ 369.989827][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 369.989922][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.990093][ T44] task:kworker/u16:1 state:D stack:28040 pid:71 tgid:71 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 369.990323][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 369.990454][ T44] Call Trace: [ 369.990532][ T44] [ 369.990592][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.990700][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.990807][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.990915][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.991019][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.991124][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.991206][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.991310][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.991412][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.991522][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.991642][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 369.991748][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.991851][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.991955][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.992056][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.992160][ T44] process_one_work (kernel/workqueue.c:3268) [ 369.992269][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 369.992390][ T44] ? assign_work (kernel/workqueue.c:1206) [ 369.992494][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 369.992606][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.992709][ 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)) [ 369.992814][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.992918][ T44] kthread (kernel/kthread.c:463) [ 369.992997][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.993105][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.993211][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.993318][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.993422][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 369.993526][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.993634][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 369.993743][ T44] | [ 369.993824][ T44] INFO: task kworker/u16:1:71 is blocked on a mutex likely owned by task ip:252. [ 369.994006][ T44] INFO: task ip:252 blocked for more than 245 seconds. [ 369.994126][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 369.994222][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.994390][ T44] task:ip state:D stack:24672 pid:252 tgid:252 ppid:1 task_flags:0x400100 flags:0x00080003 [ 369.994625][ T44] Call Trace: [ 369.994703][ T44] [ 369.994756][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.994862][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.994971][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.995078][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.995183][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.995290][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.995372][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.995475][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.995589][ T44] ? napi_enable (net/core/dev.c:7611) [ 369.995694][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 369.995827][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.995931][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 369.996035][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 369.996138][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 369.996250][ T44] ? napi_enable (net/core/dev.c:7611) [ 369.996354][ T44] napi_enable (net/core/dev.c:7611) [ 369.996434][ 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.996540][ 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.996649][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 369.996757][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 369.996865][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 369.996970][ T44] dev_xdp_install (net/core/dev.c:10307) [ 369.997074][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10275) [ 369.997182][ T44] dev_xdp_attach (net/core/dev.c:10463) [ 369.997292][ T44] ? bpf_xdp_link_update (net/core/dev.c:10353) [ 369.997398][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 369.997505][ T44] dev_change_xdp_fd (net/core/dev.c:10717) [ 369.997617][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 369.997725][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 369.997829][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 369.997961][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 369.998065][ 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.998169][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 369.998274][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 369.998380][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.998492][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.998599][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 369.998703][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 369.998804][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.998907][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.999010][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.999111][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 369.999218][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.999322][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 369.999428][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.999530][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 369.999645][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 369.999751][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 369.999856][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.999964][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.000070][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.000173][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 370.000277][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.000380][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 370.000483][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 370.000591][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 370.000692][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.000796][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.000902][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.001005][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 370.001106][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 370.001209][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 370.001319][ 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.001428][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 370.001534][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 370.001646][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.001754][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 370.001857][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 370.001961][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 370.002068][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 370.002170][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 370.002274][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 370.002400][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 370.002509][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 370.002615][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 370.002720][ T44] ___sys_sendmsg (net/socket.c:2686) [ 370.002824][ 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) [ 370.002951][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 370.003069][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 370.003175][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 370.003284][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 370.003385][ 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.003516][ 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.003629][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.003733][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.003837][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 370.003966][ T44] RIP: 0033:0x7f5599a72c5e [ 370.004079][ T44] RSP: 002b:00007ffc7063ea50 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.004237][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f5599a72c5e [ 370.004395][ T44] RDX: 0000000000000000 RSI: 00007ffc7063eb10 RDI: 0000000000000003 [ 370.004550][ T44] RBP: 00007ffc7063ea60 R08: 0000000000000000 R09: 0000000000000000 [ 370.004710][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc7063f1d0 [ 370.004865][ T44] R13: 0000000069280640 R14: 0000000000000000 R15: 0000000000499600 | [ 370.009362][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 370.009468][ T44] ret_from_fork (arch/x86/kernel/process.c:164) | [ 370.009578][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 370.009679][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 370.009786][ T44] [ 370.009924][ T44] INFO: task ip:319 blocked for more than 122 seconds. [ 370.010043][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 370.010141][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 370.010359][ T44] task:ip state:D stack:25744 pid:319 tgid:319 ppid:318 task_flags:0x400100 flags:0x00080001 [ 370.010586][ T44] Call Trace: [ 370.010664][ T44] [ 370.010717][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 370.010877][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 370.010984][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.011091][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.011195][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.011302][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 370.011384][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 370.011489][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 370.011606][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.011766][ T44] ? write_profile (kernel/stacktrace.c:83) [ 370.011871][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 370.011976][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.012079][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.012238][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.012341][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.012446][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 370.012551][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.012659][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.012761][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.012864][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 370.012966][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 370.013126][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 370.013232][ 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.013344][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 370.013447][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 370.013608][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.013715][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 370.013819][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 370.013922][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 370.014084][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 370.014188][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 370.014295][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 370.014421][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 370.014588][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 370.014716][ T44] ___sys_sendmsg (net/socket.c:2686) [ 370.014818][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 370.014973][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 370.015083][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.015187][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 370.015296][ 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) [ 370.015405][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 370.015511][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 370.015628][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.015732][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.015893][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 370.016019][ T44] RIP: 0033:0x7f4521138c5e [ 370.016127][ T44] RSP: 002b:00007ffc7711c4e0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.016285][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f4521138c5e [ 370.016496][ T44] RDX: 0000000000000000 RSI: 00007ffc7711c5a0 RDI: 0000000000000004 [ 370.016652][ T44] RBP: 00007ffc7711c4f0 R08: 0000000000000000 R09: 0000000000000000 [ 370.016865][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc7711d6bf [ 370.017017][ T44] R13: 0000000069280710 R14: 000000000000000d R15: 00007ffc7711c650 | [ 370.020810][ T44] 1 lock held by ip/319: | [ 370.020884][ T44] #0: ffffffffa0a92428 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 370.021059][ T44] | [ 370.021109][ T44] ============================================= | [ 370.021109][ T44] [ 492.865600][ T44] INFO: task kworker/2:2:67 blocked for more than 245 seconds. [ 492.865923][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 492.866056][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.866296][ T44] task:kworker/2:2 state:D stack:29280 pid:67 tgid:67 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.866625][ T44] Workqueue: events xp_release_deferred [ 492.866761][ T44] Call Trace: [ 492.866869][ T44] [ 492.866940][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.867077][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.867213][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.867346][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.867475][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.867564][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.867702][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.867827][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.867948][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.868068][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.868190][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.868311][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 492.868441][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.868549][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.868675][ T44] process_one_work (kernel/workqueue.c:3268) [ 492.868796][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 492.868909][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.869022][ T44] ? assign_work (kernel/workqueue.c:1206) [ 492.869139][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 492.869266][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.869370][ 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.869479][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.869586][ T44] kthread (kernel/kthread.c:463) [ 492.869666][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.869770][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.869873][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.869978][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.870082][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.870186][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.870297][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.870404][ T44] | [ 492.870492][ T44] INFO: task kworker/2:2:67 is blocked on a mutex likely owned by task ip:252. [ 492.870670][ T44] INFO: task kworker/u16:1:71 blocked for more than 245 seconds. [ 492.870821][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 492.870918][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.871090][ T44] task:kworker/u16:1 state:D stack:28040 pid:71 tgid:71 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.871317][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 492.871449][ T44] Call Trace: [ 492.871526][ T44] [ 492.871591][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.871697][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.871806][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.871911][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.872015][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.872123][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.872203][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.872307][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.872411][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.872521][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.872632][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 492.872737][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.872846][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.872951][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.873054][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.873158][ T44] process_one_work (kernel/workqueue.c:3268) [ 492.873265][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 492.873384][ T44] ? assign_work (kernel/workqueue.c:1206) [ 492.873491][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 492.873602][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.873705][ 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.873811][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.873915][ T44] kthread (kernel/kthread.c:463) [ 492.873995][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.874102][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.874207][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.874313][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.874422][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.874526][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.874634][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.874744][ T44] | [ 492.874826][ T44] INFO: task kworker/u16:1:71 is blocked on a mutex likely owned by task ip:252. [ 492.875000][ T44] INFO: task ip:252 blocked for more than 368 seconds. [ 492.875121][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 492.875216][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.875382][ T44] task:ip state:D stack:24672 pid:252 tgid:252 ppid:1 task_flags:0x400100 flags:0x00080003 [ 492.875631][ T44] Call Trace: [ 492.875709][ T44] [ 492.875763][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.875869][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.875977][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.876081][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.876186][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.876292][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.876373][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.876481][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.876592][ T44] ? napi_enable (net/core/dev.c:7611) [ 492.876697][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 492.876827][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.876929][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 492.877036][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 492.877142][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 492.877250][ T44] ? napi_enable (net/core/dev.c:7611) [ 492.877352][ T44] napi_enable (net/core/dev.c:7611) [ 492.877435][ 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.877539][ 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.877649][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 492.877754][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 492.877861][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 492.877967][ T44] dev_xdp_install (net/core/dev.c:10307) [ 492.878072][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10275) [ 492.878180][ T44] dev_xdp_attach (net/core/dev.c:10463) [ 492.878286][ T44] ? bpf_xdp_link_update (net/core/dev.c:10353) [ 492.878389][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 492.878500][ T44] dev_change_xdp_fd (net/core/dev.c:10717) [ 492.878611][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 492.878719][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 492.878823][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 492.878954][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.879057][ 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.879160][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 492.879262][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.879368][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.879478][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.879590][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 492.879693][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 492.879799][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.879904][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.880007][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.880110][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 492.880214][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.880316][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 492.880425][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.880530][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 492.880640][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 492.880748][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 492.880854][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.880959][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.881062][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.881163][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.881265][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.881369][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.881479][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 492.881585][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.881686][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.881790][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.881893][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.881997][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.882098][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.882200][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.882306][ 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.882410][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.882517][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.882628][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.882733][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.882836][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.882942][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.883048][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 492.883153][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 492.883255][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 492.883381][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 492.883493][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.883605][ 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.883709][ T44] ___sys_sendmsg (net/socket.c:2686) [ 492.883810][ 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.883936][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 492.884053][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 492.884155][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 492.884261][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 492.884362][ 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.884494][ 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.884602][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.884707][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.884810][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 492.884940][ T44] RIP: 0033:0x7f5599a72c5e [ 492.885050][ T44] RSP: 002b:00007ffc7063ea50 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.885204][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f5599a72c5e [ 492.885356][ T44] RDX: 0000000000000000 RSI: 00007ffc7063eb10 RDI: 0000000000000003 [ 492.885514][ T44] RBP: 00007ffc7063ea60 R08: 0000000000000000 R09: 0000000000000000 [ 492.885673][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc7063f1d0 [ 492.885825][ T44] R13: 0000000069280640 R14: 0000000000000000 R15: 0000000000499600 | [ 492.890272][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.890430][ T44] ret_from_fork (arch/x86/kernel/process.c:164) | [ 492.890532][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.890639][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.890746][ T44] [ 492.890827][ T44] INFO: task ip:319 blocked for more than 245 seconds. [ 492.890947][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 492.891041][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.891256][ T44] task:ip state:D stack:25744 pid:319 tgid:319 ppid:318 task_flags:0x400100 flags:0x00080001 [ 492.891481][ T44] Call Trace: [ 492.891559][ T44] [ 492.891682][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.891789][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.891893][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.891996][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.892097][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.892255][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.892332][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.892438][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.892543][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.892650][ T44] ? write_profile (kernel/stacktrace.c:83) [ 492.892753][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.892858][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.892960][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.893120][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.893223][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.893329][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.893433][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.893598][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.893699][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.893802][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.893905][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.894061][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.894167][ 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.894273][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.894378][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.894539][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.894648][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.894752][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.894854][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.895012][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 492.895114][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 492.895217][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 492.895342][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 492.895505][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 492.895641][ T44] ___sys_sendmsg (net/socket.c:2686) [ 492.895743][ 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.895898][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 492.896005][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.896108][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.896216][ 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.896374][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 492.896477][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 492.896588][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.896691][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.896796][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 492.896928][ T44] RIP: 0033:0x7f4521138c5e [ 492.897033][ T44] RSP: 002b:00007ffc7711c4e0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.897186][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f4521138c5e [ 492.897338][ T44] RDX: 0000000000000000 RSI: 00007ffc7711c5a0 RDI: 0000000000000004 [ 492.897492][ T44] RBP: 00007ffc7711c4f0 R08: 0000000000000000 R09: 0000000000000000 [ 492.897709][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc7711d6bf 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