[ 954.184807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 264704 ms [ 954.185214][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 264704000 usecs ago [ 959.304808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 269824 ms [ 959.305260][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 269824000 usecs ago [ 964.424807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 274944 ms [ 964.425311][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 274944000 usecs ago [ 970.568807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 281088 ms [ 970.569250][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 281088000 usecs ago [ 976.200808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 286720 ms [ 976.201207][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 286720000 usecs ago [ 981.320807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 291840 ms [ 981.321243][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 291840000 usecs ago [ 984.391818][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 984.392090][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 984.392231][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.392459][ T44] task:kworker/u16:0 state:D stack:26160 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.392771][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 984.392951][ T44] Call Trace: [ 984.393043][ T44] [ 984.393110][ T44] __schedule+0xae2/0x1720 [ 984.393241][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.393362][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.393481][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.393600][ T44] schedule+0xd4/0x260 [ 984.393690][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.393814][ T44] __mutex_lock+0xd76/0x1f20 [ 984.393938][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.394051][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.394174][ T44] ? process_one_work+0xd16/0x1390 [ 984.394290][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.394405][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.394521][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.394633][ T44] addrconf_verify_work+0x12/0x30 [ 984.394750][ T44] process_one_work+0xd57/0x1390 [ 984.394871][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.394984][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.395098][ T44] ? assign_work+0x152/0x380 [ 984.395216][ T44] worker_thread+0x4d6/0xd40 [ 984.395334][ T44] ? process_one_work+0x1390/0x1390 [ 984.395447][ T44] kthread+0x355/0x5b0 [ 984.395534][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.395649][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.395761][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.395880][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.395994][ T44] ret_from_fork+0x3fb/0x510 [ 984.396109][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.396252][ T44] ? __switch_to+0x53c/0xd00 [ 984.396367][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.396484][ T44] ret_from_fork_asm+0x11/0x20 [ 984.396604][ T44] [ 984.396708][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5791. [ 984.396921][ T44] INFO: task ip:5791 blocked for more than 368 seconds. [ 984.397052][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 984.397165][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.397349][ T44] task:ip state:D stack:25520 pid:5791 tgid:5791 ppid:1 task_flags:0x400100 flags:0x00080002 [ 984.397597][ T44] Call Trace: [ 984.397681][ T44] [ 984.397740][ T44] __schedule+0xae2/0x1720 [ 984.397864][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.397979][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.398093][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.398212][ T44] schedule+0xd4/0x260 [ 984.398299][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.398413][ T44] __mutex_lock+0xd76/0x1f20 [ 984.398527][ T44] ? __folio_put+0x1f5/0x320 [ 984.398643][ T44] ? napi_enable+0x3b/0x80 [ 984.398760][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.398879][ T44] ? dma_map_phys+0x1b1/0x220 [ 984.398996][ T44] ? __asan_memset+0x27/0x50 [ 984.399111][ T44] ? sg_init_table+0x19/0x60 [ 984.399230][ T44] ? try_fill_recv+0x3ec/0x1750 [ 984.399348][ T44] ? napi_enable+0x3b/0x80 [ 984.399464][ T44] napi_enable+0x3b/0x80 [ 984.399550][ T44] __virtnet_rx_resume+0x156/0x290 [ 984.399665][ T44] ? queue_delayed_work_on+0x91/0x100 [ 984.399781][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 984.399906][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 984.400025][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 984.400141][ T44] dev_xdp_install+0x3e4/0x890 [ 984.400257][ T44] ? netif_set_xps_queue+0x40/0x40 [ 984.400375][ T44] dev_xdp_attach+0x50d/0x1310 [ 984.400493][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 984.400608][ T44] ? __bpf_prog_get+0x320/0x320 [ 984.400728][ T44] dev_change_xdp_fd+0x176/0x210 [ 984.400854][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 984.400971][ T44] ? rtnl_newlink_create+0x900/0x900 [ 984.401085][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 984.401232][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.401347][ T44] ? validate_chain+0x37b/0xb70 [ 984.401461][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 984.401576][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.401693][ T44] ? __lock_acquire+0x577/0xc10 [ 984.401813][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.401928][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.402040][ T44] ? lock_acquire+0x10a/0x150 [ 984.402158][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.402270][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.402386][ T44] ? trace_contention_end+0xd6/0x110 [ 984.402501][ T44] ? __mutex_lock+0x285/0x1f20 [ 984.402616][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.402730][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.402849][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 984.402969][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 984.403088][ T44] rtnl_newlink+0x75c/0xe90 [ 984.403210][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.403324][ T44] ? rtnl_setlink+0x880/0x880 [ 984.403437][ T44] ? __lock_acquire+0x577/0xc10 [ 984.403556][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.403670][ T44] ? find_held_lock+0x2b/0x80 [ 984.403785][ T44] ? rtnl_setlink+0x880/0x880 [ 984.403903][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.404017][ T44] ? rtnl_setlink+0x880/0x880 [ 984.404136][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 984.404251][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.404364][ T44] ? __lock_acquire+0x577/0xc10 [ 984.404484][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.404596][ T44] ? find_held_lock+0x2b/0x80 [ 984.404714][ T44] netlink_rcv_skb+0x123/0x380 [ 984.404838][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.404952][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.405070][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 984.405186][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.405302][ T44] netlink_unicast+0x4a3/0x770 [ 984.405418][ T44] ? netlink_attachskb+0x810/0x810 [ 984.405530][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.405643][ T44] ? __lock_acquire+0x577/0xc10 [ 984.405756][ T44] netlink_sendmsg+0x735/0xc60 [ 984.405877][ T44] ? netlink_unicast+0x770/0x770 [ 984.405993][ T44] ____sys_sendmsg+0x419/0x850 [ 984.406108][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.406226][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.406366][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.406481][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.406594][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.406711][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.406830][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 984.406970][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.407102][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.407221][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.407334][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.407447][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 984.407593][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 984.407706][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.407827][ T44] do_syscall_64+0xbd/0xfc0 [ 984.407941][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.408083][ T44] RIP: 0033:0x7f07906b1c5e [ 984.408206][ T44] RSP: 002b:00007ffe35684590 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.408384][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f07906b1c5e [ 984.408556][ T44] RDX: 0000000000000000 RSI: 00007ffe35684650 RDI: 0000000000000003 [ 984.408729][ T44] RBP: 00007ffe356845a0 R08: 0000000000000000 R09: 0000000000000000 [ 984.408911][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffe35684d10 [ 984.409085][ T44] R13: 00000000694c139d R14: 0000000000000000 R15: 0000000000499600 [ 984.409266][ T44] [ 984.409355][ T44] INFO: task ip:5791 is blocked on a mutex likely owned by task kworker/3:1:52. [ 984.409542][ T44] task:kworker/3:1 state:D stack:28064 pid:52 tgid:52 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.409789][ T44] Workqueue: events refill_work [ 984.409908][ T44] Call Trace: [ 984.409998][ T44] [ 984.410059][ T44] __schedule+0xae2/0x1720 [ 984.410177][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.410290][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.410410][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.410526][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.410638][ T44] schedule+0xd4/0x260 [ 984.410727][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 984.410873][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 984.410989][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 984.411104][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.411220][ T44] ? ktime_get+0x15e/0x220 [ 984.411333][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 984.411447][ T44] ? ktime_get+0xa9/0x220 [ 984.411537][ T44] usleep_range_state+0x133/0x1b0 [ 984.411651][ T44] ? schedule_hrtimeout+0x20/0x20 [ 984.411766][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 984.411885][ T44] ? refill_work+0x149/0x210 [ 984.412001][ T44] napi_disable_locked+0x379/0x5f0 [ 984.412113][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 984.412229][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 984.412374][ T44] napi_disable+0x43/0x80 [ 984.412461][ T44] refill_work+0x116/0x210 [ 984.412577][ T44] process_one_work+0xd57/0x1390 [ 984.412693][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.412814][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.412930][ T44] ? assign_work+0x152/0x380 [ 984.413045][ T44] worker_thread+0x4d6/0xd40 [ 984.413167][ T44] ? process_one_work+0x1390/0x1390 [ 984.413282][ T44] ? __kthread_parkme+0xb3/0x200 [ 984.413398][ T44] ? process_one_work+0x1390/0x1390 [ 984.413512][ T44] kthread+0x355/0x5b0 [ 984.413598][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.413712][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.413830][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.413942][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.414059][ T44] ret_from_fork+0x3fb/0x510 [ 984.414175][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.414317][ T44] ? __switch_to+0x53c/0xd00 [ 984.414430][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.414544][ T44] ret_from_fork_asm+0x11/0x20 [ 984.414663][ T44] [ 984.414758][ T44] [ 984.414758][ T44] Showing all locks held in the system: [ 984.415023][ T44] 3 locks held by kworker/u16:0/12: [ 984.415139][ T44] #0: ff1100000907f148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.415362][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.415634][ T44] #2: ffffffff95685768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 984.415838][ T44] 1 lock held by khungtaskd/44: [ 984.415949][ T44] #0: ffffffff94f71040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 984.416173][ T44] 3 locks held by kworker/3:1/52: [ 984.416283][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.416502][ T44] #1: ffa000000038fcc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.416750][ T44] #2: ff11000008a62c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 984.416950][ T44] 3 locks held by kworker/2:3/1415: [ 984.417059][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.417280][ T44] #1: ffa0000000b17cc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.417502][ T44] #2: ffffffff95685768 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 984.417700][ T44] 2 locks held by ip/5791: [ 984.417818][ T44] #0: ffffffff95685768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 984.418010][ T44] #1: ff11000008a62c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 984.418209][ T44] 1 lock held by xdp_helper/5799: [ 984.418317][ T44] #0: ffffffff95685768 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10 [ 984.418513][ T44] [ 984.418570][ T44] ============================================= [ 984.418570][ T44] [ 987.464808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 297984 ms [ 987.465258][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 297984000 usecs ago [ 993.096808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 303616 ms [ 993.097252][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 303616000 usecs ago [ 998.216808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 308736 ms [ 998.217234][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 308736000 usecs ago [ 1003.336807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 313856 ms [ 1003.337243][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 313856000 usecs ago [ 1009.480808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 320000 ms [ 1009.481238][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 320000000 usecs ago [ 1015.112807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 325632 ms [ 1015.113252][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 325632000 usecs ago [ 1020.232807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 330752 ms [ 1020.233259][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 330752000 usecs ago [ 1025.352807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 335872 ms [ 1025.353239][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 335872000 usecs ago [ 1031.496808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 342016 ms [ 1031.497252][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 342016000 usecs ago [ 1037.128807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 347648 ms [ 1037.129303][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 347648000 usecs ago [ 1042.248808][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 352768 ms [ 1042.249242][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 352768000 usecs ago [ 1047.368807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 357888 ms [ 1047.369230][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 357888000 usecs ago [ 1053.512807][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 364032 ms [ 1053.513254][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 364032000 usecs ago