[ 965.132923][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 5311 ms
[ 965.133497][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 5311000 usecs ago
[ 970.572909][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 10751 ms
[ 970.573274][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 10751000 usecs ago
[ 976.204911][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 16383 ms
[ 976.205289][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 16383000 usecs ago
[ 981.324912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 21503 ms
[ 981.325275][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 21503000 usecs ago
[ 984.397918][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds.
[ 984.398207][ T44] Not tainted 6.19.0-rc3-virtme #1
[ 984.398366][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.398653][ T44] task:kworker/u16:0 state:D stack:26128 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.399022][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 984.399182][ T44] Call Trace:
[ 984.399277][ T44]
[ 984.399345][ T44] __schedule+0xae2/0x1720
[ 984.399475][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.399601][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.399726][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.399854][ T44] schedule+0xd4/0x260
[ 984.399958][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.400078][ T44] __mutex_lock+0xd76/0x1f20
[ 984.400197][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.400316][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.400437][ T44] ? process_one_work+0xd16/0x1390
[ 984.400555][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.400675][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.400793][ T44] ? addrconf_verify_work+0x12/0x30
[ 984.400920][ T44] addrconf_verify_work+0x12/0x30
[ 984.401037][ T44] process_one_work+0xd57/0x1390
[ 984.401155][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.401268][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.401384][ T44] ? assign_work+0x152/0x380
[ 984.401500][ T44] worker_thread+0x4d6/0xd40
[ 984.401622][ T44] ? process_one_work+0x1390/0x1390
[ 984.401736][ T44] kthread+0x355/0x5b0
[ 984.401823][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.401941][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.402055][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.402169][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.402284][ T44] ret_from_fork+0x3fb/0x510
[ 984.402400][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.402542][ T44] ? __switch_to+0x53c/0xd00
[ 984.402656][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.402768][ T44] ret_from_fork_asm+0x11/0x20
[ 984.402891][ T44]
[ 984.403009][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5814.
[ 984.403215][ T44] INFO: task ip:5814 blocked for more than 368 seconds.
[ 984.403349][ T44] Not tainted 6.19.0-rc3-virtme #1
[ 984.403463][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 984.403646][ T44] task:ip state:D stack:24976 pid:5814 tgid:5814 ppid:1 task_flags:0x400100 flags:0x00080002
[ 984.403895][ T44] Call Trace:
[ 984.403986][ T44]
[ 984.404048][ T44] __schedule+0xae2/0x1720
[ 984.404163][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.404278][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.404390][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.404503][ T44] schedule+0xd4/0x260
[ 984.404589][ T44] schedule_preempt_disabled+0x18/0x30
[ 984.404701][ T44] __mutex_lock+0xd76/0x1f20
[ 984.404819][ T44] ? napi_enable+0x3b/0x80
[ 984.404940][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.405052][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.405165][ T44] ? __asan_memset+0x27/0x50
[ 984.405282][ T44] ? sg_init_table+0x19/0x60
[ 984.405398][ T44] ? try_fill_recv+0x3ec/0x1750
[ 984.405515][ T44] ? napi_enable+0x3b/0x80
[ 984.405627][ T44] napi_enable+0x3b/0x80
[ 984.405715][ T44] __virtnet_rx_resume+0x156/0x290
[ 984.405827][ T44] ? queue_delayed_work_on+0x91/0x100
[ 984.405948][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 984.406074][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 984.406192][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 984.406305][ T44] dev_xdp_install+0x3e4/0x890
[ 984.406419][ T44] ? netif_set_xps_queue+0x40/0x40
[ 984.406538][ T44] dev_xdp_attach+0x50d/0x1310
[ 984.406655][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 984.406768][ T44] ? __bpf_prog_get+0x320/0x320
[ 984.406886][ T44] dev_change_xdp_fd+0x176/0x210
[ 984.407011][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 984.407128][ T44] ? rtnl_newlink_create+0x900/0x900
[ 984.407242][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 984.407385][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.407497][ T44] ? validate_chain+0x37b/0xb70
[ 984.407611][ T44] ? rcu_read_lock_any_held+0x66/0x90
[ 984.407723][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.407836][ T44] ? __lock_acquire+0x577/0xc10
[ 984.407959][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.408074][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.408188][ T44] ? lock_acquire+0x10a/0x150
[ 984.408303][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.408416][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.408528][ T44] ? trace_contention_end+0xd6/0x110
[ 984.408642][ T44] ? __mutex_lock+0x285/0x1f20
[ 984.408756][ T44] ? rtnl_newlink+0x6fc/0xe90
[ 984.408872][ T44] ? ww_mutex_lock+0x160/0x160
[ 984.408990][ T44] ? nla_get_range_signed+0x3d0/0x3d0
[ 984.409110][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 984.409228][ T44] rtnl_newlink+0x75c/0xe90
[ 984.409343][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.409456][ T44] ? rtnl_setlink+0x880/0x880
[ 984.409570][ T44] ? __lock_acquire+0x577/0xc10
[ 984.409684][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.409798][ T44] ? find_held_lock+0x2b/0x80
[ 984.409924][ T44] ? rtnl_setlink+0x880/0x880
[ 984.410038][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.410153][ T44] ? rtnl_setlink+0x880/0x880
[ 984.410266][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 984.410381][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.410494][ T44] ? __lock_acquire+0x577/0xc10
[ 984.410611][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.410723][ T44] ? find_held_lock+0x2b/0x80
[ 984.410840][ T44] netlink_rcv_skb+0x123/0x380
[ 984.410972][ T44] ? rtnl_fdb_dump+0x620/0x620
[ 984.411085][ T44] ? netlink_ack+0xcc0/0xcc0
[ 984.411200][ T44] ? netlink_deliver_tap+0xc5/0x330
[ 984.411313][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 984.411429][ T44] netlink_unicast+0x4a3/0x770
[ 984.411544][ T44] ? netlink_attachskb+0x810/0x810
[ 984.411659][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.411771][ T44] ? __lock_acquire+0x577/0xc10
[ 984.411890][ T44] netlink_sendmsg+0x735/0xc60
[ 984.412010][ T44] ? netlink_unicast+0x770/0x770
[ 984.412128][ T44] ____sys_sendmsg+0x419/0x850
[ 984.412242][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 984.412356][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 984.412498][ T44] ? move_addr_to_kernel+0x40/0x40
[ 984.412612][ T44] ? stack_depot_save_flags+0x3f1/0x6f0
[ 984.412724][ T44] ? rcu_read_lock_any_held+0x3c/0x90
[ 984.412837][ T44] ___sys_sendmsg+0xfd/0x180
[ 984.412959][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00
[ 984.413100][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 984.413231][ T44] __sys_sendmsg+0x124/0x1c0
[ 984.413345][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 984.413459][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.413571][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00
[ 984.413715][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 984.413829][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.413951][ T44] do_syscall_64+0xbd/0xfc0
[ 984.414065][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 984.414209][ T44] RIP: 0033:0x7fbac8392c5e
[ 984.414328][ T44] RSP: 002b:00007fff8b7c64d0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 984.414499][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fbac8392c5e
[ 984.414668][ T44] RDX: 0000000000000000 RSI: 00007fff8b7c6590 RDI: 0000000000000003
[ 984.414837][ T44] RBP: 00007fff8b7c64e0 R08: 0000000000000000 R09: 0000000000000000
[ 984.415023][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fff8b7c6c50
[ 984.415193][ T44] R13: 00000000695be684 R14: 0000000000000000 R15: 0000000000499600
[ 984.415369][ T44]
[ 984.415458][ T44] INFO: task ip:5814 is blocked on a mutex likely owned by task kworker/3:2:497.
[ 984.415644][ T44] task:kworker/3:2 state:D stack:28096 pid:497 tgid:497 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 984.415892][ T44] Workqueue: events refill_work
[ 984.416012][ T44] Call Trace:
[ 984.416099][ T44]
[ 984.416158][ T44] __schedule+0xae2/0x1720
[ 984.416275][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.416389][ T44] ? io_schedule_timeout+0x130/0x130
[ 984.416502][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.416619][ T44] ? usleep_range_state+0xba/0x1b0
[ 984.416731][ T44] schedule+0xd4/0x260
[ 984.416816][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 984.416965][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 984.417079][ T44] ? __hrtimer_cb_get_time+0x50/0x50
[ 984.417194][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 984.417309][ T44] ? ktime_get+0x15e/0x220
[ 984.417422][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 984.417535][ T44] ? ktime_get+0xa9/0x220
[ 984.417622][ T44] usleep_range_state+0x133/0x1b0
[ 984.417737][ T44] ? schedule_hrtimeout+0x20/0x20
[ 984.417851][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 984.417972][ T44] ? refill_work+0x149/0x210
[ 984.418086][ T44] napi_disable_locked+0x379/0x5f0
[ 984.418201][ T44] ? _mutex_trylock_nest_lock+0x340/0x340
[ 984.418320][ T44] ? register_netdevice_notifier_net+0x40/0x40
[ 984.418464][ T44] napi_disable+0x43/0x80
[ 984.418549][ T44] refill_work+0x116/0x210
[ 984.418664][ T44] process_one_work+0xd57/0x1390
[ 984.418780][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 984.418898][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 984.419026][ T44] ? assign_work+0x152/0x380
[ 984.419140][ T44] worker_thread+0x4d6/0xd40
[ 984.419256][ T44] ? process_one_work+0x1390/0x1390
[ 984.419369][ T44] ? __kthread_parkme+0xb3/0x200
[ 984.419484][ T44] ? process_one_work+0x1390/0x1390
[ 984.419595][ T44] kthread+0x355/0x5b0
[ 984.419683][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.419799][ T44] ? __lock_release.isra.0+0x59/0x170
[ 984.419918][ T44] ? rcu_is_watching+0x15/0xd0
[ 984.420032][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.420146][ T44] ret_from_fork+0x3fb/0x510
[ 984.420261][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140
[ 984.420403][ T44] ? __switch_to+0x53c/0xd00
[ 984.420516][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 984.420632][ T44] ret_from_fork_asm+0x11/0x20
[ 984.420751][ T44]
[ 984.420850][ T44]
[ 984.420850][ T44] Showing all locks held in the system:
[ 984.421102][ T44] 3 locks held by kworker/u16:0/12:
[ 984.421212][ T44] #0: ff110000091e7148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.421433][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.421709][ T44] #2: ffffffff962859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 984.421913][ T44] 1 lock held by khungtaskd/44:
[ 984.422021][ T44] #0: ffffffff95b710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30
[ 984.422240][ T44] 3 locks held by kworker/2:1/52:
[ 984.422351][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 984.422570][ T44] #1: ffa000000038fcc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 984.422789][ T44] #2: ffffffff962859a8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0
[ 984.423002][ T44] 3 locks held by kworker/3:2/497:
[ 984.423115][ T44] 2 locks held by ip/5814:
[ 984.423223][ T44] #0: ffffffff962859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90
[ 984.423418][ T44] #1: ff11000008baac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 984.423609][ T44] 1 lock held by xdp_helper/5823:
[ 984.423720][ T44] #0: ffffffff962859a8 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1b10
[ 984.423929][ T44]
[ 984.423990][ T44] =============================================
[ 984.423990][ T44]
[ 987.468909][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 27647 ms
[ 987.469278][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 27647000 usecs ago
[ 993.100911][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 33279 ms
[ 993.101306][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 33279000 usecs ago
[ 998.220912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 38399 ms
[ 998.221270][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 38399000 usecs ago
[ 1003.340912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 43519 ms
[ 1003.341615][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 43519000 usecs ago
[ 1009.484912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 49663 ms
[ 1009.485298][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 49663000 usecs ago
[ 1015.116912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 55295 ms
[ 1015.117279][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 55295000 usecs ago
[ 1020.236909][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 60415 ms
[ 1020.237303][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 60415000 usecs ago
[ 1025.356910][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 65535 ms
[ 1025.357276][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 65535000 usecs ago
[ 1031.500912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 71679 ms
[ 1031.501283][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 71679000 usecs ago
[ 1037.132912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 77311 ms
[ 1037.133285][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 77311000 usecs ago
[ 1042.252908][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 82431 ms
[ 1042.253273][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 82431000 usecs ago
[ 1047.372911][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 87551 ms
[ 1047.373296][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 87551000 usecs ago
[ 1053.516912][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 93695 ms
[ 1053.517290][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 93695000 usecs ago
[ 1059.148909][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 99327 ms
[ 1059.149263][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 99327000 usecs ago