FYI, we noticed the following commit (built with gcc-7):
commit: a816f77862fadcd1e7c8f663c6f5c7b30fa6064b ("livepatch: Fix ftrace module text
permissions race")
https://git.kernel.org/cgit/linux/kernel/git/jpoimboe/linux.git fix-livepatch-ftrace-race
in testcase: rcutorture
with following parameters:
runtime: 300s
test: default
torture_type: srcud
test-description: rcutorture is rcutorture kernel module load/unload test.
test-url:
https://www.kernel.org/doc/Documentation/RCU/torture.txt
on test machine: qemu-system-i386 -enable-kvm -cpu SandyBridge -smp 2 -m 2G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-------------------------------------------------+----------+------------+
| | v5.2-rc1 | a816f77862 |
+-------------------------------------------------+----------+------------+
| boot_successes | 18 | 2 |
| boot_failures | 27 | 10 |
| BUG:kernel_reboot-without-warning_in_test_stage | 27 | |
| WARNING:at_kernel/module.c:#module_enable_ro | 0 | 10 |
| EIP:module_enable_ro | 0 | 10 |
+-------------------------------------------------+----------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 10.721011] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest0/status
[ 10.722483] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest1/status
[ 10.723814] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest2/status
[ 10.725144] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest3/status
[ 10.726663] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest5/status
[ 10.728096] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest6/status
[ 10.729414] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest7/status
[ 10.730936] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest8/status
[ 10.732263] OF: overlay: WARNING: memory leak will occur if overlay removed, property:
/testcase-data/overlay-node/test-bus/test-unittest8/property-foo
[ 10.733503] OF: overlay: node_overlaps_later_cs: #6 overlaps with #7
@/testcase-data/overlay-node/test-bus/test-unittest8
[ 10.734543] OF: overlay: overlay #6 is not topmost
[ 10.735910] OF: overlay: remove: Could not find overlay #7
[ 10.736424] ### dt-test ### of_unittest_destroy_tracked_overlays: no overlay to destroy
for #7
[ 10.737777] ### dt-test ### FAIL of_unittest_overlay_high_level():2380
overlay_base_root not initialized
[ 10.738690] ### dt-test ### end of unittest - 212 passed, 1 failed
[ 12.750981] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[ 12.754496] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 12.756281] _warn_unseeded_randomness: 100 callbacks suppressed
[ 12.756288] random: get_random_bytes called from addrconf_dad_kick+0x67/0x94 with
crng_init=1
[ 12.774520] Sending DHCP requests .
[ 12.774528] random: get_random_bytes called from ip_auto_config+0x437/0xd03 with
crng_init=1
[ 12.776322] , OK
[ 12.782802] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15
[ 12.783707] IP-Config: Complete:
[ 12.784137] 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.785330] host=vm-snb-quantal-i386-529, domain=, nis-domain=(none)
[ 12.786175] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath=
[ 12.786177] nameserver0=10.0.2.3
[ 12.788892] Freeing unused kernel image memory: 484K
[ 12.789842] Write protecting kernel text and read-only data: 7548k
[ 12.790727] Run /init as init process
[ 12.791372] random: get_random_u32 called from arch_rnd+0x18/0x2d with crng_init=1
[ 12.800638] random: init: uninitialized urandom read (12 bytes read)
[ 12.821504] process 1 (init) attempted a POSIX timer syscall while CONFIG_POSIX_TIMERS
is not set
[ 12.998401] random: mountall: uninitialized urandom read (12 bytes read)
LKP: HOSTNAME vm-snb-quantal-i386-529, MAC 52:54:00:12:34:56, kernel
5.2.0-rc1-00001-ga816f77 1, serial console /dev/ttyS0
[ 13.237890] Kernel tests: Boot OK!
[ 13.237894]
[ 13.270603] /lkp/lkp/src/bin/run-lkp
[ 13.270607]
[ 13.308364] udevd[302]: starting version 175
[ 13.481190] WARNING: CPU: 0 PID: 332 at kernel/module.c:1961
module_enable_ro+0x24/0xaa
[ 13.482499] Modules linked in:
[ 13.482893] CPU: 0 PID: 332 Comm: modprobe Not tainted 5.2.0-rc1-00001-ga816f77 #1
[ 13.483820] EIP: module_enable_ro+0x24/0xaa
[ 13.484347] Code: ff ff 5b 5e 5d c3 55 83 3d 08 87 80 c1 00 89 e5 57 56 89 c6 53 88 d3
74 13 83 ca ff b8 70 28 78 c1 e8 5c b3 fd ff 85 c0 75 02 <0f> 0b 80 3d 20 e7 71 c1
00 74 76 8b 86 20 01 00 00 8d be 20 01 00
[ 13.486604] EAX: 00000000 EBX: f8077100 ECX: eed49b28 EDX: eed49680
[ 13.487377] ESI: f8077180 EDI: 00000005 EBP: eed59e68 ESP: eed59e5c
[ 13.488149] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068 EFLAGS: 00010246
[ 13.488988] CR0: 80050033 CR2: b7db7000 CR3: 2ed27000 CR4: 00040690
[ 13.489755] Call Trace:
[ 13.490081] load_module+0xdd7/0x1549
[ 13.490546] ? trace_hardirqs_on_caller+0x35/0x37
[ 13.491154] sys_init_module+0xc0/0xc8
[ 13.491638] do_fast_syscall_32+0x9a/0xd9
[ 13.492150] entry_SYSENTER_32+0x70/0xc7
[ 13.492641] EIP: 0xb7f667a1
[ 13.493004] Code: d2 8b 98 58 cd ff ff 89 c8 74 02 89 0a 5b 5d c3 8b 04 24 c3 8b 14 24
c3 8b 1c 24 c3 8b 3c 24 c3 90 51 52 55 89 e5 0f 34 cd 80 <5d> 5a 59 c3 90 90 90 90
8d 76 00 58 b8 77 00 00 00 cd 80 90 8d 76
[ 13.495277] EAX: ffffffda EBX: b7da7000 ECX: 00010578 EDX: 08058470
[ 13.496050] ESI: 08058470 EDI: 0805aa48 EBP: bf873aa4 ESP: bf873910
[ 13.496819] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000292
[ 13.497667] irq event stamp: 3834
[ 13.498091] hardirqs last enabled at (3833): [<c10da7d6>]
get_page_from_freelist+0x38c/0x7f7
[ 13.499133] hardirqs last disabled at (3834): [<c10010ce>]
trace_hardirqs_off_thunk+0xc/0x10
[ 13.500168] softirqs last enabled at (962): [<c1013884>] fpregs_unlock+0x0/0x1a
[ 13.501076] softirqs last disabled at (960): [<c10137ea>] fpregs_lock+0x0/0x1a
[ 13.501962] ---[ end trace c6ca8e28d4fd6b29 ]---
To reproduce:
# build kernel
cd linux
cp config-5.2.0-rc1-00001-ga816f77 .config
make HOSTCC=gcc-7 CC=gcc-7 ARCH=i386 olddefconfig
make HOSTCC=gcc-7 CC=gcc-7 ARCH=i386 prepare
make HOSTCC=gcc-7 CC=gcc-7 ARCH=i386 modules_prepare
make HOSTCC=gcc-7 CC=gcc-7 ARCH=i386 SHELL=/bin/bash
make HOSTCC=gcc-7 CC=gcc-7 ARCH=i386 bzImage
git clone
https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
lkp