* [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
@ 2021-06-26 13:52 ` Sachin Sant
0 siblings, 0 replies; 10+ messages in thread
From: Sachin Sant @ 2021-06-26 13:52 UTC (permalink / raw)
To: linuxppc-dev; +Cc: linux-next, npiggin, Michael Ellerman
Following kernel warning is seen while booting 5.13.0-rc7-next-20210625
on POWER9 LPAR.
[ 40.573592] ------------[ cut here ]------------
[ 40.573604] WARNING: CPU: 6 PID: 4743 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
[ 40.573614] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts uio_pdrv_genirq uio vmx_crypto sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 40.573649] CPU: 6 PID: 4743 Comm: dracut-install Not tainted 5.13.0-rc7-next-20210625 #1
[ 40.573655] NIP: c000000000032990 LR: c00000000000c958 CTR: 000000000048dd1c
[ 40.573660] REGS: c0000000414db640 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
[ 40.573664] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28044288 XER: 00000000
[ 40.573674] CFAR: c0000000000327a4 IRQMASK: 1
GPR00: c00000000000c958 c0000000414db8e0 c0000000029bbd00 c0000000414db9a0
GPR04: 8000000000001033 0000000000000093 0000000000000048 ffffffffffffffbf
GPR08: 0000000000000008 0000000000000000 0000000000000003 0000000000000010
GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
GPR28: 0000000000000000 fcffffffffffffff 0000000000000000 c0000000414db9a0
[ 40.573725] NIP [c000000000032990] interrupt_exit_kernel_prepare+0x280/0x2a0
[ 40.573730] LR [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
[ 40.573736] Call Trace:
[ 40.573738] [c0000000414db8e0] [c000000043cbbc00] 0xc000000043cbbc00 (unreliable)
[ 40.573744] [c0000000414db930] [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
[ 40.573751] --- interrupt: 300 at strnlen_user+0x74/0x240
[ 40.573756] NIP: c00000000070ccf4 LR: c00000000048a460 CTR: 000000000003fffe
[ 40.573760] REGS: c0000000414db9a0 TRAP: 0300 Not tainted (5.13.0-rc7-next-20210625)
[ 40.573764] MSR: 8000000000001033 <SF,ME,IR,DR,RI,LE> CR: 48044228 XER: 20040000
[ 40.573774] CFAR: c00000000048a45c DAR: 000001003da495d0 DSISR: 40000000 IRQMASK: 0
GPR00: c00000000048a44c c0000000414dbc40 c0000000029bbd00 0000000000000000
GPR04: 0000000000200000 0000000000000030 c000000043cbbc00 000001003da495d0
GPR08: a8aaaaaaaaaaaaaa bcffffffffffffff 000001003da495d0 0000000000000000
GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
GPR28: 0000000000000000 c000000043b6a000 c000000043cbbc00 0000000000000000
[ 40.573826] NIP [c00000000070ccf4] strnlen_user+0x74/0x240
[ 40.573830] LR [c00000000048a460] copy_strings.isra.42+0xb0/0x350
[ 40.573835] --- interrupt: 300
[ 40.573838] [c0000000414dbc40] [c00000007d7c0000] 0xc00000007d7c0000 (unreliable)
[ 40.573843] [c0000000414dbc70] [c00000000048a44c] copy_strings.isra.42+0x9c/0x350
[ 40.573849] [c0000000414dbd10] [c00000000048b60c] do_execveat_common.isra.44+0x1fc/0x240
[ 40.573855] [c0000000414dbd80] [c00000000048b6a4] sys_execve+0x54/0x70
[ 40.573860] [c0000000414dbdb0] [c0000000000322c0] system_call_exception+0x150/0x2d0
[ 40.573865] [c0000000414dbe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 40.573871] --- interrupt: c00 at 0x7fffb76db8a8
[ 40.573875] NIP: 00007fffb76db8a8 LR: 00007fffb76dc488 CTR: 0000000000000000
[ 40.573878] REGS: c0000000414dbe80 TRAP: 0c00 Not tainted (5.13.0-rc7-next-20210625)
[ 40.573883] MSR: 800000000280f033 <SF,VEC,VSX,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28044283 XER: 00000000
[ 40.573895] IRQMASK: 0
GPR00: 000000000000000b 00007fffc7ab7a00 00007fffb77f7300 00007fffc7ab7a20
GPR04: 00007fffc7ab7ae0 00007fffc7ab8b50 0000000000007063 0000000000000000
GPR08: ffff800038540059 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00007fffb792d720 0000000101dc15a8 0000000101dc1590
GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 00007fffc7ab7a20
GPR20: 00007fffb7926740 000000000000002f 0000000000000000 0000000000000013
GPR24: 0000000000000003 00007fffc7abffa7 0000000000000001 00007fffc7ab8b50
GPR28: 00007fffc7ab7ae0 00007fffc7abffb0 0000000101dc1378 00007fffc7ab7a20
[ 40.573943] NIP [00007fffb76db8a8] 0x7fffb76db8a8
[ 40.573947] LR [00007fffb76dc488] 0x7fffb76dc488
[ 40.573950] --- interrupt: c00
[ 40.573952] Instruction dump:
[ 40.573955] 71290001 892d0933 61290001 992d0933 4082000c 392d0918 7c20492a 4bfe36dd
[ 40.573964] 60000000 4bfffe34 60000000 60000000 <0fe00000> 4bfffe14 60000000 60000000
[ 40.573973] ---[ end trace 604b708523af26f5 ]—
I cannot consistently recreate this problem.
next-20210624 was good.
Last patch that touched this code was 6eaaf9de3599.
Thanks
-Sachin
^ permalink raw reply [flat|nested] 10+ messages in thread
* [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
@ 2021-06-26 13:52 ` Sachin Sant
0 siblings, 0 replies; 10+ messages in thread
From: Sachin Sant @ 2021-06-26 13:52 UTC (permalink / raw)
To: linuxppc-dev; +Cc: linux-next, npiggin
Following kernel warning is seen while booting 5.13.0-rc7-next-20210625
on POWER9 LPAR.
[ 40.573592] ------------[ cut here ]------------
[ 40.573604] WARNING: CPU: 6 PID: 4743 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
[ 40.573614] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts uio_pdrv_genirq uio vmx_crypto sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 40.573649] CPU: 6 PID: 4743 Comm: dracut-install Not tainted 5.13.0-rc7-next-20210625 #1
[ 40.573655] NIP: c000000000032990 LR: c00000000000c958 CTR: 000000000048dd1c
[ 40.573660] REGS: c0000000414db640 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
[ 40.573664] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28044288 XER: 00000000
[ 40.573674] CFAR: c0000000000327a4 IRQMASK: 1
GPR00: c00000000000c958 c0000000414db8e0 c0000000029bbd00 c0000000414db9a0
GPR04: 8000000000001033 0000000000000093 0000000000000048 ffffffffffffffbf
GPR08: 0000000000000008 0000000000000000 0000000000000003 0000000000000010
GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
GPR28: 0000000000000000 fcffffffffffffff 0000000000000000 c0000000414db9a0
[ 40.573725] NIP [c000000000032990] interrupt_exit_kernel_prepare+0x280/0x2a0
[ 40.573730] LR [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
[ 40.573736] Call Trace:
[ 40.573738] [c0000000414db8e0] [c000000043cbbc00] 0xc000000043cbbc00 (unreliable)
[ 40.573744] [c0000000414db930] [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
[ 40.573751] --- interrupt: 300 at strnlen_user+0x74/0x240
[ 40.573756] NIP: c00000000070ccf4 LR: c00000000048a460 CTR: 000000000003fffe
[ 40.573760] REGS: c0000000414db9a0 TRAP: 0300 Not tainted (5.13.0-rc7-next-20210625)
[ 40.573764] MSR: 8000000000001033 <SF,ME,IR,DR,RI,LE> CR: 48044228 XER: 20040000
[ 40.573774] CFAR: c00000000048a45c DAR: 000001003da495d0 DSISR: 40000000 IRQMASK: 0
GPR00: c00000000048a44c c0000000414dbc40 c0000000029bbd00 0000000000000000
GPR04: 0000000000200000 0000000000000030 c000000043cbbc00 000001003da495d0
GPR08: a8aaaaaaaaaaaaaa bcffffffffffffff 000001003da495d0 0000000000000000
GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
GPR28: 0000000000000000 c000000043b6a000 c000000043cbbc00 0000000000000000
[ 40.573826] NIP [c00000000070ccf4] strnlen_user+0x74/0x240
[ 40.573830] LR [c00000000048a460] copy_strings.isra.42+0xb0/0x350
[ 40.573835] --- interrupt: 300
[ 40.573838] [c0000000414dbc40] [c00000007d7c0000] 0xc00000007d7c0000 (unreliable)
[ 40.573843] [c0000000414dbc70] [c00000000048a44c] copy_strings.isra.42+0x9c/0x350
[ 40.573849] [c0000000414dbd10] [c00000000048b60c] do_execveat_common.isra.44+0x1fc/0x240
[ 40.573855] [c0000000414dbd80] [c00000000048b6a4] sys_execve+0x54/0x70
[ 40.573860] [c0000000414dbdb0] [c0000000000322c0] system_call_exception+0x150/0x2d0
[ 40.573865] [c0000000414dbe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 40.573871] --- interrupt: c00 at 0x7fffb76db8a8
[ 40.573875] NIP: 00007fffb76db8a8 LR: 00007fffb76dc488 CTR: 0000000000000000
[ 40.573878] REGS: c0000000414dbe80 TRAP: 0c00 Not tainted (5.13.0-rc7-next-20210625)
[ 40.573883] MSR: 800000000280f033 <SF,VEC,VSX,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28044283 XER: 00000000
[ 40.573895] IRQMASK: 0
GPR00: 000000000000000b 00007fffc7ab7a00 00007fffb77f7300 00007fffc7ab7a20
GPR04: 00007fffc7ab7ae0 00007fffc7ab8b50 0000000000007063 0000000000000000
GPR08: ffff800038540059 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00007fffb792d720 0000000101dc15a8 0000000101dc1590
GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 00007fffc7ab7a20
GPR20: 00007fffb7926740 000000000000002f 0000000000000000 0000000000000013
GPR24: 0000000000000003 00007fffc7abffa7 0000000000000001 00007fffc7ab8b50
GPR28: 00007fffc7ab7ae0 00007fffc7abffb0 0000000101dc1378 00007fffc7ab7a20
[ 40.573943] NIP [00007fffb76db8a8] 0x7fffb76db8a8
[ 40.573947] LR [00007fffb76dc488] 0x7fffb76dc488
[ 40.573950] --- interrupt: c00
[ 40.573952] Instruction dump:
[ 40.573955] 71290001 892d0933 61290001 992d0933 4082000c 392d0918 7c20492a 4bfe36dd
[ 40.573964] 60000000 4bfffe34 60000000 60000000 <0fe00000> 4bfffe14 60000000 60000000
[ 40.573973] ---[ end trace 604b708523af26f5 ]—
I cannot consistently recreate this problem.
next-20210624 was good.
Last patch that touched this code was 6eaaf9de3599.
Thanks
-Sachin
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
2021-06-26 13:52 ` Sachin Sant
@ 2021-06-26 18:57 ` Nicholas Piggin
-1 siblings, 0 replies; 10+ messages in thread
From: Nicholas Piggin @ 2021-06-26 18:57 UTC (permalink / raw)
To: linuxppc-dev, Sachin Sant; +Cc: linux-next, Michael Ellerman
Excerpts from Sachin Sant's message of June 26, 2021 11:52 pm:
> Following kernel warning is seen while booting 5.13.0-rc7-next-20210625
> on POWER9 LPAR.
>
> [ 40.573592] ------------[ cut here ]------------
> [ 40.573604] WARNING: CPU: 6 PID: 4743 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
> [ 40.573614] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts uio_pdrv_genirq uio vmx_crypto sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
> [ 40.573649] CPU: 6 PID: 4743 Comm: dracut-install Not tainted 5.13.0-rc7-next-20210625 #1
> [ 40.573655] NIP: c000000000032990 LR: c00000000000c958 CTR: 000000000048dd1c
> [ 40.573660] REGS: c0000000414db640 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
> [ 40.573664] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28044288 XER: 00000000
> [ 40.573674] CFAR: c0000000000327a4 IRQMASK: 1
> GPR00: c00000000000c958 c0000000414db8e0 c0000000029bbd00 c0000000414db9a0
> GPR04: 8000000000001033 0000000000000093 0000000000000048 ffffffffffffffbf
> GPR08: 0000000000000008 0000000000000000 0000000000000003 0000000000000010
> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
> GPR28: 0000000000000000 fcffffffffffffff 0000000000000000 c0000000414db9a0
> [ 40.573725] NIP [c000000000032990] interrupt_exit_kernel_prepare+0x280/0x2a0
> [ 40.573730] LR [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
BTW this isn't a restart but a kernel exit. I'll have to update labels
to make this clear.
> [ 40.573736] Call Trace:
> [ 40.573738] [c0000000414db8e0] [c000000043cbbc00] 0xc000000043cbbc00 (unreliable)
> [ 40.573744] [c0000000414db930] [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
> [ 40.573751] --- interrupt: 300 at strnlen_user+0x74/0x240
> [ 40.573756] NIP: c00000000070ccf4 LR: c00000000048a460 CTR: 000000000003fffe
> [ 40.573760] REGS: c0000000414db9a0 TRAP: 0300 Not tainted (5.13.0-rc7-next-20210625)
> [ 40.573764] MSR: 8000000000001033 <SF,ME,IR,DR,RI,LE> CR: 48044228 XER: 20040000
> [ 40.573774] CFAR: c00000000048a45c DAR: 000001003da495d0 DSISR: 40000000 IRQMASK: 0
> GPR00: c00000000048a44c c0000000414dbc40 c0000000029bbd00 0000000000000000
> GPR04: 0000000000200000 0000000000000030 c000000043cbbc00 000001003da495d0
> GPR08: a8aaaaaaaaaaaaaa bcffffffffffffff 000001003da495d0 0000000000000000
> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
> GPR28: 0000000000000000 c000000043b6a000 c000000043cbbc00 0000000000000000
> [ 40.573826] NIP [c00000000070ccf4] strnlen_user+0x74/0x240
> [ 40.573830] LR [c00000000048a460] copy_strings.isra.42+0xb0/0x350
So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
what the warning was.
I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
doesn't get enabled when irqs are restored, or maybe the change to
arch_local_irq_restore(). Less likely that the stack got messed up.
Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
Thanks,
Nick
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
@ 2021-06-26 18:57 ` Nicholas Piggin
0 siblings, 0 replies; 10+ messages in thread
From: Nicholas Piggin @ 2021-06-26 18:57 UTC (permalink / raw)
To: linuxppc-dev, Sachin Sant; +Cc: linux-next
Excerpts from Sachin Sant's message of June 26, 2021 11:52 pm:
> Following kernel warning is seen while booting 5.13.0-rc7-next-20210625
> on POWER9 LPAR.
>
> [ 40.573592] ------------[ cut here ]------------
> [ 40.573604] WARNING: CPU: 6 PID: 4743 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
> [ 40.573614] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts uio_pdrv_genirq uio vmx_crypto sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
> [ 40.573649] CPU: 6 PID: 4743 Comm: dracut-install Not tainted 5.13.0-rc7-next-20210625 #1
> [ 40.573655] NIP: c000000000032990 LR: c00000000000c958 CTR: 000000000048dd1c
> [ 40.573660] REGS: c0000000414db640 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
> [ 40.573664] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28044288 XER: 00000000
> [ 40.573674] CFAR: c0000000000327a4 IRQMASK: 1
> GPR00: c00000000000c958 c0000000414db8e0 c0000000029bbd00 c0000000414db9a0
> GPR04: 8000000000001033 0000000000000093 0000000000000048 ffffffffffffffbf
> GPR08: 0000000000000008 0000000000000000 0000000000000003 0000000000000010
> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
> GPR28: 0000000000000000 fcffffffffffffff 0000000000000000 c0000000414db9a0
> [ 40.573725] NIP [c000000000032990] interrupt_exit_kernel_prepare+0x280/0x2a0
> [ 40.573730] LR [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
BTW this isn't a restart but a kernel exit. I'll have to update labels
to make this clear.
> [ 40.573736] Call Trace:
> [ 40.573738] [c0000000414db8e0] [c000000043cbbc00] 0xc000000043cbbc00 (unreliable)
> [ 40.573744] [c0000000414db930] [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
> [ 40.573751] --- interrupt: 300 at strnlen_user+0x74/0x240
> [ 40.573756] NIP: c00000000070ccf4 LR: c00000000048a460 CTR: 000000000003fffe
> [ 40.573760] REGS: c0000000414db9a0 TRAP: 0300 Not tainted (5.13.0-rc7-next-20210625)
> [ 40.573764] MSR: 8000000000001033 <SF,ME,IR,DR,RI,LE> CR: 48044228 XER: 20040000
> [ 40.573774] CFAR: c00000000048a45c DAR: 000001003da495d0 DSISR: 40000000 IRQMASK: 0
> GPR00: c00000000048a44c c0000000414dbc40 c0000000029bbd00 0000000000000000
> GPR04: 0000000000200000 0000000000000030 c000000043cbbc00 000001003da495d0
> GPR08: a8aaaaaaaaaaaaaa bcffffffffffffff 000001003da495d0 0000000000000000
> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
> GPR28: 0000000000000000 c000000043b6a000 c000000043cbbc00 0000000000000000
> [ 40.573826] NIP [c00000000070ccf4] strnlen_user+0x74/0x240
> [ 40.573830] LR [c00000000048a460] copy_strings.isra.42+0xb0/0x350
So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
what the warning was.
I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
doesn't get enabled when irqs are restored, or maybe the change to
arch_local_irq_restore(). Less likely that the stack got messed up.
Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
Thanks,
Nick
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
2021-06-26 18:57 ` Nicholas Piggin
@ 2021-06-27 10:06 ` Nicholas Piggin
-1 siblings, 0 replies; 10+ messages in thread
From: Nicholas Piggin @ 2021-06-27 10:06 UTC (permalink / raw)
To: linuxppc-dev, Sachin Sant; +Cc: linux-next, Michael Ellerman
Excerpts from Nicholas Piggin's message of June 27, 2021 4:57 am:
> Excerpts from Sachin Sant's message of June 26, 2021 11:52 pm:
>> Following kernel warning is seen while booting 5.13.0-rc7-next-20210625
>> on POWER9 LPAR.
>>
>> [ 40.573592] ------------[ cut here ]------------
>> [ 40.573604] WARNING: CPU: 6 PID: 4743 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
>> [ 40.573614] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts uio_pdrv_genirq uio vmx_crypto sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
>> [ 40.573649] CPU: 6 PID: 4743 Comm: dracut-install Not tainted 5.13.0-rc7-next-20210625 #1
>> [ 40.573655] NIP: c000000000032990 LR: c00000000000c958 CTR: 000000000048dd1c
>> [ 40.573660] REGS: c0000000414db640 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
>> [ 40.573664] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28044288 XER: 00000000
>> [ 40.573674] CFAR: c0000000000327a4 IRQMASK: 1
>> GPR00: c00000000000c958 c0000000414db8e0 c0000000029bbd00 c0000000414db9a0
>> GPR04: 8000000000001033 0000000000000093 0000000000000048 ffffffffffffffbf
>> GPR08: 0000000000000008 0000000000000000 0000000000000003 0000000000000010
>> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
>> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
>> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
>> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
>> GPR28: 0000000000000000 fcffffffffffffff 0000000000000000 c0000000414db9a0
>> [ 40.573725] NIP [c000000000032990] interrupt_exit_kernel_prepare+0x280/0x2a0
>> [ 40.573730] LR [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
>
> BTW this isn't a restart but a kernel exit. I'll have to update labels
> to make this clear.
>
>> [ 40.573736] Call Trace:
>> [ 40.573738] [c0000000414db8e0] [c000000043cbbc00] 0xc000000043cbbc00 (unreliable)
>> [ 40.573744] [c0000000414db930] [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
>> [ 40.573751] --- interrupt: 300 at strnlen_user+0x74/0x240
>> [ 40.573756] NIP: c00000000070ccf4 LR: c00000000048a460 CTR: 000000000003fffe
>> [ 40.573760] REGS: c0000000414db9a0 TRAP: 0300 Not tainted (5.13.0-rc7-next-20210625)
>> [ 40.573764] MSR: 8000000000001033 <SF,ME,IR,DR,RI,LE> CR: 48044228 XER: 20040000
>> [ 40.573774] CFAR: c00000000048a45c DAR: 000001003da495d0 DSISR: 40000000 IRQMASK: 0
>> GPR00: c00000000048a44c c0000000414dbc40 c0000000029bbd00 0000000000000000
>> GPR04: 0000000000200000 0000000000000030 c000000043cbbc00 000001003da495d0
>> GPR08: a8aaaaaaaaaaaaaa bcffffffffffffff 000001003da495d0 0000000000000000
>> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
>> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
>> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
>> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
>> GPR28: 0000000000000000 c000000043b6a000 c000000043cbbc00 0000000000000000
>> [ 40.573826] NIP [c00000000070ccf4] strnlen_user+0x74/0x240
>> [ 40.573830] LR [c00000000048a460] copy_strings.isra.42+0xb0/0x350
>
> So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
> what the warning was.
>
> I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
> doesn't get enabled when irqs are restored, or maybe the change to
> arch_local_irq_restore(). Less likely that the stack got messed up.
>
> Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
Nevermind, I think I've found the problem. Some code runs in the
implicit soft-mask region without expecting to be masked. Working
on a fix...
Thanks,
Nick
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
@ 2021-06-27 10:06 ` Nicholas Piggin
0 siblings, 0 replies; 10+ messages in thread
From: Nicholas Piggin @ 2021-06-27 10:06 UTC (permalink / raw)
To: linuxppc-dev, Sachin Sant; +Cc: linux-next
Excerpts from Nicholas Piggin's message of June 27, 2021 4:57 am:
> Excerpts from Sachin Sant's message of June 26, 2021 11:52 pm:
>> Following kernel warning is seen while booting 5.13.0-rc7-next-20210625
>> on POWER9 LPAR.
>>
>> [ 40.573592] ------------[ cut here ]------------
>> [ 40.573604] WARNING: CPU: 6 PID: 4743 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
>> [ 40.573614] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts uio_pdrv_genirq uio vmx_crypto sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
>> [ 40.573649] CPU: 6 PID: 4743 Comm: dracut-install Not tainted 5.13.0-rc7-next-20210625 #1
>> [ 40.573655] NIP: c000000000032990 LR: c00000000000c958 CTR: 000000000048dd1c
>> [ 40.573660] REGS: c0000000414db640 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
>> [ 40.573664] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28044288 XER: 00000000
>> [ 40.573674] CFAR: c0000000000327a4 IRQMASK: 1
>> GPR00: c00000000000c958 c0000000414db8e0 c0000000029bbd00 c0000000414db9a0
>> GPR04: 8000000000001033 0000000000000093 0000000000000048 ffffffffffffffbf
>> GPR08: 0000000000000008 0000000000000000 0000000000000003 0000000000000010
>> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
>> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
>> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
>> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
>> GPR28: 0000000000000000 fcffffffffffffff 0000000000000000 c0000000414db9a0
>> [ 40.573725] NIP [c000000000032990] interrupt_exit_kernel_prepare+0x280/0x2a0
>> [ 40.573730] LR [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
>
> BTW this isn't a restart but a kernel exit. I'll have to update labels
> to make this clear.
>
>> [ 40.573736] Call Trace:
>> [ 40.573738] [c0000000414db8e0] [c000000043cbbc00] 0xc000000043cbbc00 (unreliable)
>> [ 40.573744] [c0000000414db930] [c00000000000c958] interrupt_return_srr_user_restart+0x34/0x118
>> [ 40.573751] --- interrupt: 300 at strnlen_user+0x74/0x240
>> [ 40.573756] NIP: c00000000070ccf4 LR: c00000000048a460 CTR: 000000000003fffe
>> [ 40.573760] REGS: c0000000414db9a0 TRAP: 0300 Not tainted (5.13.0-rc7-next-20210625)
>> [ 40.573764] MSR: 8000000000001033 <SF,ME,IR,DR,RI,LE> CR: 48044228 XER: 20040000
>> [ 40.573774] CFAR: c00000000048a45c DAR: 000001003da495d0 DSISR: 40000000 IRQMASK: 0
>> GPR00: c00000000048a44c c0000000414dbc40 c0000000029bbd00 0000000000000000
>> GPR04: 0000000000200000 0000000000000030 c000000043cbbc00 000001003da495d0
>> GPR08: a8aaaaaaaaaaaaaa bcffffffffffffff 000001003da495d0 0000000000000000
>> GPR12: 0000000000004000 c000000005587a00 0000000101dc15a8 0000000101dc1590
>> GPR16: 0000000101dc05a8 00007fffc7abe353 00007fffb7926740 0000000000000000
>> GPR20: 00007fffc7ab7ae0 fffffffffffff000 0000000000000006 c000000043cbbc00
>> GPR24: 0000000000000000 000001003da495d0 0000000000000000 0000000000000000
>> GPR28: 0000000000000000 c000000043b6a000 c000000043cbbc00 0000000000000000
>> [ 40.573826] NIP [c00000000070ccf4] strnlen_user+0x74/0x240
>> [ 40.573830] LR [c00000000048a460] copy_strings.isra.42+0xb0/0x350
>
> So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
> what the warning was.
>
> I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
> doesn't get enabled when irqs are restored, or maybe the change to
> arch_local_irq_restore(). Less likely that the stack got messed up.
>
> Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
Nevermind, I think I've found the problem. Some code runs in the
implicit soft-mask region without expecting to be masked. Working
on a fix...
Thanks,
Nick
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
2021-06-27 10:06 ` Nicholas Piggin
@ 2021-06-27 11:23 ` Sachin Sant
-1 siblings, 0 replies; 10+ messages in thread
From: Sachin Sant @ 2021-06-27 11:23 UTC (permalink / raw)
To: Nicholas Piggin; +Cc: linuxppc-dev, linux-next, Michael Ellerman
[-- Attachment #1: Type: text/plain, Size: 5132 bytes --]
> On 27-Jun-2021, at 3:36 PM, Nicholas Piggin <npiggin@gmail.com> wrote:
>>
>> So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
>> what the warning was.
>>
>> I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
>> doesn't get enabled when irqs are restored, or maybe the change to
>> arch_local_irq_restore(). Less likely that the stack got messed up.
>>
>> Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
>
> Nevermind, I think I've found the problem. Some code runs in the
> implicit soft-mask region without expecting to be masked. Working
> on a fix…
:-) . I was able to recreate this after few attempts. It seem the warning isn’t
always triggered during boot. I had to run a kernel compile operation after
boot to trigger this warning again.
In case its helpful here is the additional trace with PPC_IRQ_SOFT_MASK_DEBUG.
[ 92.106731] ------------[ cut here ]------------
[ 92.106738] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/irq.c:255 arch_local_irq_restore+0x1d0/0x200
[ 92.106753] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 92.106828] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
[ 92.106841] NIP: c0000000000164d0 LR: c000000000cedaa8 CTR: 0000000000000000
[ 92.106849] REGS: c00000008dfeb7e0 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106859] MSR: 8000000002823033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 28004222 XER: 00000000
[ 92.106892] CFAR: c00000000001632c IRQMASK: 0
GPR00: c000000000ceda98 c00000008dfeba80 c000000002921e00 0000000000000000
GPR04: 0000000000000000 0000000000000000 0000000000000000 00000000000000ff
GPR08: 0000000000000001 0000000000000000 0000000000000001 0000000000000017
GPR12: 0000000024004822 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00003fffa93f8000 0000000000000000 00003fffa93f9300 000000012efb1988
GPR24: 000000012ee7fe7c 000000012efccba0 000000012ee50000 c00000008d5d7600
GPR28: c0000000314c0bc0 c000000040d9f100 c0000008beb5861c 4b72201a3063fe13
[ 92.107024] NIP [c0000000000164d0] arch_local_irq_restore+0x1d0/0x200
[ 92.107035] LR [c000000000cedaa8] _raw_spin_unlock_irqrestore+0x88/0xb0
[ 92.107047] Call Trace:
[ 92.107052] [c00000008dfeba80] [c00000008dfebb50] 0xc00000008dfebb50 (unreliable)
[ 92.107065] [c00000008dfebab0] [238c5bf052df0858] 0x238c5bf052df0858
[ 92.107076] [c00000008dfebae0] [c0000000008178e8] get_random_u64+0x88/0x100
[ 92.107090] [c00000008dfebb20] [c000000000020134] arch_randomize_brk+0xb4/0xd8
[ 92.107105] [c00000008dfebb50] [c0000000005430b0] load_elf_binary+0xe70/0x1220
[ 92.107119] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
[ 92.107132] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
[ 92.107145] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
[ 92.107157] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
[ 92.107169] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 92.107185] --- interrupt: c00 at 0x3fff9bb6b8a8
[ 92.107193] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
[ 92.107202] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.107213] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
[ 92.107243] IRQMASK: 0
GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
[ 92.107369] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
[ 92.107378] LR [00003fff9bb6c240] 0x3fff9bb6c240
[ 92.107386] --- interrupt: c00
[ 92.107393] Instruction dump:
[ 92.107400] 7d2000a6 71298000 40820048 39200000 992d0152 39400000 992d0153 614a8002
[ 92.107427] 7d410164 4bfffe6c 60000000 60000000 <0fe00000> 4bfffe5c 60000000 60000000
[ 92.107451] ---[ end trace 5f1d49fb99f3613d ]—
Complete dmesg log attached.
Thanks
-Sachin
[-- Attachment #2: next-20210625.txt --]
[-- Type: text/plain, Size: 35026 bytes --]
[ 0.000000] Reserving 512MB of memory at 128MB for crashkernel (System RAM: 35840MB)
[ 0.000000] hash-mmu: Page sizes from device-tree:
[ 0.000000] hash-mmu: base_shift=12: shift=12, sllp=0x0000, avpnm=0x00000000, tlbiel=1, penc=0
[ 0.000000] hash-mmu: base_shift=12: shift=16, sllp=0x0000, avpnm=0x00000000, tlbiel=1, penc=7
[ 0.000000] hash-mmu: base_shift=12: shift=24, sllp=0x0000, avpnm=0x00000000, tlbiel=1, penc=56
[ 0.000000] hash-mmu: base_shift=16: shift=16, sllp=0x0110, avpnm=0x00000000, tlbiel=1, penc=1
[ 0.000000] hash-mmu: base_shift=16: shift=24, sllp=0x0110, avpnm=0x00000000, tlbiel=1, penc=8
[ 0.000000] hash-mmu: base_shift=24: shift=24, sllp=0x0100, avpnm=0x00000001, tlbiel=0, penc=0
[ 0.000000] hash-mmu: base_shift=34: shift=34, sllp=0x0120, avpnm=0x000007ff, tlbiel=0, penc=3
[ 0.000000] Enabling pkeys with max key count 8
[ 0.000000] Activating Kernel Userspace Execution Prevention
[ 0.000000] Activating Kernel Userspace Access Prevention
[ 0.000000] Page orders: linear mapping = 24, virtual = 12, io = 12, vmemmap = 24
[ 0.000000] Using 1TB segments
[ 0.000000] hash-mmu: Initializing hash mmu with SLB
[ 0.000000] Linux version 5.13.0-rc7-next-20210625 (root@ltc-zzci-2.aus.stglabs.ibm.com) (gcc (GCC) 8.4.1 20200928 (Red Hat 8.4.1-1), GNU ld version 2.30-93.el8) #1 SMP Sun Jun 27 05:45:43 CDT 2021
[ 0.000000] Found initrd at 0xc00000000d400000:0xc000000010d118ce
[ 0.000000] Using pSeries machine description
[ 0.000000] printk: bootconsole [udbg0] enabled
[ 0.000000] Partition configured for 96 cpus.
[ 0.000000] CPU maps initialized for 8 threads per core
[ 0.000000] (thread shift is 3)
[ 0.000000] Allocated 3328 bytes for 96 pacas
[ 0.000000] -----------------------------------------------------
[ 0.000000] phys_mem_size = 0x8c0000000
[ 0.000000] dcache_bsize = 0x80
[ 0.000000] icache_bsize = 0x80
[ 0.000000] cpu_features = 0x0001c07b8f5f9187
[ 0.000000] possible = 0x000ffbfbcf5fb187
[ 0.000000] always = 0x0000000380008181
[ 0.000000] cpu_user_features = 0xdc0065c2 0xeff00000
[ 0.000000] mmu_features = 0x7c006e01
[ 0.000000] firmware_features = 0x0000009fc45bfc57
[ 0.000000] vmalloc start = 0xc0003d0000000000
[ 0.000000] IO start = 0xc0003e0000000000
[ 0.000000] vmemmap start = 0xc0003f0000000000
[ 0.000000] hash-mmu: ppc64_pft_size = 0x1c
[ 0.000000] hash-mmu: htab_hash_mask = 0x1fffff
[ 0.000000] -----------------------------------------------------
[ 0.000000] numa: NODE_DATA [mem 0x8bfcd6c80-0x8bfcdbfff]
[ 0.000000] rfi-flush: fallback displacement flush available
[ 0.000000] rfi-flush: mttrig type flush available
[ 0.000000] rfi-flush: patched 14 locations (mttrig type flush)
[ 0.000000] count-cache-flush: flush disabled.
[ 0.000000] link-stack-flush: software flush enabled.
[ 0.000000] entry-flush: patched 61 locations (mttrig type flush)
[ 0.000000] uaccess-flush: patched 1 locations (mttrig type flush)
[ 0.000000] stf-barrier: eieio barrier available
[ 0.000000] stf-barrier: patched 61 entry locations (eieio barrier)
[ 0.000000] stf-barrier: patched 14 exit locations (eieio barrier)
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:0 psize:0 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:0 psize:2 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:0 psize:10 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:2 psize:2 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:2 psize:10 block size:8
[ 0.000000] PPC64 nvram contains 15360 bytes
[ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
[ 0.000000] barrier-nospec: using ORI speculation barrier
[ 0.000000] barrier-nospec: patched 389 locations
[ 0.000000] Top of RAM: 0x8c0000000, Total RAM: 0x8c0000000
[ 0.000000] Memory hole size: 0MB
[ 0.000000] Zone ranges:
[ 0.000000] Normal [mem 0x0000000000000000-0x00000008bfffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x00000008bfffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000008bfffffff]
[ 0.000000] percpu: Embedded 37 pages/cpu s114456 r0 d37096 u262144
[ 0.000000] pcpu-alloc: s114456 r0 d37096 u262144 alloc=1*1048576
[ 0.000000] pcpu-alloc: [0] 00 01 02 03 [0] 04 05 06 07
[ 0.000000] pcpu-alloc: [0] 08 09 10 11 [0] 12 13 14 15
[ 0.000000] pcpu-alloc: [0] 16 17 18 19 [0] 20 21 22 23
[ 0.000000] pcpu-alloc: [0] 24 25 26 27 [0] 28 29 30 31
[ 0.000000] pcpu-alloc: [0] 32 33 34 35 [0] 36 37 38 39
[ 0.000000] pcpu-alloc: [0] 40 41 42 43 [0] 44 45 46 47
[ 0.000000] pcpu-alloc: [0] 48 49 50 51 [0] 52 53 54 55
[ 0.000000] pcpu-alloc: [0] 56 57 58 59 [0] 60 61 62 63
[ 0.000000] pcpu-alloc: [0] 64 65 66 67 [0] 68 69 70 71
[ 0.000000] pcpu-alloc: [0] 72 73 74 75 [0] 76 77 78 79
[ 0.000000] pcpu-alloc: [0] 80 81 82 83 [0] 84 85 86 87
[ 0.000000] pcpu-alloc: [0] 88 89 90 91 [0] 92 93 94 95
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 9031680
[ 0.000000] Policy zone: Normal
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-5.13.0-rc7-next-20210625 root=UUID=681ebf25-b7c8-49b9-b247-35a96bc8183f ro crashkernel=384M-2G:64M,2G-:512M biosdevname=0
[ 0.000000] Unknown command line parameters: BOOT_IMAGE=/boot/vmlinuz-5.13.0-rc7-next-20210625 crashkernel=384M-2G:64M,2G-:512M biosdevname=0
[ 0.000000] Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] Memory: 35357448K/36700160K available (13252K kernel code, 5244K rwdata, 4064K rodata, 4384K init, 2550K bss, 1342712K reserved, 0K cma-reserved)
[ 0.000000] SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=96, Nodes=2
[ 0.000000] ftrace: allocating 33103 entries in 195 pages
[ 0.000000] ftrace: allocated 194 pages with 3 groups
[ 0.000000] trace event string verifier disabled
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=2048 to nr_cpu_ids=96.
[ 0.000000] Rude variant of Tasks RCU enabled.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=96
[ 0.000000] NR_IRQS: 512, nr_irqs: 512, preallocated irqs: 16
[ 0.000000] pic: no ISA interrupt controller
[ 0.000000] rcu: Offload RCU callbacks from CPUs: (none).
[ 0.000000] random: get_random_u64 called from start_kernel+0x9b0/0xc10 with crng_init=0
[ 0.000000] time_init: decrementer frequency = 512.000000 MHz
[ 0.000000] time_init: processor frequency = 2900.000000 MHz
[ 0.000002] time_init: 56 bit decrementer (max: 7fffffffffffff)
[ 0.000041] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x761537d007, max_idle_ns: 440795202126 ns
[ 0.000108] clocksource: timebase mult[1f40000] shift[24] registered
[ 0.000152] clockevent: decrementer mult[83126f] shift[24] cpu[0]
[ 0.000242] Console: colour dummy device 80x25
[ 0.000274] printk: console [hvc0] enabled
[ 0.000304] printk: bootconsole [udbg0] disabled
[ 0.000371] pid_max: default: 98304 minimum: 768
[ 0.000434] LSM: Security Framework initializing
[ 0.000454] Yama: becoming mindful.
[ 0.000467] SELinux: Initializing.
[ 0.000602] Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[ 0.000678] Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[ 0.001696] POWER9 performance monitor hardware support registered
[ 0.001737] rcu: Hierarchical SRCU implementation.
[ 0.003750] smp: Bringing up secondary CPUs ...
[ 0.028999] smp: Brought up 1 node, 64 CPUs
[ 0.029008] numa: Node 0 CPUs: 0-63
[ 0.029014] Big cores detected but using small core scheduling
[ 0.030954] devtmpfs: initialized
[ 0.035365] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.035382] futex hash table entries: 32768 (order: 10, 4194304 bytes, linear)
[ 0.035882] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.035994] audit: initializing netlink subsys (disabled)
[ 0.036095] audit: type=2000 audit(1624792326.030:1): state=initialized audit_enabled=0 res=1
[ 0.036166] thermal_sys: Registered thermal governor 'fair_share'
[ 0.036167] thermal_sys: Registered thermal governor 'step_wise'
[ 0.036339] cpuidle: using governor menu
[ 0.036381] RTAS daemon started
[ 0.036607] pstore: Registered nvram as persistent store backend
[ 0.037251] EEH: pSeries platform initialized
[ 0.043241] PCI: Probing PCI hardware
[ 0.043248] EEH: No capable adapters found: recovery disabled.
[ 0.043252] PCI: Probing PCI hardware done
[ 0.043348] pseries-rng: Registering arch random hook.
[ 0.044804] Kprobes globally optimized
[ 0.045174] HugeTLB registered 16.0 MiB page size, pre-allocated 0 pages
[ 0.045181] HugeTLB registered 16.0 GiB page size, pre-allocated 0 pages
[ 0.085299] wait_for_initramfs() called before rootfs_initcalls
[ 0.089670] iommu: Default domain type: Translated
[ 0.089719] vgaarb: loaded
[ 0.089801] SCSI subsystem initialized
[ 0.089837] usbcore: registered new interface driver usbfs
[ 0.089848] usbcore: registered new interface driver hub
[ 0.089879] usbcore: registered new device driver usb
[ 0.090040] EDAC MC: Ver: 3.0.0
[ 0.090338] NetLabel: Initializing
[ 0.090342] NetLabel: domain hash size = 128
[ 0.090345] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
[ 0.090359] NetLabel: unlabeled traffic allowed by default
[ 0.091140] clocksource: Switched to clocksource timebase
[ 0.104582] VFS: Disk quotas dquot_6.6.0
[ 0.104616] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.107184] NET: Registered PF_INET protocol family
[ 0.107337] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[ 0.110050] tcp_listen_portaddr_hash hash table entries: 32768 (order: 7, 524288 bytes, linear)
[ 0.110216] TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[ 0.110952] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
[ 0.111044] TCP: Hash tables configured (established 524288 bind 65536)
[ 0.111154] UDP hash table entries: 32768 (order: 8, 1048576 bytes, linear)
[ 0.111252] UDP-Lite hash table entries: 32768 (order: 8, 1048576 bytes, linear)
[ 0.111477] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 0.111486] PCI: CLS 0 bytes, default 128
[ 0.111552] Trying to unpack rootfs image as initramfs...
[ 0.112413] IOMMU table initialized, virtual merging enabled
[ 0.128511] hv-24x7: read 1530 catalog entries, created 509 event attrs (0 failures), 275 descs
[ 0.136073] Initialise system trusted keyrings
[ 0.136166] workingset: timestamp_bits=38 max_order=24 bucket_order=0
[ 0.137613] zbud: loaded
[ 0.158833] NET: Registered PF_ALG protocol family
[ 0.158839] Key type asymmetric registered
[ 0.158842] Asymmetric key parser 'x509' registered
[ 0.158851] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[ 0.158952] io scheduler mq-deadline registered
[ 0.158959] io scheduler kyber registered
[ 0.161625] atomic64_test: passed
[ 0.161667] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 0.162265] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.162635] Non-volatile memory driver v1.3
[ 0.162694] Linux agpgart interface v0.103
[ 0.162865] tpm_ibmvtpm 30000003: CRQ initialization completed
[ 1.192320] rdac: device handler registered
[ 1.192440] hp_sw: device handler registered
[ 1.192444] emc: device handler registered
[ 1.192594] alua: device handler registered
[ 1.192733] libphy: Fixed MDIO Bus: probed
[ 1.192787] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.192803] ehci-pci: EHCI PCI platform driver
[ 1.192816] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 1.192828] ohci-pci: OHCI PCI platform driver
[ 1.192839] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.192884] usbcore: registered new interface driver usbserial_generic
[ 1.192893] usbserial: USB Serial support registered for generic
[ 1.192971] mousedev: PS/2 mouse device common for all mice
[ 1.193091] rtc-generic rtc-generic: registered as rtc0
[ 1.193232] rtc-generic rtc-generic: setting system clock to 2021-06-27T11:12:08 UTC (1624792328)
[ 1.194808] pseries_idle_driver registered
[ 1.194820] hid: raw HID events driver (C) Jiri Kosina
[ 1.194961] usbcore: registered new interface driver usbhid
[ 1.194966] usbhid: USB HID core driver
[ 1.195009] drop_monitor: Initializing network drop monitor service
[ 1.195083] Initializing XFRM netlink socket
[ 1.195207] NET: Registered PF_INET6 protocol family
[ 1.195827] Segment Routing with IPv6
[ 1.195848] NET: Registered PF_PACKET protocol family
[ 1.195854] mpls_gso: MPLS GSO support
[ 1.195889] Running MSI bitmap self-tests ...
[ 1.198345] registered taskstats version 1
[ 1.198365] Loading compiled-in X.509 certificates
[ 1.204435] alg: No test for pkcs1pad(rsa,sha1) (pkcs1pad(rsa-generic,sha1))
[ 1.205115] Loaded X.509 cert 'Build time autogenerated kernel key: 94d0d11f98fad0e99a9eff7ee03c5e8d9a4666eb'
[ 1.205577] zswap: loaded using pool lzo/zbud
[ 1.205760] pstore: Using crash dump compression: deflate
[ 1.211882] Freeing unused kernel image (initmem) memory: 4384K
[ 1.311428] Run /init as init process
[ 1.311439] with arguments:
[ 1.311443] /init
[ 1.311446] with environment:
[ 1.311448] HOME=/
[ 1.311451] TERM=linux
[ 1.311454] BOOT_IMAGE=/boot/vmlinuz-5.13.0-rc7-next-20210625
[ 1.311458] crashkernel=384M-2G:64M,2G-:512M
[ 1.311460] biosdevname=0
[ 1.324807] systemd[1]: systemd 239 (239-45.el8) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy)
[ 1.325133] systemd[1]: Detected architecture ppc64-le.
[ 1.325141] systemd[1]: Running in initial RAM disk.
[ 1.401821] systemd[1]: Set hostname to <ltc-zzci-2.aus.stglabs.ibm.com>.
[ 1.502967] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.503095] systemd[1]: Listening on Journal Socket (/dev/log).
[ 1.503295] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.503307] systemd[1]: Reached target Swap.
[ 1.503428] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.503440] systemd[1]: Reached target Local File Systems.
[ 1.503656] systemd[1]: Listening on Journal Socket.
[ 1.505343] systemd[1]: Starting Journal Service...
[ 1.506418] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 1.579212] fuse: init (API version 7.34)
[ 1.934212] synth uevent: /devices/vio: failed to send uevent
[ 1.934222] vio vio: uevent: failed to send synthetic uevent
[ 1.934308] synth uevent: /devices/vio/4000: failed to send uevent
[ 1.934312] vio 4000: uevent: failed to send synthetic uevent
[ 1.934328] synth uevent: /devices/vio/4001: failed to send uevent
[ 1.934332] vio 4001: uevent: failed to send synthetic uevent
[ 1.934347] synth uevent: /devices/vio/4002: failed to send uevent
[ 1.934351] vio 4002: uevent: failed to send synthetic uevent
[ 1.934366] synth uevent: /devices/vio/4004: failed to send uevent
[ 1.934370] vio 4004: uevent: failed to send synthetic uevent
[ 1.948417] random: fast init done
[ 2.010019] ibmveth: IBM Power Virtual Ethernet Driver 1.06
[ 2.015699] ibmveth 30000002 env2: renamed from eth0
[ 2.015929] ibmvscsi 30000066: SRP_VERSION: 16.a
[ 2.016030] ibmvscsi 30000066: Maximum ID: 64 Maximum LUN: 32 Maximum Channel: 3
[ 2.016037] scsi host0: IBM POWER Virtual SCSI Adapter 1.5.9
[ 2.016220] ibmvscsi 30000066: partner initialization complete
[ 2.016256] ibmvscsi 30000066: host srp version: 16.a, host partition ltc-zzci-vios1 (100), OS 3, max io 1048576
[ 2.016302] ibmvscsi 30000066: Client reserve enabled
[ 2.016311] ibmvscsi 30000066: sent SRP login
[ 2.016337] ibmvscsi 30000066: SRP_LOGIN succeeded
[ 2.042065] scsi 0:0:1:0: Direct-Access AIX VDASD 0001 PQ: 0 ANSI: 3
[ 2.123138] scsi 0:0:1:0: Attached scsi generic sg0 type 0
[ 2.140916] sd 0:0:1:0: [sda] 585105408 512-byte logical blocks: (300 GB/279 GiB)
[ 2.140958] sd 0:0:1:0: [sda] Write Protect is off
[ 2.140965] sd 0:0:1:0: [sda] Mode Sense: 17 00 00 08
[ 2.140998] sd 0:0:1:0: [sda] Cache data unavailable
[ 2.141005] sd 0:0:1:0: [sda] Assuming drive cache: write through
[ 2.251694] sda: sda1 sda2 sda3 sda4 < sda5 >
[ 2.254194] sd 0:0:1:0: [sda] Attached SCSI disk
[ 4.185107] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
[ 5.049039] printk: systemd: 15 output lines suppressed due to ratelimiting
[ 5.499756] SELinux: Runtime disable is deprecated, use selinux=0 on the kernel cmdline.
[ 5.499767] SELinux: Disabled at runtime.
[ 5.671176] audit: type=1404 audit(1624792332.970:2): enforcing=0 old_enforcing=0 auid=4294967295 ses=4294967295 enabled=0 old-enabled=1 lsm=selinux res=1
[ 5.821638] systemd[1]: systemd 239 (239-45.el8) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy)
[ 5.821929] systemd[1]: Detected architecture ppc64-le.
[ 5.831224] systemd[1]: Set hostname to <ltc-zzci-2.aus.stglabs.ibm.com>.
[ 5.885571] random: crng init done
[ 5.885579] random: 7 urandom warning(s) missed due to ratelimiting
[ 6.980906] systemd[1]: systemd-journald.service: Succeeded.
[ 6.987018] systemd[1]: initrd-switch-root.service: Succeeded.
[ 6.987363] systemd[1]: Stopped Switch Root.
[ 6.988010] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart.
[ 6.988108] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
[ 6.988207] systemd[1]: Stopped Journal Service.
[ 6.989344] systemd[1]: Starting Journal Service...
[ 7.148524] EXT4-fs (sda2): re-mounted. Opts: (null). Quota mode: none.
[ 7.196100] Unable to find swap-space signature
[ 7.310654] synth uevent: /devices/vio: failed to send uevent
[ 7.310666] vio vio: uevent: failed to send synthetic uevent
[ 7.310933] synth uevent: /devices/vio/4000: failed to send uevent
[ 7.310937] vio 4000: uevent: failed to send synthetic uevent
[ 7.310953] synth uevent: /devices/vio/4001: failed to send uevent
[ 7.310957] vio 4001: uevent: failed to send synthetic uevent
[ 7.310971] synth uevent: /devices/vio/4002: failed to send uevent
[ 7.310975] vio 4002: uevent: failed to send synthetic uevent
[ 7.310989] synth uevent: /devices/vio/4004: failed to send uevent
[ 7.310993] vio 4004: uevent: failed to send synthetic uevent
[ 8.010469] pseries_rng: Registering IBM pSeries RNG driver
[ 8.399599] ibmveth 30000002 net0: renamed from env2
[ 8.781995] EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
[ 9.351118] ------------[ cut here ]------------
[ 9.351132] cfs_rq->avg.load_avg || cfs_rq->avg.util_avg || cfs_rq->avg.runnable_avg
[ 9.351138] WARNING: CPU: 48 PID: 0 at kernel/sched/fair.c:3308 update_blocked_averages+0x7c8/0x800
[ 9.351151] Modules linked in: pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 9.351178] CPU: 48 PID: 0 Comm: swapper/48 Not tainted 5.13.0-rc7-next-20210625 #1
[ 9.351185] NIP: c0000000001b0a28 LR: c0000000001b0a24 CTR: c000000000721f00
[ 9.351190] REGS: c0000000285b74b0 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
[ 9.351195] MSR: 8000000000029033 <SF,EE,ME,IR,DR,RI,LE> CR: 48000224 XER: 00000005
[ 9.351207] CFAR: c000000000145700 IRQMASK: 1
GPR00: c0000000001b0a24 c0000000285b7750 c000000002921e00 0000000000000048
GPR04: 00000000ffff7fff c0000000285b7410 0000000000000027 c0000008bec07e18
GPR08: 0000000000000023 0000000000000001 0000000000000027 c0000000027ddd18
GPR12: 0000000000000000 c000000007fb6200 c0000008bec1a580 000000000000b971
GPR16: 000000022d5eb98e 00000000000001f7 c00000003ccd0c00 0000000000000000
GPR20: 0000000000000000 c000000002944fe0 0000000000000000 00000000000003cc
GPR24: 0000000000000000 c0000008bec1af90 0000000000000001 c0000008bec1a600
GPR28: 00000000000001f7 c00000003ccd0dc0 c00000003ccd0d00 0000000000000000
[ 9.351266] NIP [c0000000001b0a28] update_blocked_averages+0x7c8/0x800
[ 9.351272] LR [c0000000001b0a24] update_blocked_averages+0x7c4/0x800
[ 9.351277] Call Trace:
[ 9.351279] [c0000000285b7750] [c0000000001b0a24] update_blocked_averages+0x7c4/0x800 (unreliable)
[ 9.351287] [c0000000285b7870] [c0000000001b6aa0] run_rebalance_domains+0xa0/0xd0
[ 9.351294] [c0000000285b78a0] [c000000000cee0cc] __do_softirq+0x15c/0x3d4
[ 9.351301] [c0000000285b7990] [c000000000150f34] irq_exit+0x1d4/0x1e0
[ 9.351308] [c0000000285b79c0] [c000000000029da0] timer_interrupt+0x170/0x360
[ 9.351315] [c0000000285b7a20] [c00000000000998c] decrementer_common_virt+0x1ac/0x1b0
[ 9.351322] --- interrupt: 900 at plpar_hcall_norets_notrace+0x18/0x2c
[ 9.351329] NIP: c0000000000ef808 LR: c000000000a050a8 CTR: 0000000000000000
[ 9.351333] REGS: c0000000285b7a90 TRAP: 0900 Not tainted (5.13.0-rc7-next-20210625)
[ 9.351338] MSR: 800000000280b033 <SF,VEC,VSX,EE,FP,ME,IR,DR,RI,LE> CR: 22000284 XER: 20040000
[ 9.351352] CFAR: 0000000000000c00 IRQMASK: 0
GPR00: 0000000000000000 c0000000285b7d30 c000000002921e00 0000000000000000
GPR04: 0000000000000010 000000002c000040 0000000000000002 0000000000000040
GPR08: 0000000000000000 0000000000000240 0000000000000024 0000000000000000
GPR12: 00000000000c7523 c000000007fb6200 0000000000000000 000000001ef29700
GPR16: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
GPR20: 0000000000000000 0000000000000000 0000000000000000 c000000002865e88
GPR24: 0000000000000001 000000022d5bd4e0 0000000000000000 0000000000000001
GPR28: c0000008bec18fc8 0000000000000001 c000000002110998 c0000000021109a0
[ 9.351412] NIP [c0000000000ef808] plpar_hcall_norets_notrace+0x18/0x2c
[ 9.351417] LR [c000000000a050a8] check_and_cede_processor+0x48/0x60
[ 9.351424] --- interrupt: 900
[ 9.351426] [c0000000285b7d30] [c0000000285b7db0] 0xc0000000285b7db0 (unreliable)
[ 9.351433] [c0000000285b7d90] [c000000000a05368] shared_cede_loop+0x78/0x170
[ 9.351440] [c0000000285b7dd0] [c000000000a01c34] cpuidle_enter_state+0x2e4/0x4e0
[ 9.351446] [c0000000285b7e30] [c000000000a01ed0] cpuidle_enter+0x50/0x70
[ 9.351452] [c0000000285b7e70] [c0000000001a318c] call_cpuidle+0x4c/0x80
[ 9.351460] [c0000000285b7e90] [c0000000001a3810] do_idle+0x380/0x3e0
[ 9.351465] [c0000000285b7f10] [c0000000001a3aec] cpu_startup_entry+0x3c/0x50
[ 9.351471] [c0000000285b7f40] [c0000000000654d0] start_secondary+0x280/0x2a0
[ 9.351479] [c0000000285b7f90] [c00000000000d054] start_secondary_prolog+0x10/0x14
[ 9.351485] Instruction dump:
[ 9.351488] 38635a78 9be9fda5 4bf94c99 60000000 0fe00000 4bfff910 e9210070 e8610088
[ 9.351499] 39400001 99490009 4bf94c79 60000000 <0fe00000> e95201ba 2faa0000 4bfffbd0
[ 9.351509] ---[ end trace 5f1d49fb99f3613b ]---
[ 9.427038] RPC: Registered named UNIX socket transport module.
[ 9.427049] RPC: Registered udp transport module.
[ 9.427052] RPC: Registered tcp transport module.
[ 9.427056] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 18.411772] sysrq: Changing Loglevel
[ 18.411785] sysrq: Loglevel set to 9
[ 19.952501] device-mapper: uevent: version 1.0.3
[ 19.952630] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
[ 92.105621] ------------[ cut here ]------------
[ 92.105650] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
[ 92.105673] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 92.105774] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
[ 92.105789] NIP: c000000000032a00 LR: c00000000000c958 CTR: 000000000049f42c
[ 92.105800] REGS: c00000008dfeb460 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.105812] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28088288 XER: 00000000
[ 92.105846] CFAR: c000000000032814 IRQMASK: 1
GPR00: c00000000000c958 c00000008dfeb700 c000000002921e00 c00000008dfeb7c0
GPR04: 8000000002803033 00000000000064cf 00000000000000d0 ffffffffffffffbf
GPR08: 0000000000000040 0000000000000000 0000000000000003 000000000000000f
GPR12: 0000000000008000 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000007 0000400000000008 0000400000000008 c00000002c464948
GPR20: fcffffffffffffff 000000000001ffff 5455555555555555 00003fffffffffff
GPR24: 00003ffff69ff790 0000000000000000 00003ffff69ff400 0000000000000220
GPR28: 00003ffff69ff3f8 fcffffffffffffff 0000000000000000 c00000008dfeb7c0
[ 92.106004] NIP [c000000000032a00] interrupt_exit_kernel_prepare+0x280/0x2a0
[ 92.106017] LR [c00000000000c958] interrupt_return_srr_user_restart+0x2c/0x110
[ 92.106030] Call Trace:
[ 92.106036] [c00000008dfeb700] [00003ffff69ff400] 0x3ffff69ff400 (unreliable)
[ 92.106049] [c00000008dfeb750] [c00000000000c958] interrupt_return_srr_user_restart+0x2c/0x110
[ 92.106065] --- interrupt: 300 at strnlen_user+0xe0/0x240
[ 92.106076] NIP: c0000000006ff820 LR: c000000000541fc4 CTR: 0000000000003fc3
[ 92.106085] REGS: c00000008dfeb7c0 TRAP: 0300 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106095] MSR: 8000000002803033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 44088222 XER: 00000000
[ 92.106127] CFAR: c0000000006ff844 DAR: 00003ffff6a00000 DSISR: 40000000 IRQMASK: 0
GPR00: c000000000541fc4 c00000008dfeba60 c000000002921e00 0000000000000000
GPR04: 0000000000020000 0000000000020008 00000000000001e8 00003ffff69ffe10
GPR08: 00000000000001f0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000006 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000007 0000400000000008 0000400000000008 c00000002c464948
GPR20: fcffffffffffffff 000000000001ffff 5455555555555555 00003fffffffffff
GPR24: 00003ffff69ff790 0000000000000000 00003ffff69ff400 0000000000000220
GPR28: 00003ffff69ff3f8 00003ffff69ffe16 00003ffff69ff400 c00000002c464800
[ 92.106256] NIP [c0000000006ff820] strnlen_user+0xe0/0x240
[ 92.106267] LR [c000000000541fc4] create_elf_tables.isra.22+0xa04/0xc80
[ 92.106279] --- interrupt: 300
[ 92.106285] [c00000008dfeba60] [c000000000ce91b8] down_read_killable+0x28/0x130 (unreliable)
[ 92.106302] [c00000008dfeba90] [c000000000541fc4] create_elf_tables.isra.22+0xa04/0xc80
[ 92.106315] [c00000008dfebb50] [c000000000543050] load_elf_binary+0xe10/0x1220
[ 92.106329] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
[ 92.106343] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
[ 92.106356] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
[ 92.106368] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
[ 92.106382] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 92.106396] --- interrupt: c00 at 0x3fff9bb6b8a8
[ 92.106405] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
[ 92.106414] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106424] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
[ 92.106454] IRQMASK: 0
GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
[ 92.106579] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
[ 92.106588] LR [00003fff9bb6c240] 0x3fff9bb6c240
[ 92.106596] --- interrupt: c00
[ 92.106602] Instruction dump:
[ 92.106611] 71290001 892d0153 61290001 992d0153 4082000c 392d0138 7c20492a 4bfe362d
[ 92.106631] 60000000 4bfffe34 60000000 60000000 <0fe00000> 4bfffe14 60000000 60000000
[ 92.106654] ---[ end trace 5f1d49fb99f3613c ]---
[ 92.106731] ------------[ cut here ]------------
[ 92.106738] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/irq.c:255 arch_local_irq_restore+0x1d0/0x200
[ 92.106753] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 92.106828] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
[ 92.106841] NIP: c0000000000164d0 LR: c000000000cedaa8 CTR: 0000000000000000
[ 92.106849] REGS: c00000008dfeb7e0 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106859] MSR: 8000000002823033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 28004222 XER: 00000000
[ 92.106892] CFAR: c00000000001632c IRQMASK: 0
GPR00: c000000000ceda98 c00000008dfeba80 c000000002921e00 0000000000000000
GPR04: 0000000000000000 0000000000000000 0000000000000000 00000000000000ff
GPR08: 0000000000000001 0000000000000000 0000000000000001 0000000000000017
GPR12: 0000000024004822 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00003fffa93f8000 0000000000000000 00003fffa93f9300 000000012efb1988
GPR24: 000000012ee7fe7c 000000012efccba0 000000012ee50000 c00000008d5d7600
GPR28: c0000000314c0bc0 c000000040d9f100 c0000008beb5861c 4b72201a3063fe13
[ 92.107024] NIP [c0000000000164d0] arch_local_irq_restore+0x1d0/0x200
[ 92.107035] LR [c000000000cedaa8] _raw_spin_unlock_irqrestore+0x88/0xb0
[ 92.107047] Call Trace:
[ 92.107052] [c00000008dfeba80] [c00000008dfebb50] 0xc00000008dfebb50 (unreliable)
[ 92.107065] [c00000008dfebab0] [238c5bf052df0858] 0x238c5bf052df0858
[ 92.107076] [c00000008dfebae0] [c0000000008178e8] get_random_u64+0x88/0x100
[ 92.107090] [c00000008dfebb20] [c000000000020134] arch_randomize_brk+0xb4/0xd8
[ 92.107105] [c00000008dfebb50] [c0000000005430b0] load_elf_binary+0xe70/0x1220
[ 92.107119] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
[ 92.107132] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
[ 92.107145] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
[ 92.107157] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
[ 92.107169] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 92.107185] --- interrupt: c00 at 0x3fff9bb6b8a8
[ 92.107193] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
[ 92.107202] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.107213] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
[ 92.107243] IRQMASK: 0
GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
[ 92.107369] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
[ 92.107378] LR [00003fff9bb6c240] 0x3fff9bb6c240
[ 92.107386] --- interrupt: c00
[ 92.107393] Instruction dump:
[ 92.107400] 7d2000a6 71298000 40820048 39200000 992d0152 39400000 992d0153 614a8002
[ 92.107427] 7d410164 4bfffe6c 60000000 60000000 <0fe00000> 4bfffe5c 60000000 60000000
[ 92.107451] ---[ end trace 5f1d49fb99f3613d ]---
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
@ 2021-06-27 11:23 ` Sachin Sant
0 siblings, 0 replies; 10+ messages in thread
From: Sachin Sant @ 2021-06-27 11:23 UTC (permalink / raw)
To: Nicholas Piggin; +Cc: linux-next, linuxppc-dev
[-- Attachment #1: Type: text/plain, Size: 5132 bytes --]
> On 27-Jun-2021, at 3:36 PM, Nicholas Piggin <npiggin@gmail.com> wrote:
>>
>> So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
>> what the warning was.
>>
>> I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
>> doesn't get enabled when irqs are restored, or maybe the change to
>> arch_local_irq_restore(). Less likely that the stack got messed up.
>>
>> Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
>
> Nevermind, I think I've found the problem. Some code runs in the
> implicit soft-mask region without expecting to be masked. Working
> on a fix…
:-) . I was able to recreate this after few attempts. It seem the warning isn’t
always triggered during boot. I had to run a kernel compile operation after
boot to trigger this warning again.
In case its helpful here is the additional trace with PPC_IRQ_SOFT_MASK_DEBUG.
[ 92.106731] ------------[ cut here ]------------
[ 92.106738] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/irq.c:255 arch_local_irq_restore+0x1d0/0x200
[ 92.106753] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 92.106828] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
[ 92.106841] NIP: c0000000000164d0 LR: c000000000cedaa8 CTR: 0000000000000000
[ 92.106849] REGS: c00000008dfeb7e0 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106859] MSR: 8000000002823033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 28004222 XER: 00000000
[ 92.106892] CFAR: c00000000001632c IRQMASK: 0
GPR00: c000000000ceda98 c00000008dfeba80 c000000002921e00 0000000000000000
GPR04: 0000000000000000 0000000000000000 0000000000000000 00000000000000ff
GPR08: 0000000000000001 0000000000000000 0000000000000001 0000000000000017
GPR12: 0000000024004822 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00003fffa93f8000 0000000000000000 00003fffa93f9300 000000012efb1988
GPR24: 000000012ee7fe7c 000000012efccba0 000000012ee50000 c00000008d5d7600
GPR28: c0000000314c0bc0 c000000040d9f100 c0000008beb5861c 4b72201a3063fe13
[ 92.107024] NIP [c0000000000164d0] arch_local_irq_restore+0x1d0/0x200
[ 92.107035] LR [c000000000cedaa8] _raw_spin_unlock_irqrestore+0x88/0xb0
[ 92.107047] Call Trace:
[ 92.107052] [c00000008dfeba80] [c00000008dfebb50] 0xc00000008dfebb50 (unreliable)
[ 92.107065] [c00000008dfebab0] [238c5bf052df0858] 0x238c5bf052df0858
[ 92.107076] [c00000008dfebae0] [c0000000008178e8] get_random_u64+0x88/0x100
[ 92.107090] [c00000008dfebb20] [c000000000020134] arch_randomize_brk+0xb4/0xd8
[ 92.107105] [c00000008dfebb50] [c0000000005430b0] load_elf_binary+0xe70/0x1220
[ 92.107119] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
[ 92.107132] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
[ 92.107145] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
[ 92.107157] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
[ 92.107169] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 92.107185] --- interrupt: c00 at 0x3fff9bb6b8a8
[ 92.107193] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
[ 92.107202] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.107213] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
[ 92.107243] IRQMASK: 0
GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
[ 92.107369] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
[ 92.107378] LR [00003fff9bb6c240] 0x3fff9bb6c240
[ 92.107386] --- interrupt: c00
[ 92.107393] Instruction dump:
[ 92.107400] 7d2000a6 71298000 40820048 39200000 992d0152 39400000 992d0153 614a8002
[ 92.107427] 7d410164 4bfffe6c 60000000 60000000 <0fe00000> 4bfffe5c 60000000 60000000
[ 92.107451] ---[ end trace 5f1d49fb99f3613d ]—
Complete dmesg log attached.
Thanks
-Sachin
[-- Attachment #2: next-20210625.txt --]
[-- Type: text/plain, Size: 35026 bytes --]
[ 0.000000] Reserving 512MB of memory at 128MB for crashkernel (System RAM: 35840MB)
[ 0.000000] hash-mmu: Page sizes from device-tree:
[ 0.000000] hash-mmu: base_shift=12: shift=12, sllp=0x0000, avpnm=0x00000000, tlbiel=1, penc=0
[ 0.000000] hash-mmu: base_shift=12: shift=16, sllp=0x0000, avpnm=0x00000000, tlbiel=1, penc=7
[ 0.000000] hash-mmu: base_shift=12: shift=24, sllp=0x0000, avpnm=0x00000000, tlbiel=1, penc=56
[ 0.000000] hash-mmu: base_shift=16: shift=16, sllp=0x0110, avpnm=0x00000000, tlbiel=1, penc=1
[ 0.000000] hash-mmu: base_shift=16: shift=24, sllp=0x0110, avpnm=0x00000000, tlbiel=1, penc=8
[ 0.000000] hash-mmu: base_shift=24: shift=24, sllp=0x0100, avpnm=0x00000001, tlbiel=0, penc=0
[ 0.000000] hash-mmu: base_shift=34: shift=34, sllp=0x0120, avpnm=0x000007ff, tlbiel=0, penc=3
[ 0.000000] Enabling pkeys with max key count 8
[ 0.000000] Activating Kernel Userspace Execution Prevention
[ 0.000000] Activating Kernel Userspace Access Prevention
[ 0.000000] Page orders: linear mapping = 24, virtual = 12, io = 12, vmemmap = 24
[ 0.000000] Using 1TB segments
[ 0.000000] hash-mmu: Initializing hash mmu with SLB
[ 0.000000] Linux version 5.13.0-rc7-next-20210625 (root@ltc-zzci-2.aus.stglabs.ibm.com) (gcc (GCC) 8.4.1 20200928 (Red Hat 8.4.1-1), GNU ld version 2.30-93.el8) #1 SMP Sun Jun 27 05:45:43 CDT 2021
[ 0.000000] Found initrd at 0xc00000000d400000:0xc000000010d118ce
[ 0.000000] Using pSeries machine description
[ 0.000000] printk: bootconsole [udbg0] enabled
[ 0.000000] Partition configured for 96 cpus.
[ 0.000000] CPU maps initialized for 8 threads per core
[ 0.000000] (thread shift is 3)
[ 0.000000] Allocated 3328 bytes for 96 pacas
[ 0.000000] -----------------------------------------------------
[ 0.000000] phys_mem_size = 0x8c0000000
[ 0.000000] dcache_bsize = 0x80
[ 0.000000] icache_bsize = 0x80
[ 0.000000] cpu_features = 0x0001c07b8f5f9187
[ 0.000000] possible = 0x000ffbfbcf5fb187
[ 0.000000] always = 0x0000000380008181
[ 0.000000] cpu_user_features = 0xdc0065c2 0xeff00000
[ 0.000000] mmu_features = 0x7c006e01
[ 0.000000] firmware_features = 0x0000009fc45bfc57
[ 0.000000] vmalloc start = 0xc0003d0000000000
[ 0.000000] IO start = 0xc0003e0000000000
[ 0.000000] vmemmap start = 0xc0003f0000000000
[ 0.000000] hash-mmu: ppc64_pft_size = 0x1c
[ 0.000000] hash-mmu: htab_hash_mask = 0x1fffff
[ 0.000000] -----------------------------------------------------
[ 0.000000] numa: NODE_DATA [mem 0x8bfcd6c80-0x8bfcdbfff]
[ 0.000000] rfi-flush: fallback displacement flush available
[ 0.000000] rfi-flush: mttrig type flush available
[ 0.000000] rfi-flush: patched 14 locations (mttrig type flush)
[ 0.000000] count-cache-flush: flush disabled.
[ 0.000000] link-stack-flush: software flush enabled.
[ 0.000000] entry-flush: patched 61 locations (mttrig type flush)
[ 0.000000] uaccess-flush: patched 1 locations (mttrig type flush)
[ 0.000000] stf-barrier: eieio barrier available
[ 0.000000] stf-barrier: patched 61 entry locations (eieio barrier)
[ 0.000000] stf-barrier: patched 14 exit locations (eieio barrier)
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:0 psize:0 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:0 psize:2 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:0 psize:10 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:2 psize:2 block size:8
[ 0.000000] lpar: H_BLOCK_REMOVE supports base psize:2 psize:10 block size:8
[ 0.000000] PPC64 nvram contains 15360 bytes
[ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
[ 0.000000] barrier-nospec: using ORI speculation barrier
[ 0.000000] barrier-nospec: patched 389 locations
[ 0.000000] Top of RAM: 0x8c0000000, Total RAM: 0x8c0000000
[ 0.000000] Memory hole size: 0MB
[ 0.000000] Zone ranges:
[ 0.000000] Normal [mem 0x0000000000000000-0x00000008bfffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x00000008bfffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000008bfffffff]
[ 0.000000] percpu: Embedded 37 pages/cpu s114456 r0 d37096 u262144
[ 0.000000] pcpu-alloc: s114456 r0 d37096 u262144 alloc=1*1048576
[ 0.000000] pcpu-alloc: [0] 00 01 02 03 [0] 04 05 06 07
[ 0.000000] pcpu-alloc: [0] 08 09 10 11 [0] 12 13 14 15
[ 0.000000] pcpu-alloc: [0] 16 17 18 19 [0] 20 21 22 23
[ 0.000000] pcpu-alloc: [0] 24 25 26 27 [0] 28 29 30 31
[ 0.000000] pcpu-alloc: [0] 32 33 34 35 [0] 36 37 38 39
[ 0.000000] pcpu-alloc: [0] 40 41 42 43 [0] 44 45 46 47
[ 0.000000] pcpu-alloc: [0] 48 49 50 51 [0] 52 53 54 55
[ 0.000000] pcpu-alloc: [0] 56 57 58 59 [0] 60 61 62 63
[ 0.000000] pcpu-alloc: [0] 64 65 66 67 [0] 68 69 70 71
[ 0.000000] pcpu-alloc: [0] 72 73 74 75 [0] 76 77 78 79
[ 0.000000] pcpu-alloc: [0] 80 81 82 83 [0] 84 85 86 87
[ 0.000000] pcpu-alloc: [0] 88 89 90 91 [0] 92 93 94 95
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 9031680
[ 0.000000] Policy zone: Normal
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-5.13.0-rc7-next-20210625 root=UUID=681ebf25-b7c8-49b9-b247-35a96bc8183f ro crashkernel=384M-2G:64M,2G-:512M biosdevname=0
[ 0.000000] Unknown command line parameters: BOOT_IMAGE=/boot/vmlinuz-5.13.0-rc7-next-20210625 crashkernel=384M-2G:64M,2G-:512M biosdevname=0
[ 0.000000] Dentry cache hash table entries: 8388608 (order: 14, 67108864 bytes, linear)
[ 0.000000] Inode-cache hash table entries: 4194304 (order: 13, 33554432 bytes, linear)
[ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.000000] Memory: 35357448K/36700160K available (13252K kernel code, 5244K rwdata, 4064K rodata, 4384K init, 2550K bss, 1342712K reserved, 0K cma-reserved)
[ 0.000000] SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=96, Nodes=2
[ 0.000000] ftrace: allocating 33103 entries in 195 pages
[ 0.000000] ftrace: allocated 194 pages with 3 groups
[ 0.000000] trace event string verifier disabled
[ 0.000000] rcu: Hierarchical RCU implementation.
[ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=2048 to nr_cpu_ids=96.
[ 0.000000] Rude variant of Tasks RCU enabled.
[ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=96
[ 0.000000] NR_IRQS: 512, nr_irqs: 512, preallocated irqs: 16
[ 0.000000] pic: no ISA interrupt controller
[ 0.000000] rcu: Offload RCU callbacks from CPUs: (none).
[ 0.000000] random: get_random_u64 called from start_kernel+0x9b0/0xc10 with crng_init=0
[ 0.000000] time_init: decrementer frequency = 512.000000 MHz
[ 0.000000] time_init: processor frequency = 2900.000000 MHz
[ 0.000002] time_init: 56 bit decrementer (max: 7fffffffffffff)
[ 0.000041] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x761537d007, max_idle_ns: 440795202126 ns
[ 0.000108] clocksource: timebase mult[1f40000] shift[24] registered
[ 0.000152] clockevent: decrementer mult[83126f] shift[24] cpu[0]
[ 0.000242] Console: colour dummy device 80x25
[ 0.000274] printk: console [hvc0] enabled
[ 0.000304] printk: bootconsole [udbg0] disabled
[ 0.000371] pid_max: default: 98304 minimum: 768
[ 0.000434] LSM: Security Framework initializing
[ 0.000454] Yama: becoming mindful.
[ 0.000467] SELinux: Initializing.
[ 0.000602] Mount-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[ 0.000678] Mountpoint-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[ 0.001696] POWER9 performance monitor hardware support registered
[ 0.001737] rcu: Hierarchical SRCU implementation.
[ 0.003750] smp: Bringing up secondary CPUs ...
[ 0.028999] smp: Brought up 1 node, 64 CPUs
[ 0.029008] numa: Node 0 CPUs: 0-63
[ 0.029014] Big cores detected but using small core scheduling
[ 0.030954] devtmpfs: initialized
[ 0.035365] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.035382] futex hash table entries: 32768 (order: 10, 4194304 bytes, linear)
[ 0.035882] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.035994] audit: initializing netlink subsys (disabled)
[ 0.036095] audit: type=2000 audit(1624792326.030:1): state=initialized audit_enabled=0 res=1
[ 0.036166] thermal_sys: Registered thermal governor 'fair_share'
[ 0.036167] thermal_sys: Registered thermal governor 'step_wise'
[ 0.036339] cpuidle: using governor menu
[ 0.036381] RTAS daemon started
[ 0.036607] pstore: Registered nvram as persistent store backend
[ 0.037251] EEH: pSeries platform initialized
[ 0.043241] PCI: Probing PCI hardware
[ 0.043248] EEH: No capable adapters found: recovery disabled.
[ 0.043252] PCI: Probing PCI hardware done
[ 0.043348] pseries-rng: Registering arch random hook.
[ 0.044804] Kprobes globally optimized
[ 0.045174] HugeTLB registered 16.0 MiB page size, pre-allocated 0 pages
[ 0.045181] HugeTLB registered 16.0 GiB page size, pre-allocated 0 pages
[ 0.085299] wait_for_initramfs() called before rootfs_initcalls
[ 0.089670] iommu: Default domain type: Translated
[ 0.089719] vgaarb: loaded
[ 0.089801] SCSI subsystem initialized
[ 0.089837] usbcore: registered new interface driver usbfs
[ 0.089848] usbcore: registered new interface driver hub
[ 0.089879] usbcore: registered new device driver usb
[ 0.090040] EDAC MC: Ver: 3.0.0
[ 0.090338] NetLabel: Initializing
[ 0.090342] NetLabel: domain hash size = 128
[ 0.090345] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
[ 0.090359] NetLabel: unlabeled traffic allowed by default
[ 0.091140] clocksource: Switched to clocksource timebase
[ 0.104582] VFS: Disk quotas dquot_6.6.0
[ 0.104616] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.107184] NET: Registered PF_INET protocol family
[ 0.107337] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[ 0.110050] tcp_listen_portaddr_hash hash table entries: 32768 (order: 7, 524288 bytes, linear)
[ 0.110216] TCP established hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[ 0.110952] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
[ 0.111044] TCP: Hash tables configured (established 524288 bind 65536)
[ 0.111154] UDP hash table entries: 32768 (order: 8, 1048576 bytes, linear)
[ 0.111252] UDP-Lite hash table entries: 32768 (order: 8, 1048576 bytes, linear)
[ 0.111477] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 0.111486] PCI: CLS 0 bytes, default 128
[ 0.111552] Trying to unpack rootfs image as initramfs...
[ 0.112413] IOMMU table initialized, virtual merging enabled
[ 0.128511] hv-24x7: read 1530 catalog entries, created 509 event attrs (0 failures), 275 descs
[ 0.136073] Initialise system trusted keyrings
[ 0.136166] workingset: timestamp_bits=38 max_order=24 bucket_order=0
[ 0.137613] zbud: loaded
[ 0.158833] NET: Registered PF_ALG protocol family
[ 0.158839] Key type asymmetric registered
[ 0.158842] Asymmetric key parser 'x509' registered
[ 0.158851] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[ 0.158952] io scheduler mq-deadline registered
[ 0.158959] io scheduler kyber registered
[ 0.161625] atomic64_test: passed
[ 0.161667] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 0.162265] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.162635] Non-volatile memory driver v1.3
[ 0.162694] Linux agpgart interface v0.103
[ 0.162865] tpm_ibmvtpm 30000003: CRQ initialization completed
[ 1.192320] rdac: device handler registered
[ 1.192440] hp_sw: device handler registered
[ 1.192444] emc: device handler registered
[ 1.192594] alua: device handler registered
[ 1.192733] libphy: Fixed MDIO Bus: probed
[ 1.192787] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.192803] ehci-pci: EHCI PCI platform driver
[ 1.192816] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 1.192828] ohci-pci: OHCI PCI platform driver
[ 1.192839] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.192884] usbcore: registered new interface driver usbserial_generic
[ 1.192893] usbserial: USB Serial support registered for generic
[ 1.192971] mousedev: PS/2 mouse device common for all mice
[ 1.193091] rtc-generic rtc-generic: registered as rtc0
[ 1.193232] rtc-generic rtc-generic: setting system clock to 2021-06-27T11:12:08 UTC (1624792328)
[ 1.194808] pseries_idle_driver registered
[ 1.194820] hid: raw HID events driver (C) Jiri Kosina
[ 1.194961] usbcore: registered new interface driver usbhid
[ 1.194966] usbhid: USB HID core driver
[ 1.195009] drop_monitor: Initializing network drop monitor service
[ 1.195083] Initializing XFRM netlink socket
[ 1.195207] NET: Registered PF_INET6 protocol family
[ 1.195827] Segment Routing with IPv6
[ 1.195848] NET: Registered PF_PACKET protocol family
[ 1.195854] mpls_gso: MPLS GSO support
[ 1.195889] Running MSI bitmap self-tests ...
[ 1.198345] registered taskstats version 1
[ 1.198365] Loading compiled-in X.509 certificates
[ 1.204435] alg: No test for pkcs1pad(rsa,sha1) (pkcs1pad(rsa-generic,sha1))
[ 1.205115] Loaded X.509 cert 'Build time autogenerated kernel key: 94d0d11f98fad0e99a9eff7ee03c5e8d9a4666eb'
[ 1.205577] zswap: loaded using pool lzo/zbud
[ 1.205760] pstore: Using crash dump compression: deflate
[ 1.211882] Freeing unused kernel image (initmem) memory: 4384K
[ 1.311428] Run /init as init process
[ 1.311439] with arguments:
[ 1.311443] /init
[ 1.311446] with environment:
[ 1.311448] HOME=/
[ 1.311451] TERM=linux
[ 1.311454] BOOT_IMAGE=/boot/vmlinuz-5.13.0-rc7-next-20210625
[ 1.311458] crashkernel=384M-2G:64M,2G-:512M
[ 1.311460] biosdevname=0
[ 1.324807] systemd[1]: systemd 239 (239-45.el8) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy)
[ 1.325133] systemd[1]: Detected architecture ppc64-le.
[ 1.325141] systemd[1]: Running in initial RAM disk.
[ 1.401821] systemd[1]: Set hostname to <ltc-zzci-2.aus.stglabs.ibm.com>.
[ 1.502967] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.503095] systemd[1]: Listening on Journal Socket (/dev/log).
[ 1.503295] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.503307] systemd[1]: Reached target Swap.
[ 1.503428] random: systemd: uninitialized urandom read (16 bytes read)
[ 1.503440] systemd[1]: Reached target Local File Systems.
[ 1.503656] systemd[1]: Listening on Journal Socket.
[ 1.505343] systemd[1]: Starting Journal Service...
[ 1.506418] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 1.579212] fuse: init (API version 7.34)
[ 1.934212] synth uevent: /devices/vio: failed to send uevent
[ 1.934222] vio vio: uevent: failed to send synthetic uevent
[ 1.934308] synth uevent: /devices/vio/4000: failed to send uevent
[ 1.934312] vio 4000: uevent: failed to send synthetic uevent
[ 1.934328] synth uevent: /devices/vio/4001: failed to send uevent
[ 1.934332] vio 4001: uevent: failed to send synthetic uevent
[ 1.934347] synth uevent: /devices/vio/4002: failed to send uevent
[ 1.934351] vio 4002: uevent: failed to send synthetic uevent
[ 1.934366] synth uevent: /devices/vio/4004: failed to send uevent
[ 1.934370] vio 4004: uevent: failed to send synthetic uevent
[ 1.948417] random: fast init done
[ 2.010019] ibmveth: IBM Power Virtual Ethernet Driver 1.06
[ 2.015699] ibmveth 30000002 env2: renamed from eth0
[ 2.015929] ibmvscsi 30000066: SRP_VERSION: 16.a
[ 2.016030] ibmvscsi 30000066: Maximum ID: 64 Maximum LUN: 32 Maximum Channel: 3
[ 2.016037] scsi host0: IBM POWER Virtual SCSI Adapter 1.5.9
[ 2.016220] ibmvscsi 30000066: partner initialization complete
[ 2.016256] ibmvscsi 30000066: host srp version: 16.a, host partition ltc-zzci-vios1 (100), OS 3, max io 1048576
[ 2.016302] ibmvscsi 30000066: Client reserve enabled
[ 2.016311] ibmvscsi 30000066: sent SRP login
[ 2.016337] ibmvscsi 30000066: SRP_LOGIN succeeded
[ 2.042065] scsi 0:0:1:0: Direct-Access AIX VDASD 0001 PQ: 0 ANSI: 3
[ 2.123138] scsi 0:0:1:0: Attached scsi generic sg0 type 0
[ 2.140916] sd 0:0:1:0: [sda] 585105408 512-byte logical blocks: (300 GB/279 GiB)
[ 2.140958] sd 0:0:1:0: [sda] Write Protect is off
[ 2.140965] sd 0:0:1:0: [sda] Mode Sense: 17 00 00 08
[ 2.140998] sd 0:0:1:0: [sda] Cache data unavailable
[ 2.141005] sd 0:0:1:0: [sda] Assuming drive cache: write through
[ 2.251694] sda: sda1 sda2 sda3 sda4 < sda5 >
[ 2.254194] sd 0:0:1:0: [sda] Attached SCSI disk
[ 4.185107] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
[ 5.049039] printk: systemd: 15 output lines suppressed due to ratelimiting
[ 5.499756] SELinux: Runtime disable is deprecated, use selinux=0 on the kernel cmdline.
[ 5.499767] SELinux: Disabled at runtime.
[ 5.671176] audit: type=1404 audit(1624792332.970:2): enforcing=0 old_enforcing=0 auid=4294967295 ses=4294967295 enabled=0 old-enabled=1 lsm=selinux res=1
[ 5.821638] systemd[1]: systemd 239 (239-45.el8) running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=legacy)
[ 5.821929] systemd[1]: Detected architecture ppc64-le.
[ 5.831224] systemd[1]: Set hostname to <ltc-zzci-2.aus.stglabs.ibm.com>.
[ 5.885571] random: crng init done
[ 5.885579] random: 7 urandom warning(s) missed due to ratelimiting
[ 6.980906] systemd[1]: systemd-journald.service: Succeeded.
[ 6.987018] systemd[1]: initrd-switch-root.service: Succeeded.
[ 6.987363] systemd[1]: Stopped Switch Root.
[ 6.988010] systemd[1]: systemd-journald.service: Service has no hold-off time (RestartSec=0), scheduling restart.
[ 6.988108] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
[ 6.988207] systemd[1]: Stopped Journal Service.
[ 6.989344] systemd[1]: Starting Journal Service...
[ 7.148524] EXT4-fs (sda2): re-mounted. Opts: (null). Quota mode: none.
[ 7.196100] Unable to find swap-space signature
[ 7.310654] synth uevent: /devices/vio: failed to send uevent
[ 7.310666] vio vio: uevent: failed to send synthetic uevent
[ 7.310933] synth uevent: /devices/vio/4000: failed to send uevent
[ 7.310937] vio 4000: uevent: failed to send synthetic uevent
[ 7.310953] synth uevent: /devices/vio/4001: failed to send uevent
[ 7.310957] vio 4001: uevent: failed to send synthetic uevent
[ 7.310971] synth uevent: /devices/vio/4002: failed to send uevent
[ 7.310975] vio 4002: uevent: failed to send synthetic uevent
[ 7.310989] synth uevent: /devices/vio/4004: failed to send uevent
[ 7.310993] vio 4004: uevent: failed to send synthetic uevent
[ 8.010469] pseries_rng: Registering IBM pSeries RNG driver
[ 8.399599] ibmveth 30000002 net0: renamed from env2
[ 8.781995] EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none.
[ 9.351118] ------------[ cut here ]------------
[ 9.351132] cfs_rq->avg.load_avg || cfs_rq->avg.util_avg || cfs_rq->avg.runnable_avg
[ 9.351138] WARNING: CPU: 48 PID: 0 at kernel/sched/fair.c:3308 update_blocked_averages+0x7c8/0x800
[ 9.351151] Modules linked in: pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 9.351178] CPU: 48 PID: 0 Comm: swapper/48 Not tainted 5.13.0-rc7-next-20210625 #1
[ 9.351185] NIP: c0000000001b0a28 LR: c0000000001b0a24 CTR: c000000000721f00
[ 9.351190] REGS: c0000000285b74b0 TRAP: 0700 Not tainted (5.13.0-rc7-next-20210625)
[ 9.351195] MSR: 8000000000029033 <SF,EE,ME,IR,DR,RI,LE> CR: 48000224 XER: 00000005
[ 9.351207] CFAR: c000000000145700 IRQMASK: 1
GPR00: c0000000001b0a24 c0000000285b7750 c000000002921e00 0000000000000048
GPR04: 00000000ffff7fff c0000000285b7410 0000000000000027 c0000008bec07e18
GPR08: 0000000000000023 0000000000000001 0000000000000027 c0000000027ddd18
GPR12: 0000000000000000 c000000007fb6200 c0000008bec1a580 000000000000b971
GPR16: 000000022d5eb98e 00000000000001f7 c00000003ccd0c00 0000000000000000
GPR20: 0000000000000000 c000000002944fe0 0000000000000000 00000000000003cc
GPR24: 0000000000000000 c0000008bec1af90 0000000000000001 c0000008bec1a600
GPR28: 00000000000001f7 c00000003ccd0dc0 c00000003ccd0d00 0000000000000000
[ 9.351266] NIP [c0000000001b0a28] update_blocked_averages+0x7c8/0x800
[ 9.351272] LR [c0000000001b0a24] update_blocked_averages+0x7c4/0x800
[ 9.351277] Call Trace:
[ 9.351279] [c0000000285b7750] [c0000000001b0a24] update_blocked_averages+0x7c4/0x800 (unreliable)
[ 9.351287] [c0000000285b7870] [c0000000001b6aa0] run_rebalance_domains+0xa0/0xd0
[ 9.351294] [c0000000285b78a0] [c000000000cee0cc] __do_softirq+0x15c/0x3d4
[ 9.351301] [c0000000285b7990] [c000000000150f34] irq_exit+0x1d4/0x1e0
[ 9.351308] [c0000000285b79c0] [c000000000029da0] timer_interrupt+0x170/0x360
[ 9.351315] [c0000000285b7a20] [c00000000000998c] decrementer_common_virt+0x1ac/0x1b0
[ 9.351322] --- interrupt: 900 at plpar_hcall_norets_notrace+0x18/0x2c
[ 9.351329] NIP: c0000000000ef808 LR: c000000000a050a8 CTR: 0000000000000000
[ 9.351333] REGS: c0000000285b7a90 TRAP: 0900 Not tainted (5.13.0-rc7-next-20210625)
[ 9.351338] MSR: 800000000280b033 <SF,VEC,VSX,EE,FP,ME,IR,DR,RI,LE> CR: 22000284 XER: 20040000
[ 9.351352] CFAR: 0000000000000c00 IRQMASK: 0
GPR00: 0000000000000000 c0000000285b7d30 c000000002921e00 0000000000000000
GPR04: 0000000000000010 000000002c000040 0000000000000002 0000000000000040
GPR08: 0000000000000000 0000000000000240 0000000000000024 0000000000000000
GPR12: 00000000000c7523 c000000007fb6200 0000000000000000 000000001ef29700
GPR16: 0000000000000000 0000000000000000 0000000000000000 0000000000000000
GPR20: 0000000000000000 0000000000000000 0000000000000000 c000000002865e88
GPR24: 0000000000000001 000000022d5bd4e0 0000000000000000 0000000000000001
GPR28: c0000008bec18fc8 0000000000000001 c000000002110998 c0000000021109a0
[ 9.351412] NIP [c0000000000ef808] plpar_hcall_norets_notrace+0x18/0x2c
[ 9.351417] LR [c000000000a050a8] check_and_cede_processor+0x48/0x60
[ 9.351424] --- interrupt: 900
[ 9.351426] [c0000000285b7d30] [c0000000285b7db0] 0xc0000000285b7db0 (unreliable)
[ 9.351433] [c0000000285b7d90] [c000000000a05368] shared_cede_loop+0x78/0x170
[ 9.351440] [c0000000285b7dd0] [c000000000a01c34] cpuidle_enter_state+0x2e4/0x4e0
[ 9.351446] [c0000000285b7e30] [c000000000a01ed0] cpuidle_enter+0x50/0x70
[ 9.351452] [c0000000285b7e70] [c0000000001a318c] call_cpuidle+0x4c/0x80
[ 9.351460] [c0000000285b7e90] [c0000000001a3810] do_idle+0x380/0x3e0
[ 9.351465] [c0000000285b7f10] [c0000000001a3aec] cpu_startup_entry+0x3c/0x50
[ 9.351471] [c0000000285b7f40] [c0000000000654d0] start_secondary+0x280/0x2a0
[ 9.351479] [c0000000285b7f90] [c00000000000d054] start_secondary_prolog+0x10/0x14
[ 9.351485] Instruction dump:
[ 9.351488] 38635a78 9be9fda5 4bf94c99 60000000 0fe00000 4bfff910 e9210070 e8610088
[ 9.351499] 39400001 99490009 4bf94c79 60000000 <0fe00000> e95201ba 2faa0000 4bfffbd0
[ 9.351509] ---[ end trace 5f1d49fb99f3613b ]---
[ 9.427038] RPC: Registered named UNIX socket transport module.
[ 9.427049] RPC: Registered udp transport module.
[ 9.427052] RPC: Registered tcp transport module.
[ 9.427056] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 18.411772] sysrq: Changing Loglevel
[ 18.411785] sysrq: Loglevel set to 9
[ 19.952501] device-mapper: uevent: version 1.0.3
[ 19.952630] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
[ 92.105621] ------------[ cut here ]------------
[ 92.105650] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/interrupt.c:518 interrupt_exit_kernel_prepare+0x280/0x2a0
[ 92.105673] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 92.105774] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
[ 92.105789] NIP: c000000000032a00 LR: c00000000000c958 CTR: 000000000049f42c
[ 92.105800] REGS: c00000008dfeb460 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.105812] MSR: 8000000000021033 <SF,ME,IR,DR,RI,LE> CR: 28088288 XER: 00000000
[ 92.105846] CFAR: c000000000032814 IRQMASK: 1
GPR00: c00000000000c958 c00000008dfeb700 c000000002921e00 c00000008dfeb7c0
GPR04: 8000000002803033 00000000000064cf 00000000000000d0 ffffffffffffffbf
GPR08: 0000000000000040 0000000000000000 0000000000000003 000000000000000f
GPR12: 0000000000008000 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000007 0000400000000008 0000400000000008 c00000002c464948
GPR20: fcffffffffffffff 000000000001ffff 5455555555555555 00003fffffffffff
GPR24: 00003ffff69ff790 0000000000000000 00003ffff69ff400 0000000000000220
GPR28: 00003ffff69ff3f8 fcffffffffffffff 0000000000000000 c00000008dfeb7c0
[ 92.106004] NIP [c000000000032a00] interrupt_exit_kernel_prepare+0x280/0x2a0
[ 92.106017] LR [c00000000000c958] interrupt_return_srr_user_restart+0x2c/0x110
[ 92.106030] Call Trace:
[ 92.106036] [c00000008dfeb700] [00003ffff69ff400] 0x3ffff69ff400 (unreliable)
[ 92.106049] [c00000008dfeb750] [c00000000000c958] interrupt_return_srr_user_restart+0x2c/0x110
[ 92.106065] --- interrupt: 300 at strnlen_user+0xe0/0x240
[ 92.106076] NIP: c0000000006ff820 LR: c000000000541fc4 CTR: 0000000000003fc3
[ 92.106085] REGS: c00000008dfeb7c0 TRAP: 0300 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106095] MSR: 8000000002803033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 44088222 XER: 00000000
[ 92.106127] CFAR: c0000000006ff844 DAR: 00003ffff6a00000 DSISR: 40000000 IRQMASK: 0
GPR00: c000000000541fc4 c00000008dfeba60 c000000002921e00 0000000000000000
GPR04: 0000000000020000 0000000000020008 00000000000001e8 00003ffff69ffe10
GPR08: 00000000000001f0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000006 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000007 0000400000000008 0000400000000008 c00000002c464948
GPR20: fcffffffffffffff 000000000001ffff 5455555555555555 00003fffffffffff
GPR24: 00003ffff69ff790 0000000000000000 00003ffff69ff400 0000000000000220
GPR28: 00003ffff69ff3f8 00003ffff69ffe16 00003ffff69ff400 c00000002c464800
[ 92.106256] NIP [c0000000006ff820] strnlen_user+0xe0/0x240
[ 92.106267] LR [c000000000541fc4] create_elf_tables.isra.22+0xa04/0xc80
[ 92.106279] --- interrupt: 300
[ 92.106285] [c00000008dfeba60] [c000000000ce91b8] down_read_killable+0x28/0x130 (unreliable)
[ 92.106302] [c00000008dfeba90] [c000000000541fc4] create_elf_tables.isra.22+0xa04/0xc80
[ 92.106315] [c00000008dfebb50] [c000000000543050] load_elf_binary+0xe10/0x1220
[ 92.106329] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
[ 92.106343] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
[ 92.106356] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
[ 92.106368] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
[ 92.106382] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 92.106396] --- interrupt: c00 at 0x3fff9bb6b8a8
[ 92.106405] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
[ 92.106414] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106424] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
[ 92.106454] IRQMASK: 0
GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
[ 92.106579] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
[ 92.106588] LR [00003fff9bb6c240] 0x3fff9bb6c240
[ 92.106596] --- interrupt: c00
[ 92.106602] Instruction dump:
[ 92.106611] 71290001 892d0153 61290001 992d0153 4082000c 392d0138 7c20492a 4bfe362d
[ 92.106631] 60000000 4bfffe34 60000000 60000000 <0fe00000> 4bfffe14 60000000 60000000
[ 92.106654] ---[ end trace 5f1d49fb99f3613c ]---
[ 92.106731] ------------[ cut here ]------------
[ 92.106738] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/irq.c:255 arch_local_irq_restore+0x1d0/0x200
[ 92.106753] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
[ 92.106828] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
[ 92.106841] NIP: c0000000000164d0 LR: c000000000cedaa8 CTR: 0000000000000000
[ 92.106849] REGS: c00000008dfeb7e0 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.106859] MSR: 8000000002823033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 28004222 XER: 00000000
[ 92.106892] CFAR: c00000000001632c IRQMASK: 0
GPR00: c000000000ceda98 c00000008dfeba80 c000000002921e00 0000000000000000
GPR04: 0000000000000000 0000000000000000 0000000000000000 00000000000000ff
GPR08: 0000000000000001 0000000000000000 0000000000000001 0000000000000017
GPR12: 0000000024004822 c000000007fb9200 000000012efd81d4 000000012ee50000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00003fffa93f8000 0000000000000000 00003fffa93f9300 000000012efb1988
GPR24: 000000012ee7fe7c 000000012efccba0 000000012ee50000 c00000008d5d7600
GPR28: c0000000314c0bc0 c000000040d9f100 c0000008beb5861c 4b72201a3063fe13
[ 92.107024] NIP [c0000000000164d0] arch_local_irq_restore+0x1d0/0x200
[ 92.107035] LR [c000000000cedaa8] _raw_spin_unlock_irqrestore+0x88/0xb0
[ 92.107047] Call Trace:
[ 92.107052] [c00000008dfeba80] [c00000008dfebb50] 0xc00000008dfebb50 (unreliable)
[ 92.107065] [c00000008dfebab0] [238c5bf052df0858] 0x238c5bf052df0858
[ 92.107076] [c00000008dfebae0] [c0000000008178e8] get_random_u64+0x88/0x100
[ 92.107090] [c00000008dfebb20] [c000000000020134] arch_randomize_brk+0xb4/0xd8
[ 92.107105] [c00000008dfebb50] [c0000000005430b0] load_elf_binary+0xe70/0x1220
[ 92.107119] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
[ 92.107132] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
[ 92.107145] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
[ 92.107157] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
[ 92.107169] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
[ 92.107185] --- interrupt: c00 at 0x3fff9bb6b8a8
[ 92.107193] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
[ 92.107202] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
[ 92.107213] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
[ 92.107243] IRQMASK: 0
GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
[ 92.107369] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
[ 92.107378] LR [00003fff9bb6c240] 0x3fff9bb6c240
[ 92.107386] --- interrupt: c00
[ 92.107393] Instruction dump:
[ 92.107400] 7d2000a6 71298000 40820048 39200000 992d0152 39400000 992d0153 614a8002
[ 92.107427] 7d410164 4bfffe6c 60000000 60000000 <0fe00000> 4bfffe5c 60000000 60000000
[ 92.107451] ---[ end trace 5f1d49fb99f3613d ]---
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
2021-06-27 11:23 ` Sachin Sant
@ 2021-06-28 3:52 ` Nicholas Piggin
-1 siblings, 0 replies; 10+ messages in thread
From: Nicholas Piggin @ 2021-06-28 3:52 UTC (permalink / raw)
To: Sachin Sant; +Cc: linux-next, linuxppc-dev, Michael Ellerman
Excerpts from Sachin Sant's message of June 27, 2021 9:23 pm:
>
>> On 27-Jun-2021, at 3:36 PM, Nicholas Piggin <npiggin@gmail.com> wrote:
>>>
>>> So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
>>> what the warning was.
>>>
>>> I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
>>> doesn't get enabled when irqs are restored, or maybe the change to
>>> arch_local_irq_restore(). Less likely that the stack got messed up.
>>>
>>> Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
>>
>> Nevermind, I think I've found the problem. Some code runs in the
>> implicit soft-mask region without expecting to be masked. Working
>> on a fix…
>
> :-) . I was able to recreate this after few attempts. It seem the warning isn’t
> always triggered during boot. I had to run a kernel compile operation after
> boot to trigger this warning again.
>
> In case its helpful here is the additional trace with PPC_IRQ_SOFT_MASK_DEBUG.
Thanks. I ended up being able to reproduce as well, quite frequently
with some extra debug checks that specifically catch more cases.
I've got a few patches under test right now, very stable so far. I'll
post them out if they survive a nother hour or two stress testing.
The problem is some code (e.g., ret_from_fork) now gets implicitly
soft-masked where that was not expecting to be. A masked interrupt might
hit, and then when it moves out of the implicit soft-mask region it
does not re-enable interrupts. Some types of pending interrupts will
clear MSR[EE], and that ends up causing this bug on the next interrupt
that happens.
Not a wonderful escape :\ thanks for finding it. The fixes aren't too
bad, fortunately.
Thanks,
Nick
>
> [ 92.106731] ------------[ cut here ]------------
> [ 92.106738] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/irq.c:255 arch_local_irq_restore+0x1d0/0x200
> [ 92.106753] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
> [ 92.106828] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
> [ 92.106841] NIP: c0000000000164d0 LR: c000000000cedaa8 CTR: 0000000000000000
> [ 92.106849] REGS: c00000008dfeb7e0 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
> [ 92.106859] MSR: 8000000002823033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 28004222 XER: 00000000
> [ 92.106892] CFAR: c00000000001632c IRQMASK: 0
> GPR00: c000000000ceda98 c00000008dfeba80 c000000002921e00 0000000000000000
> GPR04: 0000000000000000 0000000000000000 0000000000000000 00000000000000ff
> GPR08: 0000000000000001 0000000000000000 0000000000000001 0000000000000017
> GPR12: 0000000024004822 c000000007fb9200 000000012efd81d4 000000012ee50000
> GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
> GPR20: 00003fffa93f8000 0000000000000000 00003fffa93f9300 000000012efb1988
> GPR24: 000000012ee7fe7c 000000012efccba0 000000012ee50000 c00000008d5d7600
> GPR28: c0000000314c0bc0 c000000040d9f100 c0000008beb5861c 4b72201a3063fe13
> [ 92.107024] NIP [c0000000000164d0] arch_local_irq_restore+0x1d0/0x200
> [ 92.107035] LR [c000000000cedaa8] _raw_spin_unlock_irqrestore+0x88/0xb0
> [ 92.107047] Call Trace:
> [ 92.107052] [c00000008dfeba80] [c00000008dfebb50] 0xc00000008dfebb50 (unreliable)
> [ 92.107065] [c00000008dfebab0] [238c5bf052df0858] 0x238c5bf052df0858
> [ 92.107076] [c00000008dfebae0] [c0000000008178e8] get_random_u64+0x88/0x100
> [ 92.107090] [c00000008dfebb20] [c000000000020134] arch_randomize_brk+0xb4/0xd8
> [ 92.107105] [c00000008dfebb50] [c0000000005430b0] load_elf_binary+0xe70/0x1220
> [ 92.107119] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
> [ 92.107132] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
> [ 92.107145] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
> [ 92.107157] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
> [ 92.107169] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
> [ 92.107185] --- interrupt: c00 at 0x3fff9bb6b8a8
> [ 92.107193] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
> [ 92.107202] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
> [ 92.107213] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
> [ 92.107243] IRQMASK: 0
> GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
> GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
> GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
> GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
> GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
> GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
> GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
> GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
> [ 92.107369] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
> [ 92.107378] LR [00003fff9bb6c240] 0x3fff9bb6c240
> [ 92.107386] --- interrupt: c00
> [ 92.107393] Instruction dump:
> [ 92.107400] 7d2000a6 71298000 40820048 39200000 992d0152 39400000 992d0153 614a8002
> [ 92.107427] 7d410164 4bfffe6c 60000000 60000000 <0fe00000> 4bfffe5c 60000000 60000000
> [ 92.107451] ---[ end trace 5f1d49fb99f3613d ]—
>
> Complete dmesg log attached.
>
> Thanks
> -Sachin
>
>
^ permalink raw reply [flat|nested] 10+ messages in thread
* Re: [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot
@ 2021-06-28 3:52 ` Nicholas Piggin
0 siblings, 0 replies; 10+ messages in thread
From: Nicholas Piggin @ 2021-06-28 3:52 UTC (permalink / raw)
To: Sachin Sant; +Cc: linux-next, linuxppc-dev
Excerpts from Sachin Sant's message of June 27, 2021 9:23 pm:
>
>> On 27-Jun-2021, at 3:36 PM, Nicholas Piggin <npiggin@gmail.com> wrote:
>>>
>>> So there's definitely IRQMASK=0 and no MSR[EE]=0 in this frame, which is
>>> what the warning was.
>>>
>>> I'd say either something hasn't set PACA_IRQ_HARD_DIS properly, so EE
>>> doesn't get enabled when irqs are restored, or maybe the change to
>>> arch_local_irq_restore(). Less likely that the stack got messed up.
>>>
>>> Can you try run with CONFIG_PPC_IRQ_SOFT_MASK_DEBUG=y ?
>>
>> Nevermind, I think I've found the problem. Some code runs in the
>> implicit soft-mask region without expecting to be masked. Working
>> on a fix…
>
> :-) . I was able to recreate this after few attempts. It seem the warning isn’t
> always triggered during boot. I had to run a kernel compile operation after
> boot to trigger this warning again.
>
> In case its helpful here is the additional trace with PPC_IRQ_SOFT_MASK_DEBUG.
Thanks. I ended up being able to reproduce as well, quite frequently
with some extra debug checks that specifically catch more cases.
I've got a few patches under test right now, very stable so far. I'll
post them out if they survive a nother hour or two stress testing.
The problem is some code (e.g., ret_from_fork) now gets implicitly
soft-masked where that was not expecting to be. A masked interrupt might
hit, and then when it moves out of the implicit soft-mask region it
does not re-enable interrupts. Some types of pending interrupts will
clear MSR[EE], and that ends up causing this bug on the next interrupt
that happens.
Not a wonderful escape :\ thanks for finding it. The fixes aren't too
bad, fortunately.
Thanks,
Nick
>
> [ 92.106731] ------------[ cut here ]------------
> [ 92.106738] WARNING: CPU: 45 PID: 12757 at arch/powerpc/kernel/irq.c:255 arch_local_irq_restore+0x1d0/0x200
> [ 92.106753] Modules linked in: dm_mod bonding nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip_set rfkill nf_tables libcrc32c nfnetlink sunrpc pseries_rng xts vmx_crypto uio_pdrv_genirq uio sch_fq_codel ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg ibmvscsi ibmveth scsi_transport_srp fuse
> [ 92.106828] CPU: 45 PID: 12757 Comm: sh Kdump: loaded Tainted: G W 5.13.0-rc7-next-20210625 #1
> [ 92.106841] NIP: c0000000000164d0 LR: c000000000cedaa8 CTR: 0000000000000000
> [ 92.106849] REGS: c00000008dfeb7e0 TRAP: 0700 Tainted: G W (5.13.0-rc7-next-20210625)
> [ 92.106859] MSR: 8000000002823033 <SF,VEC,VSX,FP,ME,IR,DR,RI,LE> CR: 28004222 XER: 00000000
> [ 92.106892] CFAR: c00000000001632c IRQMASK: 0
> GPR00: c000000000ceda98 c00000008dfeba80 c000000002921e00 0000000000000000
> GPR04: 0000000000000000 0000000000000000 0000000000000000 00000000000000ff
> GPR08: 0000000000000001 0000000000000000 0000000000000001 0000000000000017
> GPR12: 0000000024004822 c000000007fb9200 000000012efd81d4 000000012ee50000
> GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
> GPR20: 00003fffa93f8000 0000000000000000 00003fffa93f9300 000000012efb1988
> GPR24: 000000012ee7fe7c 000000012efccba0 000000012ee50000 c00000008d5d7600
> GPR28: c0000000314c0bc0 c000000040d9f100 c0000008beb5861c 4b72201a3063fe13
> [ 92.107024] NIP [c0000000000164d0] arch_local_irq_restore+0x1d0/0x200
> [ 92.107035] LR [c000000000cedaa8] _raw_spin_unlock_irqrestore+0x88/0xb0
> [ 92.107047] Call Trace:
> [ 92.107052] [c00000008dfeba80] [c00000008dfebb50] 0xc00000008dfebb50 (unreliable)
> [ 92.107065] [c00000008dfebab0] [238c5bf052df0858] 0x238c5bf052df0858
> [ 92.107076] [c00000008dfebae0] [c0000000008178e8] get_random_u64+0x88/0x100
> [ 92.107090] [c00000008dfebb20] [c000000000020134] arch_randomize_brk+0xb4/0xd8
> [ 92.107105] [c00000008dfebb50] [c0000000005430b0] load_elf_binary+0xe70/0x1220
> [ 92.107119] [c00000008dfebc40] [c00000000047ded0] bprm_execve+0x410/0x800
> [ 92.107132] [c00000008dfebd10] [c00000000047e8ec] do_execveat_common.isra.44+0x21c/0x240
> [ 92.107145] [c00000008dfebd80] [c00000000047e964] sys_execve+0x54/0x70
> [ 92.107157] [c00000008dfebdb0] [c000000000032334] system_call_exception+0x164/0x2e0
> [ 92.107169] [c00000008dfebe10] [c00000000000c464] system_call_common+0xf4/0x258
> [ 92.107185] --- interrupt: c00 at 0x3fff9bb6b8a8
> [ 92.107193] NIP: 00003fff9bb6b8a8 LR: 00003fff9bb6c240 CTR: 0000000000000000
> [ 92.107202] REGS: c00000008dfebe80 TRAP: 0c00 Tainted: G W (5.13.0-rc7-next-20210625)
> [ 92.107213] MSR: 800000000000f033 <SF,EE,PR,FP,ME,IR,DR,RI,LE> CR: 28004224 XER: 00000000
> [ 92.107243] IRQMASK: 0
> GPR00: 000000000000000b 00003fffc36a1440 00003fff9bc87300 00000100268a67d0
> GPR04: 0000010026887e50 0000010026882c50 fefefefefefefeff 7f7f7f7f7f7f7f7f
> GPR08: 00000100268a67d0 0000000000000000 0000000000000000 0000000000000000
> GPR12: 0000000000000000 00003fff9bce3780 0000000114200db4 0000000000000000
> GPR16: 0000000000000001 00000100268a0e00 000001002687ec10 0000000114200c40
> GPR20: 00000001141dd820 0000000000000000 00000001141dd740 0000000114204358
> GPR24: 0000000114203948 0000010026876454 0000000000000001 0000010026882c50
> GPR28: 0000010026887e50 0000010026882c50 00000100268a67d0 00003fffc36a1440
> [ 92.107369] NIP [00003fff9bb6b8a8] 0x3fff9bb6b8a8
> [ 92.107378] LR [00003fff9bb6c240] 0x3fff9bb6c240
> [ 92.107386] --- interrupt: c00
> [ 92.107393] Instruction dump:
> [ 92.107400] 7d2000a6 71298000 40820048 39200000 992d0152 39400000 992d0153 614a8002
> [ 92.107427] 7d410164 4bfffe6c 60000000 60000000 <0fe00000> 4bfffe5c 60000000 60000000
> [ 92.107451] ---[ end trace 5f1d49fb99f3613d ]—
>
> Complete dmesg log attached.
>
> Thanks
> -Sachin
>
>
^ permalink raw reply [flat|nested] 10+ messages in thread
end of thread, other threads:[~2021-06-28 3:52 UTC | newest]
Thread overview: 10+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2021-06-26 13:52 [powerpc][next-20210625] Kernel warning(arch/powerpc/kernel/interrupt.c:518) during boot Sachin Sant
2021-06-26 13:52 ` Sachin Sant
2021-06-26 18:57 ` Nicholas Piggin
2021-06-26 18:57 ` Nicholas Piggin
2021-06-27 10:06 ` Nicholas Piggin
2021-06-27 10:06 ` Nicholas Piggin
2021-06-27 11:23 ` Sachin Sant
2021-06-27 11:23 ` Sachin Sant
2021-06-28 3:52 ` Nicholas Piggin
2021-06-28 3:52 ` Nicholas Piggin
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.