[ 957.074066][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 5440 ms [ 957.074592][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 5440000 usecs ago [ 962.386056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 10752 ms [ 962.386410][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 10752000 usecs ago [ 968.530057][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 16896 ms [ 968.530393][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 16896000 usecs ago [ 974.162056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 22528 ms [ 974.162395][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 22528000 usecs ago [ 979.282056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 27648 ms [ 979.282398][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 27648000 usecs ago [ 984.401056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 32767 ms [ 984.401389][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 32767000 usecs ago [ 984.402077][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 984.402294][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 984.402426][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.402647][ T44] task:kworker/u16:0 state:D stack:25936 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.402938][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 984.403104][ T44] Call Trace: [ 984.403195][ T44] [ 984.403259][ T44] __schedule+0xae2/0x1720 [ 984.403384][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.403518][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.403641][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.403761][ T44] schedule+0xd4/0x260 [ 984.403851][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.403971][ T44] __mutex_lock+0xd76/0x1f20 [ 984.404094][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.404215][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.404335][ T44] ? process_one_work+0xd16/0x1390 [ 984.404455][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.404571][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.404687][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.404801][ T44] addrconf_verify_work+0x12/0x30 [ 984.404915][ T44] process_one_work+0xd57/0x1390 [ 984.405036][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.405155][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.405272][ T44] ? assign_work+0x152/0x380 [ 984.405388][ T44] worker_thread+0x4d6/0xd40 [ 984.405515][ T44] ? process_one_work+0x1390/0x1390 [ 984.405626][ T44] kthread+0x355/0x5b0 [ 984.405714][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.405827][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.405940][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.406060][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.406174][ T44] ret_from_fork+0x3fb/0x510 [ 984.406290][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.406438][ T44] ? __switch_to+0x53c/0xd00 [ 984.406554][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.406670][ T44] ret_from_fork_asm+0x11/0x20 [ 984.406791][ T44] [ 984.406894][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5766. [ 984.407097][ T44] INFO: task ip:5766 blocked for more than 368 seconds. [ 984.407228][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 984.407335][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.407522][ T44] task:ip state:D stack:24976 pid:5766 tgid:5766 ppid:1 task_flags:0x400100 flags:0x00080002 [ 984.407769][ T44] Call Trace: [ 984.407853][ T44] [ 984.407913][ T44] __schedule+0xae2/0x1720 [ 984.408029][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.408147][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.408266][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.408382][ T44] schedule+0xd4/0x260 [ 984.408474][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.408591][ T44] __mutex_lock+0xd76/0x1f20 [ 984.408706][ T44] ? napi_enable+0x3b/0x80 [ 984.408822][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.408943][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.409060][ T44] ? __asan_memset+0x27/0x50 [ 984.409181][ T44] ? sg_init_table+0x19/0x60 [ 984.409299][ T44] ? try_fill_recv+0x3ec/0x1750 [ 984.409420][ T44] ? napi_enable+0x3b/0x80 [ 984.409538][ T44] napi_enable+0x3b/0x80 [ 984.409624][ T44] __virtnet_rx_resume+0x156/0x290 [ 984.409743][ T44] ? queue_delayed_work_on+0x91/0x100 [ 984.409859][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 984.409975][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 984.410098][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 984.410213][ T44] dev_xdp_install+0x3e4/0x890 [ 984.410332][ T44] ? netif_set_xps_queue+0x40/0x40 [ 984.410454][ T44] dev_xdp_attach+0x50d/0x1310 [ 984.410574][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 984.410688][ T44] ? __bpf_prog_get+0x320/0x320 [ 984.410808][ T44] dev_change_xdp_fd+0x176/0x210 [ 984.410923][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 984.411041][ T44] ? rtnl_newlink_create+0x900/0x900 [ 984.411161][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 984.411303][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.411416][ T44] ? validate_chain+0x37b/0xb70 [ 984.411536][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 984.411654][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.411771][ T44] ? __lock_acquire+0x577/0xc10 [ 984.411887][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.412001][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.412121][ T44] ? lock_acquire+0x10a/0x150 [ 984.412234][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.412348][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.412465][ T44] ? trace_contention_end+0xd6/0x110 [ 984.412580][ T44] ? __mutex_lock+0x285/0x1f20 [ 984.412697][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.412814][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.412926][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 984.413053][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 984.413170][ T44] rtnl_newlink+0x75c/0xe90 [ 984.413286][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.413399][ T44] ? rtnl_setlink+0x880/0x880 [ 984.413516][ T44] ? __lock_acquire+0x577/0xc10 [ 984.413632][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.413747][ T44] ? find_held_lock+0x2b/0x80 [ 984.413861][ T44] ? rtnl_setlink+0x880/0x880 [ 984.413975][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.414092][ T44] ? rtnl_setlink+0x880/0x880 [ 984.414204][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 984.414322][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.414439][ T44] ? __lock_acquire+0x577/0xc10 [ 984.414554][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.414670][ T44] ? find_held_lock+0x2b/0x80 [ 984.414785][ T44] netlink_rcv_skb+0x123/0x380 [ 984.414899][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.415014][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.415136][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 984.415248][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.415363][ T44] netlink_unicast+0x4a3/0x770 [ 984.415484][ T44] ? netlink_attachskb+0x810/0x810 [ 984.415599][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.415714][ T44] ? __lock_acquire+0x577/0xc10 [ 984.415829][ T44] netlink_sendmsg+0x735/0xc60 [ 984.415944][ T44] ? netlink_unicast+0x770/0x770 [ 984.416064][ T44] ____sys_sendmsg+0x419/0x850 [ 984.416180][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.416300][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.416445][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.416561][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.416675][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.416791][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.416905][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 984.417053][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.417182][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.417297][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.417412][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.417530][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 984.417676][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 984.417790][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.417904][ T44] do_syscall_64+0xbd/0xfc0 [ 984.418022][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.418167][ T44] RIP: 0033:0x7f5fd1e20c5e [ 984.418289][ T44] RSP: 002b:00007fffbc9cbb90 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.418466][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f5fd1e20c5e [ 984.418639][ T44] RDX: 0000000000000000 RSI: 00007fffbc9cbc50 RDI: 0000000000000003 [ 984.418813][ T44] RBP: 00007fffbc9cbba0 R08: 0000000000000000 R09: 0000000000000000 [ 984.418985][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fffbc9cc310 [ 984.419162][ T44] R13: 0000000069554f10 R14: 0000000000000000 R15: 0000000000499600 [ 984.419338][ T44] [ 984.419427][ T44] INFO: task ip:5766 is blocked on a mutex likely owned by task kworker/2:0:28. [ 984.419619][ T44] task:kworker/2:0 state:R running task stack:27392 pid:28 tgid:28 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.419898][ T44] Workqueue: events refill_work [ 984.420012][ T44] Call Trace: [ 984.420110][ T44] [ 984.420170][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.420289][ T44] ? __schedule+0xae2/0x1720 [ 984.420409][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.420526][ T44] ? asm_common_interrupt+0x26/0x40 [ 984.420639][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.420754][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.420869][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.420984][ T44] ? schedule+0xd4/0x260 [ 984.421075][ T44] ? schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 984.421221][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 984.421335][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 984.421455][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.421568][ T44] ? ktime_get+0x15e/0x220 [ 984.421680][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 984.421793][ T44] ? ktime_get+0xa9/0x220 [ 984.421881][ T44] ? usleep_range_state+0x133/0x1b0 [ 984.421998][ T44] ? schedule_hrtimeout+0x20/0x20 [ 984.422120][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 984.422235][ T44] ? refill_work+0x149/0x210 [ 984.422350][ T44] ? napi_disable_locked+0x379/0x5f0 [ 984.422472][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 984.422588][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 984.422734][ T44] ? napi_disable+0x43/0x80 [ 984.422848][ T44] ? refill_work+0x116/0x210 [ 984.422965][ T44] ? process_one_work+0xd57/0x1390 [ 984.423086][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.423202][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.423318][ T44] ? assign_work+0x152/0x380 [ 984.423435][ T44] ? worker_thread+0x4d6/0xd40 [ 984.423553][ T44] ? process_one_work+0x1390/0x1390 [ 984.423670][ T44] ? kthread+0x355/0x5b0 [ 984.423761][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.423875][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.423988][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.424107][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.424221][ T44] ? ret_from_fork+0x3fb/0x510 [ 984.424336][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.424482][ T44] ? __switch_to+0x53c/0xd00 [ 984.424596][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.424711][ T44] ? ret_from_fork_asm+0x11/0x20 [ 984.424830][ T44] [ 984.424918][ T44] [ 984.424918][ T44] Showing all locks held in the system: [ 984.425090][ T44] 3 locks held by kworker/u16:0/12: [ 984.425208][ T44] #0: ff11000008f3f148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.425438][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.425718][ T44] #2: ffffffff942859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 984.425915][ T44] 3 locks held by kworker/2:0/28: [ 984.426025][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.426254][ T44] #1: ffa00000001ffcc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.426508][ T44] #2: ff11000008992c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 984.426703][ T44] 3 locks held by kworker/3:0/33: [ 984.426812][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.427036][ T44] #1: ffa0000000257cc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.427262][ T44] #2: ffffffff942859a8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 984.427462][ T44] 1 lock held by khungtaskd/44: [ 984.427574][ T44] #0: ffffffff93b710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 984.427803][ T44] 2 locks held by ip/5766: [ 984.427914][ T44] #0: ffffffff942859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 984.428112][ T44] #1: ff11000008992c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 984.428375][ T44] 1 lock held by xdp_helper/5775: [ 984.428489][ T44] #0: ffffffff942859a8 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10 [ 984.428687][ T44] [ 984.428745][ T44] ============================================= [ 984.428745][ T44] [ 990.545057][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 38911 ms [ 990.545390][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 38911000 usecs ago [ 996.177056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 44543 ms [ 996.177390][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 44543000 usecs ago [ 1001.298055][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 49664 ms [ 1001.298389][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 49664000 usecs ago [ 1006.418055][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 54784 ms [ 1006.418394][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 54784000 usecs ago [ 1012.562056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 60928 ms [ 1012.562391][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 60928000 usecs ago [ 1018.194055][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 66560 ms [ 1018.194387][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 66560000 usecs ago [ 1023.314056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 71680 ms [ 1023.314392][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 71680000 usecs ago [ 1029.457056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 77823 ms [ 1029.457389][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 77823000 usecs ago [ 1035.090053][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 83456 ms [ 1035.090413][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 83456000 usecs ago [ 1040.210056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 88576 ms [ 1040.210394][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 88576000 usecs ago [ 1045.330056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 93696 ms [ 1045.330393][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 93696000 usecs ago [ 1051.474056][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 99840 ms [ 1051.474391][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 99840000 usecs ago [ 1057.106053][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 105472 ms [ 1057.106451][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 105472000 usecs ago [ 1062.226057][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 110592 ms [ 1062.226433][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 110592000 usecs ago