| 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
| ||
|
Message-ID: <20180419031315.5bydronkvfk2svzz@wfg-t540p.sh.intel.com>
Date: Thu, 19 Apr 2018 11:13:15 +0800
From: Fengguang Wu <fengguang.wu@...el.com>
To: Paul Blakey <paulb@...lanox.com>
Cc: linux-kernel@...r.kernel.org, lkp@...org,
Thomas Graf <tgraf@...g.ch>,
Daniel Borkmann <daniel@...earbox.net>,
Florian Westphal <fw@...len.de>,
Herbert Xu <herbert@...dor.apana.org.au>
Subject: 499ac3b60f ("test_rhashtable: add test case for rhltable with
duplicate objects"): WARNING: suspicious RCU usage
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
commit 499ac3b60f657dae82055fc81c7b01e6242ac9bc
Author: Paul Blakey <paulb@...lanox.com>
AuthorDate: Sun Mar 4 17:29:49 2018 +0200
Commit: David S. Miller <davem@...emloft.net>
CommitDate: Wed Mar 7 10:44:03 2018 -0500
test_rhashtable: add test case for rhltable with duplicate objects
Tries to insert duplicates in the middle of bucket's chain:
bucket 1: [[val 21 (tid=1)]] -> [[ val 1 (tid=2), val 1 (tid=0) ]]
Reuses tid to distinguish the elements insertion order.
Signed-off-by: Paul Blakey <paulb@...lanox.com>
Acked-by: Herbert Xu <herbert@...dor.apana.org.au>
Signed-off-by: David S. Miller <davem@...emloft.net>
d3dcf8eb61 rhashtable: Fix rhlist duplicates insertion
499ac3b60f test_rhashtable: add test case for rhltable with duplicate objects
+--------------------------------------------------------------------+------------+------------+
| | d3dcf8eb61 | 499ac3b60f |
+--------------------------------------------------------------------+------------+------------+
| boot_successes | 41 | 0 |
| boot_failures | 0 | 21 |
| WARNING:suspicious_RCU_usage | 0 | 21 |
| lib/test_rhashtable.c:#suspicious_rcu_dereference_protected()usage | 0 | 21 |
+--------------------------------------------------------------------+------------+------------+
[ 7.248372] test if its possible to exceed max_size 8192: no, ok
[ 7.249256] Average test time: 464870041
[ 7.249746] test inserting duplicates
[ 7.250234]
[ 7.250425] =============================
[ 7.250900] WARNING: suspicious RCU usage
[ 7.251392] 4.16.0-rc4-00130-g499ac3b #2 Not tainted
[ 7.251971] -----------------------------
[ 7.252469] lib/test_rhashtable.c:502 suspicious rcu_dereference_protected() usage!
[ 7.253574]
[ 7.253574] other info that might help us debug this:
[ 7.253574]
[ 7.254489]
[ 7.254489] rcu_scheduler_active = 2, debug_locks = 1
[ 7.255236] no locks held by swapper/0/1.
[ 7.255700]
[ 7.255700] stack backtrace:
[ 7.256274] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.16.0-rc4-00130-g499ac3b #2
[ 7.257148] Call Trace:
[ 7.257478] dump_stack+0xb7/0x107
[ 7.257884] print_ht+0x8f/0x35d
[ 7.258286] test_insert_dup+0x13b/0x1ce
[ 7.258745] ? ___siphash_aligned+0x2b/0x2b
[ 7.259369] ? jhash+0x1bb/0x1bb
[ 7.259769] ? my_hashfn+0x1a/0x1a
[ 7.260199] ? rhashtable_walk_peek+0x78/0x78
[ 7.260217] test_rht_init+0x6f8/0x1212
[ 7.260217] ? ___siphash_aligned+0x2b/0x2b
[ 7.260217] ? initcall_blacklisted+0xb0/0xd3
[ 7.260217] ? kstrtoll+0x9a/0xbc
[ 7.260217] ? kstrtos8+0x69/0x89
[ 7.260217] ? test_insert_dup+0x1ce/0x1ce
[ 7.260217] ? do_early_param+0xb9/0xb9
[ 7.260217] do_one_initcall+0xaa/0x17d
[ 7.260217] ? do_early_param+0xb9/0xb9
[ 7.260217] kernel_init_freeable+0x124/0x1d9
[ 7.260217] ? rest_init+0xc5/0xc5
[ 7.260217] kernel_init+0xb/0x147
[ 7.260217] ? rest_init+0xc5/0xc5
[ 7.260217] ret_from_fork+0x24/0x30
[ 7.267845]
[ 7.268075] =============================
[ 7.268564] WARNING: suspicious RCU usage
[ 7.269031] 4.16.0-rc4-00130-g499ac3b #2 Not tainted
[ 7.269622] -----------------------------
[ 7.270084] lib/test_rhashtable.c:507 suspicious rcu_dereference_protected() usage!
[ 7.271169]
[ 7.271169] other info that might help us debug this:
[ 7.271169]
[ 7.272102]
[ 7.272102] rcu_scheduler_active = 2, debug_locks = 1
[ 7.272851] no locks held by swapper/0/1.
[ 7.273338]
[ 7.273338] stack backtrace:
[ 7.273862] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.16.0-rc4-00130-g499ac3b #2
[ 7.274723] Call Trace:
[ 7.275024] dump_stack+0xb7/0x107
[ 7.275452] print_ht+0xf4/0x35d
[ 7.275856] test_insert_dup+0x13b/0x1ce
[ 7.276085] ? ___siphash_aligned+0x2b/0x2b
[ 7.276085] ? jhash+0x1bb/0x1bb
[ 7.276085] ? my_hashfn+0x1a/0x1a
[ 7.276085] ? rhashtable_walk_peek+0x78/0x78
[ 7.276085] test_rht_init+0x6f8/0x1212
[ 7.276085] ? ___siphash_aligned+0x2b/0x2b
[ 7.276085] ? initcall_blacklisted+0xb0/0xd3
[ 7.276085] ? kstrtoll+0x9a/0xbc
[ 7.276085] ? kstrtos8+0x69/0x89
[ 7.276085] ? test_insert_dup+0x1ce/0x1ce
[ 7.276085] ? do_early_param+0xb9/0xb9
[ 7.276085] do_one_initcall+0xaa/0x17d
[ 7.276085] ? do_early_param+0xb9/0xb9
[ 7.276085] kernel_init_freeable+0x124/0x1d9
[ 7.276085] ? rest_init+0xc5/0xc5
[ 7.276085] kernel_init+0xb/0x147
[ 7.276085] ? rest_init+0xc5/0xc5
[ 7.276085] ret_from_fork+0x24/0x30
[ 7.285387]
[ 7.285589] =============================
[ 7.286070] WARNING: suspicious RCU usage
[ 7.286550] 4.16.0-rc4-00130-g499ac3b #2 Not tainted
[ 7.287121] -----------------------------
[ 7.287590] lib/test_rhashtable.c:508 suspicious rcu_dereference_protected() usage!
[ 7.288702]
[ 7.288702] other info that might help us debug this:
[ 7.288702]
[ 7.289617]
[ 7.289617] rcu_scheduler_active = 2, debug_locks = 1
[ 7.290374] no locks held by swapper/0/1.
[ 7.290859]
[ 7.290859] stack backtrace:
[ 7.291375] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.16.0-rc4-00130-g499ac3b #2
[ 7.292239] Call Trace:
[ 7.292556] dump_stack+0xb7/0x107
[ 7.292669] print_ht+0x15e/0x35d
[ 7.292669] test_insert_dup+0x13b/0x1ce
[ 7.292669] ? ___siphash_aligned+0x2b/0x2b
[ 7.292669] ? jhash+0x1bb/0x1bb
[ 7.292669] ? my_hashfn+0x1a/0x1a
[ 7.292669] ? rhashtable_walk_peek+0x78/0x78
[ 7.292669] test_rht_init+0x6f8/0x1212
[ 7.292669] ? ___siphash_aligned+0x2b/0x2b
[ 7.292669] ? initcall_blacklisted+0xb0/0xd3
[ 7.292669] ? kstrtoll+0x9a/0xbc
[ 7.292669] ? kstrtos8+0x69/0x89
[ 7.292669] ? test_insert_dup+0x1ce/0x1ce
[ 7.292669] ? do_early_param+0xb9/0xb9
[ 7.292669] do_one_initcall+0xaa/0x17d
[ 7.292669] ? do_early_param+0xb9/0xb9
[ 7.292669] kernel_init_freeable+0x124/0x1d9
[ 7.292669] ? rest_init+0xc5/0xc5
[ 7.292669] kernel_init+0xb/0x147
[ 7.292669] ? rest_init+0xc5/0xc5
[ 7.292669] ret_from_fork+0x24/0x30
[ 7.302814]
[ 7.303002] =============================
[ 7.303480] WARNING: suspicious RCU usage
[ 7.303942] 4.16.0-rc4-00130-g499ac3b #2 Not tainted
[ 7.304550] -----------------------------
[ 7.305015] lib/test_rhashtable.c:519 suspicious rcu_dereference_protected() usage!
[ 7.306095]
[ 7.306095] other info that might help us debug this:
[ 7.306095]
[ 7.306995]
[ 7.306995] rcu_scheduler_active = 2, debug_locks = 1
[ 7.307755] no locks held by swapper/0/1.
[ 7.308242]
[ 7.308242] stack backtrace:
[ 7.308762] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.16.0-rc4-00130-g499ac3b #2
[ 7.309626] Call Trace:
[ 7.309945] dump_stack+0xb7/0x107
[ 7.310367] print_ht+0x1f0/0x35d
[ 7.310762] test_insert_dup+0x13b/0x1ce
[ 7.311232] ? ___siphash_aligned+0x2b/0x2b
[ 7.311851] ? jhash+0x1bb/0x1bb
[ 7.312228] ? my_hashfn+0x1a/0x1a
[ 7.312228] ? rhashtable_walk_peek+0x78/0x78
[ 7.312228] test_rht_init+0x6f8/0x1212
[ 7.312228] ? ___siphash_aligned+0x2b/0x2b
[ 7.312228] ? initcall_blacklisted+0xb0/0xd3
[ 7.312228] ? kstrtoll+0x9a/0xbc
[ 7.312228] ? kstrtos8+0x69/0x89
[ 7.312228] ? test_insert_dup+0x1ce/0x1ce
[ 7.312228] ? do_early_param+0xb9/0xb9
[ 7.312228] do_one_initcall+0xaa/0x17d
[ 7.312228] ? do_early_param+0xb9/0xb9
[ 7.312228] kernel_init_freeable+0x124/0x1d9
[ 7.312228] ? rest_init+0xc5/0xc5
[ 7.312228] kernel_init+0xb/0x147
[ 7.312228] ? rest_init+0xc5/0xc5
[ 7.312228] ret_from_fork+0x24/0x30
[ 7.320198]
[ 7.320408] =============================
[ 7.320870] WARNING: suspicious RCU usage
[ 7.321361] 4.16.0-rc4-00130-g499ac3b #2 Not tainted
[ 7.321929] -----------------------------
[ 7.322398] lib/test_rhashtable.c:529 suspicious rcu_dereference_protected() usage!
[ 7.323469]
[ 7.323469] other info that might help us debug this:
[ 7.323469]
[ 7.324404]
[ 7.324404] rcu_scheduler_active = 2, debug_locks = 1
[ 7.325157] no locks held by swapper/0/1.
[ 7.325631]
[ 7.325631] stack backtrace:
[ 7.326158] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.16.0-rc4-00130-g499ac3b #2
[ 7.326980] Call Trace:
[ 7.327293] dump_stack+0xb7/0x107
[ 7.327707] print_ht+0x2bc/0x35d
[ 7.328129] test_insert_dup+0x13b/0x1ce
[ 7.328380] ? ___siphash_aligned+0x2b/0x2b
[ 7.328380] ? jhash+0x1bb/0x1bb
[ 7.328380] ? my_hashfn+0x1a/0x1a
[ 7.328380] ? rhashtable_walk_peek+0x78/0x78
[ 7.328380] test_rht_init+0x6f8/0x1212
[ 7.328380] ? ___siphash_aligned+0x2b/0x2b
[ 7.328380] ? initcall_blacklisted+0xb0/0xd3
[ 7.328380] ? kstrtoll+0x9a/0xbc
[ 7.328380] ? kstrtos8+0x69/0x89
[ 7.328380] ? test_insert_dup+0x1ce/0x1ce
[ 7.328380] ? do_early_param+0xb9/0xb9
[ 7.328380] do_one_initcall+0xaa/0x17d
[ 7.328380] ? do_early_param+0xb9/0xb9
[ 7.328380] kernel_init_freeable+0x124/0x1d9
[ 7.328380] ? rest_init+0xc5/0xc5
[ 7.328380] kernel_init+0xb/0x147
[ 7.328380] ? rest_init+0xc5/0xc5
[ 7.328380] ret_from_fork+0x24/0x30
[ 7.337480]
[ 7.337480] ---- ht: ----
[ 7.337480] bucket[1] -> [[ val 1 (tid=0) ]] -> [[ val 21 (tid=1) ]]
[ 7.337480] -------------
[ 7.339010]
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 720b4957c76e21b64ebcfbe2db6628653457a132 661e50bc853209e41a5c14a290ca4decc43cbfd1 --
git bisect bad 2105ee619597aa7c86e54374d7c18ca66d409546 # 05:17 B 0 11 24 0 Merge 'regmap/for-next' into devel-catchup-201803080312
git bisect bad 4f9652fad49d3194174fd861d2ba2a008273380b # 05:27 B 0 2 15 0 Merge 'hid/for-4.16/upstream-fixes' into devel-catchup-201803080312
git bisect bad ee2902aa03dd3b02a8a7f01b4f8fa5b22e854d26 # 05:50 B 0 1 14 0 Merge 'jkirsher-net-queue/master' into devel-catchup-201803080312
git bisect good 08d0c47a51087fe73203e85d2455078bfeec2eeb # 06:05 G 11 0 0 0 Merge 'linux-review/Leon-Romanovsky/RDMA-ucma-Limit-possible-option-size/20180308-012724' into devel-catchup-201803080312
git bisect good 70ccbfde7342e3d79f4fce05da08d1b6002d2492 # 06:19 G 11 0 1 1 Merge 'linux-review/Leon-Romanovsky/RDMA-ucma-Check-that-user-doesn-t-overflow-QP-state/20180308-011932' into devel-catchup-201803080312
git bisect good 7cb0d12201b8971cd91400c59e91743f760e3991 # 06:32 G 11 0 4 4 Merge 'linux-nvme/nvme-4.16-rc5' into devel-catchup-201803080312
git bisect good d69242bf203e3123ab722bdaa95e1bc42472d10b # 06:46 G 11 0 1 1 Merge tag 'mac80211-for-davem-2018-03-02' of git://git.kernel.org/pub/scm/linux/kernel/git/jberg/mac80211
git bisect good b3bf5666a51068ad5ddd89a76ed877101ef3bc16 # 06:55 G 11 0 4 4 hv_netvsc: defer queue selection to VF
git bisect good 25b5cdfcce1b57971840505dfc78556bd12dea6d # 07:07 G 11 0 1 1 dt-bindings: net: renesas-ravb: Make stream buffer optional
git bisect bad 2695578b896aea472b2c0dcbe9d92daa71738484 # 07:16 B 0 4 17 0 net: usbnet: fix potential deadlock on 32bit hosts
git bisect bad 803fafbe0cd522fa6b9e41ca3b96cfb2e2a2222d # 07:34 B 0 1 14 0 fsl/fman: avoid sleeping in atomic context while adding an address
git bisect bad 499ac3b60f657dae82055fc81c7b01e6242ac9bc # 07:50 B 0 11 26 2 test_rhashtable: add test case for rhltable with duplicate objects
git bisect good d3dcf8eb615537526bd42ff27a081d46d337816e # 07:59 G 10 0 1 1 rhashtable: Fix rhlist duplicates insertion
# first bad commit: [499ac3b60f657dae82055fc81c7b01e6242ac9bc] test_rhashtable: add test case for rhltable with duplicate objects
git bisect good d3dcf8eb615537526bd42ff27a081d46d337816e # 08:02 G 32 0 3 4 rhashtable: Fix rhlist duplicates insertion
# extra tests with debug options
git bisect bad 499ac3b60f657dae82055fc81c7b01e6242ac9bc # 08:12 B 0 3 16 0 test_rhashtable: add test case for rhltable with duplicate objects
# extra tests on HEAD of linux-devel/devel-catchup-201803080312
git bisect bad 720b4957c76e21b64ebcfbe2db6628653457a132 # 08:18 B 0 13 29 0 0day head guard for 'devel-catchup-201803080312'
# extra tests on tree/branch linux-devel/devel-catchup-201803080233
# extra tests with first bad commit reverted
git bisect good 7c17a6b5257f54bfeba9868af4a2fbbf0ae73c9f # 15:37 G 11 0 0 0 Revert "test_rhashtable: add test case for rhltable with duplicate objects"
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
Download attachment "dmesg-yocto-lkp-hsw01-11:20180308074820:x86_64-randconfig-in0-03080359:4.16.0-rc4-00130-g499ac3b:2.gz" of type "application/gzip" (24247 bytes)
Download attachment "dmesg-yocto-lkp-hsw01-25:20180308080106:x86_64-randconfig-in0-03080359:4.16.0-rc4-00129-gd3dcf8e:1.gz" of type "application/gzip" (39654 bytes)
View attachment "reproduce-yocto-lkp-hsw01-11:20180308074820:x86_64-randconfig-in0-03080359:4.16.0-rc4-00130-g499ac3b:2" of type "text/plain" (916 bytes)
View attachment "config-4.16.0-rc4-00130-g499ac3b" of type "text/plain" (127291 bytes)
Powered by blists - more mailing lists