[ 613.139040][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 5567 ms
[ 613.139675][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 5567000 usecs ago
[ 618.323034][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 10751 ms
[ 618.323432][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 10751000 usecs ago
[ 623.443031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 15871 ms
[ 623.443379][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 15871000 usecs ago
[ 629.587029][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 22015 ms
[ 629.587357][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 22015000 usecs ago
[ 635.219030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 27647 ms
[ 635.219351][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 27647000 usecs ago
[ 640.339038][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 32767 ms
[ 640.339388][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 32767000 usecs ago
[ 646.483030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 38911 ms
[ 646.483365][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 38911000 usecs ago
[ 652.115030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 44543 ms
[ 652.115378][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 44543000 usecs ago
[ 657.235030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 49663 ms
[ 657.235353][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 49663000 usecs ago
[ 662.355029][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 54783 ms
[ 662.355347][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 54783000 usecs ago
[ 668.499029][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 60927 ms
[ 668.499349][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 60927000 usecs ago
[ 674.131030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 66559 ms
[ 674.131347][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 66559000 usecs ago
[ 679.251031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 71679 ms
[ 679.251348][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 71679000 usecs ago
[ 684.371030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 76799 ms
[ 684.371357][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 76799000 usecs ago
[ 690.515032][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 82943 ms
[ 690.515360][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 82943000 usecs ago
[ 696.147031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 88575 ms
[ 696.147344][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 88575000 usecs ago
[ 701.267031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 93695 ms
[ 701.267356][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 93695000 usecs ago
[ 706.387031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 98815 ms
[ 706.387355][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 98815000 usecs ago
[ 712.531030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 104959 ms
[ 712.531407][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 104959000 usecs ago
[ 718.163031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 110591 ms
[ 718.163397][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 110591000 usecs ago
[ 723.283031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 115711 ms
[ 723.283390][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 115711000 usecs ago
[ 728.403030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 120831 ms
[ 728.403398][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 120831000 usecs ago
[ 734.547030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 126975 ms
[ 734.547392][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 126975000 usecs ago
[ 738.644210][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds.
[ 738.644624][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 738.644786][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 738.645069][ T44] task:kworker/u16:0 state:D stack:27000 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 738.645384][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 738.645591][ T44] Call Trace:
[ 738.645728][ T44]
[ 738.645841][ T44] __schedule+0x88d/0x1b90
[ 738.646044][ T44] ? io_schedule_timeout+0x130/0x130
[ 738.646218][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.646390][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.646554][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.646719][ T44] schedule+0xd4/0x260
[ 738.646859][ T44] schedule_preempt_disabled+0x18/0x30
[ 738.647059][ T44] __mutex_lock+0x9ae/0x1500
[ 738.647225][ T44] ? addrconf_verify_work+0x12/0x30
[ 738.647414][ T44] ? ww_mutex_lock+0x160/0x160
[ 738.647583][ T44] ? process_one_work+0xd16/0x1390
[ 738.647773][ T44] ? trace_lock_acquire+0x88/0xd0
[ 738.647950][ T44] ? trace_lock_acquire+0x88/0xd0
[ 738.648151][ T44] ? addrconf_verify_work+0x12/0x30
[ 738.648314][ T44] addrconf_verify_work+0x12/0x30
[ 738.648499][ T44] process_one_work+0xd57/0x1390
[ 738.648669][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 738.648853][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.649056][ T44] ? assign_work+0x152/0x380
[ 738.649222][ T44] worker_thread+0x4d6/0xd40
[ 738.649417][ T44] ? process_one_work+0x1390/0x1390
[ 738.649581][ T44] kthread+0x355/0x5b0
[ 738.650108][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.650278][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.650469][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.650636][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.650827][ T44] ret_from_fork+0x1d4/0x270
[ 738.650994][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.651190][ T44] ret_from_fork_asm+0x11/0x20
[ 738.651361][ T44]
[ 738.651542][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5250.
[ 738.651817][ T44] INFO: task ip:5250 blocked for more than 122 seconds.
[ 738.652041][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 738.652196][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 738.652456][ T44] task:ip state:D stack:25496 pid:5250 tgid:5250 ppid:5245 task_flags:0x400100 flags:0x00080001
[ 738.652777][ T44] Call Trace:
[ 738.652918][ T44]
[ 738.653062][ T44] __schedule+0x88d/0x1b90
[ 738.653228][ T44] ? io_schedule_timeout+0x130/0x130
[ 738.653416][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.653583][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.653773][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.653940][ T44] schedule+0xd4/0x260
[ 738.654105][ T44] schedule_preempt_disabled+0x18/0x30
[ 738.654267][ T44] __mutex_lock+0x9ae/0x1500
[ 738.654453][ T44] ? napi_enable+0x3b/0x80
[ 738.654621][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850
[ 738.654844][ T44] ? ww_mutex_lock+0x160/0x160
[ 738.655016][ T44] ? __asan_memset+0x27/0x50
[ 738.655212][ T44] ? sg_init_table+0x19/0x60
[ 738.655377][ T44] ? try_fill_recv+0x3ec/0x1750
[ 738.655569][ T44] ? napi_enable+0x3b/0x80
[ 738.655736][ T44] napi_enable+0x3b/0x80
[ 738.655904][ T44] __virtnet_rx_resume+0x156/0x290
[ 738.656092][ T44] ? queue_delayed_work_on+0x91/0x100
[ 738.656257][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 738.656446][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 738.656615][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 738.656802][ T44] dev_xdp_install+0x3e4/0x8e0
[ 738.656972][ T44] ? netif_skb_check_for_xdp+0x600/0x600
[ 738.657170][ T44] dev_xdp_attach+0x50d/0x1320
[ 738.657339][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 738.657531][ T44] ? __bpf_prog_get+0x320/0x320
[ 738.657700][ T44] dev_change_xdp_fd+0x182/0x240
[ 738.657888][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 738.658090][ T44] ? rtnl_newlink_create+0x900/0x900
[ 738.658254][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0
[ 738.658470][ T44] ? rcu_read_lock_any_held+0x41/0xa0
[ 738.658635][ T44] ? validate_chain+0x287/0x5f0
[ 738.658827][ T44] ? rcu_read_lock_any_held+0x6b/0xa0
[ 738.658995][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 738.659195][ T44] ? __lock_acquire+0x34c/0x740
[ 738.659363][ T44] ? trace_lock_acquire+0x88/0xd0
[ 738.659550][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 738.659715][ T44] ? lock_acquire+0x31/0x80
[ 738.659903][ T44] ? rtnl_newlink+0x5df/0xb20
[ 738.660095][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.660260][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.660447][ T44] ? trace_contention_end+0xd6/0x140
[ 738.660610][ T44] ? rtnl_newlink+0x5df/0xb20
[ 738.660794][ T44] ? __mutex_lock+0x32e/0x1500
[ 738.660970][ T44] ? ww_mutex_lock+0x160/0x160
[ 738.661162][ T44] ? nla_validate_int_range+0x5b0/0x5b0
[ 738.661328][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 738.661524][ T44] rtnl_newlink+0x637/0xb20
[ 738.661693][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 738.661885][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.662085][ T44] ? find_held_lock+0x2b/0x80
[ 738.662251][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 738.662438][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.662603][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 738.662789][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 738.662966][ T44] ? rtnl_port_fill+0x940/0x940
[ 738.663158][ T44] ? __lock_acquire+0x34c/0x740
[ 738.663324][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.663511][ T44] ? find_held_lock+0x2b/0x80
[ 738.663676][ T44] netlink_rcv_skb+0x123/0x380
[ 738.663861][ T44] ? rtnl_port_fill+0x940/0x940
[ 738.664056][ T44] ? netlink_ack+0xcc0/0xcc0
[ 738.664223][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 738.664422][ T44] netlink_unicast+0x4a3/0x770
[ 738.664590][ T44] ? netlink_attachskb+0x810/0x810
[ 738.664781][ T44] ? __lock_acquire+0x34c/0x740
[ 738.664955][ T44] netlink_sendmsg+0x735/0xc60
[ 738.665152][ T44] ? netlink_unicast+0x770/0x770
[ 738.665320][ T44] ? __might_fault+0x97/0x140
[ 738.665514][ T44] ____sys_sendmsg+0x419/0x850
[ 738.665685][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 738.665870][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 738.666094][ T44] ? move_addr_to_kernel+0x40/0x40
[ 738.666257][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 738.666443][ T44] ? validate_chain+0x287/0x5f0
[ 738.666609][ T44] ___sys_sendmsg+0xfd/0x180
[ 738.666794][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680
[ 738.667018][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 738.667203][ T44] __sys_sendmsg+0x124/0x1c0
[ 738.667395][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 738.667557][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 738.667738][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680
[ 738.667961][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 738.668148][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.668315][ T44] do_syscall_64+0xbb/0xfd0
[ 738.668508][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 738.668719][ T44] RIP: 0033:0x7f955a0f3c5e
[ 738.668891][ T44] RSP: 002b:00007fffb5a20670 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 738.669152][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f955a0f3c5e
[ 738.669396][ T44] RDX: 0000000000000000 RSI: 00007fffb5a20730 RDI: 0000000000000003
[ 738.669640][ T44] RBP: 00007fffb5a20680 R08: 0000000000000000 R09: 0000000000000000
[ 738.669882][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffb5a20df0
[ 738.670140][ T44] R13: 00000000692bff5b R14: 0000000000000000 R15: 0000000000499600
[ 738.670392][ T44]
[ 738.670530][ T44] INFO: task ip:5250 is blocked on a mutex likely owned by task kworker/2:3:1704.
[ 738.670798][ T44] task:kworker/2:3 state:D stack:27984 pid:1704 tgid:1704 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 738.671131][ T44] Workqueue: events refill_work
[ 738.671298][ T44] Call Trace:
[ 738.671459][ T44]
[ 738.671568][ T44] __schedule+0x88d/0x1b90
[ 738.671765][ T44] ? io_schedule_timeout+0x130/0x130
[ 738.671939][ T44] ? usleep_range_state+0xba/0x1b0
[ 738.672135][ T44] ? find_held_lock+0x2b/0x80
[ 738.672300][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.672490][ T44] ? usleep_range_state+0xba/0x1b0
[ 738.672652][ T44] schedule+0xd4/0x260
[ 738.672811][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 738.673044][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 738.673211][ T44] ? hrtimer_cb_get_time+0x90/0x90
[ 738.673401][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 738.673564][ T44] ? ktime_get+0x15e/0x220
[ 738.673750][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 738.673923][ T44] ? ktime_get+0xa9/0x220
[ 738.674092][ T44] usleep_range_state+0x133/0x1b0
[ 738.674260][ T44] ? schedule_hrtimeout+0x20/0x20
[ 738.674488][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 738.674652][ T44] napi_disable_locked+0x379/0x5f0
[ 738.674838][ T44] ? _mutex_trylock_nest_lock+0x150/0x150
[ 738.675010][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470
[ 738.675234][ T44] napi_disable+0x43/0x80
[ 738.675370][ T44] refill_work+0x116/0x210
[ 738.675562][ T44] process_one_work+0xd57/0x1390
[ 738.675738][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 738.675931][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 738.676123][ T44] ? assign_work+0x152/0x380
[ 738.676294][ T44] worker_thread+0x4d6/0xd40
[ 738.676489][ T44] ? process_one_work+0x1390/0x1390
[ 738.676653][ T44] ? __kthread_parkme+0xb3/0x200
[ 738.676842][ T44] ? process_one_work+0x1390/0x1390
[ 738.677019][ T44] kthread+0x355/0x5b0
[ 738.677184][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.677375][ T44] ? __lock_release.isra.0+0x59/0x170
[ 738.677540][ T44] ? rcu_is_watching+0x15/0xd0
[ 738.677728][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.677902][ T44] ret_from_fork+0x1d4/0x270
[ 738.678096][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 738.678259][ T44] ret_from_fork_asm+0x11/0x20
[ 738.678458][ T44]
[ 738.678601][ T44]
[ 738.678601][ T44] Showing all locks held in the system:
[ 738.678837][ T44] 3 locks held by kworker/u16:0/12:
[ 738.679009][ T44] #0: ff1100000f57cd48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 738.679416][ T44] #1: ffa00000000c7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 738.679769][ T44] #2: ffffffff92492a68 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 738.680061][ T44] 1 lock held by khungtaskd/44:
[ 738.680218][ T44] #0: ffffffff91d78fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db
[ 738.680496][ T44] 3 locks held by kworker/2:3/1704:
[ 738.680661][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 738.680961][ T44] #1: ffa0000001b57d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 738.681285][ T44] #2: ff1100000eed2c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 738.681556][ T44] 2 locks held by ip/5250:
[ 738.681719][ T44] #0: ffffffff92492a68 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20
[ 738.681999][ T44] #1: ff1100000eed2c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 738.682272][ T44]
[ 738.682375][ T44] =============================================
[ 738.682375][ T44]
[ 740.179031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 132607 ms
[ 740.179407][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 132607000 usecs ago
[ 745.299032][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 137727 ms
[ 745.299409][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 137727000 usecs ago
[ 750.419032][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 142847 ms
[ 750.419404][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 142847000 usecs ago
[ 756.563035][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 148991 ms
[ 756.563405][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 148991000 usecs ago
[ 762.195031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 154623 ms
[ 762.195392][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 154623000 usecs ago
[ 767.315031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 159743 ms
[ 767.315407][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 159743000 usecs ago
[ 772.435031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 164863 ms
[ 772.435391][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 164863000 usecs ago
[ 778.579032][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 171007 ms
[ 778.579404][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 171007000 usecs ago
[ 784.211030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 176639 ms
[ 784.211397][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 176639000 usecs ago
[ 789.331031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 181759 ms
[ 789.331390][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 181759000 usecs ago
[ 795.475031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 187903 ms
[ 795.475401][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 187903000 usecs ago
[ 801.107031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 193535 ms
[ 801.107383][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 193535000 usecs ago
[ 806.227031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 198655 ms
[ 806.227380][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 198655000 usecs ago
[ 811.347031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 203775 ms
[ 811.347383][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 203775000 usecs ago
[ 817.491031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 209919 ms
[ 817.491388][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 209919000 usecs ago
[ 823.123030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 215551 ms
[ 823.123391][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 215551000 usecs ago
[ 828.243030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 220671 ms
[ 828.243374][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 220671000 usecs ago
[ 833.363031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 225791 ms
[ 833.363386][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 225791000 usecs ago
[ 839.507030][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 231935 ms
[ 839.507385][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 231935000 usecs ago
[ 845.139031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 237567 ms
[ 845.139396][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 237567000 usecs ago
[ 850.259029][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 242687 ms
[ 850.259387][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 242687000 usecs ago
[ 855.379031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 247807 ms
[ 855.379410][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 247807000 usecs ago
[ 861.523031][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 2 timed out 253951 ms
[ 861.523414][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 253951000 usecs ago
[ 861.524051][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds.
[ 861.524376][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 861.524561][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.524848][ T44] task:kworker/u16:0 state:D stack:27000 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.525252][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 861.525485][ T44] Call Trace:
[ 861.525616][ T44]
[ 861.525747][ T44] __schedule+0x88d/0x1b90
[ 861.525924][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.526123][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.526291][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.526486][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.526651][ T44] schedule+0xd4/0x260
[ 861.526809][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.526979][ T44] __mutex_lock+0x9ae/0x1500
[ 861.527175][ T44] ? addrconf_verify_work+0x12/0x30
[ 861.527341][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.527536][ T44] ? process_one_work+0xd16/0x1390
[ 861.527710][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.527897][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.528099][ T44] ? addrconf_verify_work+0x12/0x30
[ 861.528263][ T44] addrconf_verify_work+0x12/0x30
[ 861.528450][ T44] process_one_work+0xd57/0x1390
[ 861.528619][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.528807][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.528989][ T44] ? assign_work+0x152/0x380
[ 861.529189][ T44] worker_thread+0x4d6/0xd40
[ 861.529359][ T44] ? process_one_work+0x1390/0x1390
[ 861.529546][ T44] kthread+0x355/0x5b0
[ 861.529686][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.529874][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.530073][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.530236][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.530431][ T44] ret_from_fork+0x1d4/0x270
[ 861.530596][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.530785][ T44] ret_from_fork_asm+0x11/0x20
[ 861.530966][ T44]
[ 861.531147][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5250.
[ 861.531417][ T44] INFO: task ip:5250 blocked for more than 245 seconds.
[ 861.531623][ T44] Not tainted 6.18.0-rc7-virtme #1
[ 861.531781][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.532060][ T44] task:ip state:D stack:25496 pid:5250 tgid:5250 ppid:5245 task_flags:0x400100 flags:0x00080003
[ 861.532378][ T44] Call Trace:
[ 861.532511][ T44]
[ 861.532641][ T44] __schedule+0x88d/0x1b90
[ 861.532809][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.533006][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.533199][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.533364][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.533553][ T44] schedule+0xd4/0x260
[ 861.533690][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.533876][ T44] __mutex_lock+0x9ae/0x1500
[ 861.534074][ T44] ? napi_enable+0x3b/0x80
[ 861.534246][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850
[ 861.534466][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.534630][ T44] ? __asan_memset+0x27/0x50
[ 861.534819][ T44] ? sg_init_table+0x19/0x60
[ 861.534987][ T44] ? try_fill_recv+0x3ec/0x1750
[ 861.535186][ T44] ? napi_enable+0x3b/0x80
[ 861.535351][ T44] napi_enable+0x3b/0x80
[ 861.535514][ T44] __virtnet_rx_resume+0x156/0x290
[ 861.535680][ T44] ? queue_delayed_work_on+0x91/0x100
[ 861.535867][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 861.536068][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 861.536239][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 861.536425][ T44] dev_xdp_install+0x3e4/0x8e0
[ 861.536590][ T44] ? netif_skb_check_for_xdp+0x600/0x600
[ 861.536786][ T44] dev_xdp_attach+0x50d/0x1320
[ 861.536956][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 861.537154][ T44] ? __bpf_prog_get+0x320/0x320
[ 861.537321][ T44] dev_change_xdp_fd+0x182/0x240
[ 861.537513][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 861.537680][ T44] ? rtnl_newlink_create+0x900/0x900
[ 861.537865][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0
[ 861.538099][ T44] ? rcu_read_lock_any_held+0x41/0xa0
[ 861.538262][ T44] ? validate_chain+0x287/0x5f0
[ 861.538448][ T44] ? rcu_read_lock_any_held+0x6b/0xa0
[ 861.538610][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 861.538795][ T44] ? __lock_acquire+0x34c/0x740
[ 861.538972][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.539166][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 861.539334][ T44] ? lock_acquire+0x31/0x80
[ 861.539523][ T44] ? rtnl_newlink+0x5df/0xb20
[ 861.539685][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.539868][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.540068][ T44] ? trace_contention_end+0xd6/0x140
[ 861.540229][ T44] ? rtnl_newlink+0x5df/0xb20
[ 861.540414][ T44] ? __mutex_lock+0x32e/0x1500
[ 861.540581][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.540774][ T44] ? nla_validate_int_range+0x5b0/0x5b0
[ 861.540948][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 861.541146][ T44] rtnl_newlink+0x637/0xb20
[ 861.541313][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.541504][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.541667][ T44] ? find_held_lock+0x2b/0x80
[ 861.541852][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.542051][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.542226][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.542418][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 861.542584][ T44] ? rtnl_port_fill+0x940/0x940
[ 861.542769][ T44] ? __lock_acquire+0x34c/0x740
[ 861.542944][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.543137][ T44] ? find_held_lock+0x2b/0x80
[ 861.543301][ T44] netlink_rcv_skb+0x123/0x380
[ 861.543485][ T44] ? rtnl_port_fill+0x940/0x940
[ 861.543655][ T44] ? netlink_ack+0xcc0/0xcc0
[ 861.543848][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 861.544017][ T44] netlink_unicast+0x4a3/0x770
[ 861.544210][ T44] ? netlink_attachskb+0x810/0x810
[ 861.544376][ T44] ? __lock_acquire+0x34c/0x740
[ 861.544567][ T44] netlink_sendmsg+0x735/0xc60
[ 861.544734][ T44] ? netlink_unicast+0x770/0x770
[ 861.544934][ T44] ? __might_fault+0x97/0x140
[ 861.545126][ T44] ____sys_sendmsg+0x419/0x850
[ 861.545293][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 861.545482][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 861.545696][ T44] ? move_addr_to_kernel+0x40/0x40
[ 861.545861][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 861.546066][ T44] ? validate_chain+0x287/0x5f0
[ 861.546238][ T44] ___sys_sendmsg+0xfd/0x180
[ 861.546426][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680
[ 861.546639][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 861.546814][ T44] __sys_sendmsg+0x124/0x1c0
[ 861.547003][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 861.547191][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.547354][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680
[ 861.547574][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 861.547737][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.547930][ T44] do_syscall_64+0xbb/0xfd0
[ 861.548119][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 861.548331][ T44] RIP: 0033:0x7f955a0f3c5e
[ 861.548499][ T44] RSP: 002b:00007fffb5a20670 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 861.548744][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f955a0f3c5e
[ 861.548993][ T44] RDX: 0000000000000000 RSI: 00007fffb5a20730 RDI: 0000000000000003
[ 861.549236][ T44] RBP: 00007fffb5a20680 R08: 0000000000000000 R09: 0000000000000000
[ 861.549478][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffb5a20df0
[ 861.549718][ T44] R13: 00000000692bff5b R14: 0000000000000000 R15: 0000000000499600
[ 861.549971][ T44]
[ 861.550140][ T44] INFO: task ip:5250 is blocked on a mutex likely owned by task kworker/2:3:1704.
[ 861.550401][ T44] task:kworker/2:3 state:D stack:27984 pid:1704 tgid:1704 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.550725][ T44] Workqueue: events refill_work
[ 861.550886][ T44] Call Trace:
[ 861.551062][ T44]
[ 861.551172][ T44] __schedule+0x88d/0x1b90
[ 861.551363][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.551529][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.551719][ T44] ? find_held_lock+0x2b/0x80
[ 861.551886][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.552088][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.552251][ T44] schedule+0xd4/0x260
[ 861.552417][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 861.552634][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 861.552799][ T44] ? hrtimer_cb_get_time+0x90/0x90
[ 861.552994][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.553189][ T44] ? ktime_get+0x15e/0x220
[ 861.553355][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 861.553544][ T44] ? ktime_get+0xa9/0x220
[ 861.553685][ T44] usleep_range_state+0x133/0x1b0
[ 861.553871][ T44] ? schedule_hrtimeout+0x20/0x20
[ 861.554072][ T44] ? __free_object+0x2ad/0x4b0
[ 861.554236][ T44] napi_disable_locked+0x379/0x5f0
[ 861.554422][ T44] ? _mutex_trylock_nest_lock+0x150/0x150
[ 861.554584][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470
[ 861.554799][ T44] napi_disable+0x43/0x80
[ 861.554946][ T44] refill_work+0x116/0x210
[ 861.555142][ T44] process_one_work+0xd57/0x1390
[ 861.555316][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.555505][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.555672][ T44] ? assign_work+0x152/0x380
[ 861.555862][ T44] worker_thread+0x4d6/0xd40
[ 861.556064][ T44] ? process_one_work+0x1390/0x1390
[ 861.556235][ T44] ? __kthread_parkme+0xb3/0x200
[ 861.556427][ T44] ? process_one_work+0x1390/0x1390
[ 861.556590][ T44] kthread+0x355/0x5b0
[ 861.556750][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.556921][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.557114][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.557278][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.557465][ T44] ret_from_fork+0x1d4/0x270
[ 861.557635][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.557823][ T44] ret_from_fork_asm+0x11/0x20
[ 861.558005][ T44]
[ 861.558177][ T44]
[ 861.558177][ T44] Showing all locks held in the system:
[ 861.558414][ T44] 3 locks held by kworker/u16:0/12:
[ 861.558572][ T44] #0: ff1100000f57cd48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.558878][ T44] #1: ffa00000000c7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.559242][ T44] #2: ffffffff92492a68 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 861.559512][ T44] 1 lock held by khungtaskd/44:
[ 861.559669][ T44] #0: ffffffff91d78fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db
[ 861.559953][ T44] 3 locks held by kworker/1:3/969:
[ 861.560140][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.560532][ T44] #1: ffa0000000b37d30 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.560826][ T44] #2: ffffffff92492a68 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0
[ 861.561167][ T44] 3 locks held by kworker/2:3/1704:
[ 861.561325][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.561677][ T44] #1: ffa0000001b57d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.562006][ T44] #2: ff1100000eed2c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 861.562341][ T44] 2 locks held by ip/5250:
[ 861.562497][ T44] #0: ffffffff92492a68 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20
[ 861.562765][ T44] #1: ff1100000eed2c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 861.563102][ T44] 1 lock held by xdp_helper/5258:
[ 861.563258][ T44] #0: ffffffff92492a68 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10
[ 861.563538][ T44]
[ 861.563690][ T44] =============================================
[ 861.563690][ T44]