very long boot times in 5.13 stable.

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



Hello,

My system was stable with 5.13.0, though there was a KASAN warning.
So, I upgrade to 5.13.5, and now it takes a very long time to fully boot to
login prompt, and I see this splat in the logs.

I'm working on bisecting, but if someone has a clue, please let me know.

[ 2187.021338] irq 4: nobody cared (try booting with the "irqpoll" option)
[ 2187.026825] CPU: 7 PID: 48 Comm: ksoftirqd/7 Not tainted 5.13.5+ #26
[ 2187.026830] Hardware name: Default string Default string/SKYBAY, BIOS 5.12 02/19/2019
[ 2187.026832] Call Trace:
[ 2187.026834]  <IRQ>
[ 2187.026836]  dump_stack+0x9b/0xce
[ 2187.026844]  __report_bad_irq+0x3d/0xd7
[ 2187.026848]  note_interrupt.cold.9+0xa/0x8b
[ 2187.026851]  ? add_interrupt_randomness+0x15a/0x2a0
[ 2187.026857]  handle_irq_event_percpu+0xd6/0xe0
[ 2187.026862]  ? __handle_irq_event_percpu+0x250/0x250
[ 2187.026865]  ? _raw_spin_lock+0x7c/0xd0
[ 2187.026872]  ? _raw_read_lock+0x30/0x30
[ 2187.026876]  handle_irq_event+0x4f/0x80
[ 2187.026879]  handle_fasteoi_irq+0xf7/0x210
[ 2187.026885]  __common_interrupt+0x3e/0xb0
[ 2187.026890]  common_interrupt+0x77/0xa0
[ 2187.026893]  </IRQ>
[ 2187.026895]  asm_common_interrupt+0x1e/0x40
[ 2187.026898] RIP: 0010:unwind_next_frame+0x727/0xa70
[ 2187.026902] Code: 80 3d 49 6d 88 02 00 0f 85 b6 fc ff ff e9 7a 1e 1b 01 48 8b 44 24 60 4c 89 ea 48 89 df 4c 8d 7b 34 48 8d 70 f8 48 89 44 24 28 <e8> 94 f8 ff ff 84 c0 0f 84 8c fc ff ff 4c 8b 6c 24 60 48 8b 3c 24
[ 2187.026906] RSP: 0018:ffff888108d5f680 EFLAGS: 00000246
[ 2187.026909] RAX: ffff888108d5fba0 RBX: ffff888108d5f798 RCX: ffffffff810ba1f9
[ 2187.026912] RDX: ffff888108d5f7e0 RSI: ffff888108d5fb98 RDI: ffff888108d5f798
[ 2187.026915] RBP: 1ffff110211abed8 R08: fffffbfff07eb294 R09: fffffbfff07eb294
[ 2187.026917] R10: ffffffff83f5949d R11: fffffbfff07eb293 R12: 0000000000000001
[ 2187.026919] R13: ffff888108d5f7e0 R14: ffffffff83f5949c R15: ffff888108d5f7cc
[ 2187.026922]  ? unwind_next_frame+0x529/0xa70
[ 2187.026926]  ? packet_rcv+0x73/0x8e0
[ 2187.026931]  ? packet_rcv+0x72/0x8e0
[ 2187.026934]  ? deref_stack_reg+0x40/0x40
[ 2187.026937]  ? unwind_next_frame+0x334/0xa70
[ 2187.026940]  ? ret_from_fork+0x1f/0x30
[ 2187.026945]  ? get_stack_info_noinstr+0x12/0xe0
[ 2187.026948]  ? packet_rcv+0x73/0x8e0
[ 2187.026951]  ? create_prof_cpu_mask+0x20/0x20
[ 2187.026955]  arch_stack_walk+0x80/0xe0
[ 2187.026959]  ? packet_rcv+0x73/0x8e0
[ 2187.026963]  ? packet_rcv+0x73/0x8e0
[ 2187.026966]  stack_trace_save+0x85/0xb0
[ 2187.026969]  ? stack_trace_consume_entry+0x80/0x80
[ 2187.026973]  kasan_save_stack+0x19/0x40
[ 2187.026977]  ? kasan_save_stack+0x19/0x40
[ 2187.026981]  ? kasan_set_track+0x1c/0x30
[ 2187.026984]  ? kasan_set_free_info+0x20/0x30
[ 2187.026988]  ? __kasan_slab_free+0xec/0x130
[ 2187.026991]  ? kmem_cache_free+0x78/0x290
[ 2187.026994]  ? packet_rcv+0x73/0x8e0
[ 2187.026998]  ? kasan_save_stack+0x2f/0x40
[ 2187.027001]  ? kasan_save_stack+0x19/0x40
[ 2187.027004]  ? __kasan_slab_alloc+0x68/0x80
[ 2187.027007]  ? kmem_cache_alloc+0xc5/0x1f0
[ 2187.027010]  ? skb_clone+0x80/0x160
[ 2187.027015]  ? dev_queue_xmit_nit+0x19d/0x410
[ 2187.027020]  ? dev_hard_start_xmit+0x7f/0x330
[ 2187.027024]  ? sch_direct_xmit+0x116/0x580
[ 2187.027030]  ? __qdisc_run+0x23b/0x920
[ 2187.027033]  ? net_tx_action+0x1a3/0x420
[ 2187.027036]  ? __do_softirq+0xf0/0x3b8
[ 2187.027040]  ? run_ksoftirqd+0x21/0x30
[ 2187.027046]  ? smpboot_thread_fn+0x1b6/0x340
[ 2187.027051]  ? kthread+0x1d4/0x210
[ 2187.027055]  ? ret_from_fork+0x1f/0x30
[ 2187.027059]  ? _raw_spin_unlock+0x9/0x20
[ 2187.027063]  ? get_partial_node.isra.86.part.87+0xe0/0x280
[ 2187.027067]  ? common_interrupt+0x1b/0xa0
[ 2187.027070]  ? common_interrupt+0x1b/0xa0
[ 2187.027072]  ? dma_map_page_attrs+0x16f/0x350
[ 2187.027077]  ? common_interrupt+0x1b/0xa0
[ 2187.027080]  ? asm_common_interrupt+0x1e/0x40
[ 2187.027083]  ? bpf_skb_load_helper_16+0x6e/0xf0
[ 2187.027087]  ? bpf_skb_load_helper_8_no_cache+0x120/0x120
[ 2187.027090]  kasan_set_track+0x1c/0x30
[ 2187.027094]  kasan_set_free_info+0x20/0x30
[ 2187.027097]  __kasan_slab_free+0xec/0x130
[ 2187.027101]  ? packet_rcv+0x73/0x8e0
[ 2187.027104]  kmem_cache_free+0x78/0x290
[ 2187.027108]  packet_rcv+0x73/0x8e0
[ 2187.027111]  ? __skb_clone+0x271/0x2b0
[ 2187.027115]  ? packet_create+0x3d0/0x3d0
[ 2187.027118]  dev_queue_xmit_nit+0x401/0x410
[ 2187.027122]  dev_hard_start_xmit+0x7f/0x330
[ 2187.027126]  sch_direct_xmit+0x116/0x580
[ 2187.027130]  ? dev_reset_queue.constprop.44+0xa0/0xa0
[ 2187.027135]  ? fq_codel_dump_stats+0x310/0x310 [sch_fq_codel]
[ 2187.027141]  ? _raw_spin_unlock_irq+0x13/0x30
[ 2187.027144]  __qdisc_run+0x23b/0x920
[ 2187.027148]  net_tx_action+0x1a3/0x420
[ 2187.027152]  __do_softirq+0xf0/0x3b8
[ 2187.027156]  ? takeover_tasklets+0x2e0/0x2e0
[ 2187.027160]  run_ksoftirqd+0x21/0x30
[ 2187.027163]  smpboot_thread_fn+0x1b6/0x340
[ 2187.027167]  ? smpboot_register_percpu_thread+0x180/0x180
[ 2187.027171]  ? schedule+0xaa/0x140
[ 2187.027174]  ? __kthread_parkme+0x94/0xb0
[ 2187.027178]  ? smpboot_register_percpu_thread+0x180/0x180
[ 2187.027181]  kthread+0x1d4/0x210
[ 2187.027185]  ? set_kthread_struct+0x70/0x70
[ 2187.027188]  ret_from_fork+0x1f/0x30
[ 2187.027193] handlers:
[ 2187.028203] [<00000000ef8c02a2>] serial8250_interrupt
[ 2187.032072] Disabling IRQ #4

Thanks,
Ben

--
Ben Greear <greearb@xxxxxxxxxxxxxxx>
Candela Technologies Inc  http://www.candelatech.com




[Index of Archives]     [Linux Kernel]     [Kernel Development Newbies]     [Linux USB Devel]     [Video for Linux]     [Linux Audio Users]     [Yosemite Hiking]     [Linux Kernel]     [Linux SCSI]

  Powered by Linux