[ 748.097925][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 5376 ms
[ 748.098511][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 5376000 usecs ago
[ 753.472923][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 10751 ms
[ 753.473369][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 10751000 usecs ago
[ 759.105918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 16384 ms
[ 759.106325][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 16384000 usecs ago
[ 764.225918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 21504 ms
[ 764.226314][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 21504000 usecs ago
[ 769.345919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 26624 ms
[ 769.346316][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 26624000 usecs ago
[ 775.489919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 32768 ms
[ 775.490306][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 32768000 usecs ago
[ 781.121918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 38400 ms
[ 781.122310][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 38400000 usecs ago
[ 786.241919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 43520 ms
[ 786.242321][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 43520000 usecs ago
[ 791.361918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 48640 ms
[ 791.362309][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 48640000 usecs ago
[ 797.505918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 54784 ms
[ 797.506333][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 54784000 usecs ago
[ 803.136923][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 60415 ms
[ 803.137371][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 60415000 usecs ago
[ 808.257919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 65536 ms
[ 808.258309][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 65536000 usecs ago
[ 813.376922][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 70655 ms
[ 813.377334][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 70655000 usecs ago
[ 819.521919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 76800 ms
[ 819.522358][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 76800000 usecs ago
[ 825.153918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 82432 ms
[ 825.154340][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 82432000 usecs ago
[ 830.273918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 87552 ms
[ 830.274305][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 87552000 usecs ago
[ 835.393919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 92672 ms
[ 835.394300][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 92672000 usecs ago
[ 841.536923][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 98815 ms
[ 841.537313][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 98815000 usecs ago
[ 847.169918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 104448 ms
[ 847.170384][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 104448000 usecs ago
[ 852.289918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 109568 ms
[ 852.290346][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 109568000 usecs ago
[ 857.409919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 114688 ms
[ 857.410339][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 114688000 usecs ago
[ 861.505949][ T44] INFO: task ip:6052 blocked for more than 122 seconds.
[ 861.506250][ T44] Not tainted 6.19.0-rc3-virtme #1
[ 861.506401][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.506637][ T44] task:ip state:D stack:25312 pid:6052 tgid:6052 ppid:6047 task_flags:0x400100 flags:0x00080000
[ 861.506939][ T44] Call Trace:
[ 861.507039][ T44]
[ 861.507108][ T44] __schedule+0xae2/0x1720
[ 861.507243][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.507374][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.507506][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.507641][ T44] schedule+0xd4/0x260
[ 861.507737][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.507863][ T44] __mutex_lock+0xd76/0x1f20
[ 861.507988][ T44] ? napi_enable+0x3b/0x80
[ 861.508110][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.508230][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.508349][ T44] ? __asan_memset+0x27/0x50
[ 861.508469][ T44] ? sg_init_table+0x19/0x60
[ 861.508594][ T44] ? try_fill_recv+0x3ec/0x1750
[ 861.508718][ T44] ? napi_enable+0x3b/0x80
[ 861.508838][ T44] napi_enable+0x3b/0x80
[ 861.508937][ T44] __virtnet_rx_resume+0x156/0x290
[ 861.509051][ T44] ? queue_delayed_work_on+0x91/0x100
[ 861.509169][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 861.509286][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 861.509406][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 861.509524][ T44] dev_xdp_install+0x3e4/0x890
[ 861.509642][ T44] ? netif_set_xps_queue+0x40/0x40
[ 861.510009][ T44] dev_xdp_attach+0x50d/0x1310
[ 861.510128][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 861.510245][ T44] ? __bpf_prog_get+0x320/0x320
[ 861.510363][ T44] dev_change_xdp_fd+0x176/0x210
[ 861.510482][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 861.510603][ T44] ? rtnl_newlink_create+0x900/0x900
[ 861.510718][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 861.510862][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 861.510985][ T44] ? validate_chain+0x37b/0xb70
[ 861.511102][ T44] ? rcu_read_lock_any_held+0x66/0x90
[ 861.511216][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 861.511332][ T44] ? __lock_acquire+0x577/0xc10
[ 861.511449][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.511570][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 861.511685][ T44] ? lock_acquire+0x10a/0x150
[ 861.511800][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.511923][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.512039][ T44] ? trace_contention_end+0xd6/0x110
[ 861.512156][ T44] ? __mutex_lock+0x285/0x1f20
[ 861.512272][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 861.512389][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.512508][ T44] ? nla_get_range_signed+0x3d0/0x3d0
[ 861.512631][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 861.512748][ T44] rtnl_newlink+0x75c/0xe90
[ 861.512867][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.512987][ T44] ? rtnl_setlink+0x880/0x880
[ 861.513103][ T44] ? __lock_acquire+0x577/0xc10
[ 861.513221][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.513334][ T44] ? find_held_lock+0x2b/0x80
[ 861.513450][ T44] ? rtnl_setlink+0x880/0x880
[ 861.513569][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.513687][ T44] ? rtnl_setlink+0x880/0x880
[ 861.513801][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 861.513921][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 861.514037][ T44] ? __lock_acquire+0x577/0xc10
[ 861.514153][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.514268][ T44] ? find_held_lock+0x2b/0x80
[ 861.514384][ T44] netlink_rcv_skb+0x123/0x380
[ 861.514500][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 861.514621][ T44] ? netlink_ack+0xcc0/0xcc0
[ 861.514744][ T44] ? netlink_deliver_tap+0xc5/0x330
[ 861.514858][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 861.514979][ T44] netlink_unicast+0x4a3/0x770
[ 861.515095][ T44] ? netlink_attachskb+0x810/0x810
[ 861.515212][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.515327][ T44] ? __lock_acquire+0x577/0xc10
[ 861.515444][ T44] netlink_sendmsg+0x735/0xc60
[ 861.515564][ T44] ? netlink_unicast+0x770/0x770
[ 861.515682][ T44] ____sys_sendmsg+0x419/0x850
[ 861.515797][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 861.515918][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 861.516060][ T44] ? move_addr_to_kernel+0x40/0x40
[ 861.516182][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 861.516303][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 861.516418][ T44] ___sys_sendmsg+0xfd/0x180
[ 861.516537][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00
[ 861.516681][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 861.516810][ T44] __sys_sendmsg+0x124/0x1c0
[ 861.516931][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 861.517047][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.517163][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00
[ 861.517308][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 861.517423][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.517548][ T44] do_syscall_64+0xbd/0xfc0
[ 861.517665][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 861.517809][ T44] RIP: 0033:0x7fd4195b0c5e
[ 861.517937][ T44] RSP: 002b:00007fffcb6f1650 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 861.518117][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fd4195b0c5e
[ 861.518292][ T44] RDX: 0000000000000000 RSI: 00007fffcb6f1710 RDI: 0000000000000003
[ 861.518476][ T44] RBP: 00007fffcb6f1660 R08: 0000000000000000 R09: 0000000000000000
[ 861.518658][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffcb6f1dd0
[ 861.518832][ T44] R13: 0000000069578053 R14: 0000000000000000 R15: 0000000000499600
[ 861.519014][ T44]
[ 861.519108][ T44] INFO: task ip:6052 is blocked on a mutex likely owned by task kworker/3:1:59.
[ 861.519302][ T44] task:kworker/3:1 state:D stack:27952 pid:59 tgid:59 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.519560][ T44] Workqueue: events refill_work
[ 861.519680][ T44] Call Trace:
[ 861.519768][ T44]
[ 861.519829][ T44] __schedule+0xae2/0x1720
[ 861.519952][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.520068][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.520185][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.520300][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.520414][ T44] schedule+0xd4/0x260
[ 861.520503][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 861.520649][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 861.520765][ T44] ? __hrtimer_cb_get_time+0x50/0x50
[ 861.520881][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.521000][ T44] ? ktime_get+0x15e/0x220
[ 861.521113][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 861.521230][ T44] ? ktime_get+0xa9/0x220
[ 861.521324][ T44] usleep_range_state+0x133/0x1b0
[ 861.521439][ T44] ? schedule_hrtimeout+0x20/0x20
[ 861.521556][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 861.521671][ T44] ? refill_work+0x149/0x210
[ 861.521787][ T44] napi_disable_locked+0x379/0x5f0
[ 861.521902][ T44] ? _mutex_trylock_nest_lock+0x340/0x340
[ 861.522022][ T44] ? register_netdevice_notifier_net+0x40/0x40
[ 861.522168][ T44] napi_disable+0x43/0x80
[ 861.522256][ T44] refill_work+0x116/0x210
[ 861.522373][ T44] process_one_work+0xd57/0x1390
[ 861.522491][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.522609][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.522725][ T44] ? assign_work+0x152/0x380
[ 861.522840][ T44] worker_thread+0x4d6/0xd40
[ 861.522965][ T44] ? process_one_work+0x1390/0x1390
[ 861.523080][ T44] kthread+0x355/0x5b0
[ 861.523168][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.523286][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.523401][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.523518][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.523633][ T44] ret_from_fork+0x3fb/0x510
[ 861.523750][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 861.523893][ T44] ? __switch_to+0x53c/0xd00
[ 861.524016][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.524132][ T44] ret_from_fork_asm+0x11/0x20
[ 861.524254][ T44]
[ 861.524345][ T44]
[ 861.524345][ T44] Showing all locks held in the system:
[ 861.524517][ T44] 3 locks held by kworker/u16:0/12:
[ 861.524632][ T44] #0: ff11000009127148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.524862][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.525217][ T44] #2: ffffffff8c2859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 861.525415][ T44] 1 lock held by khungtaskd/44:
[ 861.525530][ T44] #0: ffffffff8bb710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30
[ 861.525753][ T44] 3 locks held by kworker/3:1/59:
[ 861.525862][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.526088][ T44] #1: ffa00000003ffcc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.526340][ T44] #2: ff11000008a3ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 861.526547][ T44] 2 locks held by ip/6052:
[ 861.526656][ T44] #0: ffffffff8c2859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90
[ 861.526853][ T44] #1: ff11000008a3ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 861.527053][ T44]
[ 861.527111][ T44] =============================================
[ 861.527111][ T44]
[ 863.553918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 120832 ms
[ 863.554343][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 120832000 usecs ago
[ 869.185918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 126464 ms
[ 869.186389][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 126464000 usecs ago
[ 874.304922][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 131583 ms
[ 874.305346][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 131583000 usecs ago
[ 880.448923][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 137727 ms
[ 880.449353][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 137727000 usecs ago
[ 886.081919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 143360 ms
[ 886.082349][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 143360000 usecs ago
[ 891.201918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 148480 ms
[ 891.202391][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 148480000 usecs ago
[ 896.320923][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 153599 ms
[ 896.321388][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 153599000 usecs ago
[ 902.465918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 159744 ms
[ 902.466346][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 159744000 usecs ago
[ 908.097922][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 165376 ms
[ 908.098357][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 165376000 usecs ago
[ 913.217919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 170496 ms
[ 913.218335][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 170496000 usecs ago
[ 918.337919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 175616 ms
[ 918.338386][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 175616000 usecs ago
[ 924.481919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 181760 ms
[ 924.482407][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 181760000 usecs ago
[ 930.112923][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 187391 ms
[ 930.113360][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 187391000 usecs ago
[ 935.233919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 192512 ms
[ 935.234353][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 192512000 usecs ago
[ 940.353918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 197632 ms
[ 940.354345][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 197632000 usecs ago
[ 946.497919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 203776 ms
[ 946.498346][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 203776000 usecs ago
[ 952.129919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 209408 ms
[ 952.130356][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 209408000 usecs ago
[ 957.249919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 214528 ms
[ 957.250351][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 214528000 usecs ago
[ 962.369919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 219648 ms
[ 962.370371][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 219648000 usecs ago
[ 968.513919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 225792 ms
[ 968.514344][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 225792000 usecs ago
[ 974.145918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 231424 ms
[ 974.146336][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 231424000 usecs ago
[ 979.265918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 236544 ms
[ 979.266367][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 236544000 usecs ago
[ 984.385919][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 241664 ms
[ 984.385923][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds.
[ 984.386547][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 241664000 usecs ago
[ 984.386904][ T44] Not tainted 6.19.0-rc3-virtme #1
[ 984.386905][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.386907][ T44] task:kworker/u16:0 state:D stack:26352 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.386928][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 984.386933][ T44] Call Trace:
[ 984.386934][ T44]
[ 984.386937][ T44] __schedule+0xae2/0x1720
[ 984.386944][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.386948][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.386950][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.386955][ T44] schedule+0xd4/0x260
[ 984.386958][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.386960][ T44] __mutex_lock+0xd76/0x1f20
[ 984.386965][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.388841][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.388973][ T44] ? process_one_work+0xd16/0x1390
[ 984.389092][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.389206][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.389321][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.389436][ T44] addrconf_verify_work+0x12/0x30
[ 984.389553][ T44] process_one_work+0xd57/0x1390
[ 984.389672][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.389785][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.389901][ T44] ? assign_work+0x152/0x380
[ 984.390024][ T44] worker_thread+0x4d6/0xd40
[ 984.390146][ T44] ? process_one_work+0x1390/0x1390
[ 984.390261][ T44] kthread+0x355/0x5b0
[ 984.390348][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.390464][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.390583][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.390698][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.390815][ T44] ret_from_fork+0x3fb/0x510
[ 984.390935][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.391081][ T44] ? __switch_to+0x53c/0xd00
[ 984.391198][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.391313][ T44] ret_from_fork_asm+0x11/0x20
[ 984.391433][ T44]
[ 984.391532][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:6052.
[ 984.391736][ T44] INFO: task ip:6052 blocked for more than 245 seconds.
[ 984.391869][ T44] Not tainted 6.19.0-rc3-virtme #1
[ 984.391983][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.392168][ T44] task:ip state:D stack:25312 pid:6052 tgid:6052 ppid:6047 task_flags:0x400100 flags:0x00080000
[ 984.392417][ T44] Call Trace:
[ 984.392503][ T44]
[ 984.392566][ T44] __schedule+0xae2/0x1720
[ 984.392682][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.392799][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.392918][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.393034][ T44] schedule+0xd4/0x260
[ 984.393122][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.393237][ T44] __mutex_lock+0xd76/0x1f20
[ 984.393353][ T44] ? napi_enable+0x3b/0x80
[ 984.393467][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.393585][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.393699][ T44] ? __asan_memset+0x27/0x50
[ 984.393816][ T44] ? sg_init_table+0x19/0x60
[ 984.393938][ T44] ? try_fill_recv+0x3ec/0x1750
[ 984.394055][ T44] ? napi_enable+0x3b/0x80
[ 984.394169][ T44] napi_enable+0x3b/0x80
[ 984.394255][ T44] __virtnet_rx_resume+0x156/0x290
[ 984.394371][ T44] ? queue_delayed_work_on+0x91/0x100
[ 984.394488][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 984.394605][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 984.394723][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 984.394837][ T44] dev_xdp_install+0x3e4/0x890
[ 984.394956][ T44] ? netif_set_xps_queue+0x40/0x40
[ 984.395075][ T44] dev_xdp_attach+0x50d/0x1310
[ 984.395193][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 984.395309][ T44] ? __bpf_prog_get+0x320/0x320
[ 984.395427][ T44] dev_change_xdp_fd+0x176/0x210
[ 984.395544][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 984.395661][ T44] ? rtnl_newlink_create+0x900/0x900
[ 984.395774][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 984.395921][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.396032][ T44] ? validate_chain+0x37b/0xb70
[ 984.396147][ T44] ? rcu_read_lock_any_held+0x66/0x90
[ 984.396261][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.396376][ T44] ? __lock_acquire+0x577/0xc10
[ 984.396492][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.396613][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.396727][ T44] ? lock_acquire+0x10a/0x150
[ 984.396842][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.396963][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.397078][ T44] ? trace_contention_end+0xd6/0x110
[ 984.397193][ T44] ? __mutex_lock+0x285/0x1f20
[ 984.397310][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.397426][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.397545][ T44] ? nla_get_range_signed+0x3d0/0x3d0
[ 984.397663][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 984.397784][ T44] rtnl_newlink+0x75c/0xe90
[ 984.397903][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.398023][ T44] ? rtnl_setlink+0x880/0x880
[ 984.398144][ T44] ? __lock_acquire+0x577/0xc10
[ 984.398262][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.398376][ T44] ? find_held_lock+0x2b/0x80
[ 984.398492][ T44] ? rtnl_setlink+0x880/0x880
[ 984.398611][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.398734][ T44] ? rtnl_setlink+0x880/0x880
[ 984.398850][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 984.398971][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.399085][ T44] ? __lock_acquire+0x577/0xc10
[ 984.399202][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.399315][ T44] ? find_held_lock+0x2b/0x80
[ 984.399430][ T44] netlink_rcv_skb+0x123/0x380
[ 984.399547][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.399664][ T44] ? netlink_ack+0xcc0/0xcc0
[ 984.399781][ T44] ? netlink_deliver_tap+0xc5/0x330
[ 984.399895][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 984.400015][ T44] netlink_unicast+0x4a3/0x770
[ 984.400135][ T44] ? netlink_attachskb+0x810/0x810
[ 984.400249][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.400363][ T44] ? __lock_acquire+0x577/0xc10
[ 984.400479][ T44] netlink_sendmsg+0x735/0xc60
[ 984.400597][ T44] ? netlink_unicast+0x770/0x770
[ 984.400716][ T44] ____sys_sendmsg+0x419/0x850
[ 984.400833][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 984.400952][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 984.401095][ T44] ? move_addr_to_kernel+0x40/0x40
[ 984.401210][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.401327][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.401441][ T44] ___sys_sendmsg+0xfd/0x180
[ 984.401559][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00
[ 984.401702][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 984.401827][ T44] __sys_sendmsg+0x124/0x1c0
[ 984.401949][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 984.402063][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.402180][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00
[ 984.402325][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 984.402441][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.402561][ T44] do_syscall_64+0xbd/0xfc0
[ 984.402677][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 984.402820][ T44] RIP: 0033:0x7fd4195b0c5e
[ 984.402946][ T44] RSP: 002b:00007fffcb6f1650 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 984.403121][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fd4195b0c5e
[ 984.403293][ T44] RDX: 0000000000000000 RSI: 00007fffcb6f1710 RDI: 0000000000000003
[ 984.403466][ T44] RBP: 00007fffcb6f1660 R08: 0000000000000000 R09: 0000000000000000
[ 984.403640][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffcb6f1dd0
[ 984.403818][ T44] R13: 0000000069578053 R14: 0000000000000000 R15: 0000000000499600
[ 984.403999][ T44]
[ 984.404087][ T44] INFO: task ip:6052 is blocked on a mutex likely owned by task kworker/3:1:59.
[ 984.404278][ T44] task:kworker/3:1 state:D stack:27952 pid:59 tgid:59 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.404528][ T44] Workqueue: events refill_work
[ 984.404644][ T44] Call Trace:
[ 984.404729][ T44]
[ 984.404790][ T44] __schedule+0xae2/0x1720
[ 984.404905][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.405025][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.405143][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.405260][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.405376][ T44] schedule+0xd4/0x260
[ 984.405463][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 984.405610][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 984.405725][ T44] ? __hrtimer_cb_get_time+0x50/0x50
[ 984.405841][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.405959][ T44] ? ktime_get+0x15e/0x220
[ 984.406073][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 984.406187][ T44] ? ktime_get+0xa9/0x220
[ 984.406275][ T44] usleep_range_state+0x133/0x1b0
[ 984.406391][ T44] ? schedule_hrtimeout+0x20/0x20
[ 984.406505][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 984.406622][ T44] ? refill_work+0x149/0x210
[ 984.406737][ T44] napi_disable_locked+0x379/0x5f0
[ 984.406851][ T44] ? _mutex_trylock_nest_lock+0x340/0x340
[ 984.406975][ T44] ? register_netdevice_notifier_net+0x40/0x40
[ 984.407121][ T44] napi_disable+0x43/0x80
[ 984.407208][ T44] refill_work+0x116/0x210
[ 984.407325][ T44] process_one_work+0xd57/0x1390
[ 984.407445][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.407564][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.407682][ T44] ? assign_work+0x152/0x380
[ 984.407798][ T44] worker_thread+0x4d6/0xd40
[ 984.407924][ T44] ? process_one_work+0x1390/0x1390
[ 984.408039][ T44] kthread+0x355/0x5b0
[ 984.408128][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.408247][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.408361][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.408475][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.408595][ T44] ret_from_fork+0x3fb/0x510
[ 984.408710][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.408851][ T44] ? __switch_to+0x53c/0xd00
[ 984.408972][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.409088][ T44] ret_from_fork_asm+0x11/0x20
[ 984.409207][ T44]
[ 984.409296][ T44]
[ 984.409296][ T44] Showing all locks held in the system:
[ 984.409461][ T44] 3 locks held by kworker/u16:0/12:
[ 984.409582][ T44] #0: ff11000009127148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.409807][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.410135][ T44] #2: ffffffff8c2859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 984.410332][ T44] 1 lock held by khungtaskd/44:
[ 984.410444][ T44] #0: ffffffff8bb710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30
[ 984.410680][ T44] 3 locks held by kworker/3:1/59:
[ 984.410790][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.411016][ T44] #1: ffa00000003ffcc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.411272][ T44] #2: ff11000008a3ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 984.411475][ T44] 2 locks held by ip/6052:
[ 984.411590][ T44] #0: ffffffff8c2859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90
[ 984.411782][ T44] #1: ff11000008a3ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 984.411981][ T44]
[ 984.412039][ T44] =============================================
[ 984.412039][ T44]
[ 990.529918][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 247808 ms
[ 990.530335][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 247808000 usecs ago