linux-kernel - [lkp] [locking/rwsem] INFO: rcu_preempt detected stalls on CPUs/tasks

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>] [<thread-prev] [thread-next>] [day] [month] [year] [list]

Message-ID: <20160824014622.GA629@yexl-desktop>
Date:   Wed, 24 Aug 2016 09:46:22 +0800
From:   kernel test robot <xiaolong.ye@...el.com>
To:     Waiman Long <Waiman.Long@....com>
Cc:     Ingo Molnar <mingo@...hat.com>, linux-kernel@...r.kernel.org,
        x86@...nel.org, linux-alpha@...r.kernel.org,
        linux-ia64@...r.kernel.org, linux-s390@...r.kernel.org,
        linux-arch@...r.kernel.org, linux-doc@...r.kernel.org,
        Davidlohr Bueso <dave@...olabs.net>,
        Jason Low <jason.low2@...com>,
        Dave Chinner <david@...morbit.com>,
        Jonathan Corbet <corbet@....net>,
        Scott J Norton <scott.norton@....com>,
        Douglas Hatch <doug.hatch@....com>,
        Waiman Long <Waiman.Long@....com>, lkp@...org
Subject: [lkp] [locking/rwsem]  INFO: rcu_preempt detected stalls on
 CPUs/tasks


FYI, we noticed the following commit:

https://github.com/0day-ci/linux Waiman-Long/locking-rwsem-Enable-reader-optimistic-spinning/20160819-150117
commit 1802442a39b862b1adb57cbae5fbbda3945406e2 ("locking/rwsem: Add a boot parameter to reader spinning threshold")

in testcase: boot

on test machine: qemu-system-i386 -enable-kvm -cpu Haswell,+smep,+smap  -m 360M

caused below changes:


[  115.824398] INFO: rcu_preempt detected stalls on CPUs/tasks:
[  115.826472] All QSes seen, last rcu_preempt kthread activity 105002 (-184454--289456), jiffies_till_next_fqs=3, root ->qsmask 0x0
[  115.827341] sed             R running      0   296    289 0x00000008
[  115.827853]  00000000 ce7bbd2c c107a8f4 c1705803 00000000 00000128 00000121 00000008
[  115.828537]  00000384 c17b13c0 ce7bbd80 c10ce411 c16fedbc c17b1ca0 00019a2a fffd2f7a
[  115.829216]  fffb9550 00000003 00000000 c10a028d 00000383 00019a2a 00000384 0000001d
[  115.829895] Call Trace:
[  115.830092]  [<c107a8f4>] sched_show_task+0x114/0x220
[  115.830483]  [<c10ce411>] rcu_check_callbacks+0xb51/0xb60
[  115.830893]  [<c10a028d>] ? trace_hardirqs_off_caller+0xad/0x160
[  115.831348]  [<c10d56e8>] update_process_times+0x28/0x60
[  115.831756]  [<c10e6dea>] tick_periodic+0x2a/0xc0
[  115.832116]  [<c10e6fc1>] tick_handle_periodic+0x21/0x80
[  115.832554]  [<c1027b2d>] local_apic_timer_interrupt+0x2d/0x60
[  115.833000]  [<c1028116>] smp_apic_timer_interrupt+0x36/0x60
[  115.833435]  [<c150f6b6>] apic_timer_interrupt+0x36/0x40
[  115.833840]  [<c10a007b>] ? find_usage_forwards+0x5b/0x80
[  115.834251]  [<c10aa398>] ? rwsem_optimistic_spin+0x258/0x3a0
[  115.834693]  [<c150cbb2>] rwsem_down_write_failed+0x32/0x1c0
[  115.835125]  [<c118ecf0>] ? vma_adjust+0xb0/0x6c0
[  115.835490]  [<c1267779>] call_rwsem_down_write_failed+0x9/0x10
[  115.835937]  [<c150c34f>] down_write+0x4f/0x60
[  115.836277]  [<c118ecf0>] ? vma_adjust+0xb0/0x6c0
[  115.836642]  [<c118ecf0>] vma_adjust+0xb0/0x6c0
[  115.836990]  [<c118f3d9>] __split_vma+0xd9/0x180
[  115.837393]  [<c11901a2>] split_vma+0x22/0x40
[  115.837726]  [<c1192d57>] mprotect_fixup+0x1d7/0x220
[  115.838105]  [<c1192ef5>] SyS_mprotect+0x155/0x280
[  115.838474]  [<c1001e38>] do_int80_syscall_32+0x1f8/0x240
[  115.838882]  [<c150ec83>] entry_INT80_32+0x33/0x33


FYI, raw QEMU command line is:

	qemu-system-i386 -enable-kvm -cpu Haswell,+smep,+smap -kernel /pkg/linux/i386-randconfig-sb0-08201601/gcc-5/1802442a39b862b1adb57cbae5fbbda3945406e2/vmlinuz-4.8.0-rc1-00079-g1802442 -append 'ip=::::vm-vp-quantal-i386-34::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-vp-quantal-i386-34/boot-1-quantal-core-i386.cgz-1802442a39b862b1adb57cbae5fbbda3945406e2-20160821-75698-3hybx2-6.yaml ARCH=i386 kconfig=i386-randconfig-sb0-08201601 branch=linux-devel/devel-hourly-2016082011 commit=1802442a39b862b1adb57cbae5fbbda3945406e2 BOOT_IMAGE=/pkg/linux/i386-randconfig-sb0-08201601/gcc-5/1802442a39b862b1adb57cbae5fbbda3945406e2/vmlinuz-4.8.0-rc1-00079-g1802442 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-vp-quantal-i386/quantal-core-i386.cgz/i386-randconfig-sb0-08201601/gcc-5/1802442a39b862b1adb57cbae5fbbda3945406e2/6 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 systemd.log_level=err ignore_loglevel earlyprintk=ttyS0,115200 console=ttyS0,115200 console=tty0 vga=normal rw drbd.minor_count=8'  -initrd /fs/sdd1/initrd-vm-vp-quantal-i386-34 -m 360 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -watchdog-action debug -rtc base=localtime -pidfile /dev/shm/kboot/pid-vm-vp-quantal-i386-34 -serial file:/dev/shm/kboot/serial-vm-vp-quantal-i386-34 -daemonize -display none -monitor null 





Thanks,
Xiaolong

View attachment "config-4.8.0-rc1-00079-g1802442" of type "text/plain" (87925 bytes)

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