====================================== | # | 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.100482][ T44] INFO: task ip:253 blocked for more than 122 seconds. [ 247.100900][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 247.101049][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 247.101313][ T44] task:ip state:D stack:25304 pid:253 tgid:253 ppid:1 task_flags:0x400100 flags:0x00080003 [ 247.101660][ T44] Call Trace: [ 247.101771][ T44] [ 247.101852][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 247.102011][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 247.102162][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.102320][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.102461][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.102593][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 247.102695][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 247.102842][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 247.102974][ T44] ? napi_enable (net/core/dev.c:7616) [ 247.103104][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 247.103254][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 247.103370][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 247.103504][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 247.103623][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 247.103748][ T44] ? napi_enable (net/core/dev.c:7616) [ 247.103866][ T44] napi_enable (net/core/dev.c:7616) [ 247.103955][ 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.104072][ 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.104199][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 247.104318][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 247.104454][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 247.104573][ T44] dev_xdp_install (net/core/dev.c:10312) [ 247.104691][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 247.104813][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 247.105169][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 247.105287][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 247.105406][ T44] dev_change_xdp_fd (net/core/dev.c:10722) [ 247.105532][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 247.105652][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 247.105766][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 247.105912][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 247.106026][ 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.106140][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 247.106258][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 247.106377][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.106503][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 247.106617][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 247.106734][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 247.106849][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 247.106965][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.107080][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.107204][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 247.107325][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 247.107444][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 247.107571][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 247.107685][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 247.107803][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 247.107920][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 247.108036][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 247.108156][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.108278][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 247.108393][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 247.108512][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 247.108629][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 247.108743][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 247.108863][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 247.108980][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.109097][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 247.109216][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 247.109336][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 247.109460][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 247.109580][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 247.109699][ 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.109821][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 247.109937][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 247.110054][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.110178][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 247.110297][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 247.110412][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 247.110535][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 247.110698][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 247.110811][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 247.110952][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 247.111068][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 247.111191][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 247.111306][ T44] ___sys_sendmsg (net/socket.c:2686) [ 247.111419][ 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.111574][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 247.111701][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 247.111824][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 247.111937][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 247.112051][ 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.112197][ 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.112311][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 247.112441][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 247.112557][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 247.112705][ T44] RIP: 0033:0x7fa8dc8c6c5e [ 247.112829][ T44] RSP: 002b:00007ffd6c2bc230 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 247.113004][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fa8dc8c6c5e [ 247.113178][ T44] RDX: 0000000000000000 RSI: 00007ffd6c2bc2f0 RDI: 0000000000000003 [ 247.113364][ T44] RBP: 00007ffd6c2bc240 R08: 0000000000000000 R09: 0000000000000000 [ 247.113542][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd6c2bc9b0 [ 247.113715][ T44] R13: 00000000692e9daa R14: 0000000000000000 R15: 0000000000499600 | [ 247.122367][ T44] 1 lock held by ip/320: | [ 247.122455][ T44] #0: ffffffffa1492ba8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 247.122648][ T44] | [ 247.122706][ T44] ============================================= | [ 247.122706][ T44] [ 369.981463][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds. [ 369.981819][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 369.981960][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.982206][ T44] task:kworker/u16:0 state:D stack:28040 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 369.982557][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 369.982747][ T44] Call Trace: [ 369.982851][ T44] [ 369.982930][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.983074][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.983211][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.983357][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.983497][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.983591][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.983725][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.983858][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.983990][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.984134][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 369.984271][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.984389][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.984521][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.984639][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 369.984758][ T44] process_one_work (kernel/workqueue.c:3268) [ 369.984877][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 369.984996][ T44] ? assign_work (kernel/workqueue.c:1206) [ 369.985110][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 369.985233][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.985349][ T44] kthread (kernel/kthread.c:463) [ 369.985447][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.985564][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.985679][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.985797][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.985913][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 369.986029][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.986143][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 369.986269][ T44] | [ 369.986368][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:253. [ 369.986581][ T44] INFO: task kworker/3:1:61 blocked for more than 122 seconds. [ 369.986742][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 369.986848][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.987037][ T44] task:kworker/3:1 state:D stack:28552 pid:61 tgid:61 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 369.987299][ T44] Workqueue: events xp_release_deferred [ 369.987415][ T44] Call Trace: [ 369.987508][ T44] [ 369.987567][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.987687][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.987805][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 369.987921][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.988038][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.988130][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.988248][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.988368][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.988490][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.988605][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.988721][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.988834][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 369.988955][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.989070][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 369.989186][ T44] process_one_work (kernel/workqueue.c:3268) [ 369.989309][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 369.989423][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.989546][ T44] ? assign_work (kernel/workqueue.c:1206) [ 369.989661][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 369.989779][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.989892][ 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.990008][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 369.990122][ T44] kthread (kernel/kthread.c:463) [ 369.990211][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.990331][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.990448][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.990567][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.990685][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 369.990799][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 369.990915][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 369.991034][ T44] | [ 369.991125][ T44] INFO: task kworker/3:1:61 is blocked on a mutex likely owned by task ip:253. [ 369.991333][ T44] INFO: task ip:253 blocked for more than 245 seconds. [ 369.991473][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 369.991581][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 369.991767][ T44] task:ip state:D stack:25304 pid:253 tgid:253 ppid:1 task_flags:0x400100 flags:0x00080003 [ 369.992019][ T44] Call Trace: [ 369.992105][ T44] [ 369.992165][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 369.992286][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 369.992406][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.992527][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.992640][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.992758][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 369.992845][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 369.992957][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 369.993076][ T44] ? napi_enable (net/core/dev.c:7616) [ 369.993190][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 369.993340][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.993458][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 369.993575][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 369.993693][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 369.993811][ T44] ? napi_enable (net/core/dev.c:7616) [ 369.993926][ T44] napi_enable (net/core/dev.c:7616) [ 369.994016][ 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.994131][ 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.994249][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 369.994365][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 369.994492][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 369.994606][ T44] dev_xdp_install (net/core/dev.c:10312) [ 369.994723][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 369.994850][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 369.994966][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 369.995080][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 369.995200][ T44] dev_change_xdp_fd (net/core/dev.c:10722) [ 369.995321][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 369.995447][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 369.995563][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 369.995709][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 369.995824][ 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.995938][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 369.996052][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 369.996167][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.996288][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 369.996399][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 369.996521][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 369.996632][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.996745][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.996859][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 369.996974][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 369.997089][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 369.997201][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 369.997322][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 369.997445][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 369.997561][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 369.997679][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 369.997797][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.997918][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.998031][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 369.998145][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.998263][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 369.998386][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 369.998504][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 369.998618][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 369.998731][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.998848][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 369.998962][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 369.999077][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 369.999194][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 369.999315][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 369.999442][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 369.999559][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 369.999677][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 369.999797][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 369.999912][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 370.000028][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 370.000150][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 370.000272][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 370.000393][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 370.000511][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 370.000654][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 370.000770][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 370.000888][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.001011][ T44] ___sys_sendmsg (net/socket.c:2686) [ 370.001127][ 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.001274][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 370.001406][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 370.001526][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 370.001639][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 370.001755][ 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.001905][ 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.002021][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.002142][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.002263][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 370.002405][ T44] RIP: 0033:0x7fa8dc8c6c5e [ 370.002532][ T44] RSP: 002b:00007ffd6c2bc230 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.002708][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fa8dc8c6c5e [ 370.002885][ T44] RDX: 0000000000000000 RSI: 00007ffd6c2bc2f0 RDI: 0000000000000003 [ 370.003055][ T44] RBP: 00007ffd6c2bc240 R08: 0000000000000000 R09: 0000000000000000 [ 370.003242][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd6c2bc9b0 [ 370.003414][ T44] R13: 00000000692e9daa R14: 0000000000000000 R15: 0000000000499600 | [ 370.008131][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 370.008249][ T44] ret_from_fork (arch/x86/kernel/process.c:164) | [ 370.008457][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 370.008572][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 370.008696][ T44] [ 370.008788][ T44] INFO: task ip:320 blocked for more than 122 seconds. [ 370.008921][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 370.009029][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 370.009219][ T44] task:ip state:D stack:25744 pid:320 tgid:320 ppid:319 task_flags:0x400100 flags:0x00080001 [ 370.009536][ T44] Call Trace: [ 370.009621][ T44] [ 370.009681][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 370.009797][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 370.009967][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.010087][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.010199][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.010322][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 370.010471][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 370.010587][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 370.010699][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.010813][ T44] ? write_profile (kernel/stacktrace.c:83) [ 370.010930][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 370.011046][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.011160][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 370.011279][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.011457][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 370.011572][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 370.011686][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.011803][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.011917][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 370.012030][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 370.012148][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 370.012266][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 370.012447][ 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.012563][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 370.012679][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 370.012795][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 370.012912][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 370.013032][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 370.013152][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 370.013271][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 370.013448][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 370.013563][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 370.013705][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 370.013827][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 370.013971][ T44] ___sys_sendmsg (net/socket.c:2686) [ 370.014087][ 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.014202][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 370.014382][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 370.014501][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 370.014623][ 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.014740][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 370.014910][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 370.015032][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 370.015148][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 370.015267][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 370.015470][ T44] RIP: 0033:0x7f813ee3ec5e [ 370.015589][ T44] RSP: 002b:00007fff30694120 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 370.015764][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f813ee3ec5e [ 370.015991][ T44] RDX: 0000000000000000 RSI: 00007fff306941e0 RDI: 0000000000000004 [ 370.016164][ T44] RBP: 00007fff30694130 R08: 0000000000000000 R09: 0000000000000000 [ 370.016336][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fff306956bf [ 370.016567][ T44] R13: 00000000692e9e7a R14: 000000000000000d R15: 00007fff30694290 | [ 370.020682][ T44] 1 lock held by ip/320: | [ 370.020818][ T44] #0: ffffffffa1492ba8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) | [ 370.021018][ T44] | [ 370.021077][ T44] ============================================= | [ 370.021077][ T44] [ 492.860458][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 492.860797][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.860943][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.861190][ T44] task:kworker/u16:0 state:D stack:28040 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.861577][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 492.861747][ T44] Call Trace: [ 492.861852][ T44] [ 492.861930][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.862076][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.862209][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.862353][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.862620][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.862710][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.862828][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.862945][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.863065][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.863184][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 492.863305][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.863425][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.863548][ T44] ? addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.863665][ T44] addrconf_verify_work (net/ipv6/addrconf.c:4731 (discriminator 1)) [ 492.863780][ T44] process_one_work (kernel/workqueue.c:3268) [ 492.863899][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 492.864021][ T44] ? assign_work (kernel/workqueue.c:1206) [ 492.864135][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 492.864251][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.864371][ T44] kthread (kernel/kthread.c:463) [ 492.864462][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.864577][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.864690][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.864805][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.864921][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.865033][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.865152][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.865275][ T44] | [ 492.865372][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:253. [ 492.865579][ T44] INFO: task kworker/3:1:61 blocked for more than 245 seconds. [ 492.865739][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.865848][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.866040][ T44] task:kworker/3:1 state:D stack:28552 pid:61 tgid:61 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.866294][ T44] Workqueue: events xp_release_deferred [ 492.866414][ T44] Call Trace: [ 492.866505][ T44] [ 492.866564][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.866681][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.866797][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.866914][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.867029][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.867118][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.867238][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.867357][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.867478][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.867596][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.867714][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.867829][ T44] ? process_one_work (kernel/workqueue.c:3239 (discriminator 1)) [ 492.867952][ T44] ? xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.868071][ T44] xp_release_deferred (net/xdp/xsk_buff_pool.c:282) [ 492.868186][ T44] process_one_work (kernel/workqueue.c:3268) [ 492.868306][ T44] ? pwq_dec_nr_in_flight (kernel/workqueue.c:3165) [ 492.868425][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.868550][ T44] ? assign_work (kernel/workqueue.c:1206) [ 492.868669][ T44] worker_thread (kernel/workqueue.c:3340 (discriminator 2) kernel/workqueue.c:3427 (discriminator 2)) [ 492.868790][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.868903][ 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.869020][ T44] ? process_one_work (kernel/workqueue.c:3373) [ 492.869138][ T44] kthread (kernel/kthread.c:463) [ 492.869225][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.869346][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.869467][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.869580][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.869696][ T44] ret_from_fork (arch/x86/kernel/process.c:164) [ 492.869810][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) [ 492.869923][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.870041][ T44] | [ 492.870128][ T44] INFO: task kworker/3:1:61 is blocked on a mutex likely owned by task ip:253. [ 492.870327][ T44] INFO: task ip:253 blocked for more than 368 seconds. [ 492.870465][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.870572][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.870756][ T44] task:ip state:D stack:25304 pid:253 tgid:253 ppid:1 task_flags:0x400100 flags:0x00080003 [ 492.871009][ T44] Call Trace: [ 492.871093][ T44] [ 492.871152][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.871272][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.871389][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.871507][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.871624][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.871745][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.871835][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.871953][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.872067][ T44] ? napi_enable (net/core/dev.c:7616) [ 492.872185][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 492.872339][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.872458][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 492.872575][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 492.872691][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 492.872810][ T44] ? napi_enable (net/core/dev.c:7616) [ 492.872924][ T44] napi_enable (net/core/dev.c:7616) [ 492.873015][ 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.873129][ 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.873251][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3492 (discriminator 1)) [ 492.873372][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6140 (discriminator 1)) [ 492.873495][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6167) [ 492.873613][ T44] dev_xdp_install (net/core/dev.c:10312) [ 492.873727][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 492.873845][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 492.873961][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 492.874080][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 492.874196][ T44] dev_change_xdp_fd (net/core/dev.c:10722) [ 492.874316][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 492.874441][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 492.874556][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 492.874698][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 492.874812][ 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.874925][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 492.875040][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.875155][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.875277][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 492.875392][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 492.875512][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 492.875626][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.875739][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.875852][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.875966][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 492.876082][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 492.876195][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 492.876315][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.876439][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 492.876557][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 492.876673][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 492.876789][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.876911][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.877028][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.877144][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.877259][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.877379][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 492.877497][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 492.877616][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.877729][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.877848][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.877966][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.878082][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.878198][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.878316][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.878439][ 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.878556][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.878671][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.878792][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.878907][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.879028][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.879143][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.879260][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 492.879377][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 492.879497][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 492.879639][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 492.879757][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 492.879871][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.879991][ T44] ___sys_sendmsg (net/socket.c:2686) [ 492.880106][ 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.880250][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 492.880384][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 492.880503][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 492.880619][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 492.880734][ 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.880881][ 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.881000][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.881115][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.881230][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 492.881376][ T44] RIP: 0033:0x7fa8dc8c6c5e [ 492.881505][ T44] RSP: 002b:00007ffd6c2bc230 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.881680][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fa8dc8c6c5e [ 492.881853][ T44] RDX: 0000000000000000 RSI: 00007ffd6c2bc2f0 RDI: 0000000000000003 [ 492.882025][ T44] RBP: 00007ffd6c2bc240 R08: 0000000000000000 R09: 0000000000000000 [ 492.882205][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd6c2bc9b0 [ 492.882380][ T44] R13: 00000000692e9daa R14: 0000000000000000 R15: 0000000000499600 | [ 492.887065][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.887186][ T44] ret_from_fork (arch/x86/kernel/process.c:164) | [ 492.887362][ T44] ? kthread_is_per_cpu (kernel/kthread.c:412) | [ 492.887479][ T44] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 492.887600][ T44] [ 492.887689][ T44] INFO: task ip:320 blocked for more than 245 seconds. [ 492.887880][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 492.887988][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.888180][ T44] task:ip state:D stack:25744 pid:320 tgid:320 ppid:319 task_flags:0x400100 flags:0x00080001 [ 492.888441][ T44] Call Trace: [ 492.888528][ T44] [ 492.888587][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 492.888705][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 492.888878][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.888997][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.889111][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.889232][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 492.889325][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 492.889444][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 492.889559][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.889673][ T44] ? write_profile (kernel/stacktrace.c:83) [ 492.889848][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 492.889965][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.890079][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 492.890202][ T44] ? rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.890373][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6965) [ 492.890493][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.890607][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.890722][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.890893][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 492.891007][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 492.891122][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 492.891240][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 492.891416][ 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.891537][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 492.891654][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 492.891772][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 492.891943][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 492.892066][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 492.892182][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.892306][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 492.892478][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 492.892592][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 492.892738][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 492.892864][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 492.893065][ T44] ___sys_sendmsg (net/socket.c:2686) [ 492.893179][ 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.893298][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 492.893483][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 492.893597][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 492.893715][ 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.893832][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 492.894005][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 492.894126][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 492.894242][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 492.894361][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 492.894561][ T44] RIP: 0033:0x7f813ee3ec5e [ 492.894681][ T44] RSP: 002b:00007fff30694120 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.894856][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f813ee3ec5e [ 492.895083][ T44] RDX: 0000000000000000 RSI: 00007fff306941e0 RDI: 0000000000000004 [ 492.895252][ T44] RBP: 00007fff30694130 R08: 0000000000000000 R09: 0000000000000000 [ 492.895425][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fff306956bf 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