====================================== | make: Leaving directory '/srv/vmksft/testing/wt-22/tools/testing/selftests' | xx__-> echo $? | 0 | xx__-> echo scan > /sys/kernel/debug/kmemleak | xx__-> [ 615.777278][ T44] INFO: task ip:4864 blocked for more than 122 seconds. [ 615.777793][ T44] Not tainted 6.18.0-rc6-virtme #1 [ 615.778006][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 615.778383][ T44] task:ip state:D stack:24984 pid:4864 tgid:4864 ppid:1 task_flags:0x400100 flags:0x00080003 [ 615.778802][ T44] Call Trace: [ 615.778947][ T44] [ 615.779050][ T44] __schedule (kernel/sched/core.c:5328 kernel/sched/core.c:6929) [ 615.779263][ T44] ? io_schedule_timeout (kernel/sched/core.c:6785) [ 615.779448][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.779636][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.779821][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.780013][ T44] schedule (kernel/sched/core.c:7012 kernel/sched/core.c:7026) [ 615.780143][ T44] schedule_preempt_disabled (kernel/sched/core.c:7084) [ 615.780400][ T44] __mutex_lock (kernel/locking/mutex.c:183 kernel/locking/mutex.c:678 kernel/locking/mutex.c:760) [ 615.780576][ T44] ? napi_enable (net/core/dev.c:7616) [ 615.780767][ T44] ? virtqueue_add_inbuf_ctx (drivers/virtio/virtio_ring.c:2435) [ 615.780995][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.781190][ T44] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 615.781379][ T44] ? sg_init_table (lib/scatterlist.c:106) [ 615.781569][ T44] ? try_fill_recv (drivers/net/virtio_net.c:2865 (discriminator 1)) [ 615.781762][ T44] ? napi_enable (net/core/dev.c:7616) [ 615.781950][ T44] napi_enable (net/core/dev.c:7616) [ 615.782088][ 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:3480 (discriminator 1)) [ 615.782271][ T44] ? queue_delayed_work_on (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/workqueue.c:2565) [ 615.782457][ T44] virtnet_rx_resume_all (drivers/net/virtio_net.c:3491 (discriminator 1)) [ 615.782634][ T44] virtnet_xdp_set (drivers/net/virtio_net.c:6139 (discriminator 1)) [ 615.782825][ T44] ? virtnet_xdp_set (drivers/net/virtio_net.c:6166) [ 615.783010][ T44] dev_xdp_install (net/core/dev.c:10312) [ 615.783201][ T44] ? netif_skb_check_for_xdp (net/core/dev.c:10280) [ 615.783389][ T44] dev_xdp_attach (net/core/dev.c:10468) [ 615.783949][ T44] ? bpf_xdp_link_update (net/core/dev.c:10358) [ 615.784146][ T44] ? __bpf_prog_get (kernel/bpf/syscall.c:2629) [ 615.784336][ T44] dev_change_xdp_fd (net/core/dev.c:10722) [ 615.784519][ T44] do_setlink.isra.0 (net/core/rtnetlink.c:3392) [ 615.784701][ T44] ? rtnl_newlink_create (net/core/rtnetlink.c:3036) [ 615.784888][ T44] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4032 (discriminator 2) kernel/rcu/tree.c:4024 (discriminator 2)) [ 615.785114][ T44] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 615.785303][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 615.785489][ T44] ? rcu_read_lock_any_held (./include/linux/lockdep.h:249 kernel/rcu/update.c:388 kernel/rcu/update.c:380) [ 615.785700][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 615.785884][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.786094][ T44] ? trace_lock_acquire (./include/trace/events/lock.h:24 (discriminator 33)) [ 615.786280][ T44] ? perf_trace_sched_switch (kernel/sched/core.c:8882) [ 615.786465][ T44] ? lock_acquire (kernel/locking/lockdep.c:5833) [ 615.786649][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 615.786829][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.787019][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.787205][ T44] ? trace_contention_end (./include/trace/events/lock.h:122 (discriminator 33)) [ 615.787381][ T44] ? rtnl_newlink (net/core/rtnetlink.c:343 (discriminator 1) net/core/rtnetlink.c:4071 (discriminator 1)) [ 615.787560][ T44] ? __mutex_lock (kernel/locking/mutex.c:608 (discriminator 3) kernel/locking/mutex.c:760 (discriminator 3)) [ 615.787749][ T44] ? ww_mutex_lock (kernel/locking/mutex.c:759) [ 615.787933][ T44] ? nla_validate_int_range (lib/nlattr.c:396) [ 615.788110][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3922) [ 615.788307][ T44] rtnl_newlink (net/core/rtnetlink.c:351 (discriminator 1) net/core/rtnetlink.c:4073 (discriminator 1)) [ 615.788496][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 615.788676][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.788848][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.789032][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 615.789226][ T44] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 615.789418][ T44] ? __rtnl_newlink (net/core/rtnetlink.c:3963) [ 615.789606][ T44] rtnetlink_rcv_msg (net/core/rtnetlink.c:6958) [ 615.789783][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 615.789971][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.790154][ T44] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 615.790338][ T44] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 615.790522][ T44] netlink_rcv_skb (net/netlink/af_netlink.c:2550) [ 615.790698][ T44] ? rtnl_port_fill (net/core/rtnetlink.c:6861) [ 615.790877][ T44] ? netlink_ack (net/netlink/af_netlink.c:2527) [ 615.791071][ T44] ? netlink_deliver_tap (./include/linux/rcupdate.h:341 (discriminator 1) ./include/linux/rcupdate.h:897 (discriminator 1) net/netlink/af_netlink.c:340 (discriminator 1)) [ 615.791274][ T44] netlink_unicast (net/netlink/af_netlink.c:1319 net/netlink/af_netlink.c:1344) [ 615.791463][ T44] ? netlink_attachskb (net/netlink/af_netlink.c:1329) [ 615.791646][ T44] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 615.791831][ T44] netlink_sendmsg (net/netlink/af_netlink.c:1894) [ 615.792016][ T44] ? netlink_unicast (net/netlink/af_netlink.c:1813) [ 615.792213][ T44] ? __might_fault (mm/memory.c:7099 (discriminator 4)) [ 615.792394][ T44] ____sys_sendmsg (net/socket.c:727 (discriminator 4) net/socket.c:742 (discriminator 4) net/socket.c:2630 (discriminator 4)) [ 615.792566][ T44] ? copy_msghdr_from_user (net/socket.c:2570) [ 615.792747][ T44] ? get_timestamp.constprop.0 (net/socket.c:2576) [ 615.792967][ T44] ? move_addr_to_kernel (net/socket.c:2556) [ 615.793151][ T44] ? stack_depot_save_flags (lib/stackdepot.c:601 (discriminator 4) lib/stackdepot.c:668 (discriminator 4)) [ 615.793341][ T44] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 615.793532][ T44] ___sys_sendmsg (net/socket.c:2686) [ 615.793719][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:127 kernel/rcu/tree.c:3125) [ 615.793958][ T44] ? copy_msghdr_from_user (net/socket.c:2673) [ 615.794187][ T44] __sys_sendmsg (net/socket.c:2716 (discriminator 1)) [ 615.794379][ T44] ? __sys_sendmsg_sock (net/socket.c:2701) [ 615.794571][ T44] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 615.794760][ T44] ? __call_rcu_common.constprop.0 (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 kernel/rcu/tree.c:3148) [ 615.795002][ T44] ? do_raw_spin_unlock (./arch/x86/include/asm/atomic.h:23 ./include/linux/atomic/atomic-arch-fallback.h:457 ./include/linux/atomic/atomic-instrumented.h:33 ./include/asm-generic/qspinlock.h:57 kernel/locking/spinlock_debug.c:101 kernel/locking/spinlock_debug.c:141) [ 615.795205][ T44] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:751 (discriminator 1)) [ 615.795396][ T44] do_syscall_64 (arch/x86/entry/syscall_64.c:63 (discriminator 1) arch/x86/entry/syscall_64.c:94 (discriminator 1)) [ 615.795592][ T44] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:130) [ 615.795830][ T44] RIP: 0033:0x7fad7ae37c5e [ 615.796037][ T44] RSP: 002b:00007fff9df66b90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 615.796323][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fad7ae37c5e [ 615.796599][ T44] RDX: 0000000000000000 RSI: 00007fff9df66c50 RDI: 0000000000000003 [ 615.796893][ T44] RBP: 00007fff9df66ba0 R08: 0000000000000000 R09: 0000000000000000 [ 615.797185][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fff9df67310 Finger prints: __schedule:schedule:schedule_preempt_disabled:__mutex_lock:napi_enable