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, 23 May 2016 17:58:18 +0800
From:	kernel test robot <xiaolong.ye@...el.com>
To:	Shaohua Li <shli@...com>
Cc:	lkp@...org, LKML <linux-kernel@...r.kernel.org>,
	0day robot <fengguang.wu@...el.com>
Subject: [block] e0d3dd5854: INFO: suspicious RCU usage. ]



FYI, we noticed the following commit:

https://github.com/0day-ci/linux Shaohua-Li/block-throttle-prepare-support-multiple-limits/20160511-082233
commit e0d3dd5854af35d080411e2c51308f58f72ed18b ("block-throttle: add .low interface")


on test machine: vm-kbuild-1G: 2 threads qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap with 1G memory

caused below changes:


+------------------------------+------------+------------+
|                              | dd11b46868 | e0d3dd5854 |
+------------------------------+------------+------------+
| boot_successes               | 4          | 0          |
| boot_failures                | 0          | 3          |
| INFO:suspicious_RCU_usage    | 0          | 3          |
| backtrace:async_run_entry_fn | 0          | 3          |
+------------------------------+------------+------------+



[   10.334955] scsi host0: Virtio SCSI HBA
[   10.344798] 
[   10.345419] ===============================
[   10.346304] [ INFO: suspicious RCU usage. ]
[   10.347214] 4.6.0-rc3-00122-ge0d3dd5 #2 Not tainted
[   10.348196] -------------------------------
[   10.349134] kernel/cgroup.c:4037 cgroup_mutex or RCU read lock required!
[   10.350853] 
[   10.350853] other info that might help us debug this:
[   10.350853] 
[   10.352921] 
[   10.352921] rcu_scheduler_active = 1, debug_locks = 0
[   10.354431] 5 locks held by kworker/u4:3/110:
[   10.355327]  #0:  ("events_unbound"){.+.+.+}, at: [<ffffffff810b86a5>] process_one_work+0x18d/0x63b
[   10.357444]  #1:  ((&entry->work)
[   10.357887] tun: Universal TUN/TAP device driver, 1.6
[   10.357887] tun: (C) 1999-2004 Max Krasnyansky <maxk@...lcomm.com>

[   10.360437] ){+.+.+.}, at: [<ffffffff810b86a5>] process_one_work+0x18d/0x63b
[   10.362235]  #2:  (&shost->scan_mutex){+.+.+.}, at: [<ffffffff81773c0f>] scsi_scan_host_selected+0x7c/0x104
[   10.364398]  #3:  (&(&q->__queue_lock)->rlock){..-...}, at: [<ffffffff81541545>] blkcg_exit_queue+0x19/0x38
[   10.366652]  #4:  (&(&blkcg->lock)->rlock){......}, at: [<ffffffff81540702>] blkg_destroy_all+0x78/0xb4
[   10.368788] 
[   10.368788] stack backtrace:
[   10.370073] CPU: 0 PID: 110 Comm: kworker/u4:3 Not tainted 4.6.0-rc3-00122-ge0d3dd5 #2
[   10.371731] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[   10.373494] Workqueue: events_unbound async_run_entry_fn
[   10.374583]  0000000000000000 ffff880035d67578 ffffffff8154f4de ffff880035d52ac0
[   10.376444]  0000000000000001 ffff880035d675a8 ffffffff810e7088 0000000000000000
[   10.378332]  0000000000000000 ffffffff836f0240 ffff88003e48ca90 ffff880035d675d0
[   10.380214] Call Trace:
[   10.380896]  [<ffffffff8154f4de>] dump_stack+0x86/0xc0
[   10.381873]  [<ffffffff810e7088>] lockdep_rcu_suspicious+0xf7/0x100
[   10.383006]  [<ffffffff8113814a>] css_next_descendant_post+0x5e/0xb9
[   10.384125]  [<ffffffff81541767>] blk_throtl_update_valid_limit+0x30/0x133
[   10.385276]  [<ffffffff815418aa>] throtl_pd_offline+0x40/0x63
[   10.386347]  [<ffffffff81540463>] blkg_destroy+0xf6/0x31d
[   10.387362]  [<ffffffff810e527c>] ? noop_count+0xb/0xb
[   10.388348]  [<ffffffff811561cb>] ? is_ftrace_trampoline+0x4b/0x71
[   10.389446]  [<ffffffff810bd26b>] ? __kernel_text_address+0x37/0x55
[   10.390556]  [<ffffffff81064784>] ? print_context_stack+0x6f/0xde
[   10.391635]  [<ffffffff810e527c>] ? noop_count+0xb/0xb
[   10.392615]  [<ffffffff810e8073>] ? check_usage+0xda/0x5bc
[   10.393695]  [<ffffffff810e6761>] ? add_lock_to_list+0x84/0x8b
[   10.395323]  [<ffffffff810ea813>] ? __lock_acquire+0x16ef/0x191e
[   10.396434]  [<ffffffff810e85de>] ? check_irq_usage+0x89/0x9a
[   10.397489]  [<ffffffff810e85de>] ? check_irq_usage+0x89/0x9a
[   10.398539]  [<ffffffff810ea327>] ? __lock_acquire+0x1203/0x191e
[   10.399617]  [<ffffffff810eb287>] ? lock_acquire+0x188/0x223
[   10.400663]  [<ffffffff81540702>] ? blkg_destroy_all+0x78/0xb4
[   10.401719]  [<ffffffff8154070d>] blkg_destroy_all+0x83/0xb4
[   10.402759]  [<ffffffff8154154d>] blkcg_exit_queue+0x21/0x38
[   10.403798]  [<ffffffff81529caf>] blk_release_queue+0x2b/0xd7
[   10.404847]  [<ffffffff8155160f>] kobject_put+0x81/0x95
[   10.405840]  [<ffffffff815235f2>] blk_put_queue+0x15/0x17
[   10.406852]  [<ffffffff81774ada>] scsi_device_dev_release_usercontext+0xbf/0x10f
[   10.408484]  [<ffffffff81774a1b>] ? scsi_device_dev_release+0x1e/0x1e
[   10.409598]  [<ffffffff810b8bb1>] execute_in_process_context+0x2b/0x87
[   10.410734]  [<ffffffff81774a19>] scsi_device_dev_release+0x1c/0x1e
[   10.411832]  [<ffffffff817268f4>] device_release+0x59/0x8e
[   10.412851]  [<ffffffff8155160f>] kobject_put+0x81/0x95
[   10.413839]  [<ffffffff81726c5c>] put_device+0x17/0x19
[   10.414826]  [<ffffffff817758cf>] __scsi_remove_device+0xcb/0xd0
[   10.415895]  [<ffffffff81772bf7>] scsi_probe_and_add_lun+0x2f0/0x936
[   10.417031]  [<ffffffff81773890>] __scsi_scan_target+0xaa/0x1cf
[   10.418088]  [<ffffffff81773ae6>] scsi_scan_channel+0x65/0x7f
[   10.419134]  [<ffffffff81773c62>] scsi_scan_host_selected+0xcf/0x104
[   10.420245]  [<ffffffff81773d07>] do_scsi_scan_host+0x70/0x75
[   10.421293]  [<ffffffff81773eca>] do_scan_async+0x1c/0x15c
[   10.422316]  [<ffffffff810c1308>] async_run_entry_fn+0x39/0xc3
[   10.423375]  [<ffffffff810b8813>] process_one_work+0x2fb/0x63b
[   10.424439]  [<ffffffff810b96d9>] worker_thread+0x24f/0x384
[   10.425464]  [<ffffffff810b948a>] ? rescuer_thread+0x2ba/0x2ba
[   10.426520]  [<ffffffff810be619>] kthread+0xfb/0x103
[   10.427483]  [<ffffffff81cb5272>] ret_from_fork+0x22/0x50
[   10.428524]  [<ffffffff810be51e>] ? kthread_create_on_node+0x1ca/0x1ca
[   10.430483] Atheros(R) L2 Ethernet Driver - version 2.2.3
[   10.431413] scsi 0:0:1:0: Direct-Access     QEMU     QEMU HARDDISK    2.4. PQ: 0 ANSI: 5
[   10.433419] Copyright (c) 2007 Atheros Corporation.


