[ 852.304941][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 329728 ms
[ 852.305371][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 329728000 usecs ago
[ 857.424937][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 334848 ms
[ 857.425400][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 334848000 usecs ago
[ 861.520946][ T44] INFO: task kworker/u16:0:12 blocked for more than 245 seconds.
[ 861.521319][ T44] Not tainted 6.18.0-rc6-virtme #1
[ 861.521523][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.521847][ T44] task:kworker/u16:0 state:D stack:26816 pid:12 tgid:12 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.522237][ T44] Workqueue: ipv6_addrconf addrconf_verify_work
[ 861.522461][ T44] Call Trace:
[ 861.522620][ T44]
[ 861.522744][ T44] __schedule+0x88d/0x1b90
[ 861.522957][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.523141][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.523318][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.523492][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.523669][ T44] schedule+0xd4/0x260
[ 861.523815][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.524029][ T44] __mutex_lock+0x9ae/0x1500
[ 861.524205][ T44] ? addrconf_verify_work+0x12/0x30
[ 861.524386][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.524564][ T44] ? process_one_work+0xd16/0x1390
[ 861.524735][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.524907][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.525098][ T44] ? addrconf_verify_work+0x12/0x30
[ 861.525266][ T44] addrconf_verify_work+0x12/0x30
[ 861.525438][ T44] process_one_work+0xd57/0x1390
[ 861.525611][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.525786][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.525983][ T44] ? assign_work+0x152/0x380
[ 861.526155][ T44] worker_thread+0x4d6/0xd40
[ 861.526329][ T44] ? process_one_work+0x1390/0x1390
[ 861.526499][ T44] kthread+0x355/0x5b0
[ 861.526642][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.526811][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.527011][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.527182][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.527354][ T44] ret_from_fork+0x1d4/0x270
[ 861.527524][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.527692][ T44] ret_from_fork_asm+0x11/0x20
[ 861.527874][ T44]
[ 861.528066][ T44] INFO: task kworker/u16:0:12 is blocked on a mutex likely owned by task ip:5150.
[ 861.528333][ T44] INFO: task ip:5150 blocked for more than 368 seconds.
[ 861.528522][ T44] Not tainted 6.18.0-rc6-virtme #1
[ 861.528683][ T44] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 861.528949][ T44] task:ip state:D stack:25496 pid:5150 tgid:5150 ppid:1 task_flags:0x400100 flags:0x00080003
[ 861.529253][ T44] Call Trace:
[ 861.529397][ T44]
[ 861.529508][ T44] __schedule+0x88d/0x1b90
[ 861.529681][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.529861][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.530044][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.530213][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.530384][ T44] schedule+0xd4/0x260
[ 861.530525][ T44] schedule_preempt_disabled+0x18/0x30
[ 861.530699][ T44] __mutex_lock+0x9ae/0x1500
[ 861.530877][ T44] ? napi_enable+0x3b/0x80
[ 861.531064][ T44] ? virtqueue_add_inbuf_ctx+0x1850/0x1850
[ 861.531262][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.531431][ T44] ? __asan_memset+0x27/0x50
[ 861.531602][ T44] ? sg_init_table+0x19/0x60
[ 861.531775][ T44] ? try_fill_recv+0x3ec/0x1750
[ 861.531992][ T44] ? napi_enable+0x3b/0x80
[ 861.532161][ T44] napi_enable+0x3b/0x80
[ 861.532304][ T44] __virtnet_rx_resume+0x156/0x290
[ 861.532472][ T44] ? queue_delayed_work_on+0x91/0x100
[ 861.532643][ T44] virtnet_rx_resume_all+0xe7/0x1a0
[ 861.532815][ T44] virtnet_xdp_set+0xef7/0x1aa0
[ 861.533012][ T44] ? virtnet_xdp_set+0x1aa0/0x1aa0
[ 861.533187][ T44] dev_xdp_install+0x3e4/0x8e0
[ 861.533357][ T44] ? netif_skb_check_for_xdp+0x600/0x600
[ 861.533531][ T44] dev_xdp_attach+0x50d/0x1320
[ 861.533704][ T44] ? bpf_xdp_link_update+0x6e0/0x6e0
[ 861.533882][ T44] ? __bpf_prog_get+0x320/0x320
[ 861.534070][ T44] dev_change_xdp_fd+0x182/0x240
[ 861.534244][ T44] do_setlink.isra.0+0x1c2d/0x2880
[ 861.534417][ T44] ? rtnl_newlink_create+0x900/0x900
[ 861.534591][ T44] ? rcu_lockdep_current_cpu_online+0x3e/0x1b0
[ 861.534790][ T44] ? rcu_read_lock_any_held+0x41/0xa0
[ 861.534981][ T44] ? validate_chain+0x287/0x5f0
[ 861.535152][ T44] ? rcu_read_lock_any_held+0x6b/0xa0
[ 861.535321][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 861.535491][ T44] ? __lock_acquire+0x34c/0x740
[ 861.535671][ T44] ? trace_lock_acquire+0x88/0xd0
[ 861.535846][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 861.536055][ T44] ? lock_acquire+0x31/0x80
[ 861.536225][ T44] ? rtnl_newlink+0x5df/0xb20
[ 861.536393][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.536561][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.536731][ T44] ? trace_contention_end+0xd6/0x140
[ 861.536909][ T44] ? rtnl_newlink+0x5df/0xb20
[ 861.537097][ T44] ? __mutex_lock+0x32e/0x1500
[ 861.537270][ T44] ? ww_mutex_lock+0x160/0x160
[ 861.537438][ T44] ? nla_validate_int_range+0x5b0/0x5b0
[ 861.537608][ T44] ? __rtnl_newlink+0x3fa/0xa40
[ 861.537782][ T44] rtnl_newlink+0x637/0xb20
[ 861.537980][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.538152][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.538322][ T44] ? find_held_lock+0x2b/0x80
[ 861.538498][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.538669][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.538847][ T44] ? __rtnl_newlink+0xa40/0xa40
[ 861.539032][ T44] rtnetlink_rcv_msg+0x6fe/0xb90
[ 861.539206][ T44] ? rtnl_port_fill+0x940/0x940
[ 861.539376][ T44] ? __lock_acquire+0x34c/0x740
[ 861.539546][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.539720][ T44] ? find_held_lock+0x2b/0x80
[ 861.539900][ T44] netlink_rcv_skb+0x123/0x380
[ 861.540098][ T44] ? rtnl_port_fill+0x940/0x940
[ 861.540268][ T44] ? netlink_ack+0xcc0/0xcc0
[ 861.540441][ T44] ? netlink_deliver_tap+0x13f/0x330
[ 861.540613][ T44] netlink_unicast+0x4a3/0x770
[ 861.540784][ T44] ? netlink_attachskb+0x810/0x810
[ 861.540986][ T44] ? __lock_acquire+0x34c/0x740
[ 861.541164][ T44] netlink_sendmsg+0x735/0xc60
[ 861.541336][ T44] ? netlink_unicast+0x770/0x770
[ 861.541508][ T44] ? __might_fault+0x97/0x140
[ 861.541682][ T44] ____sys_sendmsg+0x419/0x850
[ 861.541861][ T44] ? copy_msghdr_from_user+0x270/0x430
[ 861.542043][ T44] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 861.542243][ T44] ? move_addr_to_kernel+0x40/0x40
[ 861.542417][ T44] ? stack_depot_save_flags+0x3e1/0x6e0
[ 861.542585][ T44] ? validate_chain+0x287/0x5f0
[ 861.542755][ T44] ___sys_sendmsg+0xfd/0x180
[ 861.542947][ T44] ? __call_rcu_common.constprop.0+0xa5/0x680
[ 861.543145][ T44] ? copy_msghdr_from_user+0x430/0x430
[ 861.543329][ T44] __sys_sendmsg+0x124/0x1c0
[ 861.543499][ T44] ? __sys_sendmsg_sock+0x20/0x20
[ 861.543666][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.543844][ T44] ? __call_rcu_common.constprop.0+0x2fa/0x680
[ 861.544076][ T44] ? do_raw_spin_unlock+0x59/0x250
[ 861.544247][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.544419][ T44] do_syscall_64+0xbb/0xfd0
[ 861.544591][ T44] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 861.544789][ T44] RIP: 0033:0x7f6df3ea1c5e
[ 861.544985][ T44] RSP: 002b:00007fff8731ede0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 861.545215][ T44] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007f6df3ea1c5e
[ 861.545442][ T44] RDX: 0000000000000000 RSI: 00007fff8731eea0 RDI: 0000000000000003
[ 861.545663][ T44] RBP: 00007fff8731edf0 R08: 0000000000000000 R09: 0000000000000000
[ 861.545895][ T44] R10: 0000000000000000 R11: 0000000000000202 R12: 00007fff8731f560
[ 861.546136][ T44] R13: 00000000692567b8 R14: 0000000000000000 R15: 0000000000499600
[ 861.546369][ T44]
[ 861.546512][ T44] INFO: task ip:5150 is blocked on a mutex likely owned by task kworker/1:3:1419.
[ 861.546757][ T44] task:kworker/1:3 state:D stack:28424 pid:1419 tgid:1419 ppid:2 task_flags:0x4208060 flags:0x00080000
[ 861.547091][ T44] Workqueue: events refill_work
[ 861.547261][ T44] Call Trace:
[ 861.547400][ T44]
[ 861.547512][ T44] __schedule+0x88d/0x1b90
[ 861.547686][ T44] ? io_schedule_timeout+0x130/0x130
[ 861.547863][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.548066][ T44] ? find_held_lock+0x2b/0x80
[ 861.548238][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.548414][ T44] ? usleep_range_state+0xba/0x1b0
[ 861.548582][ T44] schedule+0xd4/0x260
[ 861.548724][ T44] schedule_hrtimeout_range_clock+0x1da/0x2f0
[ 861.548945][ T44] ? schedule_timeout_idle+0xe0/0xe0
[ 861.549112][ T44] ? hrtimer_cb_get_time+0x90/0x90
[ 861.549284][ T44] ? lockdep_hardirqs_on+0x84/0x130
[ 861.549453][ T44] ? ktime_get+0x15e/0x220
[ 861.549623][ T44] ? kvm_clock_get_cycles+0x18/0x30
[ 861.549791][ T44] ? ktime_get+0xa9/0x220
[ 861.549958][ T44] usleep_range_state+0x133/0x1b0
[ 861.550128][ T44] ? schedule_hrtimeout+0x20/0x20
[ 861.550295][ T44] ? perf_trace_sched_switch+0x6d0/0x6d0
[ 861.550466][ T44] napi_disable_locked+0x379/0x5f0
[ 861.550634][ T44] ? _mutex_trylock_nest_lock+0x150/0x150
[ 861.550821][ T44] ? netdev_bind_sb_channel_queue+0x470/0x470
[ 861.551046][ T44] napi_disable+0x43/0x80
[ 861.551187][ T44] refill_work+0x116/0x210
[ 861.551359][ T44] process_one_work+0xd57/0x1390
[ 861.551533][ T44] ? pwq_dec_nr_in_flight+0x700/0x700
[ 861.551702][ T44] ? lock_acquire.part.0+0xbc/0x260
[ 861.551881][ T44] ? assign_work+0x152/0x380
[ 861.552087][ T44] worker_thread+0x4d6/0xd40
[ 861.552260][ T44] ? process_one_work+0x1390/0x1390
[ 861.552431][ T44] ? __kthread_parkme+0xb3/0x200
[ 861.552604][ T44] ? process_one_work+0x1390/0x1390
[ 861.552774][ T44] kthread+0x355/0x5b0
[ 861.552926][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.553115][ T44] ? __lock_release.isra.0+0x59/0x170
[ 861.553287][ T44] ? rcu_is_watching+0x15/0xd0
[ 861.553457][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.553626][ T44] ret_from_fork+0x1d4/0x270
[ 861.553794][ T44] ? kthread_is_per_cpu+0xe0/0xe0
[ 861.553983][ T44] ret_from_fork_asm+0x11/0x20
[ 861.554160][ T44]
[ 861.554324][ T44]
[ 861.554324][ T44] Showing all locks held in the system:
[ 861.554543][ T44] 3 locks held by kworker/u16:0/12:
[ 861.554710][ T44] #0: ff11000009254d48 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.555212][ T44] #1: ffa00000000c7d30 ((work_completion)(&(&net->ipv6.addr_chk_work)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.555543][ T44] #2: ffffffff97892a28 (rtnl_mutex){+.+.}-{4:4}, at: addrconf_verify_work+0x12/0x30
[ 861.555802][ T44] 1 lock held by khungtaskd/44:
[ 861.555980][ T44] #0: ffffffff97178fc0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2b/0x1db
[ 861.556233][ T44] 3 locks held by kworker/3:2/1146:
[ 861.556395][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.556671][ T44] #1: ffa0000001227d30 ((work_completion)(&pool->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.556974][ T44] #2: ffffffff97892a28 (rtnl_mutex){+.+.}-{4:4}, at: xp_release_deferred+0x1b/0x1e0
[ 861.557225][ T44] 3 locks held by kworker/1:3/1419:
[ 861.557385][ T44] #0: ff11000001139b48 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0xcb4/0x1390
[ 861.557662][ T44] #1: ffa0000000657d30 ((work_completion)(&(&vi->refill)->work)){+.+.}-{0:0}, at: process_one_work+0xd16/0x1390
[ 861.558017][ T44] #2: ff11000008d2ac98 (&dev->lock){+.+.}-{4:4}, at: napi_disable+0x3b/0x80
[ 861.558271][ T44] 2 locks held by ip/5150:
[ 861.558432][ T44] #0: ffffffff97892a28 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x5df/0xb20
[ 861.558682][ T44] #1: ff11000008d2ac98 (&dev->lock){+.+.}-{4:4}, at: napi_enable+0x3b/0x80
[ 861.560529][ T44] 1 lock held by xdp_helper/5158:
[ 861.560696][ T44] #0: ffffffff97892a28 (rtnl_mutex){+.+.}-{4:4}, at: xsk_bind+0x17f/0x1a10
[ 861.560975][ T44]
[ 861.561083][ T44] =============================================
[ 861.561083][ T44]
[ 863.568940][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 340992 ms
[ 863.569365][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 340992000 usecs ago
[ 869.200943][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 346624 ms
[ 869.201409][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 346624000 usecs ago
[ 874.319940][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 351743 ms
[ 874.320388][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 351743000 usecs ago
[ 880.464936][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 357888 ms
[ 880.465352][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 357888000 usecs ago
[ 886.096936][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 363520 ms
[ 886.097350][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 363520000 usecs ago
[ 891.216937][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 368640 ms
[ 891.217363][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 368640000 usecs ago
[ 896.335937][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 373759 ms
[ 896.336336][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 373759000 usecs ago
[ 902.480935][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 379904 ms
[ 902.481341][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 379904000 usecs ago
[ 908.111936][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 385535 ms
[ 908.112332][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 385535000 usecs ago
[ 913.232940][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 390656 ms
[ 913.233383][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 390656000 usecs ago
[ 918.352939][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 395776 ms
[ 918.353369][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 395776000 usecs ago
[ 924.496937][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 401920 ms
[ 924.497357][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 401920000 usecs ago
[ 930.128945][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 407552 ms
[ 930.129412][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 407552000 usecs ago
[ 935.248937][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 412672 ms
[ 935.249347][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 412672000 usecs ago
[ 940.367936][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 417791 ms
[ 940.368338][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 417791000 usecs ago
[ 946.512944][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 423936 ms
[ 946.513432][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 423936000 usecs ago
[ 952.144938][ C3] virtio_net virtio2 enp0s1: NETDEV WATCHDOG: CPU: 3: transmit queue 1 timed out 429568 ms
[ 952.145358][ C3] virtio_net virtio2 enp0s1: TX timeout on queue: 1, sq: output.1, vq: 0x3, name: output.1, 429568000 usecs ago