linux-kernel - [mm] 5cb1f57750: INFO:trying_to_register_non-static

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: <20170610010443.GA71020@inn.lkp.intel.com>
Date:   Sat, 10 Jun 2017 09:04:43 +0800
From:   kernel test robot <xiaolong.ye@...el.com>
To:     Peter Zijlstra <peterz@...radead.org>
Cc:     "Paul E. McKenney" <paulmck@...ux.vnet.ibm.com>,
        Laurent Dufour <ldufour@...ux.vnet.ibm.com>,
        LKML <linux-kernel@...r.kernel.org>, lkp@...org
Subject: [mm]  5cb1f57750: INFO:trying_to_register_non-static_key


FYI, we noticed the following commit:

commit: 5cb1f57750c7ad8db1593d59ffbdb112c0945a8e ("mm: VMA sequence count")
https://git.kernel.org/cgit/linux/kernel/git/paulmck/linux-rcu.git spf

in testcase: trinity
with following parameters:

	runtime: 300s

test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/


on test machine: qemu-system-x86_64 -enable-kvm -cpu IvyBridge -m 420M

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


+---------------------------------------------------+------------+------------+
|                                                   | b6e6a3549d | 5cb1f57750 |
+---------------------------------------------------+------------+------------+
| boot_successes                                    | 2          | 0          |
| boot_failures                                     | 2          | 12         |
| BUG:kernel_hang_in_test_stage                     | 2          |            |
| INFO:trying_to_register_non-static_key            | 0          | 4          |
| is_freeing_memory#-#,with_a_lock_still_held_there | 0          | 8          |
+---------------------------------------------------+------------+------------+



[   19.461240] INFO: trying to register non-static key.
[   19.462052] the code is fine but needs lockdep annotation.
[   19.462865] turning off the locking correctness validator.
[   19.463688] CPU: 0 PID: 326 Comm: trinity-main Not tainted 4.12.0-rc4-00004-g5cb1f57 #186
[   19.464897] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[   19.466401] Call Trace:
[   19.466783]  dump_stack+0x61/0x7e
[   19.467299]  register_lock_class+0x190/0x4af
[   19.467943]  ? kvm_clock_read+0x25/0x35
[   19.468527]  __lock_acquire+0x9b/0x783
[   19.482248]  lock_acquire+0x53/0x76
[   19.482783]  ? unmap_single_vma+0xbc/0xc6
[   19.483399]  unmap_page_range+0x5d/0x92a
[   19.483998]  ? unmap_single_vma+0xbc/0xc6
[   19.484607]  ? kvm_clock_read+0x25/0x35
[   19.485196]  ? kvm_sched_clock_read+0x9/0x12
[   19.485843]  ? lru_deactivate_file_fn+0x2ab/0x2ab
[   19.486553]  unmap_single_vma+0xbc/0xc6
[   19.487139]  unmap_vmas+0x35/0x44
[   19.487646]  unmap_region+0xad/0xfa
[   19.488184]  ? kvm_sched_clock_read+0x9/0x12
[   19.488823]  ? __might_sleep+0x68/0x6f
[   19.489395]  ? mmap_region+0x1a8/0x42f
[   19.489962]  mmap_region+0x397/0x42f
[   19.490519]  do_mmap+0x369/0x3d0
[   19.491031]  vm_mmap_pgoff+0x84/0xb9
[   19.491583]  SyS_mmap_pgoff+0x165/0x1bc
[   19.492182]  do_int80_syscall_32+0x59/0xb7
[   19.492810]  entry_INT80_compat+0x30/0x40
[   19.493428] RIP: 0023:0x8090aa2
[   19.493916] RSP: 002b:00000000ffaa6358 EFLAGS: 00000246 ORIG_RAX: 00000000000000c0
[   19.496051] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000000000001000
[   19.497139] RDX: 0000000000000001 RSI: 000000000001a002 RDI: 0000000000000017
[   19.498218] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[   19.499295] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[   19.500372] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[   19.595197] trinity-main uses obsolete (PF_INET,SOCK_PACKET)
[   19.666138] trinity-c3 (363) used greatest stack depth: 13704 bytes left
[   19.718696] trinity-c3 (409) used greatest stack depth: 13448 bytes left
[   19.988577] trinity-c3 (583) used greatest stack depth: 13256 bytes left
[   25.190396] trinity-c1 (4851) used greatest stack depth: 13192 bytes left
[   30.144815] trinity-c0 (9686) used greatest stack depth: 13128 bytes left
[   43.896710] trinity-c2 (22871) used greatest stack depth: 13064 bytes left
[   60.058200] trinity-c0 (6258) used greatest stack depth: 13000 bytes left
[  248.928303] trinity-c0 (15143) used greatest stack depth: 12936 bytes left
[  306.154257] trinity-c0 (3846) used greatest stack depth: 12872 bytes left
[  311.966088] sysrq: SysRq : Emergency Sync
[  311.966543] sysrq: SysRq : Resetting