FYI, raw QEMU command line is:

	qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap -kernel /pkg/linux/x86_64-nfsroot/gcc-6/e0d3dd5854af35d080411e2c51308f58f72ed18b/vmlinuz-4.6.0-rc3-00122-ge0d3dd5 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-8/bisect_boot-1-debian-x86_64-2015-02-07.cgz-x86_64-nfsroot-e0d3dd5854af35d080411e2c51308f58f72ed18b-20160523-89777-1kpfl6n-0.yaml ARCH=x86_64 kconfig=x86_64-nfsroot branch=linux-devel/devel-hourly-2016051922 commit=e0d3dd5854af35d080411e2c51308f58f72ed18b BOOT_IMAGE=/pkg/linux/x86_64-nfsroot/gcc-6/e0d3dd5854af35d080411e2c51308f58f72ed18b/vmlinuz-4.6.0-rc3-00122-ge0d3dd5 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-nfsroot/gcc-6/e0d3dd5854af35d080411e2c51308f58f72ed18b/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err 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 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-1G-8::dhcp'  -initrd /fs/sdc1/initrd-vm-kbuild-1G-8 -m 1024 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0,hostfwd=tcp::23007-:22 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -device virtio-scsi-pci,id=scsi0 -drive file=/fs/sdc1/disk0-vm-kbuild-1G-8,if=none,id=hd0,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd0,scsi-id=1,lun=0 -drive file=/fs/sdc1/disk1-vm-kbuild-1G-8,if=none,id=hd1,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd1,scsi-id=1,lun=1 -drive file=/fs/sdc1/disk2-vm-kbuild-1G-8,if=none,id=hd2,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd2,scsi-id=1,lun=2 -drive file=/fs/sdc1/disk3-vm-kbuild-1G-8,if=none,id=hd3,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd3,scsi-id=1,lun=3 -drive file=/fs/sdc1/disk4-vm-kbuild-1G-8,if=none,id=hd4,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd4,scsi-id=1,lun=4 -pidfile /dev/shm/kboot/pid-vm-kbuild-1G-8 -serial file:/dev/shm/kboot/serial-vm-kbuild-1G-8 -daemonize -display none -monitor null 





Thanks,
Kernel Test Robot

View attachment "config-4.6.0-rc3-00122-ge0d3dd5" of type "text/plain" (109936 bytes)

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

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