[ 898.408382][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 241664 ms
[ 898.408999][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 241664000 usecs ago
[ 904.552377][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 247808 ms
[ 904.552833][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 247808000 usecs ago
[ 910.184377][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 253440 ms
[ 910.184819][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 253440000 usecs ago
[ 915.304378][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 258560 ms
[ 915.304831][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 258560000 usecs ago
[ 920.424377][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 263680 ms
[ 920.424836][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 263680000 usecs ago
[ 926.568378][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 269824 ms
[ 926.568815][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 269824000 usecs ago
[ 932.199381][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 275455 ms
[ 932.199829][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 275455000 usecs ago
[ 937.319377][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 280575 ms
[ 937.319825][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 280575000 usecs ago
[ 942.440379][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 285696 ms
[ 942.440797][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 285696000 usecs ago
[ 948.584377][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 291840 ms
[ 948.584828][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 291840000 usecs ago
[ 954.216391][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 297472 ms
[ 954.216822][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 297472000 usecs ago
[ 959.336408][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 302592 ms
[ 959.337014][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 302592000 usecs ago
[ 964.455403][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 307711 ms
[ 964.455993][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 307711000 usecs ago
[ 970.599376][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 313855 ms
[ 970.599825][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 313855000 usecs ago
[ 976.231388][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 319487 ms
[ 976.231986][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 319487000 usecs ago
[ 981.351385][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 324607 ms
[ 981.351987][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 324607000 usecs ago
[ 984.423406][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds.
[ 984.423738][ T44] Not tainted 6.19.0-rc1-virtme #1
[ 984.423864][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.424100][ T44] task:kworker/u16:0 state:D stack:26128 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.424457][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 984.424618][ T44] Call Trace:
[ 984.424718][ T44]
[ 984.424784][ T44] __schedule+0xae2/0x1720
[ 984.424910][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.425040][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.425167][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.425326][ T44] schedule+0xd4/0x260
[ 984.425472][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.425590][ T44] __mutex_lock+0xd76/0x1f20
[ 984.425756][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.425879][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.426059][ T44] ? process_one_work+0xd16/0x1390
[ 984.426181][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.426299][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.426437][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.426557][ T44] addrconf_verify_work+0x12/0x30
[ 984.426674][ T44] process_one_work+0xd57/0x1390
[ 984.426794][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.426907][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.427032][ T44] ? assign_work+0x152/0x380
[ 984.427149][ T44] worker_thread+0x4d6/0xd40
[ 984.427268][ T44] ? process_one_work+0x1390/0x1390
[ 984.427397][ T44] kthread+0x355/0x5b0
[ 984.427490][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.427604][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.427717][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.427831][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.427996][ T44] ret_from_fork+0x3fb/0x510
[ 984.428162][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.428312][ T44] ? __switch_to+0x53c/0xd00
[ 984.428460][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.428579][ T44] ret_from_fork_asm+0x11/0x20
[ 984.428700][ T44]
[ 984.428828][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5293.
[ 984.429075][ T44] INFO: task ip:5293 blocked for more than 368 seconds.
[ 984.429210][ T44] Not tainted 6.19.0-rc1-virtme #1
[ 984.429324][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.429578][ T44] task:ip state:D stack:25024 pid:5293 tgid:5293 ppid:1 task_flags:0x400100 flags:0x00080002
[ 984.429885][ T44] Call Trace:
[ 984.429980][ T44]
[ 984.430095][ T44] __schedule+0xae2/0x1720
[ 984.430224][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.430347][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.430483][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.430599][ T44] schedule+0xd4/0x260
[ 984.430687][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.430800][ T44] __mutex_lock+0xd76/0x1f20
[ 984.430944][ T44] ? napi_enable+0x3b/0x80
[ 984.431106][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.431228][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.431409][ T44] ? __asan_memset+0x27/0x50
[ 984.431535][ T44] ? sg_init_table+0x19/0x60
[ 984.431708][ T44] ? try_fill_recv+0x3ec/0x1750
[ 984.431834][ T44] ? napi_enable+0x3b/0x80
[ 984.431951][ T44] napi_enable+0x3b/0x80
[ 984.432056][ T44] __virtnet_rx_resume+0x156/0x290
[ 984.432189][ T44] ? queue_delayed_work_on+0x91/0x100
[ 984.432310][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 984.432460][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 984.432583][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 984.432698][ T44] dev_xdp_install+0x3e4/0x890
[ 984.432815][ T44] ? netif_set_xps_queue+0x40/0x40
[ 984.432936][ T44] dev_xdp_attach+0x50d/0x1310
[ 984.433063][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 984.433176][ T44] ? __bpf_prog_get+0x320/0x320
[ 984.433294][ T44] dev_change_xdp_fd+0x176/0x210
[ 984.433415][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 984.433538][ T44] ? rtnl_newlink_create+0x900/0x900
[ 984.433657][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 984.433805][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.433922][ T44] ? validate_chain+0x37b/0xb70
[ 984.434038][ T44] ? rcu_read_lock_any_held+0x66/0x90
[ 984.434151][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.434265][ T44] ? __lock_acquire+0x577/0xc10
[ 984.434385][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.434506][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.434623][ T44] ? lock_acquire+0x10a/0x150
[ 984.434739][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.434854][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.434967][ T44] ? trace_contention_end+0xd6/0x110
[ 984.435091][ T44] ? __mutex_lock+0x285/0x1f20
[ 984.435207][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.435321][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.435451][ T44] ? nla_get_range_signed+0x3d0/0x3d0
[ 984.435570][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 984.435695][ T44] rtnl_newlink+0x75c/0xe90
[ 984.435819][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.435932][ T44] ? rtnl_setlink+0x880/0x880
[ 984.436048][ T44] ? __lock_acquire+0x577/0xc10
[ 984.436165][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.436278][ T44] ? find_held_lock+0x2b/0x80
[ 984.436406][ T44] ? rtnl_setlink+0x880/0x880
[ 984.436524][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.436645][ T44] ? rtnl_setlink+0x880/0x880
[ 984.436759][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 984.436873][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.436987][ T44] ? __lock_acquire+0x577/0xc10
[ 984.437159][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.437278][ T44] ? find_held_lock+0x2b/0x80
[ 984.437412][ T44] netlink_rcv_skb+0x123/0x380
[ 984.437588][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.437708][ T44] ? netlink_ack+0xcc0/0xcc0
[ 984.437827][ T44] ? netlink_deliver_tap+0xc5/0x330
[ 984.437941][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 984.438086][ T44] netlink_unicast+0x4a3/0x770
[ 984.438210][ T44] ? netlink_attachskb+0x810/0x810
[ 984.438323][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.438466][ T44] ? __lock_acquire+0x577/0xc10
[ 984.438585][ T44] netlink_sendmsg+0x735/0xc60
[ 984.438719][ T44] ? netlink_unicast+0x770/0x770
[ 984.438874][ T44] ____sys_sendmsg+0x419/0x850
[ 984.438996][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 984.439155][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 984.439330][ T44] ? move_addr_to_kernel+0x40/0x40
[ 984.439466][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.439634][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.439758][ T44] ___sys_sendmsg+0xfd/0x180
[ 984.439879][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00
[ 984.440087][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 984.440218][ T44] __sys_sendmsg+0x124/0x1c0
[ 984.440335][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 984.440532][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.440657][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00
[ 984.440854][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 984.440999][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.441160][ T44] do_syscall_64+0xbd/0xfc0
[ 984.441279][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 984.441444][ T44] RIP: 0033:0x7fe1dd028c5e
[ 984.441570][ T44] RSP: 002b:00007ffd8236d2d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 984.441800][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fe1dd028c5e
[ 984.442015][ T44] RDX: 0000000000000000 RSI: 00007ffd8236d390 RDI: 0000000000000003
[ 984.442221][ T44] RBP: 00007ffd8236d2e0 R08: 0000000000000000 R09: 0000000000000000
[ 984.442406][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffd8236da50
[ 984.442645][ T44] R13: 00000000694dd611 R14: 0000000000000000 R15: 0000000000499600
[ 984.442828][ T44]
[ 984.442922][ T44] INFO: task ip:5293 is blocked on a mutex likely owned by task kworker/3:1:69.
[ 984.443122][ T44] task:kworker/3:1 state:D stack:28096 pid:69 tgid:69 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.443393][ T44] Workqueue: events refill_work
[ 984.443535][ T44] Call Trace:
[ 984.443656][ T44]
[ 984.443721][ T44] __schedule+0xae2/0x1720
[ 984.443840][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.444014][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.444139][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.444256][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.444401][ T44] schedule+0xd4/0x260
[ 984.444502][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 984.444697][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 984.444817][ T44] ? __hrtimer_cb_get_time+0x50/0x50
[ 984.444986][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.445123][ T44] ? ktime_get+0x15e/0x220
[ 984.445237][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 984.445358][ T44] ? ktime_get+0xa9/0x220
[ 984.445464][ T44] usleep_range_state+0x133/0x1b0
[ 984.445628][ T44] ? schedule_hrtimeout+0x20/0x20
[ 984.445748][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 984.445863][ T44] ? refill_work+0x149/0x210
[ 984.446044][ T44] napi_disable_locked+0x379/0x5f0
[ 984.446188][ T44] ? _mutex_trylock_nest_lock+0x340/0x340
[ 984.446308][ T44] ? register_netdevice_notifier_net+0x40/0x40
[ 984.446471][ T44] napi_disable+0x43/0x80
[ 984.446558][ T44] refill_work+0x116/0x210
[ 984.446679][ T44] process_one_work+0xd57/0x1390
[ 984.446847][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.446965][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.447136][ T44] ? assign_work+0x152/0x380
[ 984.447262][ T44] worker_thread+0x4d6/0xd40
[ 984.447458][ T44] ? process_one_work+0x1390/0x1390
[ 984.447576][ T44] kthread+0x355/0x5b0
[ 984.447664][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.447785][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.447948][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.448081][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.448250][ T44] ret_from_fork+0x3fb/0x510
[ 984.448408][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.448626][ T44] ? __switch_to+0x53c/0xd00
[ 984.448749][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.448866][ T44] ret_from_fork_asm+0x11/0x20
[ 984.448987][ T44]
[ 984.449110][ T44]
[ 984.449110][ T44] Showing all locks held in the system:
[ 984.449276][ T44] 3 locks held by kworker/0:0/9:
[ 984.449500][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.449786][ T44] #1: ffa0000000097cc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.450071][ T44] #2: ffffffff92085768 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0
[ 984.450314][ T44] 3 locks held by kworker/u16:0/12:
[ 984.450452][ T44] #0: ff11000009127148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.450731][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.451016][ T44] #2: ffffffff92085768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 984.451221][ T44] 1 lock held by khungtaskd/44:
[ 984.451333][ T44] #0: ffffffff91971040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30
[ 984.451569][ T44] 3 locks held by kworker/3:1/69:
[ 984.451680][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.451902][ T44] #1: ffa00000004a7cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.452210][ T44] #2: ff11000008ba2c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 984.452455][ T44] 2 locks held by ip/5293:
[ 984.452567][ T44] #0: ffffffff92085768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90
[ 984.452767][ T44] #1: ff11000008ba2c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 984.452967][ T44] 1 lock held by xdp_helper/5301:
[ 984.453089][ T44] #0: ffffffff92085768 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10
[ 984.453285][ T44]
[ 984.453343][ T44] =============================================
[ 984.453343][ T44]
[ 987.495382][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 330751 ms
[ 987.495985][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 330751000 usecs ago
[ 993.127387][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 336383 ms
[ 993.127983][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 336383000 usecs ago
[ 998.247380][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 341503 ms
[ 998.247846][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 341503000 usecs ago