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]
Date:   Mon, 22 Aug 2016 09:24:39 +0800
From:   kernel test robot <xiaolong.ye@...el.com>
To:     Jens Axboe <axboe@...com>
Cc:     LKML <linux-kernel@...r.kernel.org>, Jens Axboe <axboe@...com>,
        Jens Axboe <axboe@...nel.dk>, lkp@...org
Subject: [lkp] [writeback]  0cb0fd69dd: INFO: suspicious RCU usage. ]


FYI, we noticed the following commit:

https://git.kernel.org/pub/scm/linux/kernel/git/axboe/linux-block.git wb-buf-throttle
commit 0cb0fd69dd73bfc404b703a30168b68e1c64e828 ("writeback: throttle buffered writeback")

in testcase: boot

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

caused below changes:


+------------------------------+------------+------------+
|                              | 7474f62764 | 0cb0fd69dd |
+------------------------------+------------+------------+
| boot_successes               | 8          | 0          |
| boot_failures                | 0          | 7          |
| INFO:suspicious_RCU_usage    | 0          | 7          |
| calltrace:disk_events_workfn | 0          | 7          |
+------------------------------+------------+------------+



[    5.030953] cdrom: Uniform CD-ROM driver Revision: 3.20
[    5.033421] 
[    5.033843] ===============================
[    5.034515] [ INFO: suspicious RCU usage. ]
[    5.035166] 4.8.0-rc2-00008-g0cb0fd6 #1 Not tainted
[    5.035885] -------------------------------
[    5.036535] include/linux/cgroup.h:435 suspicious rcu_dereference_check() usage!
[    5.037902] 
[    5.037902] other info that might help us debug this:
[    5.037902] 
[    5.039353] 
[    5.039353] rcu_scheduler_active = 1, debug_locks = 0
[    5.040419] 3 locks held by kworker/0:1/19:
[    5.041057]  #0:  ("events_freezable_power_efficient"){.+.+..}, at: [<ffffffff810fc9f9>] process_one_work+0x151/0x4ee
[    5.042636]  #1:  ((&(&ev->dwork)->work)){+.+...}, at: [<ffffffff810fc9f9>] process_one_work+0x151/0x4ee
[    5.044091]  #2:  (&(&q->__queue_lock)->rlock){-.....}, at: [<ffffffff8178921f>] cfq_set_request+0x5e/0x2a3
[    5.045592] 
[    5.045592] stack backtrace:
[    5.046484] CPU: 0 PID: 19 Comm: kworker/0:1 Not tainted 4.8.0-rc2-00008-g0cb0fd6 #1
[    5.047719] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[    5.049065] Workqueue: events_freezable_power_ disk_events_workfn
[    5.049935]  0000000000000000 ffff88003431f8e8 ffffffff8178e443 ffff8800343184c0
[    5.051249]  0000000000000001 ffff88003431f918 ffffffff811234ac ffff8800343184c0
[    5.052580]  ffffffff84091180 0000000000000003 ffff880030d5cc00 ffff88003431f938
[    5.053934] Call Trace:
[    5.054468]  [<ffffffff8178e443>] dump_stack+0x82/0xb8
[    5.055257]  [<ffffffff811234ac>] lockdep_rcu_suspicious+0xf7/0x100
[    5.056146]  [<ffffffff81786af6>] bio_blkcg+0x89/0x93
[    5.056918]  [<ffffffff817888f2>] check_blkcg_changed+0x58/0x1b8
[    5.057783]  [<ffffffff81125fe1>] ? lock_acquire+0x125/0x1be
[    5.058611]  [<ffffffff81125fe1>] ? lock_acquire+0x125/0x1be
[    5.059430]  [<ffffffff8112390d>] ? lock_acquired+0xfc/0x2f2
[    5.060262]  [<ffffffff8178921f>] ? cfq_set_request+0x5e/0x2a3
[    5.061107]  [<ffffffff81789292>] cfq_set_request+0xd1/0x2a3
[    5.061935]  [<ffffffff82ef94a3>] ? _raw_spin_unlock_irq+0x2c/0x3b
[    5.062802]  [<ffffffff81124a8c>] ? trace_hardirqs_on_caller+0x17c/0x198
[    5.063720]  [<ffffffff81124ab5>] ? trace_hardirqs_on+0xd/0xf
[    5.064550]  [<ffffffff82ef94a8>] ? _raw_spin_unlock_irq+0x31/0x3b
[    5.065396]  [<ffffffff8176d4b8>] ? ioc_create_icq+0x15e/0x175
[    5.066215]  [<ffffffff8176373b>] elv_set_request+0x1f/0x24
[    5.067001]  [<ffffffff81767caa>] get_request+0x38f/0x77f
[    5.067768]  [<ffffffff8111b5d6>] ? add_wait_queue_exclusive+0x44/0x44
[    5.068647]  [<ffffffff817680ff>] blk_get_request+0x65/0xa8
[    5.069427]  [<ffffffff81c6804a>] ide_cd_queue_pc+0x76/0x19d
[    5.070213]  [<ffffffff811253d8>] ? __lock_acquire+0x679/0xed1
[    5.071015]  [<ffffffff81c68359>] cdrom_check_status+0x51/0x53
[    5.071809]  [<ffffffff81c68fe9>] ide_cdrom_check_events_real+0x20/0x3f
[    5.072679]  [<ffffffff82578b77>] cdrom_update_events+0x18/0x21
[    5.073473]  [<ffffffff82578b92>] cdrom_check_events+0x12/0x1f
[    5.074258]  [<ffffffff81c67082>] idecd_check_events+0x1c/0x1e
[    5.075031]  [<ffffffff8177844a>] disk_check_events+0x47/0x103
[    5.075797]  [<ffffffff81778522>] disk_events_workfn+0x1c/0x1e
[    5.076554]  [<ffffffff810fcb1a>] process_one_work+0x272/0x4ee
[    5.077300]  [<ffffffff810fd267>] worker_thread+0x1eb/0x2c9
[    5.078032]  [<ffffffff810fd07c>] ? rescuer_thread+0x2b3/0x2b3
[    5.078789]  [<ffffffff81101df4>] kthread+0xc5/0xcd
[    5.079446]  [<ffffffff82ef9f2f>] ret_from_fork+0x1f/0x40
[    5.080157]  [<ffffffff81101d2f>] ? kthread_create_on_node+0x1b0/0x1b0
[    5.081305] Loading iSCSI transport class v2.0-870.
[    5.082464] rdac: device handler registered


