[ 984.387826][ T44] INFO: task kworker/u16:1:69 blocked for more than 245 seconds. [ 984.388236][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 984.388464][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.388760][ T44] task:kworker/u16:1 state:D stack:26496 pid:69 tgid:69 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.389170][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 984.389400][ T44] Call Trace: [ 984.389551][ T44] [ 984.389679][ T44] __schedule+0x88d/0x1b90 [ 984.389897][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.390093][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.390284][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.390471][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.390648][ T44] schedule+0xd4/0x260 [ 984.390815][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.390999][ T44] __mutex_lock+0x9ae/0x1500 [ 984.391172][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.391346][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.391517][ T44] ? process_one_work+0xd16/0x1390 [ 984.391686][ T44] ? trace_lock_acquire+0x88/0xd0 [ 984.391866][ T44] ? trace_lock_acquire+0x88/0xd0 [ 984.392034][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.392195][ T44] addrconf_verify_work+0x12/0x30 [ 984.392377][ T44] process_one_work+0xd57/0x1390 [ 984.392548][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.392714][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.392894][ T44] ? assign_work+0x152/0x380 [ 984.393060][ T44] worker_thread+0x4d6/0xd40 [ 984.393227][ T44] ? process_one_work+0x1390/0x1390 [ 984.393399][ T44] ? __kthread_parkme+0xb3/0x200 [ 984.393572][ T44] ? process_one_work+0x1390/0x1390 [ 984.393735][ T44] kthread+0x355/0x5b0 [ 984.393887][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.394053][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.394219][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.394388][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.394554][ T44] ret_from_fork+0x1d4/0x270 [ 984.394719][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.394904][ T44] ret_from_fork_asm+0x11/0x20 [ 984.395077][ T44] [ 984.395244][ T44] INFO: task kworker/u16:1:69 is blocked on a mutex likely owned by task ip:5782. [ 984.395498][ T44] INFO: task ip:5782 blocked for more than 368 seconds. [ 984.395678][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 984.395848][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.396090][ T44] task:ip state:D stack:24984 pid:5782 tgid:5782 ppid:1 task_flags:0x400100 flags:0x00080003 [ 984.396400][ T44] Call Trace: [ 984.396533][ T44] [ 984.396641][ T44] __schedule+0x88d/0x1b90 [ 984.396825][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.396991][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.397163][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.397337][ T44] schedule+0xd4/0x260 [ 984.397474][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.397637][ T44] __mutex_lock+0x9ae/0x1500 [ 984.397817][ T44] ? napi_enable+0x3b/0x80 [ 984.397984][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850 [ 984.398179][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.398350][ T44] ? __asan_memset+0x27/0x50 [ 984.398524][ T44] ? sg_init_table+0x19/0x60 [ 984.398693][ T44] ? try_fill_recv+0x3ec/0x1750 [ 984.398877][ T44] ? napi_enable+0x3b/0x80 [ 984.399042][ T44] napi_enable+0x3b/0x80 [ 984.399179][ T44] __virtnet_rx_resume+0x156/0x290 [ 984.399349][ T44] ? queue_delayed_work_on+0x91/0x100 [ 984.399516][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 984.399689][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 984.399869][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 984.400033][ T44] dev_xdp_install+0x3e4/0x8e0 [ 984.400202][ T44] ? netif_skb_check_for_xdp+0x600/0x600 [ 984.400378][ T44] dev_xdp_attach+0x50d/0x1320 [ 984.400547][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 984.400711][ T44] ? __bpf_prog_get+0x320/0x320 [ 984.400897][ T44] dev_change_xdp_fd+0x182/0x240 [ 984.401065][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 984.401233][ T44] ? rtnl_newlink_create+0x900/0x900 [ 984.401405][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0 [ 984.401599][ T44] ? rcu_read_lock_any_held+0x41/0xa0 [ 984.401763][ T44] ? validate_chain+0x287/0x5f0 [ 984.401943][ T44] ? rcu_read_lock_any_held+0x6b/0xa0 [ 984.402112][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 984.402279][ T44] ? __lock_acquire+0x34c/0x740 [ 984.402452][ T44] ? trace_lock_acquire+0x88/0xd0 [ 984.402614][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 984.402777][ T44] ? lock_acquire+0x31/0x80 [ 984.402955][ T44] ? rtnl_newlink+0x5df/0xb20 [ 984.403119][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.403283][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.403458][ T44] ? trace_contention_end+0xd6/0x140 [ 984.403623][ T44] ? rtnl_newlink+0x5df/0xb20 [ 984.403802][ T44] ? __mutex_lock+0x32e/0x1500 [ 984.403970][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.404134][ T44] ? nla_validate_int_range+0x5b0/0x5b0 [ 984.404303][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 984.404478][ T44] rtnl_newlink+0x637/0xb20 [ 984.404653][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 984.404834][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.404998][ T44] ? find_held_lock+0x2b/0x80 [ 984.405161][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 984.405331][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.405496][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 984.405660][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 984.405838][ T44] ? rtnl_port_fill+0x940/0x940 [ 984.406009][ T44] ? __lock_acquire+0x34c/0x740 [ 984.406177][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.406346][ T44] ? find_held_lock+0x2b/0x80 [ 984.406512][ T44] netlink_rcv_skb+0x123/0x380 [ 984.406679][ T44] ? rtnl_port_fill+0x940/0x940 [ 984.406858][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.407026][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.407192][ T44] netlink_unicast+0x4a3/0x770 [ 984.407367][ T44] ? netlink_attachskb+0x810/0x810 [ 984.407533][ T44] ? __lock_acquire+0x34c/0x740 [ 984.407699][ T44] netlink_sendmsg+0x735/0xc60 [ 984.407880][ T44] ? netlink_unicast+0x770/0x770 [ 984.408045][ T44] ? __might_fault+0x97/0x140 [ 984.408215][ T44] ____sys_sendmsg+0x419/0x850 [ 984.408392][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.408563][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.408753][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.408927][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 984.409091][ T44] ? validate_chain+0x287/0x5f0 [ 984.409256][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.409424][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680 [ 984.409619][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.409815][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.409980][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.410143][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.410306][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680 [ 984.410507][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 984.410671][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.410850][ T44] do_syscall_64+0xbb/0xfd0 [ 984.411021][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.411212][ T44] RIP: 0033:0x7fe364c44c5e [ 984.411388][ T44] RSP: 002b:00007ffd894046a0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.411611][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fe364c44c5e [ 984.411846][ T44] RDX: 0000000000000000 RSI: 00007ffd89404760 RDI: 0000000000000003 [ 984.412070][ T44] RBP: 00007ffd894046b0 R08: 0000000000000000 R09: 0000000000000000 [ 984.412289][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd89404e20 [ 984.412510][ T44] R13: 00000000692f13af R14: 0000000000000000 R15: 0000000000499600 [ 984.412736][ T44] [ 984.412904][ T44] INFO: task ip:5782 is blocked on a mutex likely owned by task kworker/0:3:626. [ 984.413149][ T44] task:kworker/0:3 state:D stack:28240 pid:626 tgid:626 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.413459][ T44] Workqueue: events refill_work [ 984.413625][ T44] Call Trace: [ 984.413758][ T44] [ 984.413878][ T44] __schedule+0x88d/0x1b90 [ 984.414048][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.414214][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.414389][ T44] ? find_held_lock+0x2b/0x80 [ 984.414554][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.414720][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.414895][ T44] schedule+0xd4/0x260 [ 984.415035][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 984.415228][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 984.415399][ T44] ? hrtimer_cb_get_time+0x90/0x90 [ 984.415572][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.415736][ T44] ? ktime_get+0x15e/0x220 [ 984.415915][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 984.416079][ T44] ? ktime_get+0xa9/0x220 [ 984.416216][ T44] usleep_range_state+0x133/0x1b0 [ 984.416389][ T44] ? schedule_hrtimeout+0x20/0x20 [ 984.416553][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 984.416725][ T44] napi_disable_locked+0x379/0x5f0 [ 984.416906][ T44] ? _mutex_trylock_nest_lock+0x150/0x150 [ 984.417075][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470 [ 984.417269][ T44] napi_disable+0x43/0x80 [ 984.417413][ T44] refill_work+0x116/0x210 [ 984.417582][ T44] process_one_work+0xd57/0x1390 [ 984.417753][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.417933][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.418101][ T44] ? assign_work+0x152/0x380 [ 984.418268][ T44] worker_thread+0x4d6/0xd40 [ 984.418441][ T44] ? process_one_work+0x1390/0x1390 [ 984.418605][ T44] ? __kthread_parkme+0xb3/0x200 [ 984.418771][ T44] ? process_one_work+0x1390/0x1390 [ 984.418951][ T44] kthread+0x355/0x5b0 [ 984.419093][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.419260][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.419433][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.419597][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.419763][ T44] ret_from_fork+0x1d4/0x270 [ 984.419941][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.420108][ T44] ret_from_fork_asm+0x11/0x20 [ 984.420280][ T44] [ 984.420429][ T44] [ 984.420429][ T44] Showing all locks held in the system: [ 984.420650][ T44] 1 lock held by khungtaskd/44: [ 984.420826][ T44] #0: ffffffffbb178fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db [ 984.421078][ T44] 3 locks held by kworker/u16:1/69: [ 984.421236][ T44] #0: ff110000093bcd48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.421517][ T44] #1: ffa00000004a7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.421858][ T44] #2: ffffffffbb8925e8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 984.422107][ T44] 3 locks held by kworker/0:3/626: [ 984.422265][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.422548][ T44] #1: ffa0000000b97d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.422859][ T44] #2: ff11000008d0ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 984.423111][ T44] 3 locks held by kworker/1:3/2728: [ 984.423270][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.423552][ T44] #1: ffa00000017b7d30 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.423835][ T44] #2: ffffffffbb8925e8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 984.424082][ T44] 2 locks held by ip/5782: [ 984.424240][ T44] #0: ffffffffbb8925e8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20 [ 984.424497][ T44] #1: ff11000008d0ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 984.424743][ T44] 1 lock held by xdp_helper/5791: [ 984.424914][ T44] #0: ffffffffbb8925e8 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10 [ 984.425257][ T44] [ 984.425367][ T44] ============================================= [ 984.425367][ T44]