RCU stall with 6.4.0 with delayed loading of wireguard.ko

rcu-5.txt (text/plain), 4.65 KB, created by satmd on 2023-07-01 12:22:20 UTC

[  116.273958] wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information.
[  116.273963] wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld <[e-mail]>. All Rights Reserved.
[  168.957827] rcu: INFO: rcu_preempt self-detected stall on CPU
[  168.957835] rcu:     6-....: (1 GPs behind) idle=a364/1/0x4000000000000004 softirq=13024/13024 fqs=911
[  168.957840] rcu:              hardirqs   softirqs   csw/system
[  168.957841] rcu:      number:       11          0            0
[  168.957843] rcu:     cputime:        0      10490            0   ==> 10490(ms)
[  168.957845] rcu:     (t=2100 jiffies g=9561 q=740302 ncpus=12)
[  168.957849] CPU: 6 PID: 0 Comm: swapper/6 Tainted: G                T  6.4.0-gentoo #1
[  168.957851] Hardware name: Dell Inc. PowerEdge R620/0VV3F2, BIOS 2.9.0 12/06/2019
[  168.957853] RIP: 0010:wg_packet_receive+0x789/0x860 [wireguard]
[  168.957869] Code: 00 48 d3 e2 48 f7 da 48 23 15 f3 c7 34 cf 74 05 f3 48 0f bc c2 31 d2 f7 35 c4 c9 34 cf 89 d0 49 89 c4 48 0f a3 05 d7 c7 34 cf <0f> 82 9d fc ff ff eb b5 c7 85 40 01 00 00 00 00 00 00 e9 2f fd ff
[  168.957871] RSP: 0018:ffffb8890036cb48 EFLAGS: 00000246
[  168.957874] RAX: 0000000000000010 RBX: ffff9f7d8acb0900 RCX: 0000000000000011
[  168.957875] RDX: 0000000000000010 RSI: 0000000000000001 RDI: ffff9f7daab09e60
[  168.957876] RBP: ffff9f7d8536d900 R08: 000000000000000e R09: 0000000000000008
[  168.957878] R10: ffffffff8ff69740 R11: 000000000000def7 R12: 0000000000000010
[  168.957879] R13: ffff9f7d8bde2600 R14: ffff9f7d838740ce R15: ffffb8890036ccc8
[  168.957881] FS:  0000000000000000(0000) GS:ffff9f887f380000(0000) knlGS:0000000000000000
[  168.957882] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  168.957884] CR2: 00007f9cf39636dc CR3: 00000007e662a001 CR4: 00000000001706e0
[  168.957886] Call Trace:
[  168.957889]  <IRQ>
[  168.957891]  ? rcu_dump_cpu_stacks+0xea/0x170
[  168.957896]  ? rcu_sched_clock_irq+0x500/0x1010
[  168.957900]  ? remove_entity_load_avg+0x2e/0x70
[  168.957904]  ? __smp_call_single_queue+0x45/0x140
[  168.957908]  ? perf_event_task_tick+0x42/0x70
[  168.957911]  ? scheduler_tick+0xf8/0x2a0
[  168.957914]  ? update_process_times+0x57/0x90
[  168.957918]  ? tick_sched_timer+0xb9/0xe0
[  168.957922]  ? __pfx_tick_sched_timer+0x10/0x10
[  168.957925]  ? __hrtimer_run_queues+0x12b/0x2d0
[  168.957928]  ? hrtimer_interrupt+0xf4/0x230
[  168.957932]  ? __sysvec_apic_timer_interrupt+0x62/0x140
[  168.957935]  ? sysvec_apic_timer_interrupt+0x35/0x90
[  168.957940]  ? asm_sysvec_apic_timer_interrupt+0x16/0x20
[  168.957944]  ? wg_packet_receive+0x789/0x860 [wireguard]
[  168.957953]  ? wg_packet_receive+0x40d/0x860 [wireguard]
[  168.957961]  ? __udp4_lib_rcv+0x3fd/0xad0
[  168.957966]  ? __pfx_wg_receive+0x10/0x10 [wireguard]
[  168.957974]  wg_receive+0x25/0x40 [wireguard]
[  168.957983]  udp_queue_rcv_one_skb+0x3bf/0x5a0
[  168.957987]  udp_unicast_rcv_skb+0x76/0x90
[  168.957990]  ip_protocol_deliver_rcu+0x120/0x2f0
[  168.957995]  ip_local_deliver_finish+0x7a/0xa0
[  168.957999]  ip_sublist_rcv_finish+0x64/0x70
[  168.958002]  ip_sublist_rcv+0x167/0x1a0
[  168.958006]  ? bond_handle_frame+0x58/0x250 [bonding]
[  168.958021]  ? __pfx_ip_rcv_finish+0x10/0x10
[  168.958024]  ip_list_rcv+0xff/0x130
[  168.958028]  __netif_receive_skb_list_core+0x228/0x250
[  168.958033]  netif_receive_skb_list_internal+0x1c9/0x2f0
[  168.958036]  napi_complete_done+0x6e/0x180
[  168.958040]  igb_poll+0x8d2/0x1450 [igb]
[  168.958057]  __napi_poll+0x2b/0x1c0
[  168.958060]  net_rx_action+0x138/0x280
[  168.958062]  ? __napi_schedule+0x7a/0x80
[  168.958067]  __do_softirq+0xd8/0x2c9
[  168.958071]  common_interrupt+0x82/0xa0
[  168.958074]  </IRQ>
[  168.958075]  <TASK>
[  168.958076]  asm_common_interrupt+0x22/0x40
[  168.958078] RIP: 0010:cpuidle_enter_state+0xcc/0x440
[  168.958082] Code: ff ff 8b 53 04 49 89 c5 8b 05 88 27 bd 00 85 c0 0f 8f e8 02 00 00 31 ff e8 81 c8 52 ff 45 84 ff 0f 85 f8 01 00 00 fb 45 85 f6 <0f> 88 2f 01 00 00 48 8b 04 24 49 63 ce 4c 89 ea 48 6b f1 68 48 29
[  168.958084] RSP: 0018:ffffb889000e3ea0 EFLAGS: 00000202
[  168.958086] RAX: ffff9f887f3aaac0 RBX: ffffd888ff380278 RCX: 0000000000000000
[  168.958087] RDX: 0000000000000006 RSI: 0000000000000002 RDI: 0000000000000000
[  168.958089] RBP: 0000000000000001 R08: fffffdf9c372c188 R09: 000000003cf3d124
[  168.958090] R10: 0000000000000001 R11: 0000000000000000 R12: ffffffff8f7a0320
[  168.958091] R13: 0000002272d2148d R14: 0000000000000001 R15: 0000000000000000
[  168.958094]  cpuidle_enter+0x2f/0x40
[  168.958099]  do_idle+0xe7/0x190
[  168.958101]  cpu_startup_entry+0x19/0x20
[  168.958104]  start_secondary+0xe8/0xf0
[  168.958108]  secondary_startup_64_no_verify+0x106/0x10b
[  168.958113]  </TASK>