FYI, raw QEMU command line is:

	qemu-system-x86_64 -enable-kvm -cpu IvyBridge -kernel /pkg/linux/x86_64-allyesdebian/gcc-6/0cb0fd69dd73bfc404b703a30168b68e1c64e828/vmlinuz-4.8.0-rc2-00008-g0cb0fd6 -append 'ip=::::vm-ivb41-yocto-ia32-1::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-ivb41-yocto-ia32-1/boot-1-yocto-minimal-i386.cgz-0cb0fd69dd73bfc404b703a30168b68e1c64e828-20160820-31851-iyl1vg-0.yaml ARCH=x86_64 kconfig=x86_64-allyesdebian branch=linux-devel/devel-hourly-2016081811 commit=0cb0fd69dd73bfc404b703a30168b68e1c64e828 BOOT_IMAGE=/pkg/linux/x86_64-allyesdebian/gcc-6/0cb0fd69dd73bfc404b703a30168b68e1c64e828/vmlinuz-4.8.0-rc2-00008-g0cb0fd6 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-ivb41-yocto-ia32/yocto-minimal-i386.cgz/x86_64-allyesdebian/gcc-6/0cb0fd69dd73bfc404b703a30168b68e1c64e828/0 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/sda5/initrd-vm-ivb41-yocto-ia32-1 -m 872 -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-1,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-ivb41-yocto-ia32-1 -serial file:/dev/shm/kboot/serial-vm-ivb41-yocto-ia32-1 -daemonize -display none -monitor null 





Thanks,
Xiaolong

View attachment "config-4.8.0-rc2-00008-g0cb0fd6" of type "text/plain" (154408 bytes)

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

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