[ 588.109573][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 5119 ms [ 588.110167][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 5119000 usecs ago [ 593.229576][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 10239 ms [ 593.230135][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 10239000 usecs ago [ 598.349556][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 15359 ms [ 598.349981][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 15359000 usecs ago [ 604.493568][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 21503 ms [ 604.494029][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 21503000 usecs ago [ 610.125568][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 27135 ms [ 610.125993][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 27135000 usecs ago [ 615.246551][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 32255 ms [ 615.246983][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 32256000 usecs ago [ 620.366554][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 37376 ms [ 620.366970][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 37376000 usecs ago [ 626.509552][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 43519 ms [ 626.510003][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 43519000 usecs ago [ 632.142569][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 49152 ms [ 632.143055][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 49152000 usecs ago [ 637.261569][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 54271 ms [ 637.261999][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 54271000 usecs ago [ 642.382555][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 59392 ms [ 642.382951][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 59392000 usecs ago [ 648.526553][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 65535 ms [ 648.527035][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 65536000 usecs ago [ 654.158559][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 71168 ms [ 654.159016][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 71168000 usecs ago [ 659.278553][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 76288 ms [ 659.278974][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 76288000 usecs ago [ 664.398558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 81408 ms [ 664.398980][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 81408000 usecs ago [ 670.541567][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 87551 ms [ 670.541999][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 87551000 usecs ago [ 676.174562][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 93184 ms [ 676.175099][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 93184000 usecs ago [ 681.293554][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 98303 ms [ 681.293968][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 98303000 usecs ago [ 686.414558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 103424 ms [ 686.414990][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 103424000 usecs ago [ 692.557558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 109567 ms [ 692.558161][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 109567000 usecs ago [ 698.190563][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 115200 ms [ 698.191173][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 115200000 usecs ago [ 703.310557][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 120320 ms [ 703.311170][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 120320000 usecs ago [ 708.430555][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 125440 ms [ 708.430971][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 125440000 usecs ago [ 714.574568][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 131584 ms [ 714.575030][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 131584000 usecs ago [ 720.205582][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 137215 ms [ 720.206182][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 137215000 usecs ago [ 725.326552][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 142336 ms [ 725.326974][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 142336000 usecs ago [ 731.469583][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 148479 ms [ 731.470109][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 148479000 usecs ago [ 737.102558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 154112 ms [ 737.103183][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 154112000 usecs ago [ 738.638639][ T44] INFO: task ip:4715 blocked for more than 122 seconds. [ 738.639076][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 738.639216][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 738.639460][ T44] task:ip state:D stack:25384 pid:4715 tgid:4715 ppid:4708 task_flags:0x400100 flags:0x00080001 [ 738.639804][ T44] Call Trace: [ 738.639911][ T44] [ 738.639990][ T44] __schedule+0x88d/0x1b90 [ 738.640144][ T44] ? io_schedule_timeout+0x130/0x130 [ 738.640293][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.640428][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.640572][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.640712][ T44] schedule+0xd4/0x260 [ 738.640809][ T44] schedule_preempt_disabled+0x18/0x30 [ 738.640941][ T44] __mutex_lock+0x9ae/0x1500 [ 738.641073][ T44] ? napi_enable+0x3b/0x80 [ 738.641208][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850 [ 738.641380][ T44] ? ww_mutex_lock+0x160/0x160 [ 738.641513][ T44] ? __asan_memset+0x27/0x50 [ 738.641672][ T44] ? sg_init_table+0x19/0x60 [ 738.641794][ T44] ? try_fill_recv+0x3ec/0x1750 [ 738.641916][ T44] ? napi_enable+0x3b/0x80 [ 738.642036][ T44] napi_enable+0x3b/0x80 [ 738.642132][ T44] __virtnet_rx_resume+0x156/0x290 [ 738.642251][ T44] ? queue_delayed_work_on+0x91/0x100 [ 738.642376][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 738.642497][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 738.642629][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 738.642752][ T44] dev_xdp_install+0x4ba/0x8e0 [ 738.642873][ T44] ? netif_skb_check_for_xdp+0x600/0x600 [ 738.643000][ T44] dev_xdp_attach+0x50d/0x1320 [ 738.643126][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 738.643635][ T44] ? mutex_is_locked+0x1c/0x50 [ 738.643765][ T44] ? rtnl_is_locked+0x15/0x20 [ 738.643885][ T44] ? dev_change_xdp_fd+0x9f/0x240 [ 738.644004][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 738.644130][ T44] ? rtnl_newlink_create+0x900/0x900 [ 738.644260][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0 [ 738.644408][ T44] ? rcu_read_lock_any_held+0x41/0xa0 [ 738.644526][ T44] ? validate_chain+0x287/0x5f0 [ 738.644652][ T44] ? rcu_read_lock_any_held+0x6b/0xa0 [ 738.644772][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 738.644891][ T44] ? __lock_acquire+0x34c/0x740 [ 738.645016][ T44] ? trace_lock_acquire+0x88/0xd0 [ 738.645136][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 738.645260][ T44] ? lock_acquire+0x31/0x80 [ 738.645380][ T44] ? rtnl_newlink+0x5df/0xb20 [ 738.645498][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.645621][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.645743][ T44] ? trace_contention_end+0xd6/0x140 [ 738.645861][ T44] ? rtnl_newlink+0x5df/0xb20 [ 738.645976][ T44] ? __mutex_lock+0x32e/0x1500 [ 738.646108][ T44] ? ww_mutex_lock+0x160/0x160 [ 738.646234][ T44] ? nla_validate_int_range+0x5b0/0x5b0 [ 738.646360][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 738.646482][ T44] rtnl_newlink+0x637/0xb20 [ 738.646607][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 738.646739][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.646858][ T44] ? find_held_lock+0x2b/0x80 [ 738.646982][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 738.647103][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.647223][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 738.647347][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 738.647469][ T44] ? rtnl_port_fill+0x940/0x940 [ 738.647619][ T44] ? __lock_acquire+0x34c/0x740 [ 738.647742][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.647859][ T44] ? find_held_lock+0x2b/0x80 [ 738.647981][ T44] netlink_rcv_skb+0x123/0x380 [ 738.648101][ T44] ? rtnl_port_fill+0x940/0x940 [ 738.648221][ T44] ? netlink_ack+0xcc0/0xcc0 [ 738.648350][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 738.648469][ T44] netlink_unicast+0x4a3/0x770 [ 738.648593][ T44] ? netlink_attachskb+0x810/0x810 [ 738.648712][ T44] ? __lock_acquire+0x34c/0x740 [ 738.648836][ T44] netlink_sendmsg+0x735/0xc60 [ 738.648963][ T44] ? netlink_unicast+0x770/0x770 [ 738.649081][ T44] ? __might_fault+0x97/0x140 [ 738.649204][ T44] ____sys_sendmsg+0x419/0x850 [ 738.649327][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 738.649445][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 738.649602][ T44] ? move_addr_to_kernel+0x40/0x40 [ 738.649728][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 738.649847][ T44] ? validate_chain+0x287/0x5f0 [ 738.649969][ T44] ___sys_sendmsg+0xfd/0x180 [ 738.650092][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680 [ 738.650244][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 738.650385][ T44] __sys_sendmsg+0x124/0x1c0 [ 738.650506][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 738.650630][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 738.650760][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680 [ 738.650909][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 738.651028][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.651148][ T44] do_syscall_64+0xbb/0xfd0 [ 738.651280][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 738.651434][ T44] RIP: 0033:0x7fbf5e924c5e [ 738.651572][ T44] RSP: 002b:00007ffe015a5f40 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 738.651768][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fbf5e924c5e [ 738.651949][ T44] RDX: 0000000000000000 RSI: 00007ffe015a6000 RDI: 0000000000000003 [ 738.652131][ T44] RBP: 00007ffe015a5f50 R08: 0000000000000000 R09: 0000000000000000 [ 738.652319][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffe015a66c0 [ 738.652503][ T44] R13: 00000000692e2fd3 R14: 0000000000000000 R15: 0000000000499600 [ 738.652697][ T44] [ 738.652807][ T44] INFO: task ip:4715 is blocked on a mutex likely owned by task kworker/3:2:1562. [ 738.653008][ T44] task:kworker/3:2 state:D stack:28808 pid:1562 tgid:1562 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 738.653287][ T44] Workqueue: events refill_work [ 738.653452][ T44] Call Trace: [ 738.653548][ T44] [ 738.653617][ T44] __schedule+0x88d/0x1b90 [ 738.653747][ T44] ? clockevents_program_event+0xee/0x350 [ 738.653869][ T44] ? usleep_range_state+0xba/0x1b0 [ 738.653991][ T44] ? find_held_lock+0x2b/0x80 [ 738.654119][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.654240][ T44] ? usleep_range_state+0xba/0x1b0 [ 738.654365][ T44] schedule+0xd4/0x260 [ 738.654456][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 738.654615][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 738.654741][ T44] ? hrtimer_cb_get_time+0x90/0x90 [ 738.654862][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 738.654979][ T44] ? ktime_get+0x15e/0x220 [ 738.655101][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 738.655222][ T44] ? ktime_get+0xa9/0x220 [ 738.655317][ T44] usleep_range_state+0x133/0x1b0 [ 738.655440][ T44] ? schedule_hrtimeout+0x20/0x20 [ 738.655565][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 738.655691][ T44] napi_disable_locked+0x379/0x5f0 [ 738.655812][ T44] ? _mutex_trylock_nest_lock+0x150/0x150 [ 738.655937][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470 [ 738.656092][ T44] napi_disable+0x43/0x80 [ 738.656185][ T44] refill_work+0x116/0x210 [ 738.656312][ T44] process_one_work+0xd57/0x1390 [ 738.656438][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 738.656563][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.656687][ T44] ? assign_work+0x152/0x380 [ 738.656809][ T44] worker_thread+0x4d6/0xd40 [ 738.656931][ T44] ? process_one_work+0x1390/0x1390 [ 738.657049][ T44] ? __kthread_parkme+0xb3/0x200 [ 738.657173][ T44] ? process_one_work+0x1390/0x1390 [ 738.657295][ T44] kthread+0x355/0x5b0 [ 738.657384][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.657506][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.657630][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.657762][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.657880][ T44] ret_from_fork+0x1d4/0x270 [ 738.658000][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.658118][ T44] ret_from_fork_asm+0x11/0x20 [ 738.658243][ T44] [ 738.658353][ T44] [ 738.658353][ T44] Showing all locks held in the system: [ 738.658529][ T44] 3 locks held by kworker/u16:0/12: [ 738.658758][ T44] #0: ff11000008af4d48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 738.658998][ T44] #1: ffa00000000c7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 738.659295][ T44] #2: ffffffff8ae92ce8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 738.659504][ T44] 1 lock held by khungtaskd/44: [ 738.659627][ T44] #0: ffffffff8a778fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db [ 738.659844][ T44] 3 locks held by kworker/3:2/1562: [ 738.659957][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 738.660205][ T44] #1: ffa00000006a7d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 738.660474][ T44] #2: ff110000084cac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 738.660695][ T44] 2 locks held by ip/4715: [ 738.660811][ T44] #0: ffffffff8ae92ce8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20 [ 738.661014][ T44] #1: ff110000084cac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 738.661223][ T44] [ 738.661291][ T44] ============================================= [ 738.661291][ T44] [ 742.222558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 159232 ms [ 742.223025][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 159232000 usecs ago [ 747.342553][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 164351 ms [ 747.343007][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 164352000 usecs ago [ 753.485557][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 170495 ms [ 753.486020][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 170495000 usecs ago [ 759.118554][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 176127 ms [ 759.119004][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 176128000 usecs ago [ 764.238557][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 181248 ms [ 764.238997][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 181248000 usecs ago [ 769.358553][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 186367 ms [ 769.358983][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 186368000 usecs ago [ 775.502569][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 192512 ms [ 775.503021][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 192512000 usecs ago [ 781.134567][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 198144 ms [ 781.135009][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 198144000 usecs ago [ 786.253581][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 203263 ms [ 786.254009][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 203263000 usecs ago [ 791.373573][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 208383 ms [ 791.374163][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 208383000 usecs ago [ 797.517558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 214527 ms [ 797.517994][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 214527000 usecs ago [ 803.149567][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 220159 ms [ 803.150037][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 220159000 usecs ago [ 808.270558][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 225280 ms [ 808.271070][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 225280000 usecs ago [ 813.389571][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 230399 ms [ 813.390020][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 230399000 usecs ago [ 819.534559][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 236544 ms [ 819.534990][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 236544000 usecs ago [ 825.165554][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 242175 ms [ 825.165984][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 242175000 usecs ago [ 830.285571][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 247295 ms [ 830.286105][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 247295000 usecs ago [ 835.406552][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 252416 ms [ 835.407041][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 252416000 usecs ago [ 841.549602][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 258559 ms [ 841.550210][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 258559000 usecs ago [ 847.181567][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 264191 ms [ 847.181999][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 264191000 usecs ago [ 852.301583][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 269311 ms [ 852.302273][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 269311000 usecs ago [ 857.421571][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 274431 ms [ 857.422066][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 274431000 usecs ago [ 861.518579][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds. [ 861.518846][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 861.518963][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.519177][ T44] task:kworker/u16:0 state:D stack:27000 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.519444][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 861.519620][ T44] Call Trace: [ 861.519713][ T44] [ 861.519780][ T44] __schedule+0x88d/0x1b90 [ 861.519907][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.520030][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.520165][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.520356][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.520550][ T44] schedule+0xd4/0x260 [ 861.520689][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.520868][ T44] __mutex_lock+0x9ae/0x1500 [ 861.521048][ T44] ? addrconf_verify_work+0x12/0x30 [ 861.521243][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.521429][ T44] ? process_one_work+0xd16/0x1390 [ 861.521642][ T44] ? trace_lock_acquire+0x88/0xd0 [ 861.521822][ T44] ? trace_lock_acquire+0x88/0xd0 [ 861.522009][ T44] ? addrconf_verify_work+0x12/0x30 [ 861.522194][ T44] addrconf_verify_work+0x12/0x30 [ 861.522373][ T44] process_one_work+0xd57/0x1390 [ 861.522574][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.522759][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.522944][ T44] ? assign_work+0x152/0x380 [ 861.523139][ T44] worker_thread+0x4d6/0xd40 [ 861.523298][ T44] ? process_one_work+0x1390/0x1390 [ 861.523417][ T44] kthread+0x355/0x5b0 [ 861.523508][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.523637][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.523764][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.523892][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.524012][ T44] ret_from_fork+0x1d4/0x270 [ 861.524139][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.524264][ T44] ret_from_fork_asm+0x11/0x20 [ 861.524388][ T44] [ 861.524515][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:4715. [ 861.524734][ T44] INFO: task ip:4715 blocked for more than 245 seconds. [ 861.524878][ T44] Not tainted 6.18.0-rc7-virtme #1 [ 861.524988][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.525193][ T44] task:ip state:D stack:25384 pid:4715 tgid:4715 ppid:4708 task_flags:0x400100 flags:0x00080001 [ 861.525457][ T44] Call Trace: [ 861.525550][ T44] [ 861.525615][ T44] __schedule+0x88d/0x1b90 [ 861.525736][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.525857][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.525978][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.526100][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.526221][ T44] schedule+0xd4/0x260 [ 861.526311][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.526437][ T44] __mutex_lock+0x9ae/0x1500 [ 861.526562][ T44] ? napi_enable+0x3b/0x80 [ 861.526683][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850 [ 861.526832][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.526951][ T44] ? __asan_memset+0x27/0x50 [ 861.527078][ T44] ? sg_init_table+0x19/0x60 [ 861.527216][ T44] ? try_fill_recv+0x3ec/0x1750 [ 861.527402][ T44] ? napi_enable+0x3b/0x80 [ 861.527596][ T44] napi_enable+0x3b/0x80 [ 861.527735][ T44] __virtnet_rx_resume+0x156/0x290 [ 861.527913][ T44] ? queue_delayed_work_on+0x91/0x100 [ 861.528033][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 861.528156][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 861.528281][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 861.528400][ T44] dev_xdp_install+0x4ba/0x8e0 [ 861.528522][ T44] ? netif_skb_check_for_xdp+0x600/0x600 [ 861.528649][ T44] dev_xdp_attach+0x50d/0x1320 [ 861.528772][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 861.528892][ T44] ? mutex_is_locked+0x1c/0x50 [ 861.529010][ T44] ? rtnl_is_locked+0x15/0x20 [ 861.529136][ T44] ? dev_change_xdp_fd+0x9f/0x240 [ 861.529260][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 861.529385][ T44] ? rtnl_newlink_create+0x900/0x900 [ 861.529507][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0 [ 861.529657][ T44] ? rcu_read_lock_any_held+0x41/0xa0 [ 861.529775][ T44] ? validate_chain+0x287/0x5f0 [ 861.529897][ T44] ? rcu_read_lock_any_held+0x6b/0xa0 [ 861.530016][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 861.530141][ T44] ? __lock_acquire+0x34c/0x740 [ 861.530274][ T44] ? trace_lock_acquire+0x88/0xd0 [ 861.530392][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 861.530513][ T44] ? lock_acquire+0x31/0x80 [ 861.530634][ T44] ? rtnl_newlink+0x5df/0xb20 [ 861.530751][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.530866][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.530984][ T44] ? trace_contention_end+0xd6/0x140 [ 861.531113][ T44] ? rtnl_newlink+0x5df/0xb20 [ 861.531234][ T44] ? __mutex_lock+0x32e/0x1500 [ 861.531353][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.531472][ T44] ? nla_validate_int_range+0x5b0/0x5b0 [ 861.531598][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 861.531718][ T44] rtnl_newlink+0x637/0xb20 [ 861.531838][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 861.531956][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.532083][ T44] ? find_held_lock+0x2b/0x80 [ 861.532213][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 861.532342][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.532461][ T44] ? __rtnl_newlink+0xa40/0xa40 [ 861.532584][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 861.532704][ T44] ? rtnl_port_fill+0x940/0x940 [ 861.532825][ T44] ? __lock_acquire+0x34c/0x740 [ 861.532946][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.533069][ T44] ? find_held_lock+0x2b/0x80 [ 861.533191][ T44] netlink_rcv_skb+0x123/0x380 [ 861.533329][ T44] ? rtnl_port_fill+0x940/0x940 [ 861.533446][ T44] ? netlink_ack+0xcc0/0xcc0 [ 861.533598][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 861.533718][ T44] netlink_unicast+0x4a3/0x770 [ 861.533836][ T44] ? netlink_attachskb+0x810/0x810 [ 861.533959][ T44] ? __lock_acquire+0x34c/0x740 [ 861.534084][ T44] netlink_sendmsg+0x735/0xc60 [ 861.534207][ T44] ? netlink_unicast+0x770/0x770 [ 861.534325][ T44] ? __might_fault+0x97/0x140 [ 861.534446][ T44] ____sys_sendmsg+0x419/0x850 [ 861.534573][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 861.534690][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 861.534835][ T44] ? move_addr_to_kernel+0x40/0x40 [ 861.534957][ T44] ? stack_depot_save_flags+0x3e1/0x6e0 [ 861.535078][ T44] ? validate_chain+0x287/0x5f0 [ 861.535208][ T44] ___sys_sendmsg+0xfd/0x180 [ 861.535383][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680 [ 861.535538][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 861.535671][ T44] __sys_sendmsg+0x124/0x1c0 [ 861.535790][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 861.535910][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 861.536028][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680 [ 861.536189][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 861.536309][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.536427][ T44] do_syscall_64+0xbb/0xfd0 [ 861.536550][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 861.536695][ T44] RIP: 0033:0x7fbf5e924c5e [ 861.536832][ T44] RSP: 002b:00007ffe015a5f40 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 861.537012][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fbf5e924c5e [ 861.537196][ T44] RDX: 0000000000000000 RSI: 00007ffe015a6000 RDI: 0000000000000003 [ 861.537375][ T44] RBP: 00007ffe015a5f50 R08: 0000000000000000 R09: 0000000000000000 [ 861.537566][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffe015a66c0 [ 861.537741][ T44] R13: 00000000692e2fd3 R14: 0000000000000000 R15: 0000000000499600 [ 861.537923][ T44] [ 861.538020][ T44] INFO: task ip:4715 is blocked on a mutex likely owned by task kworker/3:2:1562. [ 861.538227][ T44] task:kworker/3:2 state:D stack:28808 pid:1562 tgid:1562 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.538496][ T44] Workqueue: events refill_work [ 861.538621][ T44] Call Trace: [ 861.538711][ T44] [ 861.538773][ T44] __schedule+0x88d/0x1b90 [ 861.538894][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.539022][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.539145][ T44] ? find_held_lock+0x2b/0x80 [ 861.539269][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.539393][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.539511][ T44] schedule+0xd4/0x260 [ 861.539602][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 861.539750][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 861.539869][ T44] ? hrtimer_cb_get_time+0x90/0x90 [ 861.539988][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 861.540114][ T44] ? ktime_get+0x15e/0x220 [ 861.540236][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 861.540356][ T44] ? ktime_get+0xa9/0x220 [ 861.540445][ T44] usleep_range_state+0x133/0x1b0 [ 861.540570][ T44] ? schedule_hrtimeout+0x20/0x20 [ 861.540692][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 861.540812][ T44] napi_disable_locked+0x379/0x5f0 [ 861.540932][ T44] ? _mutex_trylock_nest_lock+0x150/0x150 [ 861.541048][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470 [ 861.541207][ T44] napi_disable+0x43/0x80 [ 861.541295][ T44] refill_work+0x116/0x210 [ 861.541414][ T44] process_one_work+0xd57/0x1390 [ 861.541545][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.541671][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.541796][ T44] ? assign_work+0x152/0x380 [ 861.541919][ T44] worker_thread+0x4d6/0xd40 [ 861.542038][ T44] ? process_one_work+0x1390/0x1390 [ 861.542161][ T44] ? __kthread_parkme+0xb3/0x200 [ 861.542282][ T44] ? process_one_work+0x1390/0x1390 [ 861.542399][ T44] kthread+0x355/0x5b0 [ 861.542487][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.542608][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.542728][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.542860][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.542981][ T44] ret_from_fork+0x1d4/0x270 [ 861.543108][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.543229][ T44] ret_from_fork_asm+0x11/0x20 [ 861.543352][ T44] [ 861.543448][ T44] [ 861.543448][ T44] Showing all locks held in the system: [ 861.543734][ T44] 3 locks held by kworker/u16:0/12: [ 861.543853][ T44] #0: ff11000008af4d48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 861.544090][ T44] #1: ffa00000000c7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 861.544379][ T44] #2: ffffffff8ae92ce8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 861.544593][ T44] 1 lock held by khungtaskd/44: [ 861.544704][ T44] #0: ffffffff8a778fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db [ 861.544915][ T44] 3 locks held by kworker/3:2/1562: [ 861.545027][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 861.545264][ T44] #1: ffa00000006a7d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 861.545524][ T44] #2: ff110000084cac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 861.545739][ T44] 2 locks held by ip/4715: [ 861.545851][ T44] #0: ffffffff8ae92ce8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20 [ 861.546049][ T44] #1: ff110000084cac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 861.546265][ T44] [ 861.546323][ T44] ============================================= [ 861.546323][ T44] [ 863.566559][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 280576 ms [ 863.567052][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 280576000 usecs ago [ 869.198554][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 286207 ms [ 869.198999][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 286208000 usecs ago [ 874.318570][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 291328 ms [ 874.318997][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 291328000 usecs ago [ 880.462569][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 297472 ms [ 880.463009][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 297472000 usecs ago [ 886.094571][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 303104 ms [ 886.095055][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 303104000 usecs ago [ 891.213575][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 308223 ms [ 891.214157][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 308223000 usecs ago [ 896.334571][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 313344 ms [ 896.335008][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 313344000 usecs ago [ 902.478565][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 2 timed out 319488 ms [ 902.479025][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 319488000 usecs ago