[ 704.335445][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 10751 ms [ 704.335842][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 10751000 usecs ago [ 710.479437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 16895 ms [ 710.479802][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 16895000 usecs ago [ 716.111436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 22527 ms [ 716.111779][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 22527000 usecs ago [ 721.231437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 27647 ms [ 721.231811][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 27647000 usecs ago [ 726.351434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 32767 ms [ 726.351786][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 32767000 usecs ago [ 732.495436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 38911 ms [ 732.495797][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 38911000 usecs ago [ 738.127442][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 44543 ms [ 738.127820][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 44543000 usecs ago [ 738.640449][ T44] INFO: task kworker/u16:0:12 blocked for more than 122 seconds. [ 738.640906][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 738.641128][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 738.641466][ T44] task:kworker/u16:0 state:D stack:26432 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 738.641858][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 738.642089][ T44] Call Trace: [ 738.642231][ T44] [ 738.642368][ T44] __schedule+0xae2/0x1720 [ 738.642583][ T44] ? io_schedule_timeout+0x130/0x130 [ 738.642764][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.642959][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.643127][ T44] schedule+0xd4/0x260 [ 738.643286][ T44] schedule_preempt_disabled+0x18/0x30 [ 738.643489][ T44] __mutex_lock+0xd76/0x1f20 [ 738.643661][ T44] ? addrconf_verify_work+0x12/0x30 [ 738.643852][ T44] ? ww_mutex_lock+0x160/0x160 [ 738.644024][ T44] ? process_one_work+0xd16/0x1390 [ 738.644216][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.644381][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.644585][ T44] ? addrconf_verify_work+0x12/0x30 [ 738.644747][ T44] addrconf_verify_work+0x12/0x30 [ 738.644932][ T44] process_one_work+0xd57/0x1390 [ 738.645098][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 738.645286][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.645483][ T44] ? assign_work+0x152/0x380 [ 738.645648][ T44] worker_thread+0x4d6/0xd40 [ 738.645841][ T44] ? process_one_work+0x1390/0x1390 [ 738.646001][ T44] kthread+0x355/0x5b0 [ 738.646159][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.646693][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.646860][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.647051][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.647212][ T44] ret_from_fork+0x3fb/0x510 [ 738.647394][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 738.647617][ T44] ? __switch_to+0x53c/0xd00 [ 738.647781][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.647966][ T44] ret_from_fork_asm+0x11/0x20 [ 738.648135][ T44] [ 738.648314][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5309. [ 738.648602][ T44] INFO: task ip:5309 blocked for more than 122 seconds. [ 738.648781][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 738.648957][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 738.649212][ T44] task:ip state:D stack:25024 pid:5309 tgid:5309 ppid:1 task_flags:0x400100 flags:0x00080002 [ 738.649544][ T44] Call Trace: [ 738.649676][ T44] [ 738.649803][ T44] __schedule+0xae2/0x1720 [ 738.649969][ T44] ? io_schedule_timeout+0x130/0x130 [ 738.650156][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.650315][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.650508][ T44] schedule+0xd4/0x260 [ 738.650649][ T44] schedule_preempt_disabled+0x18/0x30 [ 738.650835][ T44] __mutex_lock+0xd76/0x1f20 [ 738.650999][ T44] ? napi_enable+0x3b/0x80 [ 738.651185][ T44] ? ww_mutex_lock+0x160/0x160 [ 738.651347][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.651539][ T44] ? __asan_memset+0x27/0x50 [ 738.651703][ T44] ? sg_init_table+0x19/0x60 [ 738.651892][ T44] ? try_fill_recv+0x3ec/0x1750 [ 738.652062][ T44] ? napi_enable+0x3b/0x80 [ 738.652245][ T44] napi_enable+0x3b/0x80 [ 738.652379][ T44] __virtnet_rx_resume+0x156/0x290 [ 738.652577][ T44] ? queue_delayed_work_on+0x91/0x100 [ 738.652741][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 738.652929][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 738.653096][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 738.653281][ T44] dev_xdp_install+0x3e4/0x890 [ 738.653481][ T44] ? netif_set_xps_queue+0x40/0x40 [ 738.653648][ T44] dev_xdp_attach+0x50d/0x1310 [ 738.653845][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 738.654007][ T44] ? __bpf_prog_get+0x320/0x320 [ 738.654201][ T44] dev_change_xdp_fd+0x176/0x210 [ 738.654365][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 738.654569][ T44] ? rtnl_newlink_create+0x900/0x900 [ 738.654731][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 738.654946][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 738.655108][ T44] ? validate_chain+0x37b/0xb70 [ 738.655288][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 738.655483][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 738.655646][ T44] ? __lock_acquire+0x577/0xc10 [ 738.655837][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.656001][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 738.656187][ T44] ? lock_acquire+0x10a/0x150 [ 738.656347][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.656537][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.656701][ T44] ? trace_contention_end+0xd6/0x110 [ 738.656887][ T44] ? __mutex_lock+0x285/0x1f20 [ 738.657052][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 738.657243][ T44] ? ww_mutex_lock+0x160/0x160 [ 738.657404][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 738.657604][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 738.657771][ T44] rtnl_newlink+0x75c/0xe90 [ 738.657960][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.658120][ T44] ? rtnl_setlink+0x880/0x880 [ 738.658301][ T44] ? __lock_acquire+0x577/0xc10 [ 738.658501][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.658664][ T44] ? find_held_lock+0x2b/0x80 [ 738.658851][ T44] ? rtnl_setlink+0x880/0x880 [ 738.659012][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.659199][ T44] ? rtnl_setlink+0x880/0x880 [ 738.659360][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 738.659555][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 738.659718][ T44] ? __lock_acquire+0x577/0xc10 [ 738.659908][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.660068][ T44] ? find_held_lock+0x2b/0x80 [ 738.660251][ T44] netlink_rcv_skb+0x123/0x380 [ 738.660416][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 738.660614][ T44] ? netlink_ack+0xcc0/0xcc0 [ 738.660783][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 738.660968][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 738.661135][ T44] netlink_unicast+0x4a3/0x770 [ 738.661320][ T44] ? netlink_attachskb+0x810/0x810 [ 738.661515][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.661682][ T44] ? __lock_acquire+0x577/0xc10 [ 738.661870][ T44] netlink_sendmsg+0x735/0xc60 [ 738.662033][ T44] ? netlink_unicast+0x770/0x770 [ 738.662224][ T44] ____sys_sendmsg+0x419/0x850 [ 738.662389][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 738.662591][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 738.662780][ T44] ? move_addr_to_kernel+0x40/0x40 [ 738.662966][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 738.663150][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 738.663314][ T44] ___sys_sendmsg+0xfd/0x180 [ 738.663510][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 738.663729][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 738.663905][ T44] __sys_sendmsg+0x124/0x1c0 [ 738.664093][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 738.664253][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 738.664447][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 738.664672][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 738.664834][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.665027][ T44] do_syscall_64+0xbd/0xfc0 [ 738.665192][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 738.665401][ T44] RIP: 0033:0x7f7e26967c5e [ 738.665597][ T44] RSP: 002b:00007ffeaece10c0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 738.665841][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7e26967c5e [ 738.666082][ T44] RDX: 0000000000000000 RSI: 00007ffeaece1180 RDI: 0000000000000003 [ 738.666324][ T44] RBP: 00007ffeaece10d0 R08: 0000000000000000 R09: 0000000000000000 [ 738.666575][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffeaece1840 [ 738.666816][ T44] R13: 00000000695b753c R14: 0000000000000000 R15: 0000000000499600 [ 738.667063][ T44] [ 738.667198][ T44] INFO: task ip:5309 is blocked on a mutex likely owned by task kworker/2:2:67. [ 738.667482][ T44] task:kworker/2:2 state:D stack:28784 pid:67 tgid:67 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 738.667801][ T44] Workqueue: events refill_work [ 738.667963][ T44] Call Trace: [ 738.668118][ T44] [ 738.668226][ T44] __schedule+0xae2/0x1720 [ 738.668413][ T44] ? usleep_range_state+0xba/0x1b0 [ 738.668617][ T44] ? io_schedule_timeout+0x130/0x130 [ 738.668783][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.668970][ T44] ? usleep_range_state+0xba/0x1b0 [ 738.669131][ T44] schedule+0xd4/0x260 [ 738.669284][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 738.669507][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 738.669671][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 738.669959][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 738.670119][ T44] ? ktime_get+0x15e/0x220 [ 738.670297][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 738.670492][ T44] ? ktime_get+0xa9/0x220 [ 738.670629][ T44] usleep_range_state+0x133/0x1b0 [ 738.670818][ T44] ? schedule_hrtimeout+0x20/0x20 [ 738.670981][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 738.671169][ T44] ? refill_work+0x149/0x210 [ 738.671334][ T44] napi_disable_locked+0x379/0x5f0 [ 738.671528][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 738.671692][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 738.671906][ T44] napi_disable+0x43/0x80 [ 738.672041][ T44] refill_work+0x116/0x210 [ 738.672230][ T44] process_one_work+0xd57/0x1390 [ 738.672400][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 738.672595][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 738.672760][ T44] ? assign_work+0x152/0x380 [ 738.672946][ T44] worker_thread+0x4d6/0xd40 [ 738.673111][ T44] ? process_one_work+0x1390/0x1390 [ 738.673292][ T44] kthread+0x355/0x5b0 [ 738.673427][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.673626][ T44] ? __lock_release.isra.0+0x59/0x170 [ 738.673810][ T44] ? rcu_is_watching+0x15/0xd0 [ 738.673971][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.674155][ T44] ret_from_fork+0x3fb/0x510 [ 738.674319][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 738.674540][ T44] ? __switch_to+0x53c/0xd00 [ 738.674704][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 738.674890][ T44] ret_from_fork_asm+0x11/0x20 [ 738.675061][ T44] [ 738.675230][ T44] [ 738.675230][ T44] Showing all locks held in the system: [ 738.675543][ T44] 3 locks held by kworker/u16:0/12: [ 738.675701][ T44] #0: ff11000009127148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 738.676003][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 738.676351][ T44] #2: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 738.676633][ T44] 1 lock held by khungtaskd/44: [ 738.676790][ T44] #0: ffffffffaad710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 738.677089][ T44] 3 locks held by kworker/0:2/61: [ 738.677250][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 738.677556][ T44] #1: ffa000000041fcc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 738.677850][ T44] #2: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 738.678117][ T44] 3 locks held by kworker/2:2/67: [ 738.678276][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 738.678582][ T44] #1: ffa0000000487cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 738.678902][ T44] #2: ff11000008af2c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 738.679174][ T44] 2 locks held by ip/5309: [ 738.679331][ T44] #0: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 738.679720][ T44] #1: ff11000008af2c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 738.679989][ T44] 1 lock held by ip/5374: [ 738.680117][ T44] #0: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg+0x2ab/0xb90 [ 738.680378][ T44] [ 738.680514][ T44] ============================================= [ 738.680514][ T44] [ 743.247435][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 49663 ms [ 743.247788][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 49663000 usecs ago [ 748.367438][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 54783 ms [ 748.367816][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 54783000 usecs ago [ 754.511437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 60927 ms [ 754.511807][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 60927000 usecs ago [ 760.143433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 66559 ms [ 760.143809][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 66559000 usecs ago [ 765.263436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 71679 ms [ 765.263785][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 71679000 usecs ago [ 770.383437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 76799 ms [ 770.383787][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 76799000 usecs ago [ 776.527433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 82943 ms [ 776.527780][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 82943000 usecs ago [ 782.159435][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 88575 ms [ 782.159785][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 88575000 usecs ago [ 787.279436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 93695 ms [ 787.279794][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 93695000 usecs ago [ 792.399437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 98815 ms [ 792.399779][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 98815000 usecs ago [ 798.543434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 104959 ms [ 798.543836][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 104959000 usecs ago [ 804.175436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 110591 ms [ 804.175863][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 110591000 usecs ago [ 809.295436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 115711 ms [ 809.295826][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 115711000 usecs ago [ 814.415433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 120831 ms [ 814.415834][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 120831000 usecs ago [ 820.559436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 126975 ms [ 820.559844][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 126975000 usecs ago [ 826.191436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 132607 ms [ 826.191848][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 132607000 usecs ago [ 831.311433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 137727 ms [ 831.311831][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 137727000 usecs ago [ 836.431436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 142847 ms [ 836.431827][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 142847000 usecs ago [ 842.575437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 148991 ms [ 842.575836][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 148991000 usecs ago [ 848.207433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 154623 ms [ 848.207825][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 154623000 usecs ago [ 853.327435][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 159743 ms [ 853.327837][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 159743000 usecs ago [ 859.471437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 165887 ms [ 859.471840][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 165887000 usecs ago [ 861.520443][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds. [ 861.520782][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 861.521003][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.521275][ T44] task:kworker/u16:0 state:D stack:26432 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.521653][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 861.521893][ T44] Call Trace: [ 861.522036][ T44] [ 861.522170][ T44] __schedule+0xae2/0x1720 [ 861.522343][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.522547][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.522726][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.522924][ T44] schedule+0xd4/0x260 [ 861.523064][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.523250][ T44] __mutex_lock+0xd76/0x1f20 [ 861.523420][ T44] ? addrconf_verify_work+0x12/0x30 [ 861.523617][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.523796][ T44] ? process_one_work+0xd16/0x1390 [ 861.523993][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.524156][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.524340][ T44] ? addrconf_verify_work+0x12/0x30 [ 861.524528][ T44] addrconf_verify_work+0x12/0x30 [ 861.524696][ T44] process_one_work+0xd57/0x1390 [ 861.524889][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.525050][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.525239][ T44] ? assign_work+0x152/0x380 [ 861.525402][ T44] worker_thread+0x4d6/0xd40 [ 861.525594][ T44] ? process_one_work+0x1390/0x1390 [ 861.525763][ T44] kthread+0x355/0x5b0 [ 861.525924][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.526086][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.526268][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.526459][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.526624][ T44] ret_from_fork+0x3fb/0x510 [ 861.526815][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 861.527030][ T44] ? __switch_to+0x53c/0xd00 [ 861.527190][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.527372][ T44] ret_from_fork_asm+0x11/0x20 [ 861.527569][ T44] [ 861.527712][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5309. [ 861.527989][ T44] INFO: task kworker/0:2:61 blocked for more than 122 seconds. [ 861.528219][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 861.528371][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.528629][ T44] task:kworker/0:2 state:D stack:28768 pid:61 tgid:61 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.528953][ T44] Workqueue: events xp_release_deferred [ 861.529116][ T44] Call Trace: [ 861.529268][ T44] [ 861.529374][ T44] __schedule+0xae2/0x1720 [ 861.529568][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.529738][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.529928][ T44] schedule+0xd4/0x260 [ 861.530063][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.530248][ T44] __mutex_lock+0xd76/0x1f20 [ 861.530409][ T44] ? look_up_lock_class+0x55/0x120 [ 861.530599][ T44] ? xp_release_deferred+0x1b/0x1e0 [ 861.530765][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.530956][ T44] ? __lock_acquire+0x577/0xc10 [ 861.531119][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.531298][ T44] ? process_one_work+0xd16/0x1390 [ 861.531493][ T44] ? xp_release_deferred+0x1b/0x1e0 [ 861.531655][ T44] xp_release_deferred+0x1b/0x1e0 [ 861.531850][ T44] process_one_work+0xd57/0x1390 [ 861.532016][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.532200][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.532364][ T44] ? assign_work+0x152/0x380 [ 861.532554][ T44] worker_thread+0x4d6/0xd40 [ 861.532725][ T44] ? process_one_work+0x1390/0x1390 [ 861.532915][ T44] ? __kthread_parkme+0xb3/0x200 [ 861.533080][ T44] ? process_one_work+0x1390/0x1390 [ 861.533262][ T44] kthread+0x355/0x5b0 [ 861.533397][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.533582][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.533753][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.533941][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.534107][ T44] ret_from_fork+0x3fb/0x510 [ 861.534289][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 861.534507][ T44] ? __switch_to+0x53c/0xd00 [ 861.534675][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.534863][ T44] ret_from_fork_asm+0x11/0x20 [ 861.535032][ T44] [ 861.535194][ T44] INFO: task kworker/0:2:61 is blocked on a mutex likely owned by task ip:5309. [ 861.535472][ T44] INFO: task ip:5309 blocked for more than 245 seconds. [ 861.535649][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 861.535837][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.536087][ T44] task:ip state:D stack:25024 pid:5309 tgid:5309 ppid:1 task_flags:0x400100 flags:0x00080002 [ 861.536401][ T44] Call Trace: [ 861.536562][ T44] [ 861.536675][ T44] __schedule+0xae2/0x1720 [ 861.536864][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.537026][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.537208][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.537372][ T44] schedule+0xd4/0x260 [ 861.537532][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.537706][ T44] __mutex_lock+0xd76/0x1f20 [ 861.537898][ T44] ? napi_enable+0x3b/0x80 [ 861.538060][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.538244][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.538407][ T44] ? __asan_memset+0x27/0x50 [ 861.538602][ T44] ? sg_init_table+0x19/0x60 [ 861.538770][ T44] ? try_fill_recv+0x3ec/0x1750 [ 861.538961][ T44] ? napi_enable+0x3b/0x80 [ 861.539126][ T44] napi_enable+0x3b/0x80 [ 861.539282][ T44] __virtnet_rx_resume+0x156/0x290 [ 861.539470][ T44] ? queue_delayed_work_on+0x91/0x100 [ 861.539633][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 861.539822][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 861.539989][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 861.540174][ T44] dev_xdp_install+0x3e4/0x890 [ 861.540341][ T44] ? netif_set_xps_queue+0x40/0x40 [ 861.540536][ T44] dev_xdp_attach+0x50d/0x1310 [ 861.540709][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 861.540896][ T44] ? __bpf_prog_get+0x320/0x320 [ 861.541060][ T44] dev_change_xdp_fd+0x176/0x210 [ 861.541243][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 861.541408][ T44] ? rtnl_newlink_create+0x900/0x900 [ 861.541602][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 861.541819][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 861.541980][ T44] ? validate_chain+0x37b/0xb70 [ 861.542164][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 861.542324][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 861.542513][ T44] ? __lock_acquire+0x577/0xc10 [ 861.542682][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.542877][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 861.543038][ T44] ? lock_acquire+0x10a/0x150 [ 861.543219][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.543381][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.543570][ T44] ? trace_contention_end+0xd6/0x110 [ 861.543736][ T44] ? __mutex_lock+0x285/0x1f20 [ 861.543924][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 861.544085][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.544270][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 861.544464][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 861.544629][ T44] rtnl_newlink+0x75c/0xe90 [ 861.544822][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.544985][ T44] ? rtnl_setlink+0x880/0x880 [ 861.545170][ T44] ? __lock_acquire+0x577/0xc10 [ 861.545336][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.545528][ T44] ? find_held_lock+0x2b/0x80 [ 861.545700][ T44] ? rtnl_setlink+0x880/0x880 [ 861.545889][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.546051][ T44] ? rtnl_setlink+0x880/0x880 [ 861.546236][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 861.546405][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 861.546596][ T44] ? __lock_acquire+0x577/0xc10 [ 861.546768][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.546959][ T44] ? find_held_lock+0x2b/0x80 [ 861.547123][ T44] netlink_rcv_skb+0x123/0x380 [ 861.547304][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 861.547492][ T44] ? netlink_ack+0xcc0/0xcc0 [ 861.547658][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 861.547849][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 861.548012][ T44] netlink_unicast+0x4a3/0x770 [ 861.548197][ T44] ? netlink_attachskb+0x810/0x810 [ 861.548361][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.548551][ T44] ? __lock_acquire+0x577/0xc10 [ 861.548723][ T44] netlink_sendmsg+0x735/0xc60 [ 861.548914][ T44] ? netlink_unicast+0x770/0x770 [ 861.549079][ T44] ____sys_sendmsg+0x419/0x850 [ 861.549264][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 861.549425][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 861.549643][ T44] ? move_addr_to_kernel+0x40/0x40 [ 861.549840][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 861.550000][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 861.550186][ T44] ___sys_sendmsg+0xfd/0x180 [ 861.550348][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 861.550565][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 861.550750][ T44] __sys_sendmsg+0x124/0x1c0 [ 861.550937][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 861.551121][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 861.551283][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 861.551500][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 861.551662][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.551857][ T44] do_syscall_64+0xbd/0xfc0 [ 861.552021][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 861.552238][ T44] RIP: 0033:0x7f7e26967c5e [ 861.552406][ T44] RSP: 002b:00007ffeaece10c0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 861.552654][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7e26967c5e [ 861.552902][ T44] RDX: 0000000000000000 RSI: 00007ffeaece1180 RDI: 0000000000000003 [ 861.553141][ T44] RBP: 00007ffeaece10d0 R08: 0000000000000000 R09: 0000000000000000 [ 861.553382][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffeaece1840 [ 861.553621][ T44] R13: 00000000695b753c R14: 0000000000000000 R15: 0000000000499600 [ 861.553874][ T44] [ 861.554012][ T44] INFO: task ip:5309 is blocked on a mutex likely owned by task kworker/2:2:67. [ 861.554272][ T44] task:kworker/2:2 state:D stack:28784 pid:67 tgid:67 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 861.554593][ T44] Workqueue: events refill_work [ 861.554761][ T44] Call Trace: [ 861.554917][ T44] [ 861.555024][ T44] __schedule+0xae2/0x1720 [ 861.555212][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.555379][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.555576][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.555741][ T44] ? usleep_range_state+0xba/0x1b0 [ 861.555925][ T44] schedule+0xd4/0x260 [ 861.556060][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 861.556272][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 861.556462][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 861.556624][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 861.556817][ T44] ? ktime_get+0x15e/0x220 [ 861.556977][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 861.557159][ T44] ? ktime_get+0xa9/0x220 [ 861.557295][ T44] usleep_range_state+0x133/0x1b0 [ 861.557487][ T44] ? schedule_hrtimeout+0x20/0x20 [ 861.557651][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 861.557845][ T44] ? refill_work+0x149/0x210 [ 861.558016][ T44] napi_disable_locked+0x379/0x5f0 [ 861.558205][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 861.558368][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 861.558585][ T44] napi_disable+0x43/0x80 [ 861.558726][ T44] refill_work+0x116/0x210 [ 861.558916][ T44] process_one_work+0xd57/0x1390 [ 861.559082][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 861.559277][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.559468][ T44] ? assign_work+0x152/0x380 [ 861.559724][ T44] worker_thread+0x4d6/0xd40 [ 861.559896][ T44] ? process_one_work+0x1390/0x1390 [ 861.560082][ T44] kthread+0x355/0x5b0 [ 861.560217][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.560467][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.560649][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.560819][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.561007][ T44] ret_from_fork+0x3fb/0x510 [ 861.561171][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 861.561453][ T44] ? __switch_to+0x53c/0xd00 [ 861.561615][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 861.561806][ T44] ret_from_fork_asm+0x11/0x20 [ 861.562053][ T44] [ 861.562190][ T44] INFO: task ip:5374 blocked for more than 122 seconds. [ 861.562391][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 861.562571][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 861.562879][ T44] task:ip state:D stack:25624 pid:5374 tgid:5374 ppid:5373 task_flags:0x400100 flags:0x00080000 [ 861.563196][ T44] Call Trace: [ 861.563332][ T44] [ 861.563524][ T44] __schedule+0xae2/0x1720 [ 861.563696][ T44] ? io_schedule_timeout+0x130/0x130 [ 861.563889][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.564050][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.564288][ T44] schedule+0xd4/0x260 [ 861.564424][ T44] schedule_preempt_disabled+0x18/0x30 [ 861.564611][ T44] __mutex_lock+0xd76/0x1f20 [ 861.564807][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.565048][ T44] ? rtnetlink_rcv_msg+0x2ab/0xb90 [ 861.565209][ T44] ? write_profile+0xf0/0xf0 [ 861.565393][ T44] ? ww_mutex_lock+0x160/0x160 [ 861.565584][ T44] ? find_held_lock+0x2b/0x80 [ 861.565837][ T44] ? __lock_release.isra.0+0x59/0x170 [ 861.566001][ T44] ? rtnetlink_rcv_msg+0x2ab/0xb90 [ 861.566190][ T44] rtnetlink_rcv_msg+0x2ab/0xb90 [ 861.566353][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 861.566596][ T44] ? __lock_acquire+0x577/0xc10 [ 861.566768][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 861.566954][ T44] ? find_held_lock+0x2b/0x80 [ 861.567119][ T44] netlink_rcv_skb+0x123/0x380 [ 861.567356][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 861.567546][ T44] ? netlink_ack+0xcc0/0xcc0 [ 861.567718][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 861.567905][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 861.568147][ T44] netlink_unicast+0x4a3/0x770 [ 861.568310][ T44] ? netlink_attachskb+0x810/0x810 [ 861.568498][ T44] ? __lock_acquire+0x577/0xc10 [ 861.568672][ T44] netlink_sendmsg+0x735/0xc60 [ 861.568919][ T44] ? netlink_unicast+0x770/0x770 [ 861.569089][ T44] ____sys_sendmsg+0x419/0x850 [ 861.569276][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 861.569463][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 861.569734][ T44] ? move_addr_to_kernel+0x40/0x40 [ 861.569896][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 861.570080][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 861.570291][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 861.570535][ T44] ___sys_sendmsg+0xfd/0x180 [ 861.570704][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 861.570893][ T44] ? __lock_acquire+0x577/0xc10 [ 861.571057][ T44] ? find_held_lock+0x2b/0x80 [ 861.571301][ T44] ? move_addr_to_user+0x43/0x60 [ 861.571489][ T44] ? do_getsockname+0xcd/0x150 [ 861.571654][ T44] __sys_sendmsg+0x124/0x1c0 [ 861.571852][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 861.572099][ T44] ? __sys_getsockname+0x91/0xf0 [ 861.572262][ T44] ? rcu_is_watching+0x15/0xd0 [ 861.572463][ T44] do_syscall_64+0xbd/0xfc0 [ 861.572627][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 861.572900][ T44] RIP: 0033:0x7f87c1550c5e [ 861.573067][ T44] RSP: 002b:00007ffddfa079b0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 861.573313][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f87c1550c5e [ 861.573616][ T44] RDX: 0000000000000000 RSI: 00007ffddfa07a70 RDI: 0000000000000004 [ 861.573865][ T44] RBP: 00007ffddfa079c0 R08: 0000000000000000 R09: 0000000000000000 [ 861.574154][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffddfa0968d [ 861.574383][ T44] R13: 00000000695b760c R14: 000000000000000d R15: 00007ffddfa07b20 [ 861.574638][ T44] [ 861.574775][ T44] INFO: task ip:5374 is blocked on a mutex likely owned by task ip:5309. [ 861.575065][ T44] [ 861.575065][ T44] Showing all locks held in the system: [ 861.575295][ T44] 3 locks held by kworker/u16:0/12: [ 861.575553][ T44] #0: ff11000009127148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 861.575853][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 861.576200][ T44] #2: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 861.576479][ T44] 1 lock held by khungtaskd/44: [ 861.576718][ T44] #0: ffffffffaad710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 861.577017][ T44] 3 locks held by kworker/0:2/61: [ 861.577172][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 861.577517][ T44] #1: ffa000000041fcc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 861.577811][ T44] #2: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 861.578132][ T44] 3 locks held by kworker/2:2/67: [ 861.578288][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 861.578633][ T44] #1: ffa0000000487cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 861.578952][ T44] #2: ff11000008af2c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 861.579274][ T44] 2 locks held by ip/5309: [ 861.579455][ T44] #0: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 861.579722][ T44] #1: ff11000008af2c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 861.580042][ T44] 1 lock held by ip/5374: [ 861.580172][ T44] #0: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg+0x2ab/0xb90 [ 861.580459][ T44] [ 861.580559][ T44] ============================================= [ 861.580559][ T44] [ 865.103433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 171519 ms [ 865.103824][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 171519000 usecs ago [ 870.223435][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 176639 ms [ 870.223835][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 176639000 usecs ago [ 875.343436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 181759 ms [ 875.343835][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 181759000 usecs ago [ 881.487439][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 187903 ms [ 881.487837][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 187903000 usecs ago [ 887.119434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 193535 ms [ 887.119824][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 193535000 usecs ago [ 892.239437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 198655 ms [ 892.239838][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 198655000 usecs ago [ 897.359436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 203775 ms [ 897.359832][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 203775000 usecs ago [ 903.503434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 209919 ms [ 903.503845][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 209919000 usecs ago [ 909.135436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 215551 ms [ 909.135870][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 215551000 usecs ago [ 914.255437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 220671 ms [ 914.255847][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 220671000 usecs ago [ 919.375432][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 225791 ms [ 919.375831][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 225791000 usecs ago [ 925.519436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 231935 ms [ 925.519828][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 231935000 usecs ago [ 931.151436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 237567 ms [ 931.151845][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 237567000 usecs ago [ 936.271433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 242687 ms [ 936.271837][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 242687000 usecs ago [ 941.391434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 247807 ms [ 941.391857][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 247807000 usecs ago [ 947.535441][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 253951 ms [ 947.535851][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 253951000 usecs ago [ 953.167439][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 259583 ms [ 953.167838][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 259583000 usecs ago [ 958.287436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 264703 ms [ 958.287845][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 264703000 usecs ago [ 963.407439][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 269823 ms [ 963.407837][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 269823000 usecs ago [ 969.551436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 275967 ms [ 969.551852][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 275967000 usecs ago [ 975.183434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 281599 ms [ 975.183831][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 281599000 usecs ago [ 980.303436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 286719 ms [ 980.303820][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 286719000 usecs ago [ 984.400443][ T44] INFO: task kworker/u16:0:12 blocked for more than 368 seconds. [ 984.400741][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 984.400967][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.401241][ T44] task:kworker/u16:0 state:D stack:26432 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.401597][ T44] Workqueue: ipv6_addrconf addrconf_verify_work [ 984.401824][ T44] Call Trace: [ 984.401975][ T44] [ 984.402113][ T44] __schedule+0xae2/0x1720 [ 984.402298][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.402519][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.402687][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.402887][ T44] schedule+0xd4/0x260 [ 984.403028][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.403222][ T44] __mutex_lock+0xd76/0x1f20 [ 984.403392][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.403593][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.403763][ T44] ? process_one_work+0xd16/0x1390 [ 984.403960][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.404123][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.404309][ T44] ? addrconf_verify_work+0x12/0x30 [ 984.404496][ T44] addrconf_verify_work+0x12/0x30 [ 984.404660][ T44] process_one_work+0xd57/0x1390 [ 984.404850][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.405014][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.405204][ T44] ? assign_work+0x152/0x380 [ 984.405369][ T44] worker_thread+0x4d6/0xd40 [ 984.405565][ T44] ? process_one_work+0x1390/0x1390 [ 984.405726][ T44] kthread+0x355/0x5b0 [ 984.405889][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.406057][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.406243][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.406406][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.406600][ T44] ret_from_fork+0x3fb/0x510 [ 984.406764][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.406984][ T44] ? __switch_to+0x53c/0xd00 [ 984.407148][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.407332][ T44] ret_from_fork_asm+0x11/0x20 [ 984.407529][ T44] [ 984.407666][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5309. [ 984.407938][ T44] INFO: task kworker/0:2:61 blocked for more than 245 seconds. [ 984.408169][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 984.408319][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.408581][ T44] task:kworker/0:2 state:D stack:28768 pid:61 tgid:61 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.408907][ T44] Workqueue: events xp_release_deferred [ 984.409069][ T44] Call Trace: [ 984.409223][ T44] [ 984.409329][ T44] __schedule+0xae2/0x1720 [ 984.409524][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.409687][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.409883][ T44] schedule+0xd4/0x260 [ 984.410019][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.410206][ T44] __mutex_lock+0xd76/0x1f20 [ 984.410370][ T44] ? look_up_lock_class+0x55/0x120 [ 984.410559][ T44] ? xp_release_deferred+0x1b/0x1e0 [ 984.410722][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.410914][ T44] ? __lock_acquire+0x577/0xc10 [ 984.411081][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.411263][ T44] ? process_one_work+0xd16/0x1390 [ 984.411454][ T44] ? xp_release_deferred+0x1b/0x1e0 [ 984.411616][ T44] xp_release_deferred+0x1b/0x1e0 [ 984.411802][ T44] process_one_work+0xd57/0x1390 [ 984.411976][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.412163][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.412332][ T44] ? assign_work+0x152/0x380 [ 984.412525][ T44] worker_thread+0x4d6/0xd40 [ 984.412691][ T44] ? process_one_work+0x1390/0x1390 [ 984.412884][ T44] ? __kthread_parkme+0xb3/0x200 [ 984.413049][ T44] ? process_one_work+0x1390/0x1390 [ 984.413236][ T44] kthread+0x355/0x5b0 [ 984.413370][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.413566][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.413729][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.413920][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.414085][ T44] ret_from_fork+0x3fb/0x510 [ 984.414269][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.414489][ T44] ? __switch_to+0x53c/0xd00 [ 984.414652][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.414838][ T44] ret_from_fork_asm+0x11/0x20 [ 984.415014][ T44] [ 984.415176][ T44] INFO: task kworker/0:2:61 is blocked on a mutex likely owned by task ip:5309. [ 984.415450][ T44] INFO: task ip:5309 blocked for more than 368 seconds. [ 984.415653][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 984.415807][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.416076][ T44] task:ip state:D stack:25024 pid:5309 tgid:5309 ppid:1 task_flags:0x400100 flags:0x00080002 [ 984.416391][ T44] Call Trace: [ 984.416551][ T44] [ 984.416657][ T44] __schedule+0xae2/0x1720 [ 984.416848][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.417015][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.417202][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.417370][ T44] schedule+0xd4/0x260 [ 984.417536][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.417698][ T44] __mutex_lock+0xd76/0x1f20 [ 984.417892][ T44] ? napi_enable+0x3b/0x80 [ 984.418057][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.418241][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.418403][ T44] ? __asan_memset+0x27/0x50 [ 984.418598][ T44] ? sg_init_table+0x19/0x60 [ 984.418763][ T44] ? try_fill_recv+0x3ec/0x1750 [ 984.418958][ T44] ? napi_enable+0x3b/0x80 [ 984.419120][ T44] napi_enable+0x3b/0x80 [ 984.419277][ T44] __virtnet_rx_resume+0x156/0x290 [ 984.419465][ T44] ? queue_delayed_work_on+0x91/0x100 [ 984.419627][ T44] virtnet_rx_resume_all+0xe7/0x1a0 [ 984.419815][ T44] virtnet_xdp_set+0xef7/0x1aa0 [ 984.419991][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0 [ 984.420182][ T44] dev_xdp_install+0x3e4/0x890 [ 984.420348][ T44] ? netif_set_xps_queue+0x40/0x40 [ 984.420541][ T44] dev_xdp_attach+0x50d/0x1310 [ 984.420706][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0 [ 984.420899][ T44] ? __bpf_prog_get+0x320/0x320 [ 984.421064][ T44] dev_change_xdp_fd+0x176/0x210 [ 984.421253][ T44] do_setlink.isra.0+0x1c2d/0x2880 [ 984.421417][ T44] ? rtnl_newlink_create+0x900/0x900 [ 984.421609][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 984.421824][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.421993][ T44] ? validate_chain+0x37b/0xb70 [ 984.422185][ T44] ? rcu_read_lock_any_held+0x66/0x90 [ 984.422347][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.422538][ T44] ? __lock_acquire+0x577/0xc10 [ 984.422703][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.422898][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.423060][ T44] ? lock_acquire+0x10a/0x150 [ 984.423239][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.423401][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.423590][ T44] ? trace_contention_end+0xd6/0x110 [ 984.423756][ T44] ? __mutex_lock+0x285/0x1f20 [ 984.423947][ T44] ? rtnl_newlink+0x6fc/0xe90 [ 984.424111][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.424293][ T44] ? nla_get_range_signed+0x3d0/0x3d0 [ 984.424490][ T44] ? __rtnl_newlink+0x3fa/0xa40 [ 984.424657][ T44] rtnl_newlink+0x75c/0xe90 [ 984.424846][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.425011][ T44] ? rtnl_setlink+0x880/0x880 [ 984.425202][ T44] ? __lock_acquire+0x577/0xc10 [ 984.425366][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.425557][ T44] ? find_held_lock+0x2b/0x80 [ 984.425722][ T44] ? rtnl_setlink+0x880/0x880 [ 984.425910][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.426074][ T44] ? rtnl_setlink+0x880/0x880 [ 984.426255][ T44] rtnetlink_rcv_msg+0x6fe/0xb90 [ 984.426424][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.426613][ T44] ? __lock_acquire+0x577/0xc10 [ 984.426800][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.426968][ T44] ? find_held_lock+0x2b/0x80 [ 984.427158][ T44] netlink_rcv_skb+0x123/0x380 [ 984.427320][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.427509][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.427677][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 984.427867][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.428038][ T44] netlink_unicast+0x4a3/0x770 [ 984.428232][ T44] ? netlink_attachskb+0x810/0x810 [ 984.428394][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.428582][ T44] ? __lock_acquire+0x577/0xc10 [ 984.428745][ T44] netlink_sendmsg+0x735/0xc60 [ 984.428935][ T44] ? netlink_unicast+0x770/0x770 [ 984.429105][ T44] ____sys_sendmsg+0x419/0x850 [ 984.429290][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.429483][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.429670][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.429856][ T44] ? stack_depot_save_flags+0x3f1/0x6f0 [ 984.430046][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.430209][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.430395][ T44] ? __call_rcu_common.constprop.0+0xa6/0xa00 [ 984.430611][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.430786][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.430980][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.431141][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.431320][ T44] ? __call_rcu_common.constprop.0+0x3bd/0xa00 [ 984.431541][ T44] ? do_raw_spin_unlock+0x59/0x250 [ 984.431710][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.431902][ T44] do_syscall_64+0xbd/0xfc0 [ 984.432066][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.432273][ T44] RIP: 0033:0x7f7e26967c5e [ 984.432467][ T44] RSP: 002b:00007ffeaece10c0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.432710][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f7e26967c5e [ 984.432958][ T44] RDX: 0000000000000000 RSI: 00007ffeaece1180 RDI: 0000000000000003 [ 984.433199][ T44] RBP: 00007ffeaece10d0 R08: 0000000000000000 R09: 0000000000000000 [ 984.433447][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffeaece1840 [ 984.433686][ T44] R13: 00000000695b753c R14: 0000000000000000 R15: 0000000000499600 [ 984.433938][ T44] [ 984.434073][ T44] INFO: task ip:5309 is blocked on a mutex likely owned by task kworker/2:2:67. [ 984.434328][ T44] task:kworker/2:2 state:D stack:28784 pid:67 tgid:67 ppid:2 task_flags:0x4208060 flags:0x00080000 [ 984.434650][ T44] Workqueue: events refill_work [ 984.434809][ T44] Call Trace: [ 984.434968][ T44] [ 984.435074][ T44] __schedule+0xae2/0x1720 [ 984.435260][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.435422][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.435624][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.435786][ T44] ? usleep_range_state+0xba/0x1b0 [ 984.435972][ T44] schedule+0xd4/0x260 [ 984.436110][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0 [ 984.436325][ T44] ? schedule_timeout_idle+0xe0/0xe0 [ 984.436514][ T44] ? __hrtimer_cb_get_time+0x50/0x50 [ 984.436677][ T44] ? lockdep_hardirqs_on+0x84/0x130 [ 984.436860][ T44] ? ktime_get+0x15e/0x220 [ 984.437027][ T44] ? kvm_clock_get_cycles+0x18/0x30 [ 984.437216][ T44] ? ktime_get+0xa9/0x220 [ 984.437351][ T44] usleep_range_state+0x133/0x1b0 [ 984.437547][ T44] ? schedule_hrtimeout+0x20/0x20 [ 984.437708][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0 [ 984.437896][ T44] ? refill_work+0x149/0x210 [ 984.438060][ T44] napi_disable_locked+0x379/0x5f0 [ 984.438239][ T44] ? _mutex_trylock_nest_lock+0x340/0x340 [ 984.438405][ T44] ? register_netdevice_notifier_net+0x40/0x40 [ 984.438625][ T44] napi_disable+0x43/0x80 [ 984.438773][ T44] refill_work+0x116/0x210 [ 984.438968][ T44] process_one_work+0xd57/0x1390 [ 984.439132][ T44] ? pwq_dec_nr_in_flight+0x700/0x700 [ 984.439314][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.439505][ T44] ? assign_work+0x152/0x380 [ 984.439750][ T44] worker_thread+0x4d6/0xd40 [ 984.439921][ T44] ? process_one_work+0x1390/0x1390 [ 984.440108][ T44] kthread+0x355/0x5b0 [ 984.440244][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.440491][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.440671][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.440835][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.441027][ T44] ret_from_fork+0x3fb/0x510 [ 984.441190][ T44] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 984.441471][ T44] ? __switch_to+0x53c/0xd00 [ 984.441636][ T44] ? kthread_is_per_cpu+0xe0/0xe0 [ 984.441820][ T44] ret_from_fork_asm+0x11/0x20 [ 984.442073][ T44] [ 984.442212][ T44] INFO: task ip:5374 blocked for more than 245 seconds. [ 984.442412][ T44] Not tainted 6.19.0-rc3-virtme #1 [ 984.442591][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 984.442897][ T44] task:ip state:D stack:25624 pid:5374 tgid:5374 ppid:5373 task_flags:0x400100 flags:0x00080000 [ 984.443215][ T44] Call Trace: [ 984.443348][ T44] [ 984.443538][ T44] __schedule+0xae2/0x1720 [ 984.443703][ T44] ? io_schedule_timeout+0x130/0x130 [ 984.443894][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.444055][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.444296][ T44] schedule+0xd4/0x260 [ 984.444455][ T44] schedule_preempt_disabled+0x18/0x30 [ 984.444618][ T44] __mutex_lock+0xd76/0x1f20 [ 984.444801][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.445050][ T44] ? rtnetlink_rcv_msg+0x2ab/0xb90 [ 984.445210][ T44] ? write_profile+0xf0/0xf0 [ 984.445392][ T44] ? ww_mutex_lock+0x160/0x160 [ 984.445585][ T44] ? find_held_lock+0x2b/0x80 [ 984.445830][ T44] ? __lock_release.isra.0+0x59/0x170 [ 984.445999][ T44] ? rtnetlink_rcv_msg+0x2ab/0xb90 [ 984.446185][ T44] rtnetlink_rcv_msg+0x2ab/0xb90 [ 984.446349][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.446592][ T44] ? __lock_acquire+0x577/0xc10 [ 984.446755][ T44] ? lock_acquire.part.0+0xbc/0x260 [ 984.446941][ T44] ? find_held_lock+0x2b/0x80 [ 984.447110][ T44] netlink_rcv_skb+0x123/0x380 [ 984.447349][ T44] ? rtnl_fdb_dump+0x620/0x620 [ 984.447539][ T44] ? netlink_ack+0xcc0/0xcc0 [ 984.447706][ T44] ? netlink_deliver_tap+0xc5/0x330 [ 984.447899][ T44] ? netlink_deliver_tap+0x13f/0x330 [ 984.448142][ T44] netlink_unicast+0x4a3/0x770 [ 984.448307][ T44] ? netlink_attachskb+0x810/0x810 [ 984.448502][ T44] ? __lock_acquire+0x577/0xc10 [ 984.448665][ T44] netlink_sendmsg+0x735/0xc60 [ 984.448913][ T44] ? netlink_unicast+0x770/0x770 [ 984.449080][ T44] ____sys_sendmsg+0x419/0x850 [ 984.449264][ T44] ? copy_msghdr_from_user+0x270/0x430 [ 984.449425][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0 [ 984.449718][ T44] ? move_addr_to_kernel+0x40/0x40 [ 984.449886][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.450078][ T44] ? rcu_lockdep_current_cpu_online+0x39/0x1b0 [ 984.450289][ T44] ? rcu_read_lock_any_held+0x3c/0x90 [ 984.450530][ T44] ___sys_sendmsg+0xfd/0x180 [ 984.450696][ T44] ? copy_msghdr_from_user+0x430/0x430 [ 984.450893][ T44] ? __lock_acquire+0x577/0xc10 [ 984.451059][ T44] ? find_held_lock+0x2b/0x80 [ 984.451306][ T44] ? move_addr_to_user+0x43/0x60 [ 984.451506][ T44] ? do_getsockname+0xcd/0x150 [ 984.451672][ T44] __sys_sendmsg+0x124/0x1c0 [ 984.451855][ T44] ? __sys_sendmsg_sock+0x20/0x20 [ 984.452108][ T44] ? __sys_getsockname+0x91/0xf0 [ 984.452274][ T44] ? rcu_is_watching+0x15/0xd0 [ 984.452472][ T44] do_syscall_64+0xbd/0xfc0 [ 984.452636][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 984.452910][ T44] RIP: 0033:0x7f87c1550c5e [ 984.453078][ T44] RSP: 002b:00007ffddfa079b0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 984.453320][ T44] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f87c1550c5e [ 984.453622][ T44] RDX: 0000000000000000 RSI: 00007ffddfa07a70 RDI: 0000000000000004 [ 984.453861][ T44] RBP: 00007ffddfa079c0 R08: 0000000000000000 R09: 0000000000000000 [ 984.454152][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffddfa0968d [ 984.454385][ T44] R13: 00000000695b760c R14: 000000000000000d R15: 00007ffddfa07b20 [ 984.454634][ T44] [ 984.454771][ T44] INFO: task ip:5374 is blocked on a mutex likely owned by task ip:5309. [ 984.455062][ T44] Future hung task reports are suppressed, see sysctl kernel.hung_task_warnings [ 984.455321][ T44] [ 984.455321][ T44] Showing all locks held in the system: [ 984.455688][ T44] 3 locks held by kworker/u16:0/12: [ 984.455865][ T44] #0: ff11000009127148 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.456160][ T44] #1: ffa00000000c7cc0 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.456512][ T44] #2: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30 [ 984.456781][ T44] 1 lock held by khungtaskd/44: [ 984.456943][ T44] #0: ffffffffaad710c0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire.constprop.0+0x7/0x30 [ 984.457286][ T44] 3 locks held by kworker/0:2/61: [ 984.457472][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.457765][ T44] #1: ffa000000041fcc0 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.458118][ T44] #2: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0 [ 984.458381][ T44] 3 locks held by kworker/2:2/67: [ 984.458620][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390 [ 984.458919][ T44] #1: ffa0000000487cc0 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390 [ 984.459285][ T44] #2: ff11000008af2c98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80 [ 984.459661][ T44] 2 locks held by ip/5309: [ 984.459838][ T44] #0: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x6fc/0xe90 [ 984.460113][ T44] #1: ff11000008af2c98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80 [ 984.460377][ T44] 1 lock held by ip/5374: [ 984.460533][ T44] #0: ffffffffab4859a8 (rtnl_mutex){+.+.}-{4:4}, at: rtnetlink_rcv_msg+0x2ab/0xb90 [ 984.460798][ T44] [ 984.460905][ T44] ============================================= [ 984.460905][ T44] [ 985.423436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 291839 ms [ 985.423840][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 291839000 usecs ago [ 991.567433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 297983 ms [ 991.567823][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 297983000 usecs ago [ 997.199437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 303615 ms [ 997.199829][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 303615000 usecs ago [ 1002.319436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 308735 ms [ 1002.319840][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 308735000 usecs ago [ 1007.439433][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 313855 ms [ 1007.439819][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 313855000 usecs ago [ 1013.583436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 319999 ms [ 1013.583826][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 319999000 usecs ago [ 1019.215436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 325631 ms [ 1019.215831][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 325631000 usecs ago [ 1024.335436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 330751 ms [ 1024.335838][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 330751000 usecs ago [ 1030.479436][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 336895 ms [ 1030.479826][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 336895000 usecs ago [ 1036.111437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 342527 ms [ 1036.111838][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 342527000 usecs ago [ 1041.231437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 347647 ms [ 1041.231846][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 347647000 usecs ago [ 1046.351434][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 352767 ms [ 1046.351829][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 352767000 usecs ago [ 1052.495437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 358911 ms [ 1052.495849][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 358911000 usecs ago [ 1058.127437][ C0] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 0: transmit queue 1 timed out 364543 ms [ 1058.127844][ C0] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 364543000 usecs ago