[ 1019.228719][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 264192 ms
[ 1019.229134][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 264192000 usecs ago
[ 1024.347736][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 269311 ms
[ 1024.348203][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 269311000 usecs ago
[ 1030.492720][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 275456 ms
[ 1030.493110][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 275456000 usecs ago
[ 1036.124720][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 281088 ms
[ 1036.125161][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 281088000 usecs ago
[ 1041.244722][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 286208 ms
[ 1041.245124][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 286208000 usecs ago
[ 1046.364732][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 291328 ms
[ 1046.365173][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 291328000 usecs ago
[ 1052.508722][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 297471 ms
[ 1052.509113][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 297472000 usecs ago
[ 1058.140720][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 303103 ms
[ 1058.141114][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 303104000 usecs ago
[ 1063.260742][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 308223 ms
[ 1063.261233][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 308224000 usecs ago
[ 1068.380721][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 313344 ms
[ 1068.381143][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 313344000 usecs ago
[ 1074.524730][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 319488 ms
[ 1074.525114][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 319488000 usecs ago
[ 1080.156721][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 325120 ms
[ 1080.157095][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 325120000 usecs ago
[ 1085.276731][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 330240 ms
[ 1085.277161][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 330240000 usecs ago
[ 1090.396720][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 335360 ms
[ 1090.397154][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 335360000 usecs ago
[ 1096.539720][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 341503 ms
[ 1096.540192][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 341503000 usecs ago
[ 1102.172718][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 347136 ms
[ 1102.173170][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 347136000 usecs ago
[ 1107.292712][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 352255 ms
[ 1107.292762][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds.
[ 1107.293100][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 352256000 usecs ago
[ 1107.293472][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 1107.294016][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1107.294322][ T44] task:kworker/u16:0 state:D stack:27000 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 1107.294748][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 1107.294980][ T44] Call Trace:
[ 1107.295121][ T44]
[ 1107.295222][ T44] __schedule+0x88d/0x1b90
[ 1107.295408][ T44] ? io_schedule_timeout+0x130/0x130
[ 1107.295600][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 1107.295796][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.295972][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.296152][ T44] schedule+0xd4/0x260
[ 1107.296288][ T44] schedule_preempt_disabled+0x18/0x30
[ 1107.296453][ T44] __mutex_lock+0x9ae/0x1500
[ 1107.296636][ T44] ? addrconf_verify_work+0x12/0x30
[ 1107.296824][ T44] ? ww_mutex_lock+0x160/0x160
[ 1107.296998][ T44] ? process_one_work+0xd16/0x1390
[ 1107.297173][ T44] ? trace_lock_acquire+0x88/0xd0
[ 1107.297345][ T44] ? trace_lock_acquire+0x88/0xd0
[ 1107.297520][ T44] ? addrconf_verify_work+0x12/0x30
[ 1107.297693][ T44] addrconf_verify_work+0x12/0x30
[ 1107.297872][ T44] process_one_work+0xd57/0x1390
[ 1107.298055][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 1107.298226][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 1107.298403][ T44] ? assign_work+0x152/0x380
[ 1107.298571][ T44] worker_thread+0x4d6/0xd40
[ 1107.298762][ T44] ? process_one_work+0x1390/0x1390
[ 1107.298937][ T44] kthread+0x355/0x5b0
[ 1107.299061][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 1107.299233][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.299396][ T44] ? rcu_is_watching+0x15/0xd0
[ 1107.299576][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 1107.299754][ T44] ret_from_fork+0x1d4/0x270
[ 1107.299928][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 1107.300095][ T44] ret_from_fork_asm+0x11/0x20
[ 1107.300273][ T44]
[ 1107.300436][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5902.
[ 1107.300747][ T44] INFO: task ip:5902 blocked for more than 368 seconds.
[ 1107.300945][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 1107.301108][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1107.301388][ T44] task:ip state:D stack:25496 pid:5902 tgid:5902 ppid:1 task_flags:0x400100 flags:0x00080003
[ 1107.301799][ T44] Call Trace:
[ 1107.301934][ T44]
[ 1107.302027][ T44] __schedule+0x88d/0x1b90
[ 1107.302210][ T44] ? io_schedule_timeout+0x130/0x130
[ 1107.302397][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 1107.302581][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.302765][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.302944][ T44] schedule+0xd4/0x260
[ 1107.303077][ T44] schedule_preempt_disabled+0x18/0x30
[ 1107.303250][ T44] __mutex_lock+0x9ae/0x1500
[ 1107.303435][ T44] ? napi_enable+0x3b/0x80
[ 1107.303614][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850
[ 1107.303845][ T44] ? ww_mutex_lock+0x160/0x160
[ 1107.304023][ T44] ? __asan_memset+0x27/0x50
[ 1107.304200][ T44] ? sg_init_table+0x19/0x60
[ 1107.304380][ T44] ? try_fill_recv+0x3ec/0x1750
[ 1107.304565][ T44] ? napi_enable+0x3b/0x80
[ 1107.304745][ T44] napi_enable+0x3b/0x80
[ 1107.304882][ T44] __virtnet_rx_resume+0x156/0x290
[ 1107.305056][ T44] ? queue_delayed_work_on+0x91/0x100
[ 1107.305233][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 1107.305410][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 1107.305599][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 1107.305780][ T44] dev_xdp_install+0x3e4/0x8e0
[ 1107.305956][ T44] ? netif_skb_check_for_xdp+0x600/0x600
[ 1107.306144][ T44] dev_xdp_attach+0x50d/0x1320
[ 1107.306325][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 1107.306500][ T44] ? __bpf_prog_get+0x320/0x320
[ 1107.306681][ T44] dev_change_xdp_fd+0x182/0x240
[ 1107.306871][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 1107.307046][ T44] ? rtnl_newlink_create+0x900/0x900
[ 1107.307215][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0
[ 1107.307435][ T44] ? rcu_read_lock_any_held+0x41/0xa0
[ 1107.307608][ T44] ? validate_chain+0x287/0x5f0
[ 1107.307792][ T44] ? rcu_read_lock_any_held+0x6b/0xa0
[ 1107.307967][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 1107.308145][ T44] ? __lock_acquire+0x34c/0x740
[ 1107.308330][ T44] ? trace_lock_acquire+0x88/0xd0
[ 1107.308504][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 1107.308689][ T44] ? lock_acquire+0x31/0x80
[ 1107.308871][ T44] ? rtnl_newlink+0x5df/0xb20
[ 1107.309046][ T44] ? rcu_is_watching+0x15/0xd0
[ 1107.309220][ T44] ? rcu_is_watching+0x15/0xd0
[ 1107.309395][ T44] ? trace_contention_end+0xd6/0x140
[ 1107.309572][ T44] ? rtnl_newlink+0x5df/0xb20
[ 1107.309755][ T44] ? __mutex_lock+0x32e/0x1500
[ 1107.309936][ T44] ? ww_mutex_lock+0x160/0x160
[ 1107.310110][ T44] ? nla_validate_int_range+0x5b0/0x5b0
[ 1107.310270][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 1107.310397][ T44] rtnl_newlink+0x637/0xb20
[ 1107.310557][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 1107.310749][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 1107.310925][ T44] ? find_held_lock+0x2b/0x80
[ 1107.311101][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 1107.311278][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.311461][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 1107.311646][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 1107.311832][ T44] ? rtnl_port_fill+0x940/0x940
[ 1107.312009][ T44] ? __lock_acquire+0x34c/0x740
[ 1107.312187][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 1107.312320][ T44] ? find_held_lock+0x2b/0x80
[ 1107.312437][ T44] netlink_rcv_skb+0x123/0x380
[ 1107.312614][ T44] ? rtnl_port_fill+0x940/0x940
[ 1107.312793][ T44] ? netlink_ack+0xcc0/0xcc0
[ 1107.312968][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 1107.313140][ T44] netlink_unicast+0x4a3/0x770
[ 1107.313316][ T44] ? netlink_attachskb+0x810/0x810
[ 1107.313488][ T44] ? __lock_acquire+0x34c/0x740
[ 1107.313675][ T44] netlink_sendmsg+0x735/0xc60
[ 1107.313862][ T44] ? netlink_unicast+0x770/0x770
[ 1107.314045][ T44] ? __might_fault+0x97/0x140
[ 1107.314225][ T44] ____sys_sendmsg+0x419/0x850
[ 1107.314396][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 1107.314574][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 1107.314803][ T44] ? move_addr_to_kernel+0x40/0x40
[ 1107.314981][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 1107.315158][ T44] ? validate_chain+0x287/0x5f0
[ 1107.315342][ T44] ___sys_sendmsg+0xfd/0x180
[ 1107.315520][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680
[ 1107.315754][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 1107.315959][ T44] __sys_sendmsg+0x124/0x1c0
[ 1107.316137][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 1107.316312][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 1107.316485][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680
[ 1107.316726][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 1107.316904][ T44] ? rcu_is_watching+0x15/0xd0
[ 1107.317084][ T44] do_syscall_64+0xbb/0xfd0
[ 1107.317261][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 1107.317472][ T44] RIP: 0033:0x7f7b2933cc5e
[ 1107.317667][ T44] RSP: 002b:00007ffc238701f0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 1107.317944][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7b2933cc5e
[ 1107.318215][ T44] RDX: 0000000000000000 RSI: 00007ffc238702b0 RDI: 0000000000000003
[ 1107.318476][ T44] RBP: 00007ffc23870200 R08: 0000000000000000 R09: 0000000000000000
[ 1107.318753][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffc23870970
[ 1107.319016][ T44] R13: 00000000692a3dd6 R14: 0000000000000000 R15: 0000000000499600
[ 1107.319296][ T44]
[ 1107.319435][ T44] INFO: task ip:5902 is blocked on a mutex likely owned by task kworker/2:2:62.
[ 1107.319741][ T44] task:kworker/2:2 state:R running task stack:28200 pid:62 tgid:62 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 1107.320176][ T44] Workqueue: events refill_work
[ 1107.320361][ T44] Call Trace:
[ 1107.320489][ T44]
[ 1107.320582][ T44] __schedule+0x88d/0x1b90
[ 1107.320749][ T44] ? io_schedule_timeout+0x130/0x130
[ 1107.320866][ T44] ? usleep_range_state+0xba/0x1b0
[ 1107.320981][ T44] ? find_held_lock+0x2b/0x80
[ 1107.321097][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.321213][ T44] ? _raw_spin_unlock_irqrestore+0x53/0x80
[ 1107.321361][ T44] ? usleep_range_state+0xba/0x1b0
[ 1107.321492][ T44] schedule+0xd4/0x260
[ 1107.321630][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 1107.321859][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 1107.321975][ T44] ? hrtimer_cb_get_time+0x90/0x90
[ 1107.322094][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 1107.322208][ T44] ? ktime_get+0x15e/0x220
[ 1107.322323][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 1107.322439][ T44] ? ktime_get+0xa9/0x220
[ 1107.322536][ T44] usleep_range_state+0x133/0x1b0
[ 1107.322658][ T44] ? schedule_hrtimeout+0x20/0x20
[ 1107.322780][ T44] ? __free_object+0x2ad/0x4b0
[ 1107.322898][ T44] napi_disable_locked+0x379/0x5f0
[ 1107.323013][ T44] ? _mutex_trylock_nest_lock+0x150/0x150
[ 1107.323132][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470
[ 1107.323277][ T44] napi_disable+0x43/0x80
[ 1107.323363][ T44] refill_work+0x116/0x210
[ 1107.323489][ T44] process_one_work+0xd57/0x1390
[ 1107.323612][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 1107.323733][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 1107.323851][ T44] ? assign_work+0x152/0x380
[ 1107.323971][ T44] worker_thread+0x4d6/0xd40
[ 1107.324089][ T44] ? process_one_work+0x1390/0x1390
[ 1107.324203][ T44] ? __kthread_parkme+0xb3/0x200
[ 1107.324320][ T44] ? process_one_work+0x1390/0x1390
[ 1107.324435][ T44] kthread+0x355/0x5b0
[ 1107.324528][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 1107.324648][ T44] ? __lock_release.isra.0+0x59/0x170
[ 1107.324768][ T44] ? rcu_is_watching+0x15/0xd0
[ 1107.324887][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 1107.325001][ T44] ret_from_fork+0x1d4/0x270
[ 1107.325116][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 1107.325232][ T44] ret_from_fork_asm+0x11/0x20
[ 1107.325354][ T44]
[ 1107.325446][ T44]
[ 1107.325446][ T44] Showing all locks held in the system:
[ 1107.325625][ T44] 3 locks held by kworker/u16:0/12:
[ 1107.325748][ T44] #0: ff110000090f4d48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 1107.325976][ T44] #1: ffa00000000c7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 1107.326260][ T44] #2: ffffffffaa692368 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 1107.326466][ T44] 3 locks held by kworker/3:0/33:
[ 1107.326629][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 1107.326862][ T44] #1: ffa0000000257d30 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 1107.327086][ T44] #2: ffffffffaa692368 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0
[ 1107.327285][ T44] 1 lock held by khungtaskd/44:
[ 1107.327399][ T44] #0: ffffffffa9f78fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db
[ 1107.327606][ T44] 4 locks held by kworker/2:2/62:
[ 1107.327728][ T44] 2 locks held by ip/5902:
[ 1107.327837][ T44] #0: ffffffffaa692368 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20
[ 1107.328032][ T44] #1: ff11000008a52c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 1107.328235][ T44] 1 lock held by xdp_helper/5910:
[ 1107.328345][ T44] #0: ffffffffaa692368 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10
[ 1107.328551][ T44]
[ 1107.328610][ T44] =============================================
[ 1107.328610][ T44]
[ 1112.412712][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 357375 ms
[ 1112.413136][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 357376000 usecs ago
[ 1118.556720][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 363519 ms
[ 1118.557167][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 363520000 usecs ago
[ 1124.188719][ C1] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 1: transmit queue 2 timed out 369151 ms
[ 1124.189173][ C1] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 369152000 usecs ago