[ 621.375830][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 5632 ms
[ 621.376398][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 5632000 usecs ago
[ 627.519823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 11776 ms
[ 627.520140][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 11776000 usecs ago
[ 633.151823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 17408 ms
[ 633.152140][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 17408000 usecs ago
[ 638.271824][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 22528 ms
[ 638.272140][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 22528000 usecs ago
[ 643.392822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 27649 ms
[ 643.393136][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 27649000 usecs ago
[ 649.536822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 33793 ms
[ 649.537186][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 33793000 usecs ago
[ 655.167823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 39424 ms
[ 655.168169][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 39424000 usecs ago
[ 660.287826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 44544 ms
[ 660.288210][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 44544000 usecs ago
[ 665.407822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 49664 ms
[ 665.408182][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 49664000 usecs ago
[ 671.551826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 55808 ms
[ 671.552183][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 55808000 usecs ago
[ 677.183822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 61440 ms
[ 677.184181][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 61440000 usecs ago
[ 682.303822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 66560 ms
[ 682.304179][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 66560000 usecs ago
[ 688.447822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 72704 ms
[ 688.448181][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 72704000 usecs ago
[ 694.079823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 78336 ms
[ 694.080176][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 78336000 usecs ago
[ 699.199822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 83456 ms
[ 699.200186][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 83456000 usecs ago
[ 704.319823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 88576 ms
[ 704.320178][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 88576000 usecs ago
[ 710.463826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 94720 ms
[ 710.464183][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 94720000 usecs ago
[ 716.095822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 100352 ms
[ 716.096222][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 100352000 usecs ago
[ 721.215822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 105472 ms
[ 721.216206][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 105472000 usecs ago
[ 726.335823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 110592 ms
[ 726.336220][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 110592000 usecs ago
[ 732.479822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 116736 ms
[ 732.480224][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 116736000 usecs ago
[ 738.111826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 122368 ms
[ 738.112260][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 122368000 usecs ago
[ 738.623850][ T44] INFO: task kworker/u16:1:70 blocked for more than 122 seconds.
[ 738.624271][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 738.624399][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 738.624679][ T44] task:kworker/u16:1 state:D stack:26352 pid:70 tgid:70 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 738.624997][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 738.625167][ T44] Call Trace:
[ 738.625275][ T44]
[ 738.625343][ T44] __schedule+0x88d/0x1b90
[ 738.625490][ T44] ? io_schedule_timeout+0x130/0x130
[ 738.625624][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.625766][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.625899][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.626019][ T44] schedule+0xd4/0x260
[ 738.626122][ T44] schedule_preempt_disabled+0x18/0x30
[ 738.626248][ T44] __mutex_lock+0x9ae/0x1500
[ 738.626373][ T44] ? addrconf_verify_work+0x12/0x30
[ 738.626512][ T44] ? ww_mutex_lock+0x160/0x160
[ 738.626646][ T44] ? process_one_work+0xd16/0x1390
[ 738.626773][ T44] ? trace_lock_acquire+0x88/0xd0
[ 738.626904][ T44] ? trace_lock_acquire+0x88/0xd0
[ 738.627020][ T44] ? addrconf_verify_work+0x12/0x30
[ 738.627144][ T44] addrconf_verify_work+0x12/0x30
[ 738.627259][ T44] process_one_work+0xd57/0x1390
[ 738.627392][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 738.627513][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.627643][ T44] ? assign_work+0x152/0x380
[ 738.627754][ T44] worker_thread+0x4d6/0xd40
[ 738.627878][ T44] ? process_one_work+0x1390/0x1390
[ 738.627990][ T44] ? __kthread_parkme+0xb3/0x200
[ 738.628461][ T44] ? process_one_work+0x1390/0x1390
[ 738.628573][ T44] kthread+0x355/0x5b0
[ 738.628667][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.628776][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.628896][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.629003][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.629124][ T44] ret_from_fork+0x1d4/0x270
[ 738.629236][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.629362][ T44] ret_from_fork_asm+0x11/0x20
[ 738.629477][ T44]
[ 738.629589][ T44] INFO: task kworker/u16:1:70 is blocked on a mutex likely owned by task ip:5316.
[ 738.629783][ T44] INFO: task ip:5316 blocked for more than 122 seconds.
[ 738.629922][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 738.630023][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 738.630204][ T44] task:ip state:D stack:25592 pid:5316 tgid:5316 ppid:5309 task_flags:0x400100 flags:0x00080001
[ 738.630455][ T44] Call Trace:
[ 738.630538][ T44]
[ 738.630594][ T44] __schedule+0x88d/0x1b90
[ 738.630711][ T44] ? io_schedule_timeout+0x130/0x130
[ 738.630836][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.630943][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.631058][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.631172][ T44] schedule+0xd4/0x260
[ 738.631263][ T44] schedule_preempt_disabled+0x18/0x30
[ 738.631369][ T44] __mutex_lock+0x9ae/0x1500
[ 738.631481][ T44] ? napi_enable+0x3b/0x80
[ 738.631595][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850
[ 738.631738][ T44] ? ww_mutex_lock+0x160/0x160
[ 738.631857][ T44] ? __asan_memset+0x27/0x50
[ 738.631976][ T44] ? sg_init_table+0x19/0x60
[ 738.632094][ T44] ? try_fill_recv+0x3ec/0x1750
[ 738.632203][ T44] ? napi_enable+0x3b/0x80
[ 738.632316][ T44] napi_enable+0x3b/0x80
[ 738.632397][ T44] __virtnet_rx_resume+0x156/0x290
[ 738.632507][ T44] ? queue_delayed_work_on+0x91/0x100
[ 738.632625][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 738.632732][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 738.632862][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 738.632967][ T44] dev_xdp_install+0x4ba/0x8e0
[ 738.633083][ T44] ? netif_skb_check_for_xdp+0x600/0x600
[ 738.633194][ T44] dev_xdp_attach+0x50d/0x1320
[ 738.633312][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 738.633424][ T44] ? mutex_is_locked+0x1c/0x50
[ 738.633542][ T44] ? rtnl_is_locked+0x15/0x20
[ 738.633654][ T44] ? dev_change_xdp_fd+0x9f/0x240
[ 738.633778][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 738.633898][ T44] ? rtnl_newlink_create+0x900/0x900
[ 738.634004][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0
[ 738.634145][ T44] ? rcu_read_lock_any_held+0x41/0xa0
[ 738.634256][ T44] ? validate_chain+0x287/0x5f0
[ 738.634371][ T44] ? rcu_read_lock_any_held+0x6b/0xa0
[ 738.634482][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 738.634603][ T44] ? __lock_acquire+0x34c/0x740
[ 738.634719][ T44] ? trace_lock_acquire+0x88/0xd0
[ 738.634839][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 738.634948][ T44] ? lock_acquire+0x31/0x80
[ 738.635065][ T44] ? rtnl_newlink+0x5df/0xb20
[ 738.635171][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.635289][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.635396][ T44] ? trace_contention_end+0xd6/0x140
[ 738.635514][ T44] ? rtnl_newlink+0x5df/0xb20
[ 738.635627][ T44] ? __mutex_lock+0x32e/0x1500
[ 738.635745][ T44] ? ww_mutex_lock+0x160/0x160
[ 738.635871][ T44] ? nla_validate_int_range+0x5b0/0x5b0
[ 738.635982][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 738.636099][ T44] rtnl_newlink+0x637/0xb20
[ 738.636212][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 738.636334][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.636439][ T44] ? find_held_lock+0x2b/0x80
[ 738.636557][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 738.636664][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.636781][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 738.636901][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 738.637016][ T44] ? rtnl_port_fill+0x940/0x940
[ 738.637133][ T44] ? __lock_acquire+0x34c/0x740
[ 738.637242][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.637356][ T44] ? find_held_lock+0x2b/0x80
[ 738.637464][ T44] netlink_rcv_skb+0x123/0x380
[ 738.637583][ T44] ? rtnl_port_fill+0x940/0x940
[ 738.637690][ T44] ? netlink_ack+0xcc0/0xcc0
[ 738.637809][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 738.637935][ T44] netlink_unicast+0x4a3/0x770
[ 738.638043][ T44] ? netlink_attachskb+0x810/0x810
[ 738.638157][ T44] ? __lock_acquire+0x34c/0x740
[ 738.638265][ T44] netlink_sendmsg+0x735/0xc60
[ 738.638383][ T44] ? netlink_unicast+0x770/0x770
[ 738.638491][ T44] ? __might_fault+0x97/0x140
[ 738.638614][ T44] ____sys_sendmsg+0x419/0x850
[ 738.638721][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 738.638843][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 738.638977][ T44] ? move_addr_to_kernel+0x40/0x40
[ 738.639093][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 738.639199][ T44] ? validate_chain+0x287/0x5f0
[ 738.639316][ T44] ___sys_sendmsg+0xfd/0x180
[ 738.639423][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680
[ 738.639570][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 738.639698][ T44] __sys_sendmsg+0x124/0x1c0
[ 738.639826][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 738.639939][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 738.640055][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680
[ 738.640192][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 738.640310][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.640418][ T44] do_syscall_64+0xbb/0xfd0
[ 738.640543][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 738.640682][ T44] RIP: 0033:0x7f9c5b32dc5e
[ 738.640811][ T44] RSP: 002b:00007ffebbb341a0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 738.640984][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f9c5b32dc5e
[ 738.641155][ T44] RDX: 0000000000000000 RSI: 00007ffebbb34260 RDI: 0000000000000003
[ 738.641321][ T44] RBP: 00007ffebbb341b0 R08: 0000000000000000 R09: 0000000000000000
[ 738.641489][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffebbb34920
[ 738.641654][ T44] R13: 00000000692ea250 R14: 0000000000000000 R15: 0000000000499600
[ 738.641840][ T44]
[ 738.641922][ T44] INFO: task ip:5316 is blocked on a mutex likely owned by task kworker/0:1:10.
[ 738.642113][ T44] task:kworker/0:1 state:D stack:27696 pid:10 tgid:10 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 738.642362][ T44] Workqueue: events refill_work
[ 738.642471][ T44] Call Trace:
[ 738.642567][ T44]
[ 738.642625][ T44] __schedule+0x88d/0x1b90
[ 738.642739][ T44] ? io_schedule_timeout+0x130/0x130
[ 738.642861][ T44] ? usleep_range_state+0xba/0x1b0
[ 738.642972][ T44] ? find_held_lock+0x2b/0x80
[ 738.643088][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.643201][ T44] ? usleep_range_state+0xba/0x1b0
[ 738.643314][ T44] schedule+0xd4/0x260
[ 738.643394][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 738.643539][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 738.643651][ T44] ? hrtimer_cb_get_time+0x90/0x90
[ 738.643771][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 738.643886][ T44] ? ktime_get+0x15e/0x220
[ 738.643997][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 738.644112][ T44] ? ktime_get+0xa9/0x220
[ 738.644192][ T44] usleep_range_state+0x133/0x1b0
[ 738.644299][ T44] ? schedule_hrtimeout+0x20/0x20
[ 738.644417][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 738.644535][ T44] napi_disable_locked+0x379/0x5f0
[ 738.644651][ T44] ? _mutex_trylock_nest_lock+0x150/0x150
[ 738.644758][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470
[ 738.644911][ T44] napi_disable+0x43/0x80
[ 738.644992][ T44] refill_work+0x116/0x210
[ 738.645102][ T44] process_one_work+0xd57/0x1390
[ 738.645222][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 738.645341][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.645450][ T44] ? assign_work+0x152/0x380
[ 738.645571][ T44] worker_thread+0x4d6/0xd40
[ 738.645681][ T44] ? process_one_work+0x1390/0x1390
[ 738.645799][ T44] ? __kthread_parkme+0xb3/0x200
[ 738.645926][ T44] ? process_one_work+0x1390/0x1390
[ 738.646032][ T44] kthread+0x355/0x5b0
[ 738.646116][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.646233][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.646343][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.646463][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.646576][ T44] ret_from_fork+0x1d4/0x270
[ 738.646690][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.646800][ T44] ret_from_fork_asm+0x11/0x20
[ 738.646924][ T44]
[ 738.647018][ T44]
[ 738.647018][ T44] Showing all locks held in the system:
[ 738.647184][ T44] 3 locks held by kworker/0:1/10:
[ 738.647291][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 738.647516][ T44] #1: ffa00000000a7d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 738.647754][ T44] #2: ff11000008c1ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 738.648040][ T44] 1 lock held by khungtaskd/44:
[ 738.648148][ T44] #0: ffffffff86778fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db
[ 738.648340][ T44] 3 locks held by kworker/u16:1/70:
[ 738.648441][ T44] #0: ff11000009284d48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 738.648663][ T44] #1: ffa00000004b7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 738.648936][ T44] #2: ffffffff86e92ba8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 738.649124][ T44] 2 locks held by ip/5316:
[ 738.649233][ T44] #0: ffffffff86e92ba8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20
[ 738.649418][ T44] #1: ff11000008c1ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 738.649613][ T44]
[ 738.649667][ T44] =============================================
[ 738.649667][ T44]
[ 743.231828][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 127488 ms
[ 743.232249][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 127488000 usecs ago
[ 748.351829][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 132608 ms
[ 748.352230][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 132608000 usecs ago
[ 754.495822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 138752 ms
[ 754.496253][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 138752000 usecs ago
[ 760.127823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 144384 ms
[ 760.128222][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 144384000 usecs ago
[ 765.247826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 149504 ms
[ 765.248222][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 149504000 usecs ago
[ 770.367823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 154624 ms
[ 770.368208][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 154624000 usecs ago
[ 776.512822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 160769 ms
[ 776.513224][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 160769000 usecs ago
[ 782.143824][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 166400 ms
[ 782.144254][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 166400000 usecs ago
[ 787.263826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 171520 ms
[ 787.264235][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 171520000 usecs ago
[ 792.383822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 176640 ms
[ 792.384222][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 176640000 usecs ago
[ 798.527828][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 182784 ms
[ 798.528236][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 182784000 usecs ago
[ 804.160822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 188417 ms
[ 804.161224][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 188417000 usecs ago
[ 809.280826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 193537 ms
[ 809.281241][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 193537000 usecs ago
[ 814.400823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 198657 ms
[ 814.401215][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 198657000 usecs ago
[ 820.543821][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 204800 ms
[ 820.544216][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 204800000 usecs ago
[ 826.175823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 210432 ms
[ 826.176215][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 210432000 usecs ago
[ 831.295826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 215552 ms
[ 831.296220][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 215552000 usecs ago
[ 836.416823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 220673 ms
[ 836.417219][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 220673000 usecs ago
[ 842.559823][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 226816 ms
[ 842.560220][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 226816000 usecs ago
[ 848.191822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 232448 ms
[ 848.192220][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 232448000 usecs ago
[ 853.312822][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 237569 ms
[ 853.313274][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 237569000 usecs ago
[ 859.455826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 243712 ms
[ 859.456217][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 243712000 usecs ago
[ 861.503849][ T44] INFO: task kworker/u16:1:70 blocked for more than 245 seconds.
[ 861.504171][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 861.504298][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.504528][ T44] task:kworker/u16:1 state:D stack:26352 pid:70 tgid:70 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.504841][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 861.505007][ T44] Call Trace:
[ 861.505117][ T44]
[ 861.505187][ T44] __schedule+0x88d/0x1b90
[ 861.505327][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.505456][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.505589][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.505719][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.505857][ T44] schedule+0xd4/0x260
[ 861.505951][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.506084][ T44] __mutex_lock+0x9ae/0x1500
[ 861.506203][ T44] ? addrconf_verify_work+0x12/0x30
[ 861.506332][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.506455][ T44] ? process_one_work+0xd16/0x1390
[ 861.506590][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.506706][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.506843][ T44] ? addrconf_verify_work+0x12/0x30
[ 861.506951][ T44] addrconf_verify_work+0x12/0x30
[ 861.507065][ T44] process_one_work+0xd57/0x1390
[ 861.507175][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.507295][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.507405][ T44] ? assign_work+0x152/0x380
[ 861.507525][ T44] worker_thread+0x4d6/0xd40
[ 861.507633][ T44] ? process_one_work+0x1390/0x1390
[ 861.507751][ T44] ? __kthread_parkme+0xb3/0x200
[ 861.507877][ T44] ? process_one_work+0x1390/0x1390
[ 861.507983][ T44] kthread+0x355/0x5b0
[ 861.508064][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.508179][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.508286][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.508406][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.508516][ T44] ret_from_fork+0x1d4/0x270
[ 861.508639][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.508746][ T44] ret_from_fork_asm+0x11/0x20
[ 861.508866][ T44]
[ 861.508958][ T44] INFO: task kworker/u16:1:70 is blocked on a mutex likely owned by task ip:5316.
[ 861.509147][ T44] INFO: task ip:5316 blocked for more than 245 seconds.
[ 861.509272][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 861.509384][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.509562][ T44] task:ip state:D stack:25592 pid:5316 tgid:5316 ppid:5309 task_flags:0x400100 flags:0x00080001
[ 861.509799][ T44] Call Trace:
[ 861.509890][ T44]
[ 861.509945][ T44] __schedule+0x88d/0x1b90
[ 861.510055][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.510177][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.510284][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.510396][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.510508][ T44] schedule+0xd4/0x260
[ 861.510589][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.510703][ T44] __mutex_lock+0x9ae/0x1500
[ 861.510808][ T44] ? napi_enable+0x3b/0x80
[ 861.510945][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850
[ 861.511080][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.511194][ T44] ? __asan_memset+0x27/0x50
[ 861.511301][ T44] ? sg_init_table+0x19/0x60
[ 861.511417][ T44] ? try_fill_recv+0x3ec/0x1750
[ 861.511528][ T44] ? napi_enable+0x3b/0x80
[ 861.511642][ T44] napi_enable+0x3b/0x80
[ 861.511729][ T44] __virtnet_rx_resume+0x156/0x290
[ 861.511853][ T44] ? queue_delayed_work_on+0x91/0x100
[ 861.511961][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 861.512078][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 861.512189][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 861.512303][ T44] dev_xdp_install+0x4ba/0x8e0
[ 861.512411][ T44] ? netif_skb_check_for_xdp+0x600/0x600
[ 861.512532][ T44] dev_xdp_attach+0x50d/0x1320
[ 861.512645][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 861.512758][ T44] ? mutex_is_locked+0x1c/0x50
[ 861.512876][ T44] ? rtnl_is_locked+0x15/0x20
[ 861.512981][ T44] ? dev_change_xdp_fd+0x9f/0x240
[ 861.513097][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 861.513207][ T44] ? rtnl_newlink_create+0x900/0x900
[ 861.513320][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0
[ 861.513457][ T44] ? rcu_read_lock_any_held+0x41/0xa0
[ 861.513575][ T44] ? validate_chain+0x287/0x5f0
[ 861.513682][ T44] ? rcu_read_lock_any_held+0x6b/0xa0
[ 861.513794][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 861.513914][ T44] ? __lock_acquire+0x34c/0x740
[ 861.514025][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.514139][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 861.514246][ T44] ? lock_acquire+0x31/0x80
[ 861.514359][ T44] ? rtnl_newlink+0x5df/0xb20
[ 861.514464][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.514579][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.514687][ T44] ? trace_contention_end+0xd6/0x140
[ 861.514802][ T44] ? rtnl_newlink+0x5df/0xb20
[ 861.514919][ T44] ? __mutex_lock+0x32e/0x1500
[ 861.515033][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.515150][ T44] ? nla_validate_int_range+0x5b0/0x5b0
[ 861.515257][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 861.515374][ T44] rtnl_newlink+0x637/0xb20
[ 861.515483][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.515602][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.515707][ T44] ? find_held_lock+0x2b/0x80
[ 861.515826][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.515932][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.516057][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.516163][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 861.516279][ T44] ? rtnl_port_fill+0x940/0x940
[ 861.516384][ T44] ? __lock_acquire+0x34c/0x740
[ 861.516504][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.516612][ T44] ? find_held_lock+0x2b/0x80
[ 861.516727][ T44] netlink_rcv_skb+0x123/0x380
[ 861.516849][ T44] ? rtnl_port_fill+0x940/0x940
[ 861.516958][ T44] ? netlink_ack+0xcc0/0xcc0
[ 861.517075][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 861.517183][ T44] netlink_unicast+0x4a3/0x770
[ 861.517300][ T44] ? netlink_attachskb+0x810/0x810
[ 861.517408][ T44] ? __lock_acquire+0x34c/0x740
[ 861.517527][ T44] netlink_sendmsg+0x735/0xc60
[ 861.517635][ T44] ? netlink_unicast+0x770/0x770
[ 861.517752][ T44] ? __might_fault+0x97/0x140
[ 861.517873][ T44] ____sys_sendmsg+0x419/0x850
[ 861.517979][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 861.518092][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 861.518225][ T44] ? move_addr_to_kernel+0x40/0x40
[ 861.518341][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 861.518447][ T44] ? validate_chain+0x287/0x5f0
[ 861.518570][ T44] ___sys_sendmsg+0xfd/0x180
[ 861.518675][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680
[ 861.518825][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 861.518944][ T44] __sys_sendmsg+0x124/0x1c0
[ 861.519057][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 861.519164][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.519277][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680
[ 861.519414][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 861.519531][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.519639][ T44] do_syscall_64+0xbb/0xfd0
[ 861.519755][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 861.519899][ T44] RIP: 0033:0x7f9c5b32dc5e
[ 861.520012][ T44] RSP: 002b:00007ffebbb341a0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 861.520183][ T44] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f9c5b32dc5e
[ 861.520346][ T44] RDX: 0000000000000000 RSI: 00007ffebbb34260 RDI: 0000000000000003
[ 861.520523][ T44] RBP: 00007ffebbb341b0 R08: 0000000000000000 R09: 0000000000000000
[ 861.520683][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffebbb34920
[ 861.520854][ T44] R13: 00000000692ea250 R14: 0000000000000000 R15: 0000000000499600
[ 861.521023][ T44]
[ 861.521111][ T44] INFO: task ip:5316 is blocked on a mutex likely owned by task kworker/0:1:10.
[ 861.521289][ T44] task:kworker/0:1 state:D stack:27696 pid:10 tgid:10 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.521533][ T44] Workqueue: events refill_work
[ 861.521640][ T44] Call Trace:
[ 861.521724][ T44]
[ 861.521787][ T44] __schedule+0x88d/0x1b90
[ 861.521910][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.522025][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.522138][ T44] ? find_held_lock+0x2b/0x80
[ 861.522251][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.522367][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.522478][ T44] schedule+0xd4/0x260
[ 861.522578][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 861.522711][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 861.522833][ T44] ? hrtimer_cb_get_time+0x90/0x90
[ 861.522945][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.523059][ T44] ? ktime_get+0x15e/0x220
[ 861.523165][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 861.523281][ T44] ? ktime_get+0xa9/0x220
[ 861.523362][ T44] usleep_range_state+0x133/0x1b0
[ 861.523470][ T44] ? schedule_hrtimeout+0x20/0x20
[ 861.523590][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 861.523699][ T44] napi_disable_locked+0x379/0x5f0
[ 861.523811][ T44] ? _mutex_trylock_nest_lock+0x150/0x150
[ 861.523928][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470
[ 861.524067][ T44] napi_disable+0x43/0x80
[ 861.524155][ T44] refill_work+0x116/0x210
[ 861.524263][ T44] process_one_work+0xd57/0x1390
[ 861.524383][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.524491][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.524611][ T44] ? assign_work+0x152/0x380
[ 861.524718][ T44] worker_thread+0x4d6/0xd40
[ 861.524836][ T44] ? process_one_work+0x1390/0x1390
[ 861.524945][ T44] ? __kthread_parkme+0xb3/0x200
[ 861.525060][ T44] ? process_one_work+0x1390/0x1390
[ 861.525171][ T44] kthread+0x355/0x5b0
[ 861.525253][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.525367][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.525484][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.525594][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.525711][ T44] ret_from_fork+0x1d4/0x270
[ 861.525826][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.525934][ T44] ret_from_fork_asm+0x11/0x20
[ 861.526054][ T44]
[ 861.526139][ T44]
[ 861.526139][ T44] Showing all locks held in the system:
[ 861.526299][ T44] 3 locks held by kworker/0:1/10:
[ 861.526404][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.526629][ T44] #1: ffa00000000a7d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.526951][ T44] #2: ff11000008c1ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 861.527144][ T44] 1 lock held by khungtaskd/44:
[ 861.527245][ T44] #0: ffffffff86778fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db
[ 861.527437][ T44] 3 locks held by kworker/u16:1/70:
[ 861.527540][ T44] #0: ff11000009284d48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.527754][ T44] #1: ffa00000004b7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.528019][ T44] #2: ffffffff86e92ba8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 861.528206][ T44] 2 locks held by ip/5316:
[ 861.528314][ T44] #0: ffffffff86e92ba8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20
[ 861.528495][ T44] #1: ff11000008c1ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 861.528684][ T44]
[ 861.528736][ T44] =============================================
[ 861.528736][ T44]
[ 865.088826][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 1 timed out 249345 ms
[ 865.089252][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 249345000 usecs ago