[ 1046.376589][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 258559 ms [ 1046.377067][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 258559000 usecs ago [ 1052.520590][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 264703 ms [ 1052.521073][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 264703000 usecs ago [ 1058.152591][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 270335 ms [ 1058.153064][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 270335000 usecs ago [ 1063.272590][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 275455 ms [ 1063.273112][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 275455000 usecs ago [ 1068.392590][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 280575 ms [ 1068.393069][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 280575000 usecs ago [ 1074.536594][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 286719 ms [ 1074.537083][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 286719000 usecs ago [ 1080.168589][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 292351 ms [ 1080.169065][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 292351000 usecs ago [ 1085.288588][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 297471 ms [ 1085.289073][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 297471000 usecs ago [ 1090.408593][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 302591 ms [ 1090.409122][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 302591000 usecs ago [ 1096.552589][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 308735 ms [ 1096.553102][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 308735000 usecs ago [ 1102.184590][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 314367 ms [ 1102.185012][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 314367000 usecs ago [ 1107.304598][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 319487 ms [ 1107.305204][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 319487000 usecs ago [ 1107.305690][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 1107.306156][ T44] Not tainted 6.18.0-virtme #1 [ 1107.306360][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1107.306726][ T44] task:kworker/u16:0 state:D stack:26832 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 1107.307203][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 1107.307471][ T44] Call Trace: [ 1107.307679][ T44] [ 1107.307830][ T44] __schedule+0xae2/0x1720 [ 1107.308087][ T44] ? io_schedule_timeout+0x130/0x130 [ 1107.308323][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.308555][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.308799][ T44] schedule+0xd4/0x260 [ 1107.308995][ T44] schedule_preempt_disabled+0x18/0x30 [ 1107.309218][ T44] __mutex_lock+0xd76/0x1f20 [ 1107.309446][ T44] ? addrconf_verify_work+0x12/0x30 [ 1107.309700][ T44] ? ww_mutex_lock+0x160/0x160 [ 1107.309943][ T44] ? process_one_work+0xd16/0x1390 [ 1107.310182][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.310415][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.310662][ T44] ? addrconf_verify_work+0x12/0x30 [ 1107.310892][ T44] addrconf_verify_work+0x12/0x30 [ 1107.311135][ T44] process_one_work+0xd57/0x1390 [ 1107.311375][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 1107.311625][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 1107.311863][ T44] ? assign_work+0x152/0x380 [ 1107.312115][ T44] worker_thread+0x4d6/0xd40 [ 1107.312358][ T44] ? process_one_work+0x1390/0x1390 [ 1107.312607][ T44] kthread+0x355/0x5b0 [ 1107.312794][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 1107.313030][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.313266][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.313502][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 1107.313753][ T44] ret_from_fork+0x3fb/0x510 [ 1107.314005][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 1107.314282][ T44] ? __switch_to+0x602/0xd00 [ 1107.314513][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 1107.314767][ T44] ret_from_fork_asm+0x11/0x20 [ 1107.315020][ T44] [ 1107.315242][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:6029. [ 1107.315620][ T44] INFO: task ip:6029 blocked for more than 368 seconds. [ 1107.315879][ T44] Not tainted 6.18.0-virtme #1 [ 1107.316103][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1107.316436][ T44] task:ip state:D stack:25008 pid:6029 tgid:6029 ppid:1 task_flags:0x400100 flags:0x00080802 [ 1107.316885][ T44] Call Trace: [ 1107.317074][ T44] [ 1107.317222][ T44] __schedule+0xae2/0x1720 [ 1107.317455][ T44] ? io_schedule_timeout+0x130/0x130 [ 1107.317703][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.317932][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.318173][ T44] schedule+0xd4/0x260 [ 1107.318351][ T44] schedule_preempt_disabled+0x18/0x30 [ 1107.318594][ T44] __mutex_lock+0xd76/0x1f20 [ 1107.318830][ T44] ? napi_enable+0x3b/0x80 [ 1107.319074][ T44] ? ww_mutex_lock+0x160/0x160 [ 1107.319298][ T44] ? __asan_memset+0x27/0x50 [ 1107.319532][ T44] ? sg_init_table+0x19/0x60 [ 1107.319782][ T44] ? try_fill_recv+0x3ec/0x1750 [ 1107.320026][ T44] ? napi_enable+0x3b/0x80 [ 1107.320257][ T44] napi_enable+0x3b/0x80 [ 1107.320446][ T44] __virtnet_rx_resume+0x156/0x290 [ 1107.320703][ T44] ? queue_delayed_work_on+0x91/0x100 [ 1107.320939][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 1107.321180][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 1107.321419][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 1107.321667][ T44] dev_xdp_install+0x3e4/0x890 [ 1107.321899][ T44] ? alloc_netdev_dummy+0x30/0x30 [ 1107.322140][ T44] dev_xdp_attach+0x50d/0x1310 [ 1107.322377][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 1107.322626][ T44] ? __bpf_prog_get+0x320/0x320 [ 1107.322863][ T44] dev_change_xdp_fd+0x176/0x210 [ 1107.323112][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 1107.323350][ T44] ? rtnl_newlink_create+0x900/0x900 [ 1107.323602][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 1107.323875][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 1107.324126][ T44] ? validate_chain+0x30f/0x8e0 [ 1107.324361][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 1107.324608][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 1107.324844][ T44] ? __lock_acquire+0x577/0xc10 [ 1107.325090][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 1107.325324][ T44] ? rtnl_newlink+0x5f9/0xb40 [ 1107.325557][ T44] ? lock_acquire+0x10a/0x150 [ 1107.325815][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.326058][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.326294][ T44] ? trace_contention_end+0xd6/0x110 [ 1107.326531][ T44] ? __mutex_lock+0x285/0x1f20 [ 1107.326780][ T44] ? rtnl_newlink+0x5f9/0xb40 [ 1107.327023][ T44] ? ww_mutex_lock+0x160/0x160 [ 1107.327258][ T44] ? nla_validate_int_range+0x5b0/0x5b0 [ 1107.327497][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 1107.327760][ T44] rtnl_newlink+0x649/0xb40 [ 1107.327996][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.328219][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 1107.328454][ T44] ? __lock_acquire+0x577/0xc10 [ 1107.328703][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 1107.328929][ T44] ? find_held_lock+0x2b/0x80 [ 1107.329169][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 1107.329401][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.329656][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 1107.329896][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 1107.330138][ T44] ? rtnl_port_fill+0x940/0x940 [ 1107.330372][ T44] ? __lock_acquire+0x577/0xc10 [ 1107.330628][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 1107.330858][ T44] ? find_held_lock+0x2b/0x80 [ 1107.331113][ T44] netlink_rcv_skb+0x123/0x380 [ 1107.331369][ T44] ? rtnl_port_fill+0x940/0x940 [ 1107.331625][ T44] ? netlink_ack+0xcc0/0xcc0 [ 1107.331869][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 1107.332110][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 1107.332352][ T44] netlink_unicast+0x4a3/0x770 [ 1107.332596][ T44] ? netlink_attachskb+0x810/0x810 [ 1107.332813][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 1107.333058][ T44] ? __lock_acquire+0x577/0xc10 [ 1107.333286][ T44] netlink_sendmsg+0x735/0xc60 [ 1107.333516][ T44] ? netlink_unicast+0x770/0x770 [ 1107.333772][ T44] ____sys_sendmsg+0x419/0x850 [ 1107.334022][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 1107.334256][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 1107.334518][ T44] ? move_addr_to_kernel+0x40/0x40 [ 1107.334760][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 1107.334999][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 1107.335234][ T44] ___sys_sendmsg+0xfd/0x180 [ 1107.335452][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 1107.335716][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 1107.336000][ T44] __sys_sendmsg+0x124/0x1c0 [ 1107.336224][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 1107.336450][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 1107.336704][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 1107.336984][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 1107.337226][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.337457][ T44] do_syscall_64+0xbd/0xfc0 [ 1107.337708][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 1107.337983][ T44] RIP: 0033:0x7fca6ae83c5e [ 1107.338234][ T44] RSP: 002b:00007ffc61499a60 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 1107.338566][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fca6ae83c5e [ 1107.338903][ T44] RDX: 0000000000000000 RSI: 00007ffc61499b20 RDI: 0000000000000003 [ 1107.339234][ T44] RBP: 00007ffc61499a70 R08: 0000000000000000 R09: 0000000000000000 [ 1107.339558][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc6149a1e0 [ 1107.339903][ T44] R13: 00000000693cb235 R14: 0000000000000000 R15: 0000000000499600 [ 1107.340248][ T44] [ 1107.340447][ T44] INFO: task ip:6029 is blocked on a mutex likely owned by task kworker/3:2:68. [ 1107.340802][ T44] task:kworker/3:2 state:D stack:28112 pid:68 tgid:68 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 1107.341255][ T44] Workqueue: events refill_work [ 1107.341487][ T44] Call Trace: [ 1107.341691][ T44] [ 1107.341835][ T44] __schedule+0xae2/0x1720 [ 1107.342082][ T44] ? usleep_range_state+0xba/0x1b0 [ 1107.342317][ T44] ? io_schedule_timeout+0x130/0x130 [ 1107.342553][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.342804][ T44] ? usleep_range_state+0xba/0x1b0 [ 1107.343062][ T44] schedule+0xd4/0x260 [ 1107.343257][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 1107.343538][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 1107.343791][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 1107.344038][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 1107.344273][ T44] ? ktime_get+0x15e/0x220 [ 1107.344508][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 1107.344768][ T44] ? ktime_get+0xa9/0x220 [ 1107.344963][ T44] usleep_range_state+0x133/0x1b0 [ 1107.345208][ T44] ? schedule_hrtimeout+0x20/0x20 [ 1107.345443][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 1107.345691][ T44] ? refill_work+0x149/0x210 [ 1107.345923][ T44] napi_disable_locked+0x379/0x5f0 [ 1107.346165][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 1107.346402][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470 [ 1107.346695][ T44] napi_disable+0x43/0x80 [ 1107.346886][ T44] refill_work+0x116/0x210 [ 1107.347130][ T44] process_one_work+0xd57/0x1390 [ 1107.347374][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 1107.347629][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 1107.347863][ T44] ? assign_work+0x152/0x380 [ 1107.348110][ T44] worker_thread+0x4d6/0xd40 [ 1107.348344][ T44] ? process_one_work+0x1390/0x1390 [ 1107.348556][ T44] ? __kthread_parkme+0xb3/0x200 [ 1107.348747][ T44] ? process_one_work+0x1390/0x1390 [ 1107.348936][ T44] kthread+0x355/0x5b0 [ 1107.349087][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 1107.349309][ T44] ? __lock_release.isra.0+0x59/0x170 [ 1107.349519][ T44] ? rcu_is_watching+0x15/0xd0 [ 1107.349756][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 1107.349981][ T44] ret_from_fork+0x3fb/0x510 [ 1107.350220][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 1107.350491][ T44] ? __switch_to+0x602/0xd00 [ 1107.350731][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 1107.350967][ T44] ret_from_fork_asm+0x11/0x20 [ 1107.351220][ T44] [ 1107.351413][ T44] [ 1107.351413][ T44] Showing all locks held in the system: [ 1107.351735][ T44] 3 locks held by kworker/0:1/10: [ 1107.351957][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 1107.352358][ T44] #1: ffa00000000a7cc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 1107.352766][ T44] #2: ffffffffb8e78aa8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 1107.353135][ T44] 3 locks held by kworker/u16:0/12: [ 1107.353313][ T44] #0: ff110000090f6548 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 1107.353605][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 1107.353976][ T44] #2: ffffffffb8e78aa8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 1107.354237][ T44] 1 lock held by khungtaskd/44: [ 1107.354395][ T44] #0: ffffffffb8770ba0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 1107.354710][ T44] 3 locks held by kworker/3:2/68: [ 1107.354947][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 1107.355382][ T44] #1: ffa0000000497cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 1107.355858][ T44] #2: ff11000008adac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 1107.356246][ T44] 2 locks held by ip/6029: [ 1107.356471][ T44] #0: ffffffffb8e78aa8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5f9/0xb40 [ 1107.356827][ T44] #1: ff11000008adac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 1107.357083][ T44] 1 lock held by xdp_helper/6036: [ 1107.357342][ T44] #0: ffffffffb8e78aa8 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10 [ 1107.357608][ T44] [ 1107.357715][ T44] ============================================= [ 1107.357715][ T44] [ 1112.424589][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 324607 ms [ 1112.425070][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 324607000 usecs ago [ 1118.568595][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 330751 ms [ 1118.569278][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 330751000 usecs ago [ 1124.200590][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 336383 ms [ 1124.201025][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 336383000 usecs ago [ 1129.320597][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 341503 ms [ 1129.321278][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 341503000 usecs ago [ 1134.440590][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 346623 ms [ 1134.441065][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 346623000 usecs ago [ 1140.584596][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 352767 ms [ 1140.585210][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 352767000 usecs ago [ 1146.216591][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 358399 ms [ 1146.217188][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 358399000 usecs ago