[ 744.256763][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 5633 ms [ 744.257283][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 5633000 usecs ago [ 749.376761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 10753 ms [ 749.377153][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 10753000 usecs ago [ 755.520760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 16897 ms [ 755.521129][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 16897000 usecs ago [ 761.152761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 22529 ms [ 761.153144][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 22529000 usecs ago [ 766.272760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 27649 ms [ 766.273138][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 27649000 usecs ago [ 771.392761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 32769 ms [ 771.393127][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 32769000 usecs ago [ 777.536761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 38913 ms [ 777.537133][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 38913000 usecs ago [ 783.168761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 44545 ms [ 783.169134][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 44545000 usecs ago [ 788.288761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 49665 ms [ 788.289133][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 49665000 usecs ago [ 793.408761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 54785 ms [ 793.409152][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 54785000 usecs ago [ 799.552761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 60929 ms [ 799.553158][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 60929000 usecs ago [ 805.184760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 66561 ms [ 805.185127][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 66561000 usecs ago [ 810.304761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 71681 ms [ 810.305124][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 71681000 usecs ago [ 816.448761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 77825 ms [ 816.449146][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 77825000 usecs ago [ 822.080760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 83457 ms [ 822.081124][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 83457000 usecs ago [ 827.200760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 88577 ms [ 827.201133][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 88577000 usecs ago [ 832.320760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 93697 ms [ 832.321127][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 93697000 usecs ago [ 838.464761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 99841 ms [ 838.465143][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 99841000 usecs ago [ 844.096761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 105473 ms [ 844.097192][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 105473000 usecs ago [ 849.216761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 110593 ms [ 849.217153][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 110593000 usecs ago [ 854.336760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 115713 ms [ 854.337158][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 115713000 usecs ago [ 860.480761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 121857 ms [ 860.481153][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 121857000 usecs ago [ 861.504770][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds. [ 861.505103][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 861.505243][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.505480][ T44] task:kworker/u16:0 state:D stack:26480 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.505821][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 861.505990][ T44] Call Trace: [ 861.506085][ T44] [ 861.506153][ T44] __schedule+0xae2/0x1720 [ 861.506286][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.506412][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.506536][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.506661][ T44] schedule+0xd4/0x260 [ 861.506765][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.506892][ T44] __mutex_lock+0xd76/0x1f20 [ 861.507015][ T44] ? addrconf_verify_work+0x12/0x30 [ 861.507133][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.507253][ T44] ? process_one_work+0xd16/0x1390 [ 861.507380][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.507503][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.507623][ T44] ? addrconf_verify_work+0x12/0x30 [ 861.507743][ T44] addrconf_verify_work+0x12/0x30 [ 861.507871][ T44] process_one_work+0xd57/0x1390 [ 861.507990][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.508106][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.508222][ T44] ? assign_work+0x152/0x380 [ 861.508338][ T44] worker_thread+0x4d6/0xd40 [ 861.508459][ T44] ? process_one_work+0x1390/0x1390 [ 861.508574][ T44] kthread+0x355/0x5b0 [ 861.508661][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.508784][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.509003][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.509119][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.509234][ T44] ret_from_fork+0x3fb/0x510 [ 861.509348][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 861.509489][ T44] ? __switch_to+0x53c/0xd00 [ 861.509603][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.509720][ T44] ret_from_fork_asm+0x11/0x20 [ 861.509846][ T44] [ 861.509951][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:6024. [ 861.510151][ T44] INFO: task ip:6024 blocked for more than 122 seconds. [ 861.510284][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 861.510389][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.510578][ T44] task:ip state:D stack:25072 pid:6024 tgid:6024 ppid:6019 task_flags:0x400100 flags:0x00080000 [ 861.510834][ T44] Call Trace: [ 861.510919][ T44] [ 861.510977][ T44] __schedule+0xae2/0x1720 [ 861.511095][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.511212][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.511326][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.511441][ T44] schedule+0xd4/0x260 [ 861.511527][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.511641][ T44] __mutex_lock+0xd76/0x1f20 [ 861.511764][ T44] ? napi_enable+0x3b/0x80 [ 861.511882][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.511996][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.512117][ T44] ? __asan_memset+0x27/0x50 [ 861.512235][ T44] ? sg_init_table+0x19/0x60 [ 861.512357][ T44] ? try_fill_recv+0x3ec/0x1750 [ 861.512478][ T44] ? napi_enable+0x3b/0x80 [ 861.512593][ T44] napi_enable+0x3b/0x80 [ 861.512683][ T44] __virtnet_rx_resume+0x156/0x290 [ 861.512802][ T44] ? queue_delayed_work_on+0x91/0x100 [ 861.512923][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 861.513041][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 861.513159][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 861.513273][ T44] dev_xdp_install+0x3e4/0x890 [ 861.513389][ T44] ? netif_set_xps_queue+0x40/0x40 [ 861.513506][ T44] dev_xdp_attach+0x50d/0x1310 [ 861.513624][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 861.513741][ T44] ? __bpf_prog_get+0x320/0x320 [ 861.513867][ T44] dev_change_xdp_fd+0x176/0x210 [ 861.513984][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 861.514103][ T44] ? rtnl_newlink_create+0x900/0x900 [ 861.514217][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 861.514362][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 861.514478][ T44] ? validate_chain+0x37b/0xb70 [ 861.514593][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 861.514713][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 861.514835][ T44] ? __lock_acquire+0x577/0xc10 [ 861.514950][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.515066][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 861.515179][ T44] ? lock_acquire+0x10a/0x150 [ 861.515293][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.515407][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.515524][ T44] ? trace_contention_end+0xd6/0x110 [ 861.515641][ T44] ? __mutex_lock+0x285/0x1f20 [ 861.515768][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 861.515884][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.515998][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 861.516116][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 861.516233][ T44] rtnl_newlink+0x75c/0xe90 [ 861.516349][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.516464][ T44] ? rtnl_setlink+0x880/0x880 [ 861.516579][ T44] ? __lock_acquire+0x577/0xc10 [ 861.516697][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.516815][ T44] ? find_held_lock+0x2b/0x80 [ 861.516929][ T44] ? rtnl_setlink+0x880/0x880 [ 861.517042][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.517155][ T44] ? rtnl_setlink+0x880/0x880 [ 861.517271][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 861.517385][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 861.517503][ T44] ? __lock_acquire+0x577/0xc10 [ 861.517618][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.517733][ T44] ? find_held_lock+0x2b/0x80 [ 861.517851][ T44] netlink_rcv_skb+0x123/0x380 [ 861.517965][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 861.518078][ T44] ? netlink_ack+0xcc0/0xcc0 [ 861.518197][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 861.518309][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 861.518425][ T44] netlink_unicast+0x4a3/0x770 [ 861.518541][ T44] ? netlink_attachskb+0x810/0x810 [ 861.518656][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.518781][ T44] ? __lock_acquire+0x577/0xc10 [ 861.518895][ T44] netlink_sendmsg+0x735/0xc60 [ 861.519018][ T44] ? netlink_unicast+0x770/0x770 [ 861.519135][ T44] ____sys_sendmsg+0x419/0x850 [ 861.519250][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 861.519366][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 861.519513][ T44] ? move_addr_to_kernel+0x40/0x40 [ 861.519630][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 861.519749][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 861.519870][ T44] ___sys_sendmsg+0xfd/0x180 [ 861.519987][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 861.520131][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 861.520262][ T44] __sys_sendmsg+0x124/0x1c0 [ 861.520378][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 861.520492][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 861.520608][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 861.520764][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 861.520878][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.520996][ T44] do_syscall_64+0xbd/0xfc0 [ 861.521112][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 861.521255][ T44] RIP: 0033:0x7f37c14b1c5e [ 861.521378][ T44] RSP: 002b:00007ffdf8340010 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 861.521555][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f37c14b1c5e [ 861.521732][ T44] RDX: 0000000000000000 RSI: 00007ffdf83400d0 RDI: 0000000000000003 [ 861.521913][ T44] RBP: 00007ffdf8340020 R08: 0000000000000000 R09: 0000000000000000 [ 861.522086][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffdf8340790 [ 861.522259][ T44] R13: 0000000069523a6f R14: 0000000000000000 R15: 0000000000499600 [ 861.522439][ T44] [ 861.522526][ T44] INFO: task ip:6024 is blocked on a mutex likely owned by task kworker/2:2:2245. [ 861.522717][ T44] task:kworker/2:2 state:D stack:28064 pid:2245 tgid:2245 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.522973][ T44] Workqueue: events refill_work [ 861.523093][ T44] Call Trace: [ 861.523182][ T44] [ 861.523243][ T44] __schedule+0xae2/0x1720 [ 861.523359][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.523473][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.523588][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.523707][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.523823][ T44] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 861.523968][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.524081][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.524195][ T44] ? schedule_hrtimeout_range_clock+0x1ca/0x2f0 [ 861.524338][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 861.524454][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 861.524570][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 861.524689][ T44] ? ktime_get+0x15e/0x220 [ 861.524809][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 861.524922][ T44] ? ktime_get+0xa9/0x220 [ 861.525009][ T44] ? usleep_range_state+0x133/0x1b0 [ 861.525123][ T44] ? schedule_hrtimeout+0x20/0x20 [ 861.525238][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 861.525351][ T44] ? refill_work+0x149/0x210 [ 861.525466][ T44] ? napi_disable_locked+0x379/0x5f0 [ 861.525580][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 861.525697][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 861.525845][ T44] ? napi_disable+0x43/0x80 [ 861.525958][ T44] ? refill_work+0x116/0x210 [ 861.526073][ T44] ? process_one_work+0xd57/0x1390 [ 861.526189][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.526305][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.526419][ T44] ? assign_work+0x152/0x380 [ 861.526533][ T44] ? worker_thread+0x4d6/0xd40 [ 861.526650][ T44] ? process_one_work+0x1390/0x1390 [ 861.526768][ T44] ? __kthread_parkme+0xb3/0x200 [ 861.526883][ T44] ? process_one_work+0x1390/0x1390 [ 861.526997][ T44] ? kthread+0x355/0x5b0 [ 861.527082][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.527197][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.527309][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.527422][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.527536][ T44] ? ret_from_fork+0x3fb/0x510 [ 861.527650][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 861.527800][ T44] ? __switch_to+0x53c/0xd00 [ 861.527913][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.528029][ T44] ? ret_from_fork_asm+0x11/0x20 [ 861.528150][ T44] [ 861.528242][ T44] [ 861.528242][ T44] Showing all locks held in the system: [ 861.528408][ T44] 3 locks held by kworker/u16:0/12: [ 861.528521][ T44] #0: ff1100000913f148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 861.528748][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 861.529114][ T44] #2: ffffffff9d285768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 861.529313][ T44] 1 lock held by khungtaskd/44: [ 861.529426][ T44] #0: ffffffff9cb71040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 861.529651][ T44] 3 locks held by kworker/2:2/2245: [ 861.529777][ T44] 2 locks held by ip/6024: [ 861.529885][ T44] #0: ffffffff9d285768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 861.530079][ T44] #1: ff11000008b2ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 861.530271][ T44] [ 861.530329][ T44] ============================================= [ 861.530329][ T44] [ 866.112761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 127489 ms [ 866.113157][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 127489000 usecs ago [ 871.232760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 132609 ms [ 871.233191][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 132609000 usecs ago [ 876.352761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 137729 ms [ 876.353165][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 137729000 usecs ago [ 882.496761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 143873 ms [ 882.497171][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 143873000 usecs ago [ 888.128760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 149505 ms [ 888.129160][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 149505000 usecs ago [ 893.248760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 154625 ms [ 893.249190][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 154625000 usecs ago [ 898.368760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 159745 ms [ 898.369163][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 159745000 usecs ago [ 904.512760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 165889 ms [ 904.513168][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 165889000 usecs ago [ 910.144760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 171521 ms [ 910.145195][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 171521000 usecs ago [ 915.264760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 176641 ms [ 915.265157][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 176641000 usecs ago [ 920.384761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 181761 ms [ 920.385169][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 181761000 usecs ago [ 926.528761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 187905 ms [ 926.529161][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 187905000 usecs ago [ 932.160761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 193537 ms [ 932.161153][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 193537000 usecs ago [ 937.280760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 198657 ms [ 937.281189][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 198657000 usecs ago [ 942.400761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 203777 ms [ 942.401153][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 203777000 usecs ago [ 948.544761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 209921 ms [ 948.545160][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 209921000 usecs ago [ 954.176760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 215553 ms [ 954.177156][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 215553000 usecs ago [ 959.296760][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 220673 ms [ 959.297191][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 220673000 usecs ago [ 964.416761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 225793 ms [ 964.417210][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 225793000 usecs ago [ 970.560761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 231937 ms [ 970.561168][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 231937000 usecs ago [ 976.192761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 237569 ms [ 976.193165][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 237569000 usecs ago [ 981.312761][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 242689 ms [ 981.313171][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 242689000 usecs ago [ 984.384768][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 984.385040][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 984.385194][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.385464][ T44] task:kworker/u16:0 state:D stack:26480 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.385848][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 984.386041][ T44] Call Trace: [ 984.386147][ T44] [ 984.386213][ T44] __schedule+0xae2/0x1720 [ 984.386338][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.386460][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.386579][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.386702][ T44] schedule+0xd4/0x260 [ 984.386803][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.386923][ T44] __mutex_lock+0xd76/0x1f20 [ 984.387043][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.387163][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.387282][ T44] ? process_one_work+0xd16/0x1390 [ 984.387397][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.387514][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.387630][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.387747][ T44] addrconf_verify_work+0x12/0x30 [ 984.387872][ T44] process_one_work+0xd57/0x1390 [ 984.387992][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.388109][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.388226][ T44] ? assign_work+0x152/0x380 [ 984.388343][ T44] worker_thread+0x4d6/0xd40 [ 984.388463][ T44] ? process_one_work+0x1390/0x1390 [ 984.388576][ T44] kthread+0x355/0x5b0 [ 984.388662][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.388785][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.388900][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.389013][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.389128][ T44] ret_from_fork+0x3fb/0x510 [ 984.389245][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.389386][ T44] ? __switch_to+0x53c/0xd00 [ 984.389499][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.389613][ T44] ret_from_fork_asm+0x11/0x20 [ 984.389734][ T44] [ 984.389835][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:6024. [ 984.390035][ T44] INFO: task ip:6024 blocked for more than 245 seconds. [ 984.390168][ T44] Not tainted 6.19.0-rc1-virtme #1 [ 984.390278][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.390459][ T44] task:ip state:D stack:25072 pid:6024 tgid:6024 ppid:6019 task_flags:0x400100 flags:0x00080000 [ 984.390704][ T44] Call Trace: [ 984.390798][ T44] [ 984.390859][ T44] __schedule+0xae2/0x1720 [ 984.390980][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.391095][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.391207][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.391321][ T44] schedule+0xd4/0x260 [ 984.391406][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.391519][ T44] __mutex_lock+0xd76/0x1f20 [ 984.391637][ T44] ? napi_enable+0x3b/0x80 [ 984.391760][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.391876][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.391994][ T44] ? __asan_memset+0x27/0x50 [ 984.392109][ T44] ? sg_init_table+0x19/0x60 [ 984.392224][ T44] ? try_fill_recv+0x3ec/0x1750 [ 984.392345][ T44] ? napi_enable+0x3b/0x80 [ 984.392458][ T44] napi_enable+0x3b/0x80 [ 984.392546][ T44] __virtnet_rx_resume+0x156/0x290 [ 984.392659][ T44] ? queue_delayed_work_on+0x91/0x100 [ 984.392781][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 984.392898][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 984.393014][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 984.393125][ T44] dev_xdp_install+0x3e4/0x890 [ 984.393240][ T44] ? netif_set_xps_queue+0x40/0x40 [ 984.393359][ T44] dev_xdp_attach+0x50d/0x1310 [ 984.393477][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 984.393590][ T44] ? __bpf_prog_get+0x320/0x320 [ 984.393707][ T44] dev_change_xdp_fd+0x176/0x210 [ 984.393828][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 984.393944][ T44] ? rtnl_newlink_create+0x900/0x900 [ 984.394057][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 984.394201][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.394313][ T44] ? validate_chain+0x37b/0xb70 [ 984.394426][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 984.394538][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.394651][ T44] ? __lock_acquire+0x577/0xc10 [ 984.394772][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.394886][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.395001][ T44] ? lock_acquire+0x10a/0x150 [ 984.395112][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.395224][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.395336][ T44] ? trace_contention_end+0xd6/0x110 [ 984.395449][ T44] ? __mutex_lock+0x285/0x1f20 [ 984.395565][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.395678][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.395796][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 984.395916][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 984.396032][ T44] rtnl_newlink+0x75c/0xe90 [ 984.396147][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.396260][ T44] ? rtnl_setlink+0x880/0x880 [ 984.396372][ T44] ? __lock_acquire+0x577/0xc10 [ 984.396487][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.396600][ T44] ? find_held_lock+0x2b/0x80 [ 984.396713][ T44] ? rtnl_setlink+0x880/0x880 [ 984.396833][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.396947][ T44] ? rtnl_setlink+0x880/0x880 [ 984.397062][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 984.397177][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.397289][ T44] ? __lock_acquire+0x577/0xc10 [ 984.397404][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.397516][ T44] ? find_held_lock+0x2b/0x80 [ 984.397633][ T44] netlink_rcv_skb+0x123/0x380 [ 984.397751][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.397871][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.397987][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 984.398098][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.398212][ T44] netlink_unicast+0x4a3/0x770 [ 984.398326][ T44] ? netlink_attachskb+0x810/0x810 [ 984.398441][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.398553][ T44] ? __lock_acquire+0x577/0xc10 [ 984.398666][ T44] netlink_sendmsg+0x735/0xc60 [ 984.398790][ T44] ? netlink_unicast+0x770/0x770 [ 984.398906][ T44] ____sys_sendmsg+0x419/0x850 [ 984.399021][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.399138][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.399279][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.399395][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.399508][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.399624][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.399740][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 984.399887][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.400012][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.400129][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.400242][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.400355][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 984.400501][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 984.400615][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.400735][ T44] do_syscall_64+0xbd/0xfc0 [ 984.400855][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.400998][ T44] RIP: 0033:0x7f37c14b1c5e [ 984.401120][ T44] RSP: 002b:00007ffdf8340010 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.401294][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f37c14b1c5e [ 984.401470][ T44] RDX: 0000000000000000 RSI: 00007ffdf83400d0 RDI: 0000000000000003 [ 984.401640][ T44] RBP: 00007ffdf8340020 R08: 0000000000000000 R09: 0000000000000000 [ 984.401819][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffdf8340790 [ 984.401990][ T44] R13: 0000000069523a6f R14: 0000000000000000 R15: 0000000000499600 [ 984.402169][ T44] [ 984.402259][ T44] INFO: task ip:6024 is blocked on a mutex likely owned by task kworker/2:2:2245. [ 984.402444][ T44] task:kworker/2:2 state:R running task stack:28064 pid:2245 tgid:2245 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.402730][ T44] Workqueue: events refill_work [ 984.402846][ T44] Call Trace: [ 984.402932][ T44] [ 984.402991][ T44] ? __schedule+0xae2/0x1720 [ 984.403106][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.403219][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.403337][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.403451][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.403563][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.403675][ T44] ? schedule+0xd4/0x260 [ 984.403767][ T44] ? schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 984.403908][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 984.404021][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 984.404137][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.404247][ T44] ? ktime_get+0x15e/0x220 [ 984.404358][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 984.404471][ T44] ? ktime_get+0xa9/0x220 [ 984.404559][ T44] ? usleep_range_state+0x133/0x1b0 [ 984.404672][ T44] ? schedule_hrtimeout+0x20/0x20 [ 984.404792][ T44] ? __free_object+0x2ad/0x4b0 [ 984.404909][ T44] ? napi_disable_locked+0x379/0x5f0 [ 984.405022][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 984.405135][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 984.405277][ T44] ? napi_disable+0x43/0x80 [ 984.405389][ T44] ? refill_work+0x116/0x210 [ 984.405504][ T44] ? process_one_work+0xd57/0x1390 [ 984.405620][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.405737][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.405857][ T44] ? assign_work+0x152/0x380 [ 984.405973][ T44] ? worker_thread+0x4d6/0xd40 [ 984.406089][ T44] ? process_one_work+0x1390/0x1390 [ 984.406201][ T44] ? __kthread_parkme+0xb3/0x200 [ 984.406315][ T44] ? process_one_work+0x1390/0x1390 [ 984.406427][ T44] ? kthread+0x355/0x5b0 [ 984.406515][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.406627][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.406742][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.406859][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.406972][ T44] ? ret_from_fork+0x3fb/0x510 [ 984.407085][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.407225][ T44] ? __switch_to+0x53c/0xd00 [ 984.407338][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.407452][ T44] ? ret_from_fork_asm+0x11/0x20 [ 984.407569][ T44] [ 984.407657][ T44] [ 984.407657][ T44] Showing all locks held in the system: [ 984.407905][ T44] 3 locks held by kworker/u16:0/12: [ 984.408016][ T44] #0: ff1100000913f148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.408239][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.408510][ T44] #2: ffffffff9d285768 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 984.408707][ T44] 1 lock held by khungtaskd/44: [ 984.408825][ T44] #0: ffffffff9cb71040 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 984.409056][ T44] 3 locks held by kworker/2:2/2245: [ 984.409165][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.409383][ T44] #1: ffa0000001f97cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.409632][ T44] #2: ff11000008b2ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 984.409838][ T44] 2 locks held by ip/6024: [ 984.409950][ T44] #0: ffffffff9d285768 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 984.410143][ T44] #1: ff11000008b2ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 984.410342][ T44] [ 984.410397][ T44] ============================================= [ 984.410397][ T44] [ 987.456762][ C2] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 2: transmit queue 3 timed out 248832 ms [ 987.457186][ C2] virtio_net virtio2 enp0s1: TX timeout on queue: 3, sq: output.3, vq: 0x7, name: output.3, 248833000 usecs ago