Elapsed time: 320

initrds=(
	/osimage/yocto/yocto-tiny-i386-2016-04-22.cgz
	/lkp/scheduled/vm-ivb41-yocto-ia32-7/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-5cb1f57750c7ad8db1593d59ffbdb112c0945a8e-20170610-40122-2y3g8l-0.cgz
	/lkp/lkp/lkp-i386.cgz
	/osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig.i386_2016-09-03.cgz
	/osimage/pkg/static/trinity-i386.cgz
)

cat "${initrds[@]}" > /fs/sda5/initrd-vm-ivb41-yocto-ia32-7

kvm=(
	qemu-system-x86_64
	-enable-kvm
	-cpu IvyBridge
	-kernel /pkg/linux/x86_64-acpi-redef/gcc-6/5cb1f57750c7ad8db1593d59ffbdb112c0945a8e/vmlinuz-4.12.0-rc4-00004-g5cb1f57
	-initrd /fs/sda5/initrd-vm-ivb41-yocto-ia32-7
	-m 420
	-smp 1
	-device e1000,netdev=net0
	-netdev user,id=net0
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-watchdog-action debug
	-rtc base=localtime
	-drive file=/fs/sda5/disk0-vm-ivb41-yocto-ia32-7,media=disk,if=virtio
	-pidfile /dev/shm/kboot/pid-vm-ivb41-yocto-ia32-7
	-serial file:/dev/shm/kboot/vm-ivb41-yocto-ia32-7/serial
	-serial file:/dev/shm/kboot/vm-ivb41-yocto-ia32-7/kmsg
	-daemonize
	-display none
	-monitor null
)

append=(
	ip=::::vm-ivb41-yocto-ia32-7::dhcp
	root=/dev/ram0
	user=lkp
	job=/lkp/scheduled/vm-ivb41-yocto-ia32-7/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-5cb1f57750c7ad8db1593d59ffbdb112c0945a8e-20170610-40122-2y3g8l-0.yaml
	ARCH=x86_64
	kconfig=x86_64-acpi-redef
	branch=rcu/spf
	commit=5cb1f57750c7ad8db1593d59ffbdb112c0945a8e
	BOOT_IMAGE=/pkg/linux/x86_64-acpi-redef/gcc-6/5cb1f57750c7ad8db1593d59ffbdb112c0945a8e/vmlinuz-4.12.0-rc4-00004-g5cb1f57
	max_uptime=1500
	RESULT_ROOT=/result/trinity/300s/vm-ivb41-yocto-ia32/yocto-tiny-i386-2016-04-22.cgz/x86_64-acpi-redef/gcc-6/5cb1f57750c7ad8db1593d59ffbdb112c0945a8e/0
	LKP_SERVER=inn
	debug
	apic=debug
	sysrq_always_enabled


To reproduce:

        git clone https://github.com/01org/lkp-tests.git
        cd lkp-tests
        bin/lkp qemu -k <bzImage> job-script  # job-script is attached in this email



Thanks,
Kernel Test Robot

View attachment "config-4.12.0-rc4-00004-g5cb1f57" of type "text/plain" (123301 bytes)

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

Download attachment "dmesg.xz" of type "application/octet-stream" (13288 bytes)