Re: [PATCH RFC] binfmt_elf: fully allocate bss pages

From: kernel test robot
Date: Mon Sep 18 2023 - 11:49:56 EST

Next message: Paul Durrant: "[PATCH v3 00/13] KVM: xen: update shared_info and vcpu_info handling"
Previous message: David Gstir: "[PATCH v3 2/3] KEYS: trusted: Introduce support for NXP DCP-based trusted keys"
Next in thread: Sebastian Ott: "Re: [PATCH RFC] binfmt_elf: fully allocate bss pages"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]

Hello,

kernel test robot noticed "segfault_at_ip_sp_error" on:

commit: 13bd7a228b281e5cef2f51a236cafaa3400592a5 ("[PATCH RFC] binfmt_elf: fully allocate bss pages")
url: https://github.com/intel-lab-lkp/linux/commits/Thomas-Wei-schuh/binfmt_elf-fully-allocate-bss-pages/20230915-000102
patch link: https://lore.kernel.org/all/20230914-bss-alloc-v1-1-78de67d2c6dd@xxxxxxxxxxxxxx/
patch subject: [PATCH RFC] binfmt_elf: fully allocate bss pages

in testcase: boot

compiler: gcc-12
test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G

(please refer to attached dmesg/kmsg for entire log/backtrace)

If you fix the issue in a separate patch/commit (i.e. not just a new version of
the same patch/commit), kindly add following tags
| Reported-by: kernel test robot <oliver.sang@xxxxxxxxx>
| Closes: https://lore.kernel.org/oe-lkp/202309181644.1932ad53-oliver.sang@xxxxxxxxx

[ 11.004901][ T1] ### dt-test ### EXPECT_NOT / : WARNING: <<all>>
[ 11.005947][ T1] ### dt-test ### EXPECT_NOT / : ------------[ cut here ]------------
[ 11.006784][ T1] ### dt-test ### pass of_unittest_lifecycle():3252
[ 11.008735][ T1] ### dt-test ### pass of_unittest_lifecycle():3253
[ 11.009666][ T1] ### dt-test ### pass of_unittest_check_tree_linkage():271
[ 11.010598][ T1] ### dt-test ### pass of_unittest_check_tree_linkage():272
[ 11.011531][ T1] ### dt-test ### FAIL of_unittest_overlay_high_level():3542 overlay_base_root not initialized
[ 11.012852][ T1] ### dt-test ### end of unittest - 303 passed, 1 failed
[ 11.022721][ T39] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[ 11.042019][ T1] Sending DHCP requests ., OK
[ 12.032757][ T1] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15
[ 12.033736][ T1] IP-Config: Complete:
[ 12.034229][ T1] device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2
[ 12.035554][ T1] host=vm-meta-36, domain=, nis-domain=(none)
[ 12.036331][ T1] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath=
[ 12.036337][ T1] nameserver0=10.0.2.3
[ 12.038817][ T1] clk: Disabling unused clocks
[ 12.041570][ T1] Freeing unused kernel image (initmem) memory: 1036K
[ 12.059292][ T1] Write protecting kernel text and read-only data: 10632k
[ 12.075444][ T1] Run /init as init process
[ 12.075883][ T1] with arguments:
[ 12.076211][ T1] /init
[ 12.076481][ T1] with environment:
[ 12.076818][ T1] HOME=/
[ 12.077095][ T1] TERM=linux
[ 12.077397][ T1] RESULT_ROOT=/result/boot/1/vm-snb/debian-11.1-i386-20220923.cgz/i386-randconfig-016-20230915/gcc-12/13bd7a228b281e5cef2f51a236cafaa3400592a5/5
[ 12.078684][ T1] BOOT_IMAGE=/pkg/linux/i386-randconfig-016-20230915/gcc-12/13bd7a228b281e5cef2f51a236cafaa3400592a5/vmlinuz-6.6.0-rc1-00073-g13bd7a228b28
[ 12.079910][ T1] branch=linux-review/Thomas-Wei-schuh/binfmt_elf-fully-allocate-bss-pages/20230915-000102
[ 12.080775][ T1] job=/lkp/jobs/scheduled/vm-meta-36/boot-1-debian-11.1-i386-20220923.cgz-i386-randconfig-016-20230915-13bd7a228b28-20230917-97632-11h3y6y-5.yaml
[ 12.082051][ T1] user=lkp
[ 12.082345][ T1] ARCH=i386
[ 12.082639][ T1] kconfig=i386-randconfig-016-20230915
[ 12.083177][ T1] commit=13bd7a228b281e5cef2f51a236cafaa3400592a5
[ 12.083743][ T1] max_uptime=600
[ 12.084074][ T1] LKP_SERVER=internal-lkp-server
[ 12.084522][ T1] selinux=0
[ 12.084820][ T1] softlockup_panic=1
[ 12.085181][ T1] prompt_ramdisk=0
[ 12.085551][ T1] vga=normal
[ 12.117728][ T1] [1]: RTC configured in localtime, applying delta of 0 minutes to system time.

