[ 492.863074][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 492.863431][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 492.863626][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.863909][ T44] task:kworker/u16:0 state:D stack:27776 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.864284][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 492.864500][ T44] Call Trace: [ 492.864641][ T44] [ 492.864754][ T44] __schedule+0xae2/0x1720 [ 492.864936][ T44] ? io_schedule_timeout+0x130/0x130 [ 492.865127][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.865309][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.865478][ T44] schedule+0xd4/0x260 [ 492.865619][ T44] schedule_preempt_disabled+0x18/0x30 [ 492.865793][ T44] __mutex_lock+0xd76/0x1f20 [ 492.865963][ T44] ? addrconf_verify_work+0x12/0x30 [ 492.866151][ T44] ? ww_mutex_lock+0x160/0x160 [ 492.866332][ T44] ? process_one_work+0xd16/0x1390 [ 492.866501][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.866665][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.866831][ T44] ? addrconf_verify_work+0x12/0x30 [ 492.866995][ T44] addrconf_verify_work+0x12/0x30 [ 492.867175][ T44] process_one_work+0xd57/0x1390 [ 492.867355][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 492.867521][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 492.867689][ T44] ? assign_work+0x152/0x380 [ 492.867854][ T44] worker_thread+0x4d6/0xd40 [ 492.868024][ T44] ? process_one_work+0x1390/0x1390 [ 492.868198][ T44] kthread+0x355/0x5b0 [ 492.868342][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 492.868505][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.868672][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.868837][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 492.869003][ T44] ret_from_fork+0x3fb/0x510 [ 492.869185][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 492.869387][ T44] ? __switch_to+0x53c/0xd00 [ 492.869552][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 492.869719][ T44] ret_from_fork_asm+0x11/0x20 [ 492.869894][ T44] [ 492.870041][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:586. [ 492.870309][ T44] INFO: task ip:586 blocked for more than 368 seconds. [ 492.870491][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 492.870645][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 492.870876][ T44] task:ip state:D stack:24976 pid:586 tgid:586 ppid:1 task_flags:0x400100 flags:0x00080002 [ 492.871188][ T44] Call Trace: [ 492.871328][ T44] [ 492.871436][ T44] __schedule+0xae2/0x1720 [ 492.871606][ T44] ? io_schedule_timeout+0x130/0x130 [ 492.871771][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.871934][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.872114][ T44] schedule+0xd4/0x260 [ 492.872252][ T44] schedule_preempt_disabled+0x18/0x30 [ 492.872422][ T44] __mutex_lock+0xd76/0x1f20 [ 492.872587][ T44] ? napi_enable+0x3b/0x80 [ 492.872755][ T44] ? ww_mutex_lock+0x160/0x160 [ 492.872918][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.873097][ T44] ? __asan_memset+0x27/0x50 [ 492.873262][ T44] ? sg_init_table+0x19/0x60 [ 492.873437][ T44] ? try_fill_recv+0x3ec/0x1750 [ 492.873606][ T44] ? napi_enable+0x3b/0x80 [ 492.873770][ T44] napi_enable+0x3b/0x80 [ 492.873908][ T44] __virtnet_rx_resume+0x156/0x290 [ 492.874084][ T44] ? queue_delayed_work_on+0x91/0x100 [ 492.874250][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 492.874425][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 492.874597][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 492.874761][ T44] dev_xdp_install+0x3e4/0x890 [ 492.874929][ T44] ? netif_set_xps_queue+0x40/0x40 [ 492.875111][ T44] dev_xdp_attach+0x50d/0x1310 [ 492.875278][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 492.875451][ T44] ? __bpf_prog_get+0x320/0x320 [ 492.875618][ T44] dev_change_xdp_fd+0x176/0x210 [ 492.875783][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 492.875952][ T44] ? rtnl_newlink_create+0x900/0x900 [ 492.876129][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 492.876326][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 492.876489][ T44] ? validate_chain+0x37b/0xb70 [ 492.876652][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 492.876813][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 492.876981][ T44] ? __lock_acquire+0x577/0xc10 [ 492.877161][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 492.877330][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 492.877493][ T44] ? lock_acquire+0x10a/0x150 [ 492.877655][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.877817][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.877981][ T44] ? trace_contention_end+0xd6/0x110 [ 492.878161][ T44] ? __mutex_lock+0x285/0x1f20 [ 492.878337][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 492.878504][ T44] ? ww_mutex_lock+0x160/0x160 [ 492.878669][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 492.878837][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 492.879005][ T44] rtnl_newlink+0x75c/0xe90 [ 492.879186][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.879358][ T44] ? rtnl_setlink+0x880/0x880 [ 492.879527][ T44] ? __lock_acquire+0x577/0xc10 [ 492.879694][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 492.879858][ T44] ? find_held_lock+0x2b/0x80 [ 492.880022][ T44] ? rtnl_setlink+0x880/0x880 [ 492.880195][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.880368][ T44] ? rtnl_setlink+0x880/0x880 [ 492.880532][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 492.880697][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 492.880862][ T44] ? __lock_acquire+0x577/0xc10 [ 492.881029][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 492.881202][ T44] ? find_held_lock+0x2b/0x80 [ 492.881372][ T44] netlink_rcv_skb+0x123/0x380 [ 492.881539][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 492.881705][ T44] ? netlink_ack+0xcc0/0xcc0 [ 492.881874][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 492.882036][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 492.882218][ T44] netlink_unicast+0x4a3/0x770 [ 492.882393][ T44] ? netlink_attachskb+0x810/0x810 [ 492.882557][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 492.882721][ T44] ? __lock_acquire+0x577/0xc10 [ 492.882886][ T44] netlink_sendmsg+0x735/0xc60 [ 492.883052][ T44] ? netlink_unicast+0x770/0x770 [ 492.883235][ T44] ____sys_sendmsg+0x419/0x850 [ 492.883405][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 492.883572][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 492.883764][ T44] ? move_addr_to_kernel+0x40/0x40 [ 492.883931][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 492.884106][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 492.884272][ T44] ___sys_sendmsg+0xfd/0x180 [ 492.884438][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 492.884635][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 492.884812][ T44] __sys_sendmsg+0x124/0x1c0 [ 492.884976][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 492.885155][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 492.885324][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 492.885524][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 492.885694][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.885860][ T44] do_syscall_64+0xbd/0xfc0 [ 492.886028][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 492.886233][ T44] RIP: 0033:0x7fe86e1afc5e [ 492.886407][ T44] RSP: 002b:00007ffd5d573480 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 492.886631][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fe86e1afc5e [ 492.886855][ T44] RDX: 0000000000000000 RSI: 00007ffd5d573540 RDI: 0000000000000003 [ 492.887091][ T44] RBP: 00007ffd5d573490 R08: 0000000000000000 R09: 0000000000000000 [ 492.887315][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd5d573c00 [ 492.887536][ T44] R13: 00000000694abdda R14: 0000000000000000 R15: 0000000000499600 [ 492.887763][ T44] [ 492.887903][ T44] INFO: task ip:586 is blocked on a mutex likely owned by task kworker/3:0:33. [ 492.888155][ T44] task:kworker/3:0 state:D stack:28624 pid:33 tgid:33 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 492.888464][ T44] Workqueue: events refill_work [ 492.888627][ T44] Call Trace: [ 492.888761][ T44] [ 492.888870][ T44] __schedule+0xae2/0x1720 [ 492.889042][ T44] ? usleep_range_state+0xba/0x1b0 [ 492.889221][ T44] ? io_schedule_timeout+0x130/0x130 [ 492.889395][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.889562][ T44] ? usleep_range_state+0xba/0x1b0 [ 492.889724][ T44] schedule+0xd4/0x260 [ 492.889862][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 492.890071][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 492.890238][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 492.890407][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 492.890569][ T44] ? ktime_get+0x15e/0x220 [ 492.890732][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 492.890894][ T44] ? ktime_get+0xa9/0x220 [ 492.891032][ T44] usleep_range_state+0x133/0x1b0 [ 492.891213][ T44] ? schedule_hrtimeout+0x20/0x20 [ 492.891388][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 492.891553][ T44] ? refill_work+0x149/0x210 [ 492.891719][ T44] napi_disable_locked+0x379/0x5f0 [ 492.891882][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 492.892045][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 492.892253][ T44] napi_disable+0x43/0x80 [ 492.892396][ T44] refill_work+0x116/0x210 [ 492.892565][ T44] process_one_work+0xd57/0x1390 [ 492.892734][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 492.892897][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 492.893076][ T44] ? assign_work+0x152/0x380 [ 492.893241][ T44] worker_thread+0x4d6/0xd40 [ 492.893417][ T44] ? process_one_work+0x1390/0x1390 [ 492.893580][ T44] kthread+0x355/0x5b0 [ 492.893720][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 492.893886][ T44] ? __lock_release.isra.0+0x59/0x170 [ 492.894050][ T44] ? rcu_is_watching+0x15/0xd0 [ 492.894228][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 492.894400][ T44] ret_from_fork+0x3fb/0x510 [ 492.894564][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 492.894755][ T44] ? __switch_to+0x53c/0xd00 [ 492.894921][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 492.895102][ T44] ret_from_fork_asm+0x11/0x20 [ 492.895274][ T44] [ 492.895419][ T44] [ 492.895419][ T44] Showing all locks held in the system: [ 492.895633][ T44] 3 locks held by kworker/u16:0/12: [ 492.895791][ T44] #0: ff110000090f7148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 492.896160][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 492.896494][ T44] #2: ffffffff85a85768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 492.896740][ T44] 3 locks held by kworker/3:0/33: [ 492.896896][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 492.897182][ T44] #1: ffa0000000257cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 492.897486][ T44] #2: ff11000008b72c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 492.897734][ T44] 1 lock held by khungtaskd/44: [ 492.897889][ T44] #0: ffffffff85371040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 492.898178][ T44] 3 locks held by kworker/2:1/51: [ 492.898342][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 492.898612][ T44] #1: ffa000000037fcc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 492.898880][ T44] #2: ffffffff85a85768 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 492.899140][ T44] 2 locks held by ip/586: [ 492.899271][ T44] #0: ffffffff85a85768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 492.899521][ T44] #1: ff11000008b72c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 492.899768][ T44] 1 lock held by xdp_helper/595: [ 492.899925][ T44] #0: ffffffff85a85768 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10 [ 492.900185][ T44] [ 492.900291][ T44] ============================================= [ 492.900291][ T44]