[ 910.182791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 159231 ms
[ 910.183333][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 159231000 usecs ago
[ 915.302791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 164351 ms
[ 915.303296][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 164351000 usecs ago
[ 920.422791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 169471 ms
[ 920.423317][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 169471000 usecs ago
[ 926.566793][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 175615 ms
[ 926.567316][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 175615000 usecs ago
[ 932.198792][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 181247 ms
[ 932.199293][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 181247000 usecs ago
[ 937.318790][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 186367 ms
[ 937.319316][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 186367000 usecs ago
[ 942.438792][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 191487 ms
[ 942.439337][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 191487000 usecs ago
[ 948.582796][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 197631 ms
[ 948.583507][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 197631000 usecs ago
[ 954.214795][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 203263 ms
[ 954.215442][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 203263000 usecs ago
[ 959.334790][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 208383 ms
[ 959.335307][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 208383000 usecs ago
[ 964.454788][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 213503 ms
[ 964.455308][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 213503000 usecs ago
[ 970.598791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 219647 ms
[ 970.599284][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 219647000 usecs ago
[ 976.230789][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 225279 ms
[ 976.231309][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 225279000 usecs ago
[ 981.350791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 230399 ms
[ 981.351545][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 230399000 usecs ago
[ 984.422808][ T44] INFO: task kworker/u16:0:12 blocked for more than 368 seconds.
[ 984.423300][ T44] Not tainted 6.19.0-rc1-virtme #1
[ 984.423575][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.423993][ T44] task:kworker/u16:0 state:D stack:26784 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.424843][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 984.425167][ T44] Call Trace:
[ 984.425402][ T44]
[ 984.425558][ T44] __schedule+0xae2/0x1720
[ 984.425850][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.426124][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.426400][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.426684][ T44] schedule+0xd4/0x260
[ 984.426915][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.427189][ T44] __mutex_lock+0xd76/0x1f20
[ 984.427454][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.427718][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.427999][ T44] ? process_one_work+0xd16/0x1390
[ 984.428268][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.428531][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.428817][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.429075][ T44] addrconf_verify_work+0x12/0x30
[ 984.429338][ T44] process_one_work+0xd57/0x1390
[ 984.429603][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.429871][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.430137][ T44] ? assign_work+0x152/0x380
[ 984.430400][ T44] worker_thread+0x4d6/0xd40
[ 984.430669][ T44] ? process_one_work+0x1390/0x1390
[ 984.430937][ T44] kthread+0x355/0x5b0
[ 984.431165][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.431423][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.431681][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.431942][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.432205][ T44] ret_from_fork+0x3fb/0x510
[ 984.432464][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.432768][ T44] ? __switch_to+0x53c/0xd00
[ 984.433062][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.433322][ T44] ret_from_fork_asm+0x11/0x20
[ 984.433592][ T44]
[ 984.433843][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5295.
[ 984.434237][ T44] INFO: task ip:5295 blocked for more than 368 seconds.
[ 984.434526][ T44] Not tainted 6.19.0-rc1-virtme #1
[ 984.434769][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.435140][ T44] task:ip state:D stack:25072 pid:5295 tgid:5295 ppid:1 task_flags:0x400100 flags:0x00080002
[ 984.435596][ T44] Call Trace:
[ 984.435814][ T44]
[ 984.435958][ T44] __schedule+0xae2/0x1720
[ 984.436234][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.436498][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.436749][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.437016][ T44] schedule+0xd4/0x260
[ 984.437245][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.437496][ T44] __mutex_lock+0xd76/0x1f20
[ 984.437751][ T44] ? __folio_put+0x1f5/0x320
[ 984.438022][ T44] ? napi_enable+0x3b/0x80
[ 984.438292][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.438549][ T44] ? dma_map_phys+0x1b1/0x220
[ 984.438824][ T44] ? __asan_memset+0x27/0x50
[ 984.439086][ T44] ? sg_init_table+0x19/0x60
[ 984.439352][ T44] ? try_fill_recv+0x3ec/0x1750
[ 984.439615][ T44] ? napi_enable+0x3b/0x80
[ 984.439886][ T44] napi_enable+0x3b/0x80
[ 984.440113][ T44] __virtnet_rx_resume+0x156/0x290
[ 984.440368][ T44] ? queue_delayed_work_on+0x91/0x100
[ 984.440627][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 984.440897][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 984.441164][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 984.441421][ T44] dev_xdp_install+0x3e4/0x890
[ 984.441681][ T44] ? netif_set_xps_queue+0x40/0x40
[ 984.441957][ T44] dev_xdp_attach+0x50d/0x1310
[ 984.442231][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 984.442492][ T44] ? __bpf_prog_get+0x320/0x320
[ 984.442751][ T44] dev_change_xdp_fd+0x176/0x210
[ 984.443018][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 984.443288][ T44] ? rtnl_newlink_create+0x900/0x900
[ 984.443547][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 984.443860][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.444123][ T44] ? validate_chain+0x37b/0xb70
[ 984.444383][ T44] ? rcu_read_lock_any_held+0x66/0x90
[ 984.444637][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.444904][ T44] ? __lock_acquire+0x577/0xc10
[ 984.445173][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.445436][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.445691][ T44] ? lock_acquire+0x10a/0x150
[ 984.445953][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.446218][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.446481][ T44] ? trace_contention_end+0xd6/0x110
[ 984.446737][ T44] ? __mutex_lock+0x285/0x1f20
[ 984.446999][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.447267][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.447524][ T44] ? nla_get_range_signed+0x3d0/0x3d0
[ 984.447807][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 984.448074][ T44] rtnl_newlink+0x75c/0xe90
[ 984.448339][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.448595][ T44] ? rtnl_setlink+0x880/0x880
[ 984.448858][ T44] ? __lock_acquire+0x577/0xc10
[ 984.449126][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.449386][ T44] ? find_held_lock+0x2b/0x80
[ 984.449651][ T44] ? rtnl_setlink+0x880/0x880
[ 984.449916][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.450183][ T44] ? rtnl_setlink+0x880/0x880
[ 984.450447][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 984.450706][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.450972][ T44] ? __lock_acquire+0x577/0xc10
[ 984.451241][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.451501][ T44] ? find_held_lock+0x2b/0x80
[ 984.451764][ T44] netlink_rcv_skb+0x123/0x380
[ 984.452039][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.452299][ T44] ? netlink_ack+0xcc0/0xcc0
[ 984.452565][ T44] ? netlink_deliver_tap+0xc5/0x330
[ 984.452832][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 984.453095][ T44] netlink_unicast+0x4a3/0x770
[ 984.453356][ T44] ? netlink_attachskb+0x810/0x810
[ 984.453620][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.453885][ T44] ? __lock_acquire+0x577/0xc10
[ 984.454151][ T44] netlink_sendmsg+0x735/0xc60
[ 984.454411][ T44] ? netlink_unicast+0x770/0x770
[ 984.454672][ T44] ____sys_sendmsg+0x419/0x850
[ 984.454938][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 984.455200][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 984.455498][ T44] ? move_addr_to_kernel+0x40/0x40
[ 984.455762][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.456032][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.456292][ T44] ___sys_sendmsg+0xfd/0x180
[ 984.456549][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00
[ 984.456847][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 984.457129][ T44] __sys_sendmsg+0x124/0x1c0
[ 984.457393][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 984.457644][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.457898][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00
[ 984.458203][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 984.458462][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.458716][ T44] do_syscall_64+0xbd/0xfc0
[ 984.458981][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 984.459288][ T44] RIP: 0033:0x7fd20ecb0c5e
[ 984.459555][ T44] RSP: 002b:00007fffb11e8bf0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 984.459887][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fd20ecb0c5e
[ 984.460205][ T44] RDX: 0000000000000000 RSI: 00007fffb11e8cb0 RDI: 0000000000000003
[ 984.460552][ T44] RBP: 00007fffb11e8c00 R08: 0000000000000000 R09: 0000000000000000
[ 984.460906][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffb11e9370
[ 984.461256][ T44] R13: 000000006949e1a8 R14: 0000000000000000 R15: 0000000000499600
[ 984.461611][ T44]
[ 984.461839][ T44] INFO: task ip:5295 is blocked on a mutex likely owned by task kworker/2:2:66.
[ 984.462208][ T44] task:kworker/2:2 state:D stack:28312 pid:66 tgid:66 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.462671][ T44] Workqueue: events refill_work
[ 984.462936][ T44] Call Trace:
[ 984.463124][ T44]
[ 984.463298][ T44] __schedule+0xae2/0x1720
[ 984.463565][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.463840][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.464106][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.464368][ T44] schedule+0xd4/0x260
[ 984.464584][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 984.464887][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 984.465152][ T44] ? __hrtimer_cb_get_time+0x50/0x50
[ 984.465414][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.465666][ T44] ? ktime_get+0x15e/0x220
[ 984.465928][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 984.466193][ T44] ? ktime_get+0xa9/0x220
[ 984.466414][ T44] usleep_range_state+0x133/0x1b0
[ 984.466668][ T44] ? schedule_hrtimeout+0x20/0x20
[ 984.466934][ T44] ? __free_object+0x2ad/0x4b0
[ 984.467197][ T44] napi_disable_locked+0x379/0x5f0
[ 984.467455][ T44] ? _mutex_trylock_nest_lock+0x340/0x340
[ 984.467713][ T44] ? register_netdevice_notifier_net+0x40/0x40
[ 984.468038][ T44] napi_disable+0x43/0x80
[ 984.468260][ T44] refill_work+0x116/0x210
[ 984.468522][ T44] process_one_work+0xd57/0x1390
[ 984.468802][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.469066][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.469334][ T44] ? assign_work+0x152/0x380
[ 984.469593][ T44] worker_thread+0x4d6/0xd40
[ 984.469871][ T44] ? process_one_work+0x1390/0x1390
[ 984.470133][ T44] kthread+0x355/0x5b0
[ 984.470353][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.470605][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.470871][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.471135][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.471395][ T44] ret_from_fork+0x3fb/0x510
[ 984.471651][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.471965][ T44] ? __switch_to+0x53c/0xd00
[ 984.472229][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.472485][ T44] ret_from_fork_asm+0x11/0x20
[ 984.472752][ T44]
[ 984.472984][ T44]
[ 984.472984][ T44] Showing all locks held in the system:
[ 984.473318][ T44] 3 locks held by kworker/u16:0/12:
[ 984.473571][ T44] #0: ff110000091a7148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.474117][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.474614][ T44] #2: ffffffffbde85768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 984.475004][ T44] 1 lock held by khungtaskd/44:
[ 984.475266][ T44] #0: ffffffffbd771040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30
[ 984.475700][ T44] 3 locks held by kworker/2:2/66:
[ 984.475956][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.476388][ T44] #1: ffa0000000477cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.476864][ T44] #2: ff11000008caac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 984.477252][ T44] 3 locks held by kworker/0:2/172:
[ 984.477501][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.477926][ T44] #1: ffa0000000807cc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.478351][ T44] #2: ffffffffbde85768 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0
[ 984.478731][ T44] 2 locks held by ip/5295:
[ 984.478980][ T44] #0: ffffffffbde85768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90
[ 984.479363][ T44] #1: ff11000008caac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 984.479730][ T44] 1 lock held by xdp_helper/5303:
[ 984.479988][ T44] #0: ffffffffbde85768 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10
[ 984.480379][ T44]
[ 984.480518][ T44] =============================================
[ 984.480518][ T44]
[ 987.494791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 236543 ms
[ 987.495268][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 236543000 usecs ago
[ 993.126791][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 242175 ms
[ 993.127273][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 242175000 usecs ago
[ 998.246792][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 247295 ms
[ 998.247291][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 247295000 usecs ago
[ 1003.366787][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 252415 ms
[ 1003.367552][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 252415000 usecs ago
[ 1009.510789][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 258559 ms
[ 1009.511307][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 258559000 usecs ago
[ 1015.142788][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 264191 ms
[ 1015.143288][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 264191000 usecs ago