Welcome to Debian GNU/Linux 11 (bullseye)!

[ 12.189049][ T58] process 58 ((sd-executor)) attempted a POSIX timer syscall while CONFIG_POSIX_TIMERS is not set
[ 12.234253][ T63] systemd-getty-g[63]: segfault at 484771 ip 00480047 sp bffb6e4c error 7 in true[480000+1000] likely on CPU 0 (core 0, socket 0)
[ 12.242969][ T63] Code: 00 00 00 b8 82 00 00 00 00 00 00 34 00 20 00 0b 00 28 00 1e 00 1d 00 06 00 00 00 34 00 00 00 34 00 00 00 34 00 00 00 60 01 00 <00> 60 01 00 00 04 00 00 00 04 00 00 00 03 00 00 00 94 01 00 00 94
All code
========
0: 00 00 add %al,(%rax)
2: 00 b8 82 00 00 00 add %bh,0x82(%rax)
8: 00 00 add %al,(%rax)
a: 00 34 00 add %dh,(%rax,%rax,1)
d: 20 00 and %al,(%rax)
f: 0b 00 or (%rax),%eax
11: 28 00 sub %al,(%rax)
13: 1e (bad)
14: 00 1d 00 06 00 00 add %bl,0x600(%rip) # 0x61a
1a: 00 34 00 add %dh,(%rax,%rax,1)
1d: 00 00 add %al,(%rax)
1f: 34 00 xor $0x0,%al
21: 00 00 add %al,(%rax)
23: 34 00 xor $0x0,%al
25: 00 00 add %al,(%rax)
27: 60 (bad)
28: 01 00 add %eax,(%rax)
2a:* 00 60 01 add %ah,0x1(%rax) <-- trapping instruction
2d: 00 00 add %al,(%rax)
2f: 04 00 add $0x0,%al
31: 00 00 add %al,(%rax)
33: 04 00 add $0x0,%al
35: 00 00 add %al,(%rax)
37: 03 00 add (%rax),%eax
39: 00 00 add %al,(%rax)
3b: 94 xchg %eax,%esp
3c: 01 00 add %eax,(%rax)
3e: 00 .byte 0x0
3f: 94 xchg %eax,%esp

Code starting with the faulting instruction
===========================================
0: 00 60 01 add %ah,0x1(%rax)
3: 00 00 add %al,(%rax)
5: 04 00 add $0x0,%al
7: 00 00 add %al,(%rax)
9: 04 00 add $0x0,%al
b: 00 00 add %al,(%rax)
d: 03 00 add (%rax),%eax
f: 00 00 add %al,(%rax)
11: 94 xchg %eax,%esp
12: 01 00 add %eax,(%rax)
14: 00 .byte 0x0
15: 94 xchg %eax,%esp
[ 12.256651][ T62] systemd-fstab-g[62]: segfault at 0 ip 004a0004 sp bf81264b error 6 in systemd-fstab-generator[4a0000+2000] likely on CPU 0 (core 0, socket 0)
[ 12.257967][ T62] Code: Unable to access opcode bytes at 0x49ffda.

Code starting with the faulting instruction
===========================================
[ 12.266578][ T60] systemd-cryptse[60]: segfault at 0 ip 00453004 sp bfeefa7b error 6 in systemd-cryptsetup-generator[453000+1000] likely on CPU 1 (core 1, socket 0)
[ 12.271885][ T60] Code: Unable to access opcode bytes at 0x452fda.

Code starting with the faulting instruction
===========================================
[ 12.276875][ T61] systemd-debug-g[61]: segfault at fffff000 ip 00464004 sp bfd3675b error 7 in systemd-debug-generator[464000+1000] likely on CPU 1 (core 1, socket 0)
[ 12.278229][ T61] Code: Unable to access opcode bytes at 0x463fda.

Code starting with the faulting instruction
===========================================

The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20230918/202309181644.1932ad53-oliver.sang@xxxxxxxxx

--
0-DAY CI Kernel Test Service
https://github.com/intel/lkp-tests/wiki

Next message: Paul Durrant: "[PATCH v3 00/13] KVM: xen: update shared_info and vcpu_info handling"
Previous message: David Gstir: "[PATCH v3 2/3] KEYS: trusted: Introduce support for NXP DCP-based trusted keys"
Next in thread: Sebastian Ott: "Re: [PATCH RFC] binfmt_elf: fully allocate bss pages"
Messages sorted by: [ date ] [ thread ] [ subject ] [ author ]