[ 957.249691][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 247296 ms [ 957.250064][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 247296000 usecs ago [ 962.369689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 252416 ms [ 962.370056][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 252416000 usecs ago [ 968.513689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 258560 ms [ 968.514030][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 258560000 usecs ago [ 974.145689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 264192 ms [ 974.146038][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 264192000 usecs ago [ 979.265689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 269312 ms [ 979.266037][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 269312000 usecs ago [ 984.385693][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 274432 ms [ 984.386039][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 274432000 usecs ago [ 984.386391][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 984.386579][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 984.386730][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.386944][ T44] task:kworker/u16:0 state:D stack:26352 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.387234][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 984.387393][ T44] Call Trace: [ 984.387497][ T44] [ 984.387563][ T44] __schedule+0xae2/0x1720 [ 984.387700][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.387825][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.387953][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.388075][ T44] schedule+0xd4/0x260 [ 984.388171][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.388291][ T44] __mutex_lock+0xd76/0x1f20 [ 984.388416][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.388535][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.388661][ T44] ? process_one_work+0xd16/0x1390 [ 984.388789][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.388910][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.389033][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.389146][ T44] addrconf_verify_work+0x12/0x30 [ 984.389272][ T44] process_one_work+0xd57/0x1390 [ 984.389392][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.389513][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.389630][ T44] ? assign_work+0x152/0x380 [ 984.389756][ T44] worker_thread+0x4d6/0xd40 [ 984.389877][ T44] ? process_one_work+0x1390/0x1390 [ 984.389997][ T44] kthread+0x355/0x5b0 [ 984.390085][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.390208][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.390325][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.390447][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.390562][ T44] ret_from_fork+0x3fb/0x510 [ 984.390692][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.390834][ T44] ? __switch_to+0x53c/0xd00 [ 984.390954][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.391067][ T44] ret_from_fork_asm+0x11/0x20 [ 984.391196][ T44] [ 984.391303][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5771. [ 984.391508][ T44] INFO: task ip:5771 blocked for more than 368 seconds. [ 984.391643][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 984.391756][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.391941][ T44] task:ip state:D stack:25024 pid:5771 tgid:5771 ppid:1 task_flags:0x400100 flags:0x00080002 [ 984.392197][ T44] Call Trace: [ 984.392286][ T44] [ 984.392345][ T44] __schedule+0xae2/0x1720 [ 984.392472][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.392588][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.392709][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.392825][ T44] schedule+0xd4/0x260 [ 984.392920][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.393034][ T44] __mutex_lock+0xd76/0x1f20 [ 984.393156][ T44] ? napi_enable+0x3b/0x80 [ 984.393279][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.393402][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.393517][ T44] ? __asan_memset+0x27/0x50 [ 984.393641][ T44] ? sg_init_table+0x19/0x60 [ 984.393770][ T44] ? try_fill_recv+0x3ec/0x1750 [ 984.393892][ T44] ? napi_enable+0x3b/0x80 [ 984.394014][ T44] napi_enable+0x3b/0x80 [ 984.394101][ T44] __virtnet_rx_resume+0x156/0x290 [ 984.394226][ T44] ? queue_delayed_work_on+0x91/0x100 [ 984.394343][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 984.394466][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 984.394588][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 984.394710][ T44] dev_xdp_install+0x3e4/0x890 [ 984.394826][ T44] ? netif_set_xps_queue+0x40/0x40 [ 984.394956][ T44] dev_xdp_attach+0x50d/0x1310 [ 984.395074][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 984.395196][ T44] ? __bpf_prog_get+0x320/0x320 [ 984.395317][ T44] dev_change_xdp_fd+0x176/0x210 [ 984.395439][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 984.395559][ T44] ? rtnl_newlink_create+0x900/0x900 [ 984.395679][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 984.395833][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.395948][ T44] ? validate_chain+0x37b/0xb70 [ 984.396068][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 984.396181][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.396307][ T44] ? __lock_acquire+0x577/0xc10 [ 984.396424][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.396545][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.396662][ T44] ? lock_acquire+0x10a/0x150 [ 984.396783][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.396898][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.397020][ T44] ? trace_contention_end+0xd6/0x110 [ 984.397135][ T44] ? __mutex_lock+0x285/0x1f20 [ 984.397261][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.397376][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.397497][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 984.397616][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 984.397744][ T44] rtnl_newlink+0x75c/0xe90 [ 984.397861][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.397982][ T44] ? rtnl_setlink+0x880/0x880 [ 984.398097][ T44] ? __lock_acquire+0x577/0xc10 [ 984.398226][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.398340][ T44] ? find_held_lock+0x2b/0x80 [ 984.398464][ T44] ? rtnl_setlink+0x880/0x880 [ 984.398580][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.398704][ T44] ? rtnl_setlink+0x880/0x880 [ 984.398818][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 984.398940][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.399054][ T44] ? __lock_acquire+0x577/0xc10 [ 984.399178][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.399295][ T44] ? find_held_lock+0x2b/0x80 [ 984.399417][ T44] netlink_rcv_skb+0x123/0x380 [ 984.399532][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.399653][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.399780][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 984.399893][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.400017][ T44] netlink_unicast+0x4a3/0x770 [ 984.400132][ T44] ? netlink_attachskb+0x810/0x810 [ 984.400256][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.400371][ T44] ? __lock_acquire+0x577/0xc10 [ 984.400495][ T44] netlink_sendmsg+0x735/0xc60 [ 984.400611][ T44] ? netlink_unicast+0x770/0x770 [ 984.400738][ T44] ____sys_sendmsg+0x419/0x850 [ 984.400855][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.400976][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.401116][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.401246][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.401358][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.401482][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.401597][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 984.401748][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.401880][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.402002][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.402117][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.402243][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 984.402389][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 984.402510][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.402627][ T44] do_syscall_64+0xbd/0xfc0 [ 984.402753][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.402895][ T44] RIP: 0033:0x7f990e6a1c5e [ 984.403026][ T44] RSP: 002b:00007ffe28159c40 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.403201][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f990e6a1c5e [ 984.403385][ T44] RDX: 0000000000000000 RSI: 00007ffe28159d00 RDI: 0000000000000003 [ 984.403559][ T44] RBP: 00007ffe28159c50 R08: 0000000000000000 R09: 0000000000000000 [ 984.403742][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffe2815a3c0 [ 984.403913][ T44] R13: 00000000695007eb R14: 0000000000000000 R15: 0000000000499600 [ 984.404101][ T44] [ 984.404189][ T44] INFO: task ip:5771 is blocked on a mutex likely owned by task kworker/3:0:33. [ 984.404387][ T44] task:kworker/3:0 state:D stack:28096 pid:33 tgid:33 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.404647][ T44] Workqueue: events refill_work [ 984.404772][ T44] Call Trace: [ 984.404859][ T44] [ 984.404920][ T44] __schedule+0xae2/0x1720 [ 984.405045][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.405160][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.405285][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.405404][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.405525][ T44] schedule+0xd4/0x260 [ 984.405612][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 984.405762][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 984.405879][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 984.406004][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.406119][ T44] ? ktime_get+0x15e/0x220 [ 984.406246][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 984.406361][ T44] ? ktime_get+0xa9/0x220 [ 984.406458][ T44] usleep_range_state+0x133/0x1b0 [ 984.406574][ T44] ? schedule_hrtimeout+0x20/0x20 [ 984.406698][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 984.406815][ T44] ? refill_work+0x149/0x210 [ 984.406937][ T44] napi_disable_locked+0x379/0x5f0 [ 984.407054][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 984.407175][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 984.407324][ T44] napi_disable+0x43/0x80 [ 984.407418][ T44] refill_work+0x116/0x210 [ 984.407534][ T44] process_one_work+0xd57/0x1390 [ 984.407658][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.407782][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.407903][ T44] ? assign_work+0x152/0x380 [ 984.408024][ T44] worker_thread+0x4d6/0xd40 [ 984.408142][ T44] ? process_one_work+0x1390/0x1390 [ 984.408265][ T44] kthread+0x355/0x5b0 [ 984.408352][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.408476][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.408590][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.408715][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.408835][ T44] ret_from_fork+0x3fb/0x510 [ 984.408958][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.409103][ T44] ? __switch_to+0x53c/0xd00 [ 984.409227][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.409343][ T44] ret_from_fork_asm+0x11/0x20 [ 984.409471][ T44] [ 984.409563][ T44] [ 984.409563][ T44] Showing all locks held in the system: [ 984.409811][ T44] 3 locks held by kworker/u16:0/12: [ 984.409925][ T44] #0: ff11000009167148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.410157][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.410447][ T44] #2: ffffffffaaa85768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 984.410652][ T44] 3 locks held by kworker/3:0/33: [ 984.410772][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.411000][ T44] #1: ffa0000000257cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.411259][ T44] #2: ff11000008b9ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 984.411467][ T44] 1 lock held by khungtaskd/44: [ 984.411576][ T44] #0: ffffffffaa371040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 984.411809][ T44] 3 locks held by kworker/2:1/63: [ 984.411920][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.412150][ T44] #1: ffa0000000447cc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.412386][ T44] #2: ffffffffaaa85768 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 984.412595][ T44] 2 locks held by ip/5771: [ 984.412714][ T44] #0: ffffffffaaa85768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 984.412908][ T44] #1: ff11000008b9ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 984.413113][ T44] 1 lock held by xdp_helper/5779: [ 984.413230][ T44] #0: ffffffffaaa85768 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10 [ 984.413435][ T44] [ 984.413544][ T44] ============================================= [ 984.413544][ T44] [ 990.529689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 280576 ms [ 990.530049][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 280576000 usecs ago [ 996.161689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 286208 ms [ 996.162063][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 286208000 usecs ago [ 1001.281689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 291328 ms [ 1001.282032][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 291328000 usecs ago [ 1006.401689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 296448 ms [ 1006.402045][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 296448000 usecs ago [ 1012.545688][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 302592 ms [ 1012.546055][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 302592000 usecs ago [ 1018.177689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 308224 ms [ 1018.178052][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 308224000 usecs ago [ 1023.297689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 313344 ms [ 1023.298036][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 313344000 usecs ago [ 1029.441689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 319488 ms [ 1029.442049][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 319488000 usecs ago [ 1035.073689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 325120 ms [ 1035.074037][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 325120000 usecs ago [ 1040.193689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 330240 ms [ 1040.194041][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 330240000 usecs ago [ 1045.313690][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 335360 ms [ 1045.314067][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 335360000 usecs ago [ 1051.457689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 341504 ms [ 1051.458048][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 341504000 usecs ago [ 1057.089689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 347136 ms [ 1057.090055][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 347136000 usecs ago [ 1062.209689][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 2 timed out 352256 ms [ 1062.210065][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 2, sq: output.2, vq: 0x5, name: output.2, 352256000 usecs ago