lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [day] [month] [year] [list]
Message-ID: <20210206140247.GA12521@xsang-OptiPlex-9020>
Date:   Sat, 6 Feb 2021 22:02:47 +0800
From:   kernel test robot <oliver.sang@...el.com>
To:     schumaker.anna@...il.com
Cc:     0day robot <lkp@...el.com>, LKML <linux-kernel@...r.kernel.org>,
        lkp@...ts.01.org, linux-nfs@...r.kernel.org,
        Anna.Schumaker@...app.com
Subject: [sunrpc]  32fea9c254: WARNING:suspicious_RCU_usage


Greeting,

FYI, we noticed the following commit (built with gcc-9):

commit: 32fea9c254057ead4e72d284606137691c1a6be9 ("sunrpc: Create a per-rpc_clnt file for managing the destination IP address")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git schumaker-anna-gmail-com/SUNRPC-Create-sysfs-files-for-changing-IP/20210203-024737


in testcase: kernel-selftests
version: kernel-selftests-x86_64-b553cffa-1_20210122
with following parameters:

	group: bpf
	ucode: 0xde

test-description: The kernel contains a set of "self tests" under the tools/testing/selftests/ directory. These are intended to be small unit tests to exercise individual code paths in the kernel.
test-url: https://www.kernel.org/doc/Documentation/kselftest.txt


on test machine: 4 threads Intel(R) Core(TM) i7-7567U CPU @ 3.50GHz with 32G memory

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang@...el.com>


kern  :warn  : [   47.544562] WARNING: suspicious RCU usage
kern  :warn  : [   47.545683] 5.11.0-rc6-00005-g32fea9c25405 #1 Not tainted
kern  :warn  : [   47.546841] -----------------------------
kern  :warn  : [   47.547898] net/sunrpc/sysfs.c:145 suspicious rcu_dereference_check() usage!
kern  :warn  : [   47.549193]
other info that might help us debug this:

kern  :warn  : [   47.551798]
rcu_scheduler_active = 2, debug_locks = 1
kern  :warn  : [   47.553704] no locks held by mount.nfs/1093.
kern  :warn  : [   47.554787]
stack backtrace:
kern  :warn  : [   47.556504] CPU: 0 PID: 1093 Comm: mount.nfs Not tainted 5.11.0-rc6-00005-g32fea9c25405 #1
kern  :warn  : [   47.557751] Hardware name: Intel Corporation NUC7i7BNH/NUC7i7BNB, BIOS BNKBL357.86A.0067.2018.0814.1500 08/14/2018
kern  :warn  : [   47.559166] Call Trace:
kern :warn : [   47.560018] dump_stack (kbuild/src/consumer/lib/dump_stack.c:122) 
kern :warn : [   47.560940] rpc_netns_sysfs_setup (kbuild/src/consumer/net/sunrpc/sysfs.c:145 (discriminator 8)) 
kern :warn : [   47.561940] rpc_client_register (kbuild/src/consumer/net/sunrpc/clnt.c:306) 
kern :warn : [   47.562920] ? preempt_count_sub (kbuild/src/consumer/kernel/sched/core.c:4751 kbuild/src/consumer/kernel/sched/core.c:4748 kbuild/src/consumer/kernel/sched/core.c:4770) 
kern :warn : [   47.563890] rpc_new_client (kbuild/src/consumer/net/sunrpc/clnt.c:429) 
kern :warn : [   47.564837] rpc_create_xprt (kbuild/src/consumer/net/sunrpc/clnt.c:475) 
kern :warn : [   47.565772] ? rcu_read_lock_sched_held (kbuild/src/consumer/include/linux/lockdep.h:271 kbuild/src/consumer/kernel/rcu/update.c:123) 
kern :warn : [   47.566775] rpc_create (kbuild/src/consumer/net/sunrpc/clnt.c:596) 
kern :warn : [   47.567699] nfs_create_rpc_client (kbuild/src/consumer/fs/nfs/client.c:536) 
kern :warn : [   47.568666] nfs4_init_client (kbuild/src/consumer/fs/nfs/nfs4client.c:392) nfsv4
kern :warn : [   47.569631] ? find_held_lock (kbuild/src/consumer/kernel/locking/lockdep.c:4935) 
kern :warn : [   47.570504] ? preempt_count_sub (kbuild/src/consumer/kernel/sched/core.c:4751 kbuild/src/consumer/kernel/sched/core.c:4748 kbuild/src/consumer/kernel/sched/core.c:4770) 
kern :warn : [   47.571354] ? _raw_spin_unlock (kbuild/src/consumer/arch/x86/include/asm/preempt.h:102 kbuild/src/consumer/include/linux/spinlock_api_smp.h:152 kbuild/src/consumer/kernel/locking/spinlock.c:183) 
kern :warn : [   47.572174] ? nfs_get_client (kbuild/src/consumer/fs/nfs/client.c:429) 
kern :warn : [   47.573007] nfs4_set_client (kbuild/src/consumer/fs/nfs/nfs4client.c:896) nfsv4
kern :warn : [   47.573908] nfs4_create_server (kbuild/src/consumer/fs/nfs/nfs4client.c:1113 kbuild/src/consumer/fs/nfs/nfs4client.c:1161) nfsv4
kern :warn : [   47.574834] nfs4_try_get_tree (kbuild/src/consumer/fs/nfs/nfs4super.c:226 (discriminator 3)) nfsv4
kern :warn : [   47.575739] vfs_get_tree (kbuild/src/consumer/fs/super.c:1497) 
kern :warn : [   47.576547] path_mount (kbuild/src/consumer/fs/namespace.c:2881 kbuild/src/consumer/fs/namespace.c:3211) 
kern :warn : [   47.577375] do_mount (kbuild/src/consumer/fs/namespace.c:3224) 
kern :warn : [   47.578175] __x64_sys_mount (kbuild/src/consumer/fs/namespace.c:3434 kbuild/src/consumer/fs/namespace.c:3409 kbuild/src/consumer/fs/namespace.c:3409) 
kern :warn : [   47.579029] do_syscall_64 (kbuild/src/consumer/arch/x86/entry/common.c:46) 
kern :warn : [   47.579864] entry_SYSCALL_64_after_hwframe (kbuild/src/consumer/arch/x86/entry/entry_64.S:127) 
kern  :warn  : [   47.580825] RIP: 0033:0x7f07fdb14fea
kern :warn : [ 47.581675] Code: 48 8b 0d a9 0e 0c 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 76 0e 0c 00 f7 d8 64 89 01 48
All code
========
   0:	48 8b 0d a9 0e 0c 00 	mov    0xc0ea9(%rip),%rcx        # 0xc0eb0
   7:	f7 d8                	neg    %eax
   9:	64 89 01             	mov    %eax,%fs:(%rcx)
   c:	48 83 c8 ff          	or     $0xffffffffffffffff,%rax
  10:	c3                   	retq   
  11:	66 2e 0f 1f 84 00 00 	nopw   %cs:0x0(%rax,%rax,1)
  18:	00 00 00 
  1b:	0f 1f 44 00 00       	nopl   0x0(%rax,%rax,1)
  20:	49 89 ca             	mov    %rcx,%r10
  23:	b8 a5 00 00 00       	mov    $0xa5,%eax
  28:	0f 05                	syscall 
  2a:*	48 3d 01 f0 ff ff    	cmp    $0xfffffffffffff001,%rax		<-- trapping instruction
  30:	73 01                	jae    0x33
  32:	c3                   	retq   
  33:	48 8b 0d 76 0e 0c 00 	mov    0xc0e76(%rip),%rcx        # 0xc0eb0
  3a:	f7 d8                	neg    %eax
  3c:	64 89 01             	mov    %eax,%fs:(%rcx)
  3f:	48                   	rex.W

Code starting with the faulting instruction
===========================================
   0:	48 3d 01 f0 ff ff    	cmp    $0xfffffffffffff001,%rax
   6:	73 01                	jae    0x9
   8:	c3                   	retq   
   9:	48 8b 0d 76 0e 0c 00 	mov    0xc0e76(%rip),%rcx        # 0xc0e86
  10:	f7 d8                	neg    %eax
  12:	64 89 01             	mov    %eax,%fs:(%rcx)
  15:	48                   	rex.W
kern  :warn  : [   47.583697] RSP: 002b:00007ffe5f04ce08 EFLAGS: 00000202 ORIG_RAX: 00000000000000a5
kern  :warn  : [   47.584949] RAX: ffffffffffffffda RBX: 00007ffe5f04cf60 RCX: 00007f07fdb14fea
kern  :warn  : [   47.586176] RDX: 0000561964d17b50 RSI: 0000561964d17b70 RDI: 0000561964d19880
kern  :warn  : [   47.587428] RBP: 0000000000000000 R08: 0000561964d1a370 R09: 0000561964d1a960
kern  :warn  : [   47.588672] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffe5f04cf60
kern  :warn  : [   47.589935] R13: 0000561964d1a160 R14: 0000000000000010 R15: 00007ffe5f04ce70
user  :notice: [   49.609026] result_service: raw_upload, RESULT_MNT: /internal-lkp-server/result, RESULT_ROOT: /internal-lkp-server/result/kernel-selftests/bpf-ucode=0xde/lkp-kbl-nuc1/debian-10.4-x86_64-20200603.cgz/x86_64-rhel-7.6-kselftests/gcc-9/32fea9c254057ead4e72d284606137691c1a6be9/3, TMP_RESULT_ROOT: /tmp/lkp/result

user  :notice: [   49.618503] run-job /lkp/jobs/scheduled/lkp-kbl-nuc1/kernel-selftests-bpf-ucode=0xde-debian-10.4-x86_64-20200603.cgz-32fea9c254057ead4e72d284606137691c1a6be9-20210205-26302-nm88l6-1.yaml

user  :notice: [   50.635273] /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 http://internal-lkp-server:80/~lkp/cgi-bin/lkp-jobfile-append-var?job_file=/lkp/jobs/scheduled/lkp-kbl-nuc1/kernel-selftests-bpf-ucode=0xde-debian-10.4-x86_64-20200603.cgz-32fea9c254057ead4e72d284606137691c1a6be9-20210205-26302-nm88l6-1.yaml&job_state=running -O /dev/null

user  :notice: [   50.644410] target ucode: 0xde

user  :notice: [   50.650623] current_version: de, target_version: de

user  :notice: [   50.660463] KERNEL SELFTESTS: linux_headers_dir is /usr/src/linux-headers-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9

user  :notice: [   76.684421] 2021-02-04 18:59:05 mount --bind /lib/modules/5.11.0-rc6-00005-g32fea9c25405/kernel/lib /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/lib

user  :notice: [   76.754555] 2021-02-04 18:59:05 sed -i s/default_timeout=45/default_timeout=300/ kselftest/runner.sh

user  :notice: [   76.975437] LKP WARN miss config CONFIG_IMA_WRITE_POLICY= of bpf/config

user  :notice: [   77.008287] 2021-02-04 18:59:05 make -C ../../../tools/bpf/bpftool

user  :notice: [   77.019128] make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool'

user  :err   : [   77.346735] 4666484 blocks



user  :notice: [   78.561427] Auto-detecting system features:

user  :notice: [   78.569098] ...                        libbfd: [ .[32mon.[m  ]

user  :notice: [   78.576912] ...        disassembler-four-args: [ .[32mon.[m  ]

user  :notice: [   78.584519] ...                          zlib: [ .[32mon.[m  ]

user  :notice: [   78.591819] ...                        libcap: [ .[32mon.[m  ]

user  :notice: [   78.598528] ...               clang-bpf-co-re: [ .[32mon.[m  ]



user  :notice: [   78.608916]   CC       map_perf_ring.o

user  :notice: [   78.726217]   CC       xlated_dumper.o

user  :notice: [   78.882817]   CC       iter.o

user  :notice: [   78.979333]   CC       btf.o

user  :notice: [   79.247725]   CC       tracelog.o

user  :notice: [   79.360871]   CC       link.o

user  :notice: [   79.536619]   CC       perf.o

user  :notice: [   79.664580]   MKDIR    /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/

user  :notice: [   79.675765]   CC       /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/main.o

user  :notice: [   79.833576]   CC       /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/common.o

user  :notice: [   80.096833]   CC       /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/json_writer.o

user  :notice: [   80.199371]   CC       /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/gen.o

user  :notice: [   80.385777]   CC       /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/btf.o

user  :notice: [   80.656214]   MKDIR    /usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/bpf/bpftool/bootstrap/libbpf/

user  :notice: [   80.671984] make[1]: Entering directory '/usr/src/perf_selftests-x86_64-rhel-7.6-kselftests-32fea9c254057ead4e72d284606137691c1a6be9/tools/lib/bpf'



user  :notice: [   81.134178] Auto-detecting system features:

user  :notice: [   81.141337] ...                        libelf: [ .[32mon.[m  ]


To reproduce:

        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        bin/lkp install                job.yaml  # job file is attached in this email
        bin/lkp split-job --compatible job.yaml
        bin/lkp run                    compatible-job.yaml



Thanks,
Oliver Sang


View attachment "config-5.11.0-rc6-00005-g32fea9c25405" of type "text/plain" (212614 bytes)

View attachment "job-script" of type "text/plain" (7190 bytes)

Download attachment "kmsg.xz" of type "application/x-xz" (33752 bytes)

View attachment "kernel-selftests" of type "text/plain" (71448 bytes)

View attachment "job.yaml" of type "text/plain" (6204 bytes)

View attachment "reproduce" of type "text/plain" (334 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