28307d938f ("percpu: make pcpu_alloc() aware of current gfp .."): BUG: kernel reboot-without-warning in boot stage
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit 28307d938fb2e4056ed4c982c06d1503d7719813
Author: Filipe Manana <fdmanana(a)suse.com>
AuthorDate: Thu May 7 18:36:10 2020 -0700
Commit: Linus Torvalds <torvalds(a)linux-foundation.org>
CommitDate: Thu May 7 19:27:21 2020 -0700
percpu: make pcpu_alloc() aware of current gfp context
Since 5.7-rc1, on btrfs we have a percpu counter initialization for
which we always pass a GFP_KERNEL gfp_t argument (this happens since
commit 2992df73268f78 ("btrfs: Implement DREW lock")).
That is safe in some contextes but not on others where allowing fs
reclaim could lead to a deadlock because we are either holding some
btrfs lock needed for a transaction commit or holding a btrfs
transaction handle open. Because of that we surround the call to the
function that initializes the percpu counter with a NOFS context using
memalloc_nofs_save() (this is done at btrfs_init_fs_root()).
However it turns out that this is not enough to prevent a possible
deadlock because percpu_alloc() determines if it is in an atomic context
by looking exclusively at the gfp flags passed to it (GFP_KERNEL in this
case) and it is not aware that a NOFS context is set.
Because percpu_alloc() thinks it is in a non atomic context it locks the
pcpu_alloc_mutex. This can result in a btrfs deadlock when
pcpu_balance_workfn() is running, has acquired that mutex and is waiting
for reclaim, while the btrfs task that called percpu_counter_init() (and
therefore percpu_alloc()) is holding either the btrfs commit_root
semaphore or a transaction handle (done fs/btrfs/backref.c:
iterate_extent_inodes()), which prevents reclaim from finishing as an
attempt to commit the current btrfs transaction will deadlock.
Lockdep reports this issue with the following trace:
======================================================
WARNING: possible circular locking dependency detected
5.6.0-rc7-btrfs-next-77 #1 Not tainted
------------------------------------------------------
kswapd0/91 is trying to acquire lock:
ffff8938a3b3fdc8 (&delayed_node->mutex){+.+.}, at: __btrfs_release_delayed_node.part.0+0x3f/0x320 [btrfs]
but task is already holding lock:
ffffffffb4f0dbc0 (fs_reclaim){+.+.}, at: __fs_reclaim_acquire+0x5/0x30
which lock already depends on the new lock.
the existing dependency chain (in reverse order) is:
-> #4 (fs_reclaim){+.+.}:
fs_reclaim_acquire.part.0+0x25/0x30
__kmalloc+0x5f/0x3a0
pcpu_create_chunk+0x19/0x230
pcpu_balance_workfn+0x56a/0x680
process_one_work+0x235/0x5f0
worker_thread+0x50/0x3b0
kthread+0x120/0x140
ret_from_fork+0x3a/0x50
-> #3 (pcpu_alloc_mutex){+.+.}:
__mutex_lock+0xa9/0xaf0
pcpu_alloc+0x480/0x7c0
__percpu_counter_init+0x50/0xd0
btrfs_drew_lock_init+0x22/0x70 [btrfs]
btrfs_get_fs_root+0x29c/0x5c0 [btrfs]
resolve_indirect_refs+0x120/0xa30 [btrfs]
find_parent_nodes+0x50b/0xf30 [btrfs]
btrfs_find_all_leafs+0x60/0xb0 [btrfs]
iterate_extent_inodes+0x139/0x2f0 [btrfs]
iterate_inodes_from_logical+0xa1/0xe0 [btrfs]
btrfs_ioctl_logical_to_ino+0xb4/0x190 [btrfs]
btrfs_ioctl+0x165a/0x3130 [btrfs]
ksys_ioctl+0x87/0xc0
__x64_sys_ioctl+0x16/0x20
do_syscall_64+0x5c/0x260
entry_SYSCALL_64_after_hwframe+0x49/0xbe
-> #2 (&fs_info->commit_root_sem){++++}:
down_write+0x38/0x70
btrfs_cache_block_group+0x2ec/0x500 [btrfs]
find_free_extent+0xc6a/0x1600 [btrfs]
btrfs_reserve_extent+0x9b/0x180 [btrfs]
btrfs_alloc_tree_block+0xc1/0x350 [btrfs]
alloc_tree_block_no_bg_flush+0x4a/0x60 [btrfs]
__btrfs_cow_block+0x122/0x5a0 [btrfs]
btrfs_cow_block+0x106/0x240 [btrfs]
commit_cowonly_roots+0x55/0x310 [btrfs]
btrfs_commit_transaction+0x509/0xb20 [btrfs]
sync_filesystem+0x74/0x90
generic_shutdown_super+0x22/0x100
kill_anon_super+0x14/0x30
btrfs_kill_super+0x12/0x20 [btrfs]
deactivate_locked_super+0x31/0x70
cleanup_mnt+0x100/0x160
task_work_run+0x93/0xc0
exit_to_usermode_loop+0xf9/0x100
do_syscall_64+0x20d/0x260
entry_SYSCALL_64_after_hwframe+0x49/0xbe
-> #1 (&space_info->groups_sem){++++}:
down_read+0x3c/0x140
find_free_extent+0xef6/0x1600 [btrfs]
btrfs_reserve_extent+0x9b/0x180 [btrfs]
btrfs_alloc_tree_block+0xc1/0x350 [btrfs]
alloc_tree_block_no_bg_flush+0x4a/0x60 [btrfs]
__btrfs_cow_block+0x122/0x5a0 [btrfs]
btrfs_cow_block+0x106/0x240 [btrfs]
btrfs_search_slot+0x50c/0xd60 [btrfs]
btrfs_lookup_inode+0x3a/0xc0 [btrfs]
__btrfs_update_delayed_inode+0x90/0x280 [btrfs]
__btrfs_commit_inode_delayed_items+0x81f/0x870 [btrfs]
__btrfs_run_delayed_items+0x8e/0x180 [btrfs]
btrfs_commit_transaction+0x31b/0xb20 [btrfs]
iterate_supers+0x87/0xf0
ksys_sync+0x60/0xb0
__ia32_sys_sync+0xa/0x10
do_syscall_64+0x5c/0x260
entry_SYSCALL_64_after_hwframe+0x49/0xbe
-> #0 (&delayed_node->mutex){+.+.}:
__lock_acquire+0xef0/0x1c80
lock_acquire+0xa2/0x1d0
__mutex_lock+0xa9/0xaf0
__btrfs_release_delayed_node.part.0+0x3f/0x320 [btrfs]
btrfs_evict_inode+0x40d/0x560 [btrfs]
evict+0xd9/0x1c0
dispose_list+0x48/0x70
prune_icache_sb+0x54/0x80
super_cache_scan+0x124/0x1a0
do_shrink_slab+0x176/0x440
shrink_slab+0x23a/0x2c0
shrink_node+0x188/0x6e0
balance_pgdat+0x31d/0x7f0
kswapd+0x238/0x550
kthread+0x120/0x140
ret_from_fork+0x3a/0x50
other info that might help us debug this:
Chain exists of:
&delayed_node->mutex --> pcpu_alloc_mutex --> fs_reclaim
Possible unsafe locking scenario:
CPU0 CPU1
---- ----
lock(fs_reclaim);
lock(pcpu_alloc_mutex);
lock(fs_reclaim);
lock(&delayed_node->mutex);
*** DEADLOCK ***
3 locks held by kswapd0/91:
#0: (fs_reclaim){+.+.}, at: __fs_reclaim_acquire+0x5/0x30
#1: (shrinker_rwsem){++++}, at: shrink_slab+0x12f/0x2c0
#2: (&type->s_umount_key#43){++++}, at: trylock_super+0x16/0x50
stack backtrace:
CPU: 1 PID: 91 Comm: kswapd0 Not tainted 5.6.0-rc7-btrfs-next-77 #1
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.12.0-0-ga698c8995f-prebuilt.qemu.org 04/01/2014
Call Trace:
dump_stack+0x8f/0xd0
check_noncircular+0x170/0x190
__lock_acquire+0xef0/0x1c80
lock_acquire+0xa2/0x1d0
__mutex_lock+0xa9/0xaf0
__btrfs_release_delayed_node.part.0+0x3f/0x320 [btrfs]
btrfs_evict_inode+0x40d/0x560 [btrfs]
evict+0xd9/0x1c0
dispose_list+0x48/0x70
prune_icache_sb+0x54/0x80
super_cache_scan+0x124/0x1a0
do_shrink_slab+0x176/0x440
shrink_slab+0x23a/0x2c0
shrink_node+0x188/0x6e0
balance_pgdat+0x31d/0x7f0
kswapd+0x238/0x550
kthread+0x120/0x140
ret_from_fork+0x3a/0x50
This could be fixed by making btrfs pass GFP_NOFS instead of GFP_KERNEL
to percpu_counter_init() in contextes where it is not reclaim safe,
however that type of approach is discouraged since
memalloc_[nofs|noio]_save() were introduced. Therefore this change
makes pcpu_alloc() look up into an existing nofs/noio context before
deciding whether it is in an atomic context or not.
Signed-off-by: Filipe Manana <fdmanana(a)suse.com>
Signed-off-by: Andrew Morton <akpm(a)linux-foundation.org>
Reviewed-by: Andrew Morton <akpm(a)linux-foundation.org>
Acked-by: Tejun Heo <tj(a)kernel.org>
Acked-by: Dennis Zhou <dennis(a)kernel.org>
Cc: Tejun Heo <tj(a)kernel.org>
Cc: Christoph Lameter <cl(a)linux.com>
Link: http://lkml.kernel.org/r/20200430164356.15543-1-fdmanana@kernel.org
Signed-off-by: Linus Torvalds <torvalds(a)linux-foundation.org>
cbfc35a486 mm/slub: fix incorrect interpretation of s->offset
28307d938f percpu: make pcpu_alloc() aware of current gfp context
+----------------------------------------------------------+------------+------------+
| | cbfc35a486 | 28307d938f |
+----------------------------------------------------------+------------+------------+
| boot_successes | 37 | 0 |
| boot_failures | 8 | 17 |
| WARNING:at_kernel/rcu/rcutorture.c:#rcu_torture_fwd_prog | 2 | |
| RIP:rcu_torture_fwd_prog | 2 | |
| BUG:kernel_reboot-without-warning_in_test_stage | 3 | |
| BUG:kernel_hang_in_boot_stage | 1 | |
| BUG:kernel_hang_in_test_stage | 2 | |
| BUG:kernel_reboot-without-warning_in_boot_stage | 0 | 17 |
+----------------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 0.144174] RAMDISK: [mem 0x7fa2e000-0x7fffffff]
[ 0.144559] ACPI: Early table checksum verification disabled
[ 0.144985] ACPI: RSDP 0x00000000000F5850 000014 (v00 BOCHS )
[ 0.145424] ACPI: RSDT 0x00000000BFFE15C9 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.146051] ACPI: FACP 0x00000000BFFE149D 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
BUG: kernel reboot-without-warning in boot stage
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start cef077e6aa4c7dbe2f23e1201cf705f9540ec467 v5.6 --
git bisect good d32cedbec0a64e24548986a0159ab86cfe6a4097 # 08:34 G 10 0 0 6 staging: wfx: drop struct wfx_queue_stats
git bisect good 2760220700ac830837742bad575630cd9bac8eba # 08:34 G 10 0 0 6 staging: wfx: show counters of all interfaces
git bisect bad 832cc98141b4b93acbb9231ca9e36f7fbe347f47 # 08:35 B 0 17 33 0 staging: wfx: fix double free
git bisect good faeea64fb9748002ed2aecff6e5caa01cc829735 # 08:39 G 10 0 0 9 staging: qlge: Remove goto statements from ql_get_mac_addr_reg
git bisect good 986da7debb04225221d8876b405c4088614ae5f4 # 08:39 G 11 0 0 4 staging: vt6656: Return on isr0 when zero.
git bisect good 3be1acffe684b11b9447cc7140ea0e59efa19a20 # 08:39 G 18 0 0 8 staging: vt6655: remove else after return and invert condition
git bisect good 0729bb9b2a97a279c4b7c7be8565d494aab3d6e9 # 08:39 G 11 0 0 0 staging: vt6655: fix LONG_LINE warning
git bisect bad ae73e7784871ebe2c43da619b4a1e2c9ff81508d # 08:39 B 0 23 39 0 Merge 5.7-rc5 into staging-next
git bisect good 2e11cc1ab790ccbc7c7f6ed74c0f40b85c561dc7 # 08:39 G 11 0 0 4 staging: vt6656: Use const for read only data
git bisect good b9388959ba507c7a48ac18e4aa3b63b8a910ed99 # 08:39 G 10 0 0 2 Merge tag 'tag-chrome-platform-fixes-for-v5.7-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/chrome-platform/linux
git bisect good 9ecc4d775f61fb3fd26a1b8cc70a56a98b3b40d3 # 08:39 G 11 0 0 4 Merge tag 'linux-kselftest-5.7-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest
git bisect bad c61529f6f59c9e136432cde96f9a053a51ad2a1e # 08:39 B 0 21 37 0 Merge tag 'driver-core-5.7-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/gregkh/driver-core
git bisect bad af38553c661207f96464e15f3506bf788daee474 # 08:39 B 0 11 27 0 Merge branch 'akpm' (patches from Andrew)
git bisect bad 8d58f222e85f01da0c0e1fc1e77986c86de889e2 # 10:31 B 0 11 37 10 ubsan: disable UBSAN_ALIGNMENT under COMPILE_TEST
git bisect good 0c54a6a44bf3d41e76ce3f583a6ece267618df2e # 12:35 G 11 0 1 1 eventpoll: fix missing wakeup for ovflist in ep_poll_callback
git bisect bad 28307d938fb2e4056ed4c982c06d1503d7719813 # 12:51 B 0 10 26 0 percpu: make pcpu_alloc() aware of current gfp context
git bisect good cbfc35a48609ceac978791e3ab9dde0c01f8cb20 # 13:58 G 10 0 2 2 mm/slub: fix incorrect interpretation of s->offset
# first bad commit: [28307d938fb2e4056ed4c982c06d1503d7719813] percpu: make pcpu_alloc() aware of current gfp context
git bisect good cbfc35a48609ceac978791e3ab9dde0c01f8cb20 # 14:10 G 30 0 2 6 mm/slub: fix incorrect interpretation of s->offset
# extra tests with debug options
# extra tests on head commit of linus/master
# 119: [75caf310d16cc5e2f851c048cd597f5437013368] Merge branch 'akpm' (patches from Andrew)
# extra tests on revert first bad commit
# 119: [9ae36539355c14fa1681e66744db5fc4e4066013] Revert "percpu: make pcpu_alloc() aware of current gfp context"
# extra tests on linus/master
# duplicated: [75caf310d16cc5e2f851c048cd597f5437013368] Merge branch 'akpm' (patches from Andrew)
# extra tests on linux-next/master
# 119: [ff387fc20c697cdc887b2abf7ef494e853795a2f] Add linux-next specific files for 20200528
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
7 months, 3 weeks
021e70c3a6 ("treewide: Replace one-element array with .."): BUG: KASAN: slab-out-of-bounds in alloc_pid
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/gustavoars/linux.git testing/fam1
commit 021e70c3a66ced20bdfa6694d32bbb64bd8c954a
Author: Gustavo A. R. Silva <gustavoars(a)kernel.org>
AuthorDate: Tue May 19 18:32:17 2020 -0500
Commit: Gustavo A. R. Silva <gustavoars(a)kernel.org>
CommitDate: Tue May 19 18:32:17 2020 -0500
treewide: Replace one-element array with flexible-array
The current codebase makes use of one-element arrays in the following
form:
struct something {
int length;
u8 data[1];
};
struct something *instance;
instance = kmalloc(sizeof(*instance) + size, GFP_KERNEL);
instance->length = size;
memcpy(instance->data, source, size);
but the preferred mechanism to declare variable-length types such as
these ones is a flexible array member[1][2], introduced in C99:
struct foo {
int stuff;
struct boo array[];
};
By making use of the mechanism above, we will get a compiler warning
in case the flexible array does not occur last in the structure, which
will help us prevent some kind of undefined behavior bugs from being
inadvertently introduced[3] to the codebase from now on.
This issue was found with the help of Coccinelle.
[1] https://gcc.gnu.org/onlinedocs/gcc/Zero-Length.html
[2] https://github.com/KSPP/linux/issues/21
[3] commit 76497732932f ("cxgb3/l2t: Fix undefined behaviour")
Signed-off-by: Gustavo A. R. Silva <gustavoars(a)kernel.org>
6a8b55ed40 Linux 5.7-rc3
021e70c3a6 treewide: Replace one-element array with flexible-array
ae1a42dc97 ice: Replace one-element arrays with flexible-arrays
+-----------------------------------------------------------+----------+------------+------------+
| | v5.7-rc3 | 021e70c3a6 | ae1a42dc97 |
+-----------------------------------------------------------+----------+------------+------------+
| boot_successes | 36 | 0 | 0 |
| boot_failures | 6 | 15 | 13 |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 5 | | |
| Assertion_failed | 2 | | |
| BUG:kernel_hang_in_boot_stage | 1 | | |
| BUG:KASAN:slab-out-of-bounds_in_a | 0 | 15 | 13 |
+-----------------------------------------------------------+----------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 3.729174] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available!
[ 3.729181] Speculative Store Bypass: Vulnerable
[ 3.731626] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[ 3.733941] Freeing SMP alternatives memory: 36K
[ 3.735777] ==================================================================
[ 3.737114] BUG: KASAN: slab-out-of-bounds in alloc_pid+0x8db/0xa60
[ 3.738191] Write of size 4 at addr ffff8881f5f720d0 by task swapper/0/0
[ 3.739317]
[ 3.739606] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.7.0-rc3-00001-g021e70c3a66ce #1
[ 3.740976] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 3.742377] Call Trace:
[ 3.742829] dump_stack+0x97/0xe0
[ 3.743412] print_address_description.cold+0xd3/0x342
[ 3.744483] ? alloc_pid+0x8db/0xa60
[ 3.745116] __kasan_report.cold+0x37/0x7d
[ 3.745533] ? alloc_pid+0x8db/0xa60
[ 3.745533] kasan_report+0x4f/0x60
[ 3.745533] alloc_pid+0x8db/0xa60
[ 3.745533] copy_process+0x25cb/0x74e0
[ 3.745533] ? lock_downgrade+0x730/0x730
[ 3.745533] ? _raw_spin_unlock_irqrestore+0x6c/0x90
[ 3.745533] ? __cleanup_sighand+0xb0/0xb0
[ 3.745533] ? sync_exp_work_done+0x1f8/0x280
[ 3.745533] ? synchronize_rcu_expedited+0x7e3/0xd30
[ 3.745533] _do_fork+0xf8/0xb80
[ 3.745533] ? sync_rcu_exp_select_cpus+0xc80/0xc80
[ 3.745533] ? acpi_hw_read+0x273/0x273
[ 3.745533] ? copy_init_mm+0x20/0x20
[ 3.745533] ? acpi_hw_register_read+0xbb/0x201
[ 3.745533] ? acpi_hw_write_pm1_control+0xa4/0xa4
[ 3.745533] kernel_thread+0x9a/0xc0
[ 3.745533] ? legacy_clone_args_valid+0x50/0x50
[ 3.745533] ? _find_next_bit+0x36/0x1b0
[ 3.745533] ? rest_init+0x273/0x273
[ 3.745533] rest_init+0x22/0x273
[ 3.745533] start_kernel+0xa15/0xa3f
[ 3.745533] ? thread_stack_cache_init+0x6/0x6
[ 3.745533] ? memcpy_orig+0x16/0x110
[ 3.745533] ? x86_family+0x5/0x20
[ 3.745533] ? load_ucode_bsp+0x42/0x144
[ 3.745533] secondary_startup_64+0xb6/0xc0
[ 3.745533]
[ 3.745533] Allocated by task 0:
[ 3.745533] save_stack+0x1b/0x40
[ 3.745533] __kasan_kmalloc+0xe2/0xf0
[ 3.745533] kmem_cache_alloc+0x197/0x4f0
[ 3.745533] alloc_pid+0xaf/0xa60
[ 3.745533] copy_process+0x25cb/0x74e0
[ 3.745533] _do_fork+0xf8/0xb80
[ 3.745533] kernel_thread+0x9a/0xc0
[ 3.745533] rest_init+0x22/0x273
[ 3.745533] start_kernel+0xa15/0xa3f
[ 3.745533] secondary_startup_64+0xb6/0xc0
[ 3.745533]
[ 3.745533] Freed by task 0:
[ 3.745533] (stack is not available)
[ 3.745533]
[ 3.745533] The buggy address belongs to the object at ffff8881f5f72000
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start ae1a42dc97fe538b80dda4e4b179ed5c553444dd 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c --
git bisect bad 1b923d697c5f94c03e966253a0061b064814a255 # 02:02 B 0 11 29 2 x86/uv/time: Replace one-element array and save heap space
git bisect bad 021e70c3a66ced20bdfa6694d32bbb64bd8c954a # 02:35 B 0 11 31 4 treewide: Replace one-element array with flexible-array
# first bad commit: [021e70c3a66ced20bdfa6694d32bbb64bd8c954a] treewide: Replace one-element array with flexible-array
git bisect good 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c # 02:40 G 32 0 0 6 Linux 5.7-rc3
# extra tests with debug options
git bisect bad 021e70c3a66ced20bdfa6694d32bbb64bd8c954a # 04:09 B 0 3 19 0 treewide: Replace one-element array with flexible-array
# extra tests on head commit of gustavoars-linux/testing/fam1
git bisect bad ae1a42dc97fe538b80dda4e4b179ed5c553444dd # 04:23 B 0 13 32 0 ice: Replace one-element arrays with flexible-arrays
# bad: [ae1a42dc97fe538b80dda4e4b179ed5c553444dd] ice: Replace one-element arrays with flexible-arrays
# extra tests on revert first bad commit
git bisect good cd9bedca23270fa6a9f92520819dc5ab407ea041 # 06:18 G 11 0 0 0 Revert "treewide: Replace one-element array with flexible-array"
# good: [cd9bedca23270fa6a9f92520819dc5ab407ea041] Revert "treewide: Replace one-element array with flexible-array"
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
7 months, 3 weeks
[x86/traps] 68a05c6247: PANIC:double_fault
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-8):
commit: 68a05c6247d2aa67f5ada1009ffd19758e5914ea ("x86/traps: Mark fixup_bad_iret() noinstr")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: kernel-selftests
with following parameters:
group: kselftests-x86
test-description: The kernel contains a set of "self tests" under the tools/testing/selftests/ directory. These are intended to be small unit tests to exercise individual code paths in the kernel.
test-url: https://www.kernel.org/doc/Documentation/kselftest.txt
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 8G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------------+------------+------------+
| | b5f7e5db38 | 68a05c6247 |
+-----------------------------------------------------------+------------+------------+
| boot_successes | 8 | 4 |
| boot_failures | 4 | 3 |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 4 | 2 |
| PANIC:double_fault | 0 | 1 |
| double_fault:#[##] | 0 | 1 |
| RIP:fixup_bad_iret | 0 | 1 |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 1 |
+-----------------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 223.398565]
[ 223.414051] ok 5 selftests: x86: check_initial_reg_state_32
[ 223.414091]
[ 223.454445] # selftests: x86: sigreturn_32
[ 223.454485]
[ 223.571324] traps: PANIC: double fault, error_code: 0x0
[ 223.571330] double fault: 0000 [#1] PREEMPT DEBUG_PAGEALLOC KASAN PTI
[ 223.571336] CPU: 0 PID: 1912 Comm: sigreturn_32 Not tainted 5.7.0-rc5-00292-g68a05c6247d2a #1
[ 223.571342] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 223.571346] RIP: 0010:fixup_bad_iret+0x37/0x140
[ 223.571359] Code: 48 c7 c7 80 0b 81 ba 41 54 49 bc 00 00 00 00 00 fc ff df 53 48 8d 9d d8 fe ff ff 48 c1 eb 03 4a 8d 04 23 48 81 ec 00 01 00 00 <48> c7 85 d8 fe ff ff b3 8a b5 41 48 c7 85 e0 fe ff ff c8 0f 60 bb
[ 223.571363] RSP: 0000:fffffe0000001fe8 EFLAGS: 00010086
[ 223.571371] RAX: fffffbc0000003fd RBX: 1fffffc0000003fd RCX: ffffffffba400aa0
[ 223.571377] RDX: 0000000000000000 RSI: ffffffffba400df5 RDI: ffffffffba810b80
[ 223.571383] RBP: fffffe0000002110 R08: 0000000000000000 R09: 0000000000000000
[ 223.571388] R10: 0000000000000000 R11: 0000000000000000 R12: dffffc0000000000
[ 223.571394] R13: fffffe0000002120 R14: 0000000000000000 R15: 0000000000000000
[ 223.571400] FS: 0000000000000000(0003) GS:ffffffffbb87e000(0063) knlGS:00000000f7c1b700
[ 223.571404] CS: 0010 DS: 0003 ES: 0003 CR0: 0000000080050033
[ 223.571410] CR2: fffffe0000001fd8 CR3: 00000001ddc30000 CR4: 00000000000406f0
[ 223.571413] Call Trace:
[ 223.571416] <ENTRY_TRAMPOLINE>
[ 223.571419] ? error_entry+0xdf/0xf0
[ 223.571423] ? general_protection+0x5/0x30
[ 223.571428] ? restore_regs_and_return_to_kernel+0x2d/0x2d
[ 223.571431] </ENTRY_TRAMPOLINE>
[ 223.571434] Modules linked in: ip_tables x_tables
[ 223.571445] ---[ end trace 15aaca2c6f41e51b ]---
[ 223.571448] RIP: 0010:fixup_bad_iret+0x37/0x140
[ 223.571460] Code: 48 c7 c7 80 0b 81 ba 41 54 49 bc 00 00 00 00 00 fc ff df 53 48 8d 9d d8 fe ff ff 48 c1 eb 03 4a 8d 04 23 48 81 ec 00 01 00 00 <48> c7 85 d8 fe ff ff b3 8a b5 41 48 c7 85 e0 fe ff ff c8 0f 60 bb
[ 223.571464] RSP: 0000:fffffe0000001fe8 EFLAGS: 00010086
[ 223.571472] RAX: fffffbc0000003fd RBX: 1fffffc0000003fd RCX: ffffffffba400aa0
[ 223.571477] RDX: 0000000000000000 RSI: ffffffffba400df5 RDI: ffffffffba810b80
[ 223.571482] RBP: fffffe0000002110 R08: 0000000000000000 R09: 0000000000000000
[ 223.571488] R10: 0000000000000000 R11: 0000000000000000 R12: dffffc0000000000
[ 223.571493] R13: fffffe0000002120 R14: 0000000000000000 R15: 0000000000000000
[ 223.571499] FS: 0000000000000000(0003) GS:ffffffffbb87e000(0063) knlGS:00000000f7c1b700
[ 223.571503] CS: 0010 DS: 0003 ES: 0003 CR0: 0000000080050033
[ 223.571508] CR2: fffffe0000001fd8 CR3: 00000001ddc30000 CR4: 00000000000406f0
[ 223.571513] Kernel panic - not syncing: Fatal exception in interrupt
[ 223.571533] Kernel Offset: 0x36200000 from 0xffffffff81000000 (relocation range: 0xffffffff80000000-0xffffffffbfffffff)
Elapsed time: 240
qemu-img create -f qcow2 disk-vm-snb-195-0 256G
To reproduce:
# build kernel
cd linux
cp config-5.7.0-rc5-00292-g68a05c6247d2a .config
make HOSTCC=gcc-8 CC=gcc-8 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
lkp
7 months, 3 weeks
4092a9304d ("__register_sysctl_table: do not drop subdir"): [ 52.099586] WARNING: CPU: 1 PID: 31 at fs/proc/proc_sysctl.c:1683 retire_sysctl_set
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux/commits/Boris-Sukholitko/__register_sysc...
commit 4092a9304d1dd88368c7cd327adb666f70a46519
Author: Boris Sukholitko <boris.sukholitko(a)broadcom.com>
AuthorDate: Wed May 27 13:48:48 2020 +0300
Commit: 0day robot <lkp(a)intel.com>
CommitDate: Wed May 27 18:50:45 2020 +0800
__register_sysctl_table: do not drop subdir
Successful get_subdir returns dir with its header.nreg properly
adjusted. No need to drop the dir in that case.
Signed-off-by: Boris Sukholitko <boris.sukholitko(a)broadcom.com>
Fixes: 7ec66d06362d (sysctl: Stop requiring explicit management of sysctl directories)
444fc5cde6 Merge tag 'for-linus' of git://git.armlinux.org.uk/~rmk/linux-arm
4092a9304d __register_sysctl_table: do not drop subdir
+----------------------------------------------------------------+------------+------------+
| | 444fc5cde6 | 4092a9304d |
+----------------------------------------------------------------+------------+------------+
| boot_successes | 264 | 6 |
| boot_failures | 104 | 130 |
| WARNING:possible_circular_locking_dependency_detected | 96 | |
| WARNING:at_kernel/tracepoint.c:#tracepoint_probe_register_prio | 7 | 3 |
| EIP:tracepoint_probe_register_prio | 7 | 3 |
| BUG:kernel_timeout_in_boot_stage | 1 | 1 |
| WARNING:at_fs/proc/proc_sysctl.c:#retire_sysctl_set | 0 | 128 |
| EIP:retire_sysctl_set | 0 | 128 |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 19 |
| Oops:#[##] | 0 | 19 |
| EIP:cap_capable | 0 | 19 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 19 |
| BUG:kernel_hang_in_test_stage | 0 | 1 |
+----------------------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 51.649226] init: tty3 main process ended, respawning
[ 51.719188] init: tty6 main process (792) terminated with status 1
[ 51.721264] init: tty6 main process ended, respawning
modprobe: FATAL: Could not load /lib/modules/5.7.0-rc7-00009-g4092a9304d1dd/modules.dep: No such file or directory
[ 52.098615] ------------[ cut here ]------------
[ 52.099586] WARNING: CPU: 1 PID: 31 at fs/proc/proc_sysctl.c:1683 retire_sysctl_set+0x50/0x60
[ 52.101221] Modules linked in:
[ 52.101759] CPU: 1 PID: 31 Comm: kworker/u4:1 Not tainted 5.7.0-rc7-00009-g4092a9304d1dd #2
[ 52.103038] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 52.104244] Workqueue: netns cleanup_net
[ 52.104916] EIP: retire_sysctl_set+0x50/0x60
[ 52.105562] Code: 76 5b de ff 59 80 7d fb 00 75 1f 6a 00 31 c9 89 da b8 e0 60 1b c3 e8 5f 5b de ff 58 8b 5d fc c9 c3 8d b4 26 00 00 00 00 66 90 <0f> 0b eb dd cc cc cc cc cc cc cc cc cc cc cc cc 3e 8d 74 26 00 55
[ 52.108365] EAX: c31b60f8 EBX: 00000001 ECX: 00000000 EDX: 00000001
[ 52.109372] ESI: c313cdb0 EDI: f6268000 EBP: f258fecc ESP: f258fec4
[ 52.110374] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010202
[ 52.111412] CR0: 80050033 CR2: 092f7020 CR3: 3647d000 CR4: 000006d0
[ 52.112384] Call Trace:
[ 52.112868] sysctl_net_exit+0x12/0x20
[ 52.113500] ops_exit_list+0x36/0x60
[ 52.114225] cleanup_net+0x1ee/0x2e0
[ 52.114881] process_one_work+0x29a/0x840
[ 52.115569] worker_thread+0x4a/0x5b0
[ 52.116219] ? mod_delayed_work_on+0xc0/0xc0
[ 52.116996] kthread+0x179/0x1b0
[ 52.117555] ? mod_delayed_work_on+0xc0/0xc0
[ 52.118243] ? kthread_mod_delayed_work+0xd0/0xd0
[ 52.119039] ret_from_fork+0x19/0x30
[ 52.119754] irq event stamp: 88960
[ 52.120323] hardirqs last enabled at (88959): [<c131d825>] kmem_cache_free+0x355/0x760
[ 52.121559] hardirqs last disabled at (88960): [<c1001db8>] trace_hardirqs_off_thunk+0xc/0x10
[ 52.122880] softirqs last enabled at (88930): [<c212d0ac>] netlink_release+0x11c/0x390
[ 52.124072] softirqs last disabled at (88928): [<c212d08b>] netlink_release+0xfb/0x390
[ 52.125285] ---[ end trace 6d87d591316b74f1 ]---
[child0:741] trace_fd was -1
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 1fba7744ed676276594af33c33711a7ade3c2917 9cb1fd0efd195590b828b9b865421ad345a4a145 --
git bisect bad a1f98555a06a0568e84f081f379495798761147d # 20:43 B 10 1 10 10 Merge 'thermal/next' into devel-hourly-2020052921
git bisect bad 6ae20b61b8ee22985f44e1d92d4f981f2ad7ae00 # 21:08 B 22 2 22 22 Merge 'linux-review/Lad-Prabhakar/media-rcar-vin-Enable-MEDIA_BUS_FMT_SRGGB8_1X8-format/20200527-201849' into devel-hourly-2020052921
git bisect good 48fcd3bb1c1f5fb23f6fe3892f9a8a53a3b3878c # 21:27 G 122 0 38 38 Merge 'lkundrak-linux-mmp/lr/ene-ec-v4' into devel-hourly-2020052921
git bisect bad 22197b2b90f8814d591f254a5e6bdc0fe627bdd2 # 21:36 B 0 2 18 0 Merge 'linux-review/Tiezhu-Yang/rtc-goldfish-Fix-return-value-of-goldfish_rtc_probe/20200523-175816' into devel-hourly-2020052921
git bisect good 676083e7e0847dcdc51959a3faac17e076215fb8 # 21:52 G 121 0 45 45 Merge 'linux-review/Gustavo-A-R-Silva/ice-Replace-one-element-arrays-with-flexible-arrays/20200527-230905' into devel-hourly-2020052921
git bisect good a83fb7003ae46837eb8046f1725dc5c3059dd946 # 22:45 G 125 0 31 31 Merge 'linux-review/Erwan-Le-Ray/STM32-Fix-uart-nodes-in-stm32mp15-pinctrl/20200528-154438' into devel-hourly-2020052921
git bisect bad 293ecfe783bbaa6c7c2ec2e36b8efb0e5e6fd4e9 # 23:02 B 0 1 17 0 Merge 'linux-review/Bartosz-Golaszewski/regmap-provide-simple-bitops-and-use-them-in-a-driver/20200528-234945' into devel-hourly-2020052921
git bisect bad 5a7a038200b0615de0ef730e14866cb5ada92864 # 23:19 B 0 3 19 0 Merge 'linux-review/Boris-Sukholitko/__register_sysctl_table-do-not-drop-subdir/20200527-185030' into devel-hourly-2020052921
git bisect good 1db0d7884078094719bcf5875e32819a1b180f00 # 23:33 G 124 0 41 41 Merge 'linux-review/Leon-Romanovsky/RDMA-core-Fix-double-destruction-of-uobject/20200527-225216' into devel-hourly-2020052921
git bisect bad 4092a9304d1dd88368c7cd327adb666f70a46519 # 23:55 B 0 4 20 0 __register_sysctl_table: do not drop subdir
# first bad commit: [4092a9304d1dd88368c7cd327adb666f70a46519] __register_sysctl_table: do not drop subdir
git bisect good 444fc5cde64330661bf59944c43844e7d4c2ccd8 # 00:20 G 361 0 110 110 Merge tag 'for-linus' of git://git.armlinux.org.uk/~rmk/linux-arm
# extra tests with debug options
git bisect bad 4092a9304d1dd88368c7cd327adb666f70a46519 # 00:35 B 0 4 20 0 __register_sysctl_table: do not drop subdir
# extra tests on head commit of linux-review/Boris-Sukholitko/__register_sysctl_table-do-not-drop-subdir/20200527-185030
git bisect bad 4092a9304d1dd88368c7cd327adb666f70a46519 # 00:39 B 0 19 147 111 __register_sysctl_table: do not drop subdir
# bad: [4092a9304d1dd88368c7cd327adb666f70a46519] __register_sysctl_table: do not drop subdir
# extra tests on revert first bad commit
git bisect good 102477b34d0fd671b7779678812bf9979c25cba4 # 02:19 G 120 0 25 25 Revert "__register_sysctl_table: do not drop subdir"
# good: [102477b34d0fd671b7779678812bf9979c25cba4] Revert "__register_sysctl_table: do not drop subdir"
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
7 months, 3 weeks
021e70c3a6 ("treewide: Replace one-element array with .."): [ 26.399858] Mem-Info:
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/gustavoars/linux.git testing/fam1
commit 021e70c3a66ced20bdfa6694d32bbb64bd8c954a
Author: Gustavo A. R. Silva <gustavoars(a)kernel.org>
AuthorDate: Tue May 19 18:32:17 2020 -0500
Commit: Gustavo A. R. Silva <gustavoars(a)kernel.org>
CommitDate: Tue May 19 18:32:17 2020 -0500
treewide: Replace one-element array with flexible-array
The current codebase makes use of one-element arrays in the following
form:
struct something {
int length;
u8 data[1];
};
struct something *instance;
instance = kmalloc(sizeof(*instance) + size, GFP_KERNEL);
instance->length = size;
memcpy(instance->data, source, size);
but the preferred mechanism to declare variable-length types such as
these ones is a flexible array member[1][2], introduced in C99:
struct foo {
int stuff;
struct boo array[];
};
By making use of the mechanism above, we will get a compiler warning
in case the flexible array does not occur last in the structure, which
will help us prevent some kind of undefined behavior bugs from being
inadvertently introduced[3] to the codebase from now on.
This issue was found with the help of Coccinelle.
[1] https://gcc.gnu.org/onlinedocs/gcc/Zero-Length.html
[2] https://github.com/KSPP/linux/issues/21
[3] commit 76497732932f ("cxgb3/l2t: Fix undefined behaviour")
Signed-off-by: Gustavo A. R. Silva <gustavoars(a)kernel.org>
6a8b55ed40 Linux 5.7-rc3
021e70c3a6 treewide: Replace one-element array with flexible-array
ae1a42dc97 ice: Replace one-element arrays with flexible-arrays
+---------------------------------------------------------------+----------+------------+------------+
| | v5.7-rc3 | 021e70c3a6 | ae1a42dc97 |
+---------------------------------------------------------------+----------+------------+------------+
| boot_successes | 1049 | 746 | 438 |
| boot_failures | 26 | 228 | 123 |
| invoked_oom-killer:gfp_mask=0x | 5 | 6 | 2 |
| Mem-Info | 6 | 19 | 4 |
| kernel_BUG_at_mm/vmalloc.c | 19 | 17 | 6 |
| invalid_opcode:#[##] | 19 | 18 | 8 |
| EIP:alloc_vmap_area | 19 | 17 | 6 |
| Kernel_panic-not_syncing:Fatal_exception | 19 | 69 | 40 |
| EIP:__copy_user_ll | 1 | 2 | 1 |
| EIP:hash_contains_ip | 1 | | |
| BUG:kernel_hang_in_boot_stage | 0 | 4 | |
| IP-Config:Auto-configuration_of_network_failed | 0 | 2 | |
| BUG:kernel_hang_in_test_stage | 0 | 4 | 2 |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 115 | 68 |
| Oops:#[##] | 0 | 132 | 76 |
| EIP:put_pid | 0 | 68 | 47 |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 80 | 44 |
| WARNING:at_net/ipv6/ip6_fib.c:#fib6_repair_tree | 0 | 40 | 17 |
| EIP:fib6_repair_tree | 0 | 40 | 17 |
| WARNING:at_lib/refcount.c:#refcount_warn_saturate | 0 | 46 | 23 |
| EIP:refcount_warn_saturate | 0 | 46 | 23 |
| BUG:unable_to_handle_page_fault_for_address | 0 | 18 | 8 |
| EIP:vt_console_print | 0 | 1 | |
| EIP:native_machine_emergency_restart | 0 | 1 | |
| INFO:rcu_sched_self-detected_stall_on_CPU | 0 | 1 | |
| EIP:native_queued_spin_lock_slowpath | 0 | 1 | |
| BUG:soft_lockup-CPU##stuck_for#s![S99trinity-root:#] | 0 | 1 | |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 0 | 1 | |
| EIP:fib6_node_lookup_1 | 0 | 3 | 2 |
| WARNING:at_mm/slab.h:#kmem_cache_free | 0 | 3 | 2 |
| EIP:kmem_cache_free | 0 | 5 | 3 |
| WARNING:at_fs/dcache.c:#dput | 0 | 1 | |
| EIP:dput | 0 | 1 | |
| EIP:fib_rules_event | 0 | 1 | |
| WARNING:at_net/ipv4/inet_connection_sock.c:#inet_csk_get_port | 0 | 1 | 2 |
| EIP:inet_csk_get_port | 0 | 1 | 2 |
| EIP:set_page_dirty | 0 | 1 | 1 |
| BUG:Bad_rss-counter_state_mm:#type:MM_SHMEMPAGES_val | 0 | 2 | 1 |
| BUG:non-zero_pgtables_bytes_on_freeing_mm | 0 | 13 | 11 |
| BUG:Bad_page_cache_in_process_trinity-c3_pfn:#c6ea | 0 | 1 | |
| EIP:aa_label_kref | 0 | 1 | |
| WARNING:at_mm/rmap.c:#unlink_anon_vmas | 0 | 3 | |
| EIP:unlink_anon_vmas | 0 | 3 | |
| PANIC:double_fault | 0 | 1 | |
| double_fault:#[##] | 0 | 1 | |
| EIP:flush_tlb_func_common | 0 | 1 | |
| WARNING:at_net/ipv6/ip6_fib.c:#fib6_walk_continue | 0 | 2 | 2 |
| EIP:fib6_walk_continue | 0 | 2 | 2 |
| EIP:kmem_cache_free_bulk | 0 | 1 | |
| WARNING:at_mm/rmap.c:#anon_vma_clone | 0 | 2 | |
| EIP:anon_vma_clone | 0 | 2 | |
| EIP:__put_anon_vma | 0 | 1 | |
| BUG:Bad_rss-counter_state_mm:#type:MM_ANONPAGES_val | 0 | 1 | 3 |
| EIP:handle_mm_fault | 0 | 3 | 1 |
| EIP:inet_sock_destruct | 0 | 1 | |
| kernel_BUG_at_mm/hugetlb.c | 0 | 1 | 2 |
| EIP:huge_pte_alloc | 0 | 1 | 2 |
| EIP:__get_user_4 | 0 | 1 | 1 |
| EIP:osq_lock | 0 | 1 | |
| BUG:Bad_rss-counter_state_mm:#type:MM_FILEPAGES_val | 0 | 1 | |
| EIP:put_pid_ns | 0 | 1 | 1 |
| EIP:__split_huge_pmd_locked | 0 | 1 | |
| EIP:free_pid | 0 | 3 | |
| EIP:__split_huge_pmd | 0 | 0 | 2 |
| EIP:copy_hugetlb_page_range | 0 | 0 | 2 |
| EIP:strncpy_from_user | 0 | 0 | 1 |
+---------------------------------------------------------------+----------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 26.238706] audit: type=1326 audit(26.437:60): auid=4294967295 uid=4294959104 gid=59368 ses=4294967295 subj==unconfined pid=858 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f3024d code=0x0
[ 26.322734] audit: type=1326 audit(26.521:61): auid=4294967295 uid=3071 gid=0 ses=4294967295 subj==unconfined pid=902 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0xb7f3024d code=0x0
[ 26.381614] vmap allocation for size 143429632 failed: use vmalloc=<size> to increase size
[ 26.382762] trinity-c1: vmalloc: allocation failure: 143421570 bytes, mode:0xcc0(GFP_KERNEL), nodemask=(null),cpuset=/,mems_allowed=0
[ 26.384332] CPU: 1 PID: 913 Comm: trinity-c1 Not tainted 5.7.0-rc3-00001-g021e70c3a66ce #1
[ 26.385448] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 26.386572] Call Trace:
[ 26.386973] dump_stack+0x60/0x7e
[ 26.387469] warn_alloc.cold+0x55/0xaf
[ 26.388011] __vmalloc_node_range+0x178/0x250
[ 26.388620] __vmalloc_node+0x46/0x50
[ 26.389268] ? kernel_read_file+0x198/0x230
[ 26.389850] vmalloc+0x34/0x40
[ 26.390305] ? kernel_read_file+0x198/0x230
[ 26.390892] kernel_read_file+0x198/0x230
[ 26.391464] ? apparmor_task_alloc+0x100/0x100
[ 26.392084] kernel_read_file_from_fd+0x36/0x70
[ 26.392718] __ia32_sys_finit_module+0x6f/0xe0
[ 26.393345] do_fast_syscall_32+0x86/0x212
[ 26.393929] entry_SYSENTER_32+0xa5/0xf8
[ 26.394499] EIP: 0xb7f3024d
[ 26.394928] Code: 0a 01 00 00 89 da 89 f3 e8 14 00 00 00 89 d3 5b 5e 5d c3 8b 04 24 c3 8b 1c 24 c3 8b 3c 24 c3 90 90 51 52 55 89 e5 0f 34 cd 80 <5d> 5a 59 c3 90 90 90 90 8d 76 00 58 b8 77 00 00 00 cd 80 90 8d 76
[ 26.397309] EAX: ffffffda EBX: 00000133 ECX: b6c9b000 EDX: 00000002
[ 26.398134] ESI: 204f496a EDI: 0000fffd EBP: 00000047 ESP: bfefbb1c
[ 26.398957] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000296
[ 26.399858] Mem-Info:
[ 26.400244] active_anon:11852 inactive_anon:38279 isolated_anon:0
[ 26.400244] active_file:0 inactive_file:2 isolated_file:0
[ 26.400244] unevictable:8977 dirty:0 writeback:0 unstable:0
[ 26.400244] slab_reclaimable:5062 slab_unreclaimable:2030
[ 26.400244] mapped:11290 shmem:48398 pagetables:473 bounce:0
[ 26.400244] free:1985158 free_pcp:540 free_cma:51200
[ 26.404408] Node 0 active_anon:47408kB inactive_anon:153116kB active_file:0kB inactive_file:8kB unevictable:35908kB isolated(anon):0kB isolated(file):0kB mapped:45160kB dirty:0kB writeback:0kB shmem:193592kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[ 26.407826] Node 0 DMA free:15916kB min:788kB low:984kB high:1180kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15916kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[ 26.411348] lowmem_reserve[]: 0 496 7808 7808
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start ae1a42dc97fe538b80dda4e4b179ed5c553444dd 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c --
git bisect bad 1b923d697c5f94c03e966253a0061b064814a255 # 17:53 B 466 2 0 166 x86/uv/time: Replace one-element array and save heap space
git bisect bad 021e70c3a66ced20bdfa6694d32bbb64bd8c954a # 17:53 B 746 1 0 253 treewide: Replace one-element array with flexible-array
# first bad commit: [021e70c3a66ced20bdfa6694d32bbb64bd8c954a] treewide: Replace one-element array with flexible-array
git bisect good 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c # 18:32 G 1002 0 5 55 Linux 5.7-rc3
# extra tests with debug options
git bisect bad 021e70c3a66ced20bdfa6694d32bbb64bd8c954a # 19:32 B 43 1 15 17 treewide: Replace one-element array with flexible-array
# extra tests on head commit of gustavoars-linux/testing/fam1
git bisect bad ae1a42dc97fe538b80dda4e4b179ed5c553444dd # 19:36 B 438 2 0 134 ice: Replace one-element arrays with flexible-arrays
# bad: [ae1a42dc97fe538b80dda4e4b179ed5c553444dd] ice: Replace one-element arrays with flexible-arrays
# extra tests on revert first bad commit
git bisect good cd9bedca23270fa6a9f92520819dc5ab407ea041 # 13:01 G 908 0 41 41 Revert "treewide: Replace one-element array with flexible-array"
# good: [cd9bedca23270fa6a9f92520819dc5ab407ea041] Revert "treewide: Replace one-element array with flexible-array"
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
7 months, 3 weeks
8177b7dcea ("scsi: move target device list to xarray"): WARNING: CPU: 0 PID: 7 at drivers/scsi/scsi_sysfs.c:1626 scsi_sysfs_device_initialize
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux/commits/Hannes-Reinecke/scsi-use-xarray-...
commit 8177b7dcea063fe348a9bf2e987142dbe5e36269
Author: Hannes Reinecke <hare(a)suse.de>
AuthorDate: Wed May 27 16:13:59 2020 +0200
Commit: 0day robot <lkp(a)intel.com>
CommitDate: Wed May 27 23:18:42 2020 +0800
scsi: move target device list to xarray
Use xarray for device lookup by target. LUNs below 256 are linear,
and can be used directly as the index into the xarray.
LUNs above 256 have a distinct LUN format, and are not necessarily
linear. They'll be stored in indices above 256 in the xarray, with
the next free index in the xarray.
Signed-off-by: Hannes Reinecke <hare(a)suse.de>
b57c88c303 target_core_pscsi: use __scsi_device_lookup()
8177b7dcea scsi: move target device list to xarray
2b83242b28 scsi: remove direct device lookup per host
+--------------------------------------------------------------------+------------+------------+------------+
| | b57c88c303 | 8177b7dcea | 2b83242b28 |
+--------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 32 | 0 | 0 |
| boot_failures | 6 | 23 | 17 |
| BUG:kernel_NULL_pointer_dereference,address | 5 | 4 | 4 |
| Oops:#[##] | 5 | 4 | 4 |
| EIP:do_swap_page | 5 | 4 | 4 |
| Kernel_panic-not_syncing:Fatal_exception | 5 | 4 | 3 |
| BUG:Bad_page_map_in_process | 1 | 1 | |
| BUG:Bad_rss-counter_state_mm:#type:MM_SWAPENTS_val | 1 | 1 | |
| BUG:Bad_rss-counter_state_mm:#type:MM_SHMEMPAGES_val | 1 | 1 | |
| EIP:__copy_user_ll | 1 | | |
| WARNING:at_drivers/scsi/scsi_sysfs.c:#scsi_sysfs_device_initialize | 0 | 23 | 17 |
| EIP:scsi_sysfs_device_initialize | 0 | 23 | 17 |
+--------------------------------------------------------------------+------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 2.947662] imm: Version 2.05 (for Linux 2.4.0)
[ 2.950853] st: Version 20160209, fixed bufsize 32768, s/g segs 256
[ 2.960659] scsi host0: scsi_debug: version 0189 [20200421]
[ 2.960659] dev_size_mb=8, opts=0x0, submit_queues=1, statistics=0
[ 2.965081] ------------[ cut here ]------------
[ 2.965510] WARNING: CPU: 0 PID: 7 at drivers/scsi/scsi_sysfs.c:1626 scsi_sysfs_device_initialize+0x11c/0x187
[ 2.965510] Modules linked in:
[ 2.965510] CPU: 0 PID: 7 Comm: kworker/u4:0 Not tainted 5.7.0-rc1-00210-g8177b7dcea063 #1
[ 2.965510] Workqueue: events_unbound async_run_entry_fn
[ 2.965510] EIP: scsi_sysfs_device_initialize+0x11c/0x187
[ 2.965510] Code: e8 0d 03 3d 00 68 c0 0c 00 00 89 f1 8b 55 ec 8d 47 0c e8 d2 37 ea ff 89 45 ec 8d 47 0c e8 76 06 3d 00 58 8b 55 ec 85 d2 75 3c <0f> 0b eb 38 8d 47 0c e8 dc 02 3d 00 8d 56 70 68 c0 0c 00 00 68 00
[ 2.965510] EAX: 00000cc0 EBX: f3784008 ECX: 00000004 EDX: 00000000
[ 2.965510] ESI: f378b008 EDI: f3785590 EBP: 4017fdbc ESP: 4017fda8
[ 2.965510] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010046
[ 2.965510] CR0: 80050033 CR2: 00000000 CR3: 0222c000 CR4: 00040690
[ 2.965510] Call Trace:
[ 2.965510] ? scsi_alloc_sdev+0x22c/0x26f
[ 2.965510] ? scsi_probe_and_add_lun+0xbc/0x475
[ 2.965510] ? preempt_count_sub+0x82/0x90
[ 2.965510] ? mark_held_locks+0x40/0x51
[ 2.965510] ? preempt_latency_stop+0x50/0x53
[ 2.965510] ? preempt_count_sub+0x82/0x90
[ 2.965510] ? _raw_spin_unlock_irqrestore+0x40/0x53
[ 2.965510] ? __scsi_scan_target+0xa0/0x1d0
[ 2.965510] ? preempt_latency_stop+0x50/0x53
[ 2.965510] ? scsi_scan_channel+0x47/0x6d
[ 2.965510] ? scsi_scan_host_selected+0xb1/0xef
[ 2.965510] ? scsi_scan_host+0x17f/0x17f
[ 2.965510] ? do_scsi_scan_host+0x67/0x71
[ 2.965510] ? do_scan_async+0x16/0x135
[ 2.965510] ? scsi_scan_host+0x17f/0x17f
[ 2.965510] ? async_run_entry_fn+0x74/0x12e
[ 2.965510] ? process_one_work+0x27d/0x42f
[ 2.965510] ? worker_thread+0x179/0x22c
[ 2.965510] ? kthread+0x104/0x109
[ 2.965510] ? rescuer_thread+0x252/0x252
[ 2.965510] ? kthread_create_on_node+0x1f/0x1f
[ 2.965510] ? ret_from_fork+0x2e/0x40
[ 2.965510] irq event stamp: 8406
[ 2.965510] hardirqs last enabled at (8405): [<418f5a4f>] _raw_spin_unlock_irqrestore+0x34/0x53
[ 2.965510] hardirqs last disabled at (8406): [<418f57eb>] _raw_spin_lock_irqsave+0x19/0x6d
[ 2.965510] softirqs last enabled at (8144): [<418f98a9>] __do_softirq+0x341/0x371
[ 2.965510] softirqs last disabled at (8135): [<4100a826>] call_on_stack+0x45/0x4b
[ 2.965510] ---[ end trace 5f8f7a50e2514289 ]---
[ 3.001482] scsi 0:0:0:0: Direct-Access Linux scsi_debug 0189 PQ: 0 ANSI: 7
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 1d0e3c9474629024587d5231a469536ec6fb21bb 9cb1fd0efd195590b828b9b865421ad345a4a145 --
git bisect bad 80b846d897551fab283f3d5643be4c61cd054c25 # 21:07 B 0 3 19 0 Merge 'linux-review/Chris-Packham/HID-logitech-dj-Fix-spelling-in-comment/20200526-070408' into devel-hourly-2020053004
git bisect good d152a5fe7a2242f55321e0bbcf9a73fcd639bff1 # 21:35 G 10 0 0 0 Merge 'linux-review/UPDATE-20200527-025635/Gaurav-Pathak/Removing-ununsed-variable-int-lo-hi-int-data-and-int-i-from-comedi-drivers-dt2814-c/20200524-194027' into devel-hourly-2020053004
git bisect bad aa8c15930fa25caa6910672efdc92364725a8bd0 # 22:08 B 0 2 18 0 Merge 'linux-review/UPDATE-20200525-170803/Alexandru-Ardelean/iio-stm32-adc-keep-a-reference-to-the-iio-device-on-the-state-struct/20200522-211102' into devel-hourly-2020053004
git bisect bad 89040fd6fec9332ed7bc70d858bf4d1ca28aea6f # 22:37 B 0 2 18 0 Merge 'linux-review/Chao-Yu/writeback-remove-unused-variable/20200528-120502' into devel-hourly-2020053004
git bisect bad 447360c79352909436aa25c427589767b2ab7a80 # 23:06 B 0 8 24 0 Merge 'linux-review/Mike-Rapoport/sparc32-register-memory-occupied-by-kernel-as-memblock-memory/20200525-005617' into devel-hourly-2020053004
git bisect bad b1b8f6e478f91166f0ea0fd7a079d813ce75fb54 # 23:24 B 0 4 20 0 Merge 'linux-review/wu000273-umn-edu/iommu-Fix-reference-count-leak-in-iommu_group_alloc/20200528-050237' into devel-hourly-2020053004
git bisect good 4859920fd84b6e32ed5dcac27ca526b1a40aac0a # 23:42 G 11 0 0 0 Merge 'linux-review/Dan-Murphy/dt-bindings-power-Add-BQ27561-compatible/20200528-202355' into devel-hourly-2020053004
git bisect bad 4699fdc1da989b7f93b4a586c445e22afe03d68a # 23:50 B 0 11 28 1 Merge 'lkundrak-linux-mmp/lr/nand/cafe-nand-exec-op-debug' into devel-hourly-2020053004
git bisect bad 795d9cb0b1a492cf4950cb23f0fc88bde7f430b3 # 00:03 B 0 11 27 0 Merge 'linux-review/Hannes-Reinecke/scsi-use-xarray-for-devices-and-targets/20200527-231824' into devel-hourly-2020053004
git bisect good b57c88c303c112261f44e7494fcdd64eaec913a1 # 00:18 G 10 0 2 2 target_core_pscsi: use __scsi_device_lookup()
git bisect bad 2b83242b2894d17aab914d66457b8dab75773acf # 00:36 B 0 2 18 0 scsi: remove direct device lookup per host
git bisect bad 8177b7dcea063fe348a9bf2e987142dbe5e36269 # 00:53 B 0 4 20 0 scsi: move target device list to xarray
# first bad commit: [8177b7dcea063fe348a9bf2e987142dbe5e36269] scsi: move target device list to xarray
git bisect good b57c88c303c112261f44e7494fcdd64eaec913a1 # 01:02 G 32 0 6 8 target_core_pscsi: use __scsi_device_lookup()
# extra tests with debug options
git bisect bad 8177b7dcea063fe348a9bf2e987142dbe5e36269 # 01:14 B 0 3 19 0 scsi: move target device list to xarray
# extra tests on head commit of linux-review/Hannes-Reinecke/scsi-use-xarray-for-devices-and-targets/20200527-231824
git bisect bad 2b83242b2894d17aab914d66457b8dab75773acf # 01:37 B 0 17 33 0 scsi: remove direct device lookup per host
# bad: [2b83242b2894d17aab914d66457b8dab75773acf] scsi: remove direct device lookup per host
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
7 months, 3 weeks
[afs] 9d1be4f4dc: kernel-selftests.bpf.test_sockmap.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-7):
commit: 9d1be4f4dc5ff1c66c86acfd2c35765d9e3776b3 ("afs: Don't unlock fetched data pages until the op completes successfully")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: kernel-selftests
with following parameters:
group: kselftests-bpf
test-description: The kernel contains a set of "self tests" under the tools/testing/selftests/ directory. These are intended to be small unit tests to exercise individual code paths in the kernel.
test-url: https://www.kernel.org/doc/Documentation/kselftest.txt
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 8G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <rong.a.chen(a)intel.com>
# selftests: bpf: test_sockmap
# libbpf: load bpf program failed: Permission denied
# libbpf: -- BEGIN DUMP LOG ---
# libbpf:
# ; int bpf_prog2(struct __sk_buff *skb)
# 0: (bf) r6 = r1
# ; __u32 lport = skb->local_port;
# 1: (61) r1 = *(u32 *)(r6 +136)
# 2: (b4) w7 = 10
# 3: (16) if w1 == 0x2710 goto pc+1
# R1_w=inv(id=0,umax_value=2147483647,var_off=(0x0; 0xffffffff)) R6_w=ctx(id=0,off=0,imm=0) R7_w=inv10 R10=fp0
# 4: (b4) w7 = 1
# 5: (b4) w1 = 0
# ; int len, *f, ret, zero = 0;
# 6: (63) *(u32 *)(r10 -4) = r1
# last_idx 6 first_idx 0
# regs=2 stack=0 before 5: (b4) w1 = 0
# ; len = (__u32)skb->data_end - (__u32)skb->data;
# 7: (61) r1 = *(u32 *)(r6 +76)
# ; len = (__u32)skb->data_end - (__u32)skb->data;
# 8: (63) *(u32 *)(r10 -44) = r1
# invalid size of register spill
# processed 9 insns (limit 1000000) max_states_per_insn 0 total_states 0 peak_states 0 mark_read 0
#
# libbpf: -- END LOG --
# libbpf: failed to load program 'sk_skb2'
# libbpf: failed to load object 'test_sockmap_kern.o'
# libbpf: Can't get the 0th fd from program sk_skb1: only -1 instances
# libbpf: Can't get the 0th fd from program sk_skb2: only -1 instances
# libbpf: Can't get the 0th fd from program sockops: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg1: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg2: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg3: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg4: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg5: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg6: only -1 instances
# libbpf: Can't get the 0th fd from program sk_msg7: only -1 instances
# load_bpf_file: (-1) Permission denied
# ERROR: (-1) load bpf failed
not ok 13 selftests: bpf: test_sockmap # exit=255
To reproduce:
# build kernel
cd linux
cp config-5.7.0-rc6-00001-g9d1be4f4dc5ff .config
make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Rong Chen
7 months, 4 weeks
0604a4fd53 ("x86/mm: remove vmalloc faulting"): [ 80.661587] BUG: unable to handle page fault for address: fb40c000
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit 0604a4fd53020a98f029e7fd56d896a136ff2357
Author: Joerg Roedel <jroedel(a)suse.de>
AuthorDate: Sat May 16 15:19:37 2020 +1000
Commit: Stephen Rothwell <sfr(a)canb.auug.org.au>
CommitDate: Sat May 16 15:19:37 2020 +1000
x86/mm: remove vmalloc faulting
Remove fault handling on vmalloc areas, as the vmalloc code now takes care
of synchronizing changes to all page-tables in the system.
Link: http://lkml.kernel.org/r/20200515140023.25469-8-joro@8bytes.org
Signed-off-by: Joerg Roedel <jroedel(a)suse.de>
Acked-by: Andy Lutomirski <luto(a)kernel.org>
Acked-by: Peter Zijlstra (Intel) <peterz(a)infradead.org>
Cc: Arnd Bergmann <arnd(a)arndb.de>
Cc: Christoph Hellwig <hch(a)lst.de>
Cc: Dave Hansen <dave.hansen(a)linux.intel.com>
Cc: "H . Peter Anvin" <hpa(a)zytor.com>
Cc: Ingo Molnar <mingo(a)elte.hu>
Cc: Matthew Wilcox (Oracle) <willy(a)infradead.org>
Cc: Michal Hocko <mhocko(a)kernel.org>
Cc: "Rafael J. Wysocki" <rjw(a)rjwysocki.net>
Cc: Steven Rostedt (VMware) <rostedt(a)goodmis.org>
Cc: Thomas Gleixner <tglx(a)linutronix.de>
Cc: Vlastimil Babka <vbabka(a)suse.cz>
Signed-off-by: Andrew Morton <akpm(a)linux-foundation.org>
Signed-off-by: Stephen Rothwell <sfr(a)canb.auug.org.au>
89c4ebd3f2 mm: remove vmalloc_sync_(un)mappings()
0604a4fd53 x86/mm: remove vmalloc faulting
+-----------------------------------------------------------------------------------+------------+------------+
| | 89c4ebd3f2 | 0604a4fd53 |
+-----------------------------------------------------------------------------------+------------+------------+
| boot_successes | 291 | 82 |
| boot_failures | 37 | 34 |
| WARNING:held_lock_freed | 30 | 9 |
| is_freeing_memory#-#,with_a_lock_still_held_there | 30 | 9 |
| Mem-Info | 5 | 1 |
| Initiating_system_reboot | 6 | 5 |
| BUG:soft_lockup-CPU##stuck_for#s![trinity-c5:#] | 1 | |
| EIP:smp_call_function_single | 1 | |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 1 | |
| BUG:sleeping_function_called_from_invalid_context_at_include/linux/percpu-rwsem.h | 1 | |
| BUG:unable_to_handle_page_fault_for_address | 0 | 22 |
| Oops:#[##] | 0 | 23 |
| EIP:__vmalloc_node_range | 0 | 14 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 23 |
| EIP:memcpy | 0 | 8 |
| BUG:unable_to_handle_page_fault_for_address:fb#c000 | 0 | 1 |
| EIP:__build_skb_around | 0 | 1 |
| BUG:unable_to_handle_page_fault_for_address:fc#c000 | 0 | 1 |
+-----------------------------------------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 78.622971] audit: type=1326 audit(1969448310.109:76): auid=4294967295 uid=2576977920 gid=3469659854 ses=4294967295 subj=kernel pid=1652 comm="trinity-c3" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0x809b132 code=0x0
[ 78.769265] audit: type=1326 audit(1969448310.255:77): auid=4294967295 uid=32 gid=478625670 ses=4294967295 subj=kernel pid=1630 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0x809b132 code=0x0
[ 79.124805] LoadPin: kernel-module old-api-denied obj=<unknown> pid=1728 cmdline="/bin/trinity -q -d -N 999999"
[ 80.251035] audit: type=1326 audit(804323345.900:78): auid=4294967295 uid=64 gid=0 ses=4294967295 subj=kernel pid=1703 comm="trinity-c2" exe="/bin/trinity" sig=9 arch=40000003 syscall=19 compat=0 ip=0x809b132 code=0x0
[ 80.330316] LoadPin: kernel-module old-api-denied obj=<unknown> pid=1742 cmdline="/bin/trinity -q -d -N 999999"
[ 80.661587] BUG: unable to handle page fault for address: fb40c000
[ 80.662910] #PF: supervisor write access in kernel mode
[ 80.663948] #PF: error_code(0x0002) - not-present page
[ 80.664986] *pde = 00000000
[ 80.665606] Oops: 0002 [#1] PREEMPT SMP
[ 80.666428] CPU: 1 PID: 1721 Comm: trinity-c3 Not tainted 5.7.0-rc5-00205-g0604a4fd53020a #1
[ 80.668017] EIP: __vmalloc_node_range+0x16d/0x470
[ 80.668864] Code: 00 83 05 48 d6 9b ba 01 83 15 4c d6 9b ba 00 85 c0 5a 74 61 8b 4d ec 8b 53 10 83 05 58 d6 9b ba 01 83 15 5c d6 9b ba 00 85 c9 <89> 04 b2 0f 85 22 01 00 00 83 c6 01 8b 43 14 83 05 70 d6 9b ba 01
[ 80.672047] EAX: f5a2bba0 EBX: ed6735c0 ECX: 00000400 EDX: fb40c000
[ 80.673019] ESI: 00000000 EDI: ffffffff EBP: e5477e84 ESP: e5477e68
[ 80.673754] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010206
[ 80.675084] CR0: 80050033 CR2: fb40c000 CR3: 3d68c000 CR4: 00000690
[ 80.676323] Call Trace:
[ 80.676916] __vmalloc_node+0x5a/0x70
[ 80.677685] ? kernel_read_file+0x4be/0x5b0
[ 80.678564] vmalloc+0x38/0x50
[ 80.679220] ? kernel_read_file+0x4be/0x5b0
[ 80.680085] kernel_read_file+0x4be/0x5b0
[ 80.680948] ? security_capable+0x72/0x100
[ 80.681824] kernel_read_file_from_fd+0x52/0xc0
[ 80.682694] __ia32_sys_finit_module+0xe7/0x1c0
[ 80.683630] ? rcu_read_lock_sched_held+0x75/0xf0
[ 80.684688] do_int80_syscall_32+0x87/0x4a0
[ 80.685506] entry_INT80_32+0x136/0x136
[ 80.686342] EIP: 0x809b132
[ 80.686904] Code: 89 c8 c3 90 8d 74 26 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66 90 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10 a3 94 94 a8 08 85
[ 80.690396] EAX: ffffffda EBX: 00000132 ECX: a6f11000 EDX: 00000000
[ 80.691639] ESI: 00000024 EDI: 0000fffc EBP: 0000fff8 ESP: afef5ae8
[ 80.692918] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000292
[ 80.694316] Modules linked in:
[ 80.694962] CR2: 00000000fb40c000
[ 80.695729] ---[ end trace eda436684f987d33 ]---
[ 80.696742] EIP: __vmalloc_node_range+0x16d/0x470
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 72bc15d0018ebfbc9c389539d636e2e9a9002b3b v5.6 --
git bisect good 51184ae37e0518fd90cb437a2fbc953ae558cd0d # 01:55 G 25 0 1 1 Merge tag 'for-5.7-rc3-tag' of git://git.kernel.org/pub/scm/linux/kernel/git/kdave/linux
git bisect good 0f640455c6f48442aee2c2130e402fce446adab2 # 02:59 G 25 0 2 4 Merge remote-tracking branch 'samsung-krzk/for-next'
git bisect good 5341ee365011b305ef8755612358378498d721bb # 03:56 G 25 0 2 2 next-20200515/mmc
git bisect good b64f6180e59db51239ed005ac46b97bcfc3949de # 04:44 G 25 0 1 1 Merge remote-tracking branch 'soundwire/next'
git bisect good 63d1307d822840a198137eda0ef4222c75dc3343 # 05:48 G 26 0 5 5 Merge remote-tracking branch 'rtc/rtc-next'
git bisect good 867ec42bbb97865e4a09fcfeaf1083dc2d56dd71 # 06:43 G 25 0 1 1 Merge remote-tracking branch 'pidfd/for-next'
git bisect good 449f4c0843bcc096f1ca353f70336e279fe9e1f8 # 07:37 G 26 0 0 0 Merge remote-tracking branch 'mhi/mhi-next'
git bisect good 7ca87fc66a98c2fbb65fa2ff2fc7d39f51e40132 # 08:13 G 25 0 1 1 Merge remote-tracking branch 'fsinfo/fsinfo-core'
git bisect bad bcda3c9d968d3a8b596904fb2ff8009717ffb6ef # 08:31 B 1 1 0 16 Merge branch 'akpm-current/current'
git bisect bad e783ce22eccc7ce946268282eebb7157d65c80ee # 09:01 B 9 1 3 5 mm/pagealloc.c: call touch_nmi_watchdog() on max order boundaries in deferred init
git bisect good 5c8ba2331d83d425ee467917107aba05768172c0 # 10:56 G 75 0 7 8 mm: memcontrol: switch to native NR_ANON_MAPPED counter
git bisect good f01a585dde24f6bd96852392f5dbc455c3df97a1 # 12:27 G 77 0 5 5 arm64: use __vmalloc_node in arch_alloc_vmap_stack
git bisect bad dca88d002e3ec1e3b58cc0a6eb142ce982211e2f # 12:59 B 2 1 0 1 arm64: simplify detection of memory zone boundaries for UMA configs
git bisect bad 102f972d05bc0b3d155000d1ab242ef88f64bb26 # 14:11 B 17 1 1 1 kasan: stop tests being eliminated as dead code with FORTIFY_SOURCE
git bisect good d0853ba5003ff8a6240b6f8bd5751c5ea8257649 # 17:33 G 100 0 15 15 mm/ioremap: track which page-table levels were modified
git bisect good 89c4ebd3f20b5ef8015d38d090e2c124bcf51581 # 21:03 G 100 0 17 17 mm: remove vmalloc_sync_(un)mappings()
git bisect bad 3149888435b3e8b872c3adee3d0af94efb80984f # 21:39 B 7 1 3 3 mm/mm_init.c: report kasan-tag information stored in page->flags
git bisect bad 0604a4fd53020a98f029e7fd56d896a136ff2357 # 22:06 B 1 1 0 3 x86/mm: remove vmalloc faulting
# first bad commit: [0604a4fd53020a98f029e7fd56d896a136ff2357] x86/mm: remove vmalloc faulting
git bisect good 89c4ebd3f20b5ef8015d38d090e2c124bcf51581 # 00:56 G 300 0 18 36 mm: remove vmalloc_sync_(un)mappings()
# extra tests with debug options
git bisect bad 0604a4fd53020a98f029e7fd56d896a136ff2357 # 01:13 B 0 1 17 0 x86/mm: remove vmalloc faulting
# extra tests on revert first bad commit
git bisect good 4fbd745e10774f514360e74fb02fac41c7a63b26 # 04:57 G 101 0 18 18 Revert "x86/mm: remove vmalloc faulting"
# good: [4fbd745e10774f514360e74fb02fac41c7a63b26] Revert "x86/mm: remove vmalloc faulting"
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
7 months, 4 weeks
[nexthops] dfb537446f: WARNING:at_mm/usercopy.c:#usercopy_warn
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-5):
commit: dfb537446f8bbbbfdeec6fcf2737741251611865 ("nexthops: Remove net argument from replace_nexthop_grp")
https://github.com/dsahern/linux nexthops/del-group-05
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 SandyBridge -smp 2 -m 8G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------+------------+------------+
| | ad5711e614 | dfb537446f |
+-----------------------------------------+------------+------------+
| boot_successes | 12 | 11 |
| boot_failures | 0 | 1 |
| WARNING:at_mm/usercopy.c:#usercopy_warn | 0 | 1 |
| RIP:usercopy_warn | 0 | 1 |
+-----------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <rong.a.chen(a)intel.com>
[ 662.990644] WARNING: CPU: 0 PID: 3447 at mm/usercopy.c:80 usercopy_warn+0x8b/0x94
[ 662.991728] Modules linked in: mpls_router can_raw can nfnetlink
[ 662.992429] CPU: 0 PID: 3447 Comm: trinity-c2 Not tainted 5.7.0-rc5-00233-gdfb537446f8bb #1
[ 662.993408] RIP: 0010:usercopy_warn+0x8b/0x94
[ 662.993901] Code: 41 50 48 c7 c0 90 f4 dc 82 48 0f 44 d6 41 52 48 c7 c6 2e 8f ec 82 55 48 0f 45 f0 49 89 d8 48 c7 c7 99 f4 dc 82 e8 6a 1c eb ff <0f> 0b 48 83 c4 18 5b 5d c3 e8 77 ed dc 00 48 85 f6 53 4c 89 c3 74
[ 662.996011] RSP: 0018:ffff888214177de8 EFLAGS: 00010282
[ 662.996617] RAX: 0000000000000079 RBX: ffffffff82dd7cea RCX: 0000000000000001
[ 662.997412] RDX: 0000000000000001 RSI: ffffffff81105e2e RDI: 0000000000000001
[ 662.998222] RBP: ffffffff82dd7ceb R08: 000000000000000c R09: 0000000000000001
[ 662.999077] R10: 00000000000004d8 R11: ffff888214177c85 R12: 0000000000000001
[ 662.999888] R13: 0000000000000001 R14: 000000000000000c R15: ffffea00086f3a00
[ 663.000726] FS: 0000000001188880(0000) GS:ffffffff83248000(0000) knlGS:0000000000000000
[ 663.001673] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 663.002347] CR2: 00007ff25bbf40fc CR3: 000000021d014000 CR4: 00000000000406f0
[ 663.003196] DR0: 0000000000000000 DR1: 00007ff25a41f000 DR2: 00007ff25a81f000
[ 663.004010] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000070602
[ 663.004812] Call Trace:
[ 663.005102] __check_object_size+0xf7/0x2eb
[ 663.005603] dn_getsockopt+0x258/0x2b6
[ 663.006040] ? arch_local_irq_save+0x5/0x7
[ 663.006516] __sys_getsockopt+0x79/0xdf
[ 663.006990] __x64_sys_getsockopt+0x20/0x23
[ 663.007503] do_syscall_64+0x17e/0x1dd
[ 663.007970] ? trace_hardirqs_off_thunk+0x1a/0x1c
[ 663.008561] entry_SYSCALL_64_after_hwframe+0x49/0xb3
[ 663.009160] RIP: 0033:0x463519
[ 663.009514] Code: 00 f3 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 0f 83 db 59 00 00 c3 66 2e 0f 1f 84 00 00 00 00
[ 663.011584] RSP: 002b:00007ffdd67630a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000037
[ 663.012421] RAX: ffffffffffffffda RBX: 0000000000000037 RCX: 0000000000463519
[ 663.013224] RDX: 0000000000000001 RSI: 0000000022000100 RDI: 000000000000016f
[ 663.014007] RBP: 00007ff25ad29000 R08: 0000000000000004 R09: 00000000ba1a1a1a
[ 663.014788] R10: 0000000000000004 R11: 0000000000000246 R12: 0000000000000002
[ 663.015607] R13: 00007ff25ad29058 R14: 0000000001188850 R15: 00007ff25ad29000
[ 663.016449] irq event stamp: 6256
[ 663.016847] hardirqs last enabled at (6255): [<ffffffff8111d800>] console_unlock+0x18c/0x484
[ 663.017857] hardirqs last disabled at (6256): [<ffffffff810019a6>] trace_hardirqs_off_thunk+0x1a/0x1c
[ 663.018944] softirqs last enabled at (6242): [<ffffffff822002d6>] __do_softirq+0x2d6/0x38a
[ 663.019917] softirqs last disabled at (6237): [<ffffffff810e84a8>] irq_exit+0x67/0x82
[ 663.020793] ---[ end trace 1e34fea14895fe1f ]---
To reproduce:
# build kernel
cd linux
cp config-5.7.0-rc5-00233-gdfb537446f8bb .config
make HOSTCC=gcc-5 CC=gcc-5 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Rong Chen
8 months
[cpumask] a7934287d8: BUG:using__this_cpu_read()in_preemptible[#]code:kworker
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-7):
commit: a7934287d8a6c43811fca8ddf421b3b6091564f2 ("[PATCH 2/4] cpumask: Make cpumask_any() truly random")
url: https://github.com/0day-ci/linux/commits/Qais-Yousef/sched-rt-Distribute-...
in testcase: locktorture
with following parameters:
runtime: 300s
test: cpuhotplug
test-description: This torture test consists of creating a number of kernel threads which acquire the lock and hold it for specific amount of time, thus simulating different critical region behaviors.
test-url: https://www.kernel.org/doc/Documentation/locking/locktorture.txt
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 8G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+----------------------------------------------------------+------------+------------+
| | bb4424cb99 | a7934287d8 |
+----------------------------------------------------------+------------+------------+
| boot_successes | 8 | 0 |
| boot_failures | 0 | 8 |
| BUG:using__this_cpu_read()in_preemptible[#]code:kworker | 0 | 8 |
| BUG:using__this_cpu_write()in_preemptible[#]code:kworker | 0 | 8 |
+----------------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <rong.a.chen(a)intel.com>
[ 69.501074] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/0:1/12
[ 69.505571] caller is cpumask_any+0x14/0x70
[ 69.508332] CPU: 1 PID: 12 Comm: kworker/0:1 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 69.512218] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 69.516270] Workqueue: events cpuset_hotplug_workfn
[ 69.519114] Call Trace:
[ 69.521394] dump_stack+0x8f/0xcb
[ 69.524026] __this_cpu_preempt_check+0xaf/0xc0
[ 69.526886] cpumask_any+0x14/0x70
[ 69.529265] partition_sched_domains_locked+0x152/0x500
[ 69.532200] rebuild_sched_domains_locked+0x5a1/0xba0
[ 69.535164] ? down_write+0x38/0x70
[ 69.537489] ? cpumask_next+0x17/0x20
[ 69.539929] ? percpu_down_write+0xa3/0x100
[ 69.542643] rebuild_sched_domains+0x1b/0x30
[ 69.545257] cpuset_hotplug_workfn+0x74e/0x1310
[ 69.547867] ? process_one_work+0x1be/0x5f0
[ 69.550317] process_one_work+0x23e/0x5f0
[ 69.552855] ? worker_thread+0xce/0x390
[ 69.555291] worker_thread+0x3c/0x390
[ 69.557624] ? process_one_work+0x5f0/0x5f0
[ 69.560003] kthread+0x145/0x170
[ 69.562255] ? kthread_park+0x90/0x90
[ 69.564666] ret_from_fork+0x3a/0x50
[ 69.567057] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/0:1/12
[ 69.570605] caller is cpumask_any+0x4d/0x70
[ 69.573025] CPU: 1 PID: 12 Comm: kworker/0:1 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 69.576279] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 69.579764] Workqueue: events cpuset_hotplug_workfn
[ 69.582268] Call Trace:
[ 69.584206] dump_stack+0x8f/0xcb
[ 69.586294] __this_cpu_preempt_check+0xaf/0xc0
[ 69.588763] cpumask_any+0x4d/0x70
[ 69.591035] partition_sched_domains_locked+0x152/0x500
[ 69.593763] rebuild_sched_domains_locked+0x5a1/0xba0
[ 69.596343] ? down_write+0x38/0x70
[ 69.598635] ? cpumask_next+0x17/0x20
[ 69.600800] ? percpu_down_write+0xa3/0x100
[ 69.603283] rebuild_sched_domains+0x1b/0x30
[ 69.605590] cpuset_hotplug_workfn+0x74e/0x1310
[ 69.608078] ? process_one_work+0x1be/0x5f0
[ 69.610607] process_one_work+0x23e/0x5f0
[ 69.613089] ? worker_thread+0xce/0x390
[ 69.615435] worker_thread+0x3c/0x390
[ 69.617739] ? process_one_work+0x5f0/0x5f0
[ 69.620199] kthread+0x145/0x170
[ 69.622269] ? kthread_park+0x90/0x90
[ 69.624534] ret_from_fork+0x3a/0x50
[ 72.608226] smpboot: Booting Node 0 Processor 0 APIC 0x0
[ 72.623234] kvm-clock: cpu 0, msr 23b401001, secondary cpu clock
[ 72.623294] masked ExtINT on CPU#0
[ 72.655688] KVM setup async PF for cpu 0
[ 72.658605] kvm-stealtime: cpu 0, msr 23fc30040
[ 75.728553] Unregister pv shared memory for cpu 1
[ 75.741355] smpboot: CPU 1 is now offline
[ 75.749031] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/1:1/32
[ 75.753000] caller is cpumask_any+0x14/0x70
[ 75.755574] CPU: 0 PID: 32 Comm: kworker/1:1 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 75.758960] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 75.762748] Workqueue: events cpuset_hotplug_workfn
[ 75.765380] Call Trace:
[ 75.767570] dump_stack+0x8f/0xcb
[ 75.769807] __this_cpu_preempt_check+0xaf/0xc0
[ 75.772365] cpumask_any+0x14/0x70
[ 75.774705] partition_sched_domains_locked+0x152/0x500
[ 75.777399] rebuild_sched_domains_locked+0x5a1/0xba0
[ 75.779940] ? down_write+0x38/0x70
[ 75.782189] ? cpumask_next+0x17/0x20
[ 75.784537] ? percpu_down_write+0xa3/0x100
[ 75.787181] rebuild_sched_domains+0x1b/0x30
[ 75.789560] cpuset_hotplug_workfn+0x74e/0x1310
[ 75.791999] ? process_one_work+0x1be/0x5f0
[ 75.794440] process_one_work+0x23e/0x5f0
[ 75.796702] ? worker_thread+0xce/0x390
[ 75.799062] worker_thread+0x3c/0x390
[ 75.801445] ? process_one_work+0x5f0/0x5f0
[ 75.803864] kthread+0x145/0x170
[ 75.805972] ? kthread_park+0x90/0x90
[ 75.808664] ret_from_fork+0x3a/0x50
[ 75.811162] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/1:1/32
[ 75.814497] caller is cpumask_any+0x4d/0x70
[ 75.816861] CPU: 0 PID: 32 Comm: kworker/1:1 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 75.820558] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 75.828295] Workqueue: events cpuset_hotplug_workfn
[ 75.830705] Call Trace:
[ 75.833009] dump_stack+0x8f/0xcb
[ 75.835214] __this_cpu_preempt_check+0xaf/0xc0
[ 75.837779] cpumask_any+0x4d/0x70
[ 75.840083] partition_sched_domains_locked+0x152/0x500
[ 75.842971] rebuild_sched_domains_locked+0x5a1/0xba0
[ 75.845729] ? down_write+0x38/0x70
[ 75.848117] ? cpumask_next+0x17/0x20
[ 75.850597] ? percpu_down_write+0xa3/0x100
[ 75.853049] rebuild_sched_domains+0x1b/0x30
[ 75.855647] cpuset_hotplug_workfn+0x74e/0x1310
[ 75.858190] ? process_one_work+0x1be/0x5f0
[ 75.860745] process_one_work+0x23e/0x5f0
[ 75.863280] ? worker_thread+0xce/0x390
[ 75.865699] worker_thread+0x3c/0x390
[ 75.868085] ? process_one_work+0x5f0/0x5f0
[ 75.870592] kthread+0x145/0x170
[ 75.872739] ? kthread_park+0x90/0x90
[ 75.875055] ret_from_fork+0x3a/0x50
[ 81.896088] x86: Booting SMP configuration:
[ 81.905907] smpboot: Booting Node 0 Processor 1 APIC 0x1
[ 81.913431] kvm-clock: cpu 1, msr 23b401041, secondary cpu clock
[ 81.913488] masked ExtINT on CPU#1
[ 81.937706] KVM setup async PF for cpu 1
[ 81.940401] kvm-stealtime: cpu 1, msr 23fd30040
[ 84.980215] Unregister pv shared memory for cpu 0
[ 85.001386] smpboot: CPU 0 is now offline
[ 85.010941] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/0:2/144
[ 85.014653] caller is cpumask_any+0x14/0x70
[ 85.017195] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 85.020677] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 85.024172] Workqueue: events cpuset_hotplug_workfn
[ 85.026826] Call Trace:
[ 85.028689] dump_stack+0x8f/0xcb
[ 85.030943] __this_cpu_preempt_check+0xaf/0xc0
[ 85.033582] cpumask_any+0x14/0x70
[ 85.035717] partition_sched_domains_locked+0x152/0x500
[ 85.038475] rebuild_sched_domains_locked+0x5a1/0xba0
[ 85.041030] ? down_write+0x38/0x70
[ 85.043283] ? cpumask_next+0x17/0x20
[ 85.045656] ? percpu_down_write+0xa3/0x100
[ 85.048027] rebuild_sched_domains+0x1b/0x30
[ 85.050432] cpuset_hotplug_workfn+0x74e/0x1310
[ 85.052972] ? process_one_work+0x1be/0x5f0
[ 85.055616] process_one_work+0x23e/0x5f0
[ 85.057954] ? worker_thread+0xce/0x390
[ 85.060290] worker_thread+0x3c/0x390
[ 85.062673] ? process_one_work+0x5f0/0x5f0
[ 85.065007] kthread+0x145/0x170
[ 85.067219] ? kthread_park+0x90/0x90
[ 85.069517] ret_from_fork+0x3a/0x50
[ 85.071998] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/0:2/144
[ 85.075495] caller is cpumask_any+0x4d/0x70
[ 85.078053] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 85.081638] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 85.085139] Workqueue: events cpuset_hotplug_workfn
[ 85.087972] Call Trace:
[ 85.090133] dump_stack+0x8f/0xcb
[ 85.092449] __this_cpu_preempt_check+0xaf/0xc0
[ 85.094945] cpumask_any+0x4d/0x70
[ 85.097255] partition_sched_domains_locked+0x152/0x500
[ 85.099968] rebuild_sched_domains_locked+0x5a1/0xba0
[ 85.102690] ? down_write+0x38/0x70
[ 85.104983] ? cpumask_next+0x17/0x20
[ 85.107318] ? percpu_down_write+0xa3/0x100
[ 85.109927] rebuild_sched_domains+0x1b/0x30
[ 85.112333] cpuset_hotplug_workfn+0x74e/0x1310
[ 85.114892] ? process_one_work+0x1be/0x5f0
[ 85.117334] process_one_work+0x23e/0x5f0
[ 85.119868] ? worker_thread+0xce/0x390
[ 85.122441] worker_thread+0x3c/0x390
[ 85.124850] ? process_one_work+0x5f0/0x5f0
[ 85.127409] kthread+0x145/0x170
[ 85.129521] ? kthread_park+0x90/0x90
[ 85.136185] ret_from_fork+0x3a/0x50
[ 88.041127] smpboot: Booting Node 0 Processor 0 APIC 0x0
[ 88.047260] kvm-clock: cpu 0, msr 23b401001, secondary cpu clock
[ 88.047315] masked ExtINT on CPU#0
[ 88.080615] KVM setup async PF for cpu 0
[ 88.083215] kvm-stealtime: cpu 0, msr 23fc30040
[ 91.122185] Unregister pv shared memory for cpu 0
[ 91.136805] smpboot: CPU 0 is now offline
[ 91.142632] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/0:2/144
[ 91.146321] caller is cpumask_any+0x14/0x70
[ 91.148857] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 91.152441] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 91.155959] Workqueue: events cpuset_hotplug_workfn
[ 91.158633] Call Trace:
[ 91.160515] dump_stack+0x8f/0xcb
[ 91.162804] __this_cpu_preempt_check+0xaf/0xc0
[ 91.165289] cpumask_any+0x14/0x70
[ 91.167414] partition_sched_domains_locked+0x152/0x500
[ 91.170239] rebuild_sched_domains_locked+0x5a1/0xba0
[ 91.172877] ? down_write+0x38/0x70
[ 91.175155] ? cpumask_next+0x17/0x20
[ 91.177550] ? percpu_down_write+0xa3/0x100
[ 91.179958] rebuild_sched_domains+0x1b/0x30
[ 91.182500] cpuset_hotplug_workfn+0x74e/0x1310
[ 91.185112] ? process_one_work+0x1be/0x5f0
[ 91.187582] process_one_work+0x23e/0x5f0
[ 91.190095] ? worker_thread+0xce/0x390
[ 91.192481] worker_thread+0x3c/0x390
[ 91.194906] ? process_one_work+0x5f0/0x5f0
[ 91.197369] kthread+0x145/0x170
[ 91.199452] ? kthread_park+0x90/0x90
[ 91.201615] ret_from_fork+0x3a/0x50
[ 91.203878] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/0:2/144
[ 91.207496] caller is cpumask_any+0x4d/0x70
[ 91.209991] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 91.213556] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 91.216919] Workqueue: events cpuset_hotplug_workfn
[ 91.219450] Call Trace:
[ 91.221455] dump_stack+0x8f/0xcb
[ 91.223683] __this_cpu_preempt_check+0xaf/0xc0
[ 91.226348] cpumask_any+0x4d/0x70
[ 91.228592] partition_sched_domains_locked+0x152/0x500
[ 91.231337] rebuild_sched_domains_locked+0x5a1/0xba0
[ 91.234159] ? down_write+0x38/0x70
[ 91.236447] ? cpumask_next+0x17/0x20
[ 91.238827] ? percpu_down_write+0xa3/0x100
[ 91.241275] rebuild_sched_domains+0x1b/0x30
[ 91.248641] cpuset_hotplug_workfn+0x74e/0x1310
[ 91.251506] ? process_one_work+0x1be/0x5f0
[ 91.254775] process_one_work+0x23e/0x5f0
[ 91.257257] ? worker_thread+0xce/0x390
[ 91.259720] worker_thread+0x3c/0x390
[ 91.262119] ? process_one_work+0x5f0/0x5f0
[ 91.264523] kthread+0x145/0x170
[ 91.266890] ? kthread_park+0x90/0x90
[ 91.269381] ret_from_fork+0x3a/0x50
[ 94.185102] smpboot: Booting Node 0 Processor 0 APIC 0x0
[ 94.194225] kvm-clock: cpu 0, msr 23b401001, secondary cpu clock
[ 94.194284] masked ExtINT on CPU#0
[ 94.227621] KVM setup async PF for cpu 0
[ 94.230391] kvm-stealtime: cpu 0, msr 23fc30040
[ 97.267310] Unregister pv shared memory for cpu 0
[ 97.277923] smpboot: CPU 0 is now offline
[ 97.284802] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/0:2/144
[ 97.292569] caller is cpumask_any+0x14/0x70
[ 97.295186] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 97.298722] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 97.302094] Workqueue: events cpuset_hotplug_workfn
[ 97.304832] Call Trace:
[ 97.306912] dump_stack+0x8f/0xcb
[ 97.309299] __this_cpu_preempt_check+0xaf/0xc0
[ 97.311842] cpumask_any+0x14/0x70
[ 97.314204] partition_sched_domains_locked+0x152/0x500
[ 97.317091] rebuild_sched_domains_locked+0x5a1/0xba0
[ 97.319800] ? down_write+0x38/0x70
[ 97.322168] ? cpumask_next+0x17/0x20
[ 97.324453] ? percpu_down_write+0xa3/0x100
[ 97.326961] rebuild_sched_domains+0x1b/0x30
[ 97.329583] cpuset_hotplug_workfn+0x74e/0x1310
[ 97.332048] ? process_one_work+0x1be/0x5f0
[ 97.334608] process_one_work+0x23e/0x5f0
[ 97.336954] ? worker_thread+0xce/0x390
[ 97.339368] worker_thread+0x3c/0x390
[ 97.341637] ? process_one_work+0x5f0/0x5f0
[ 97.344033] kthread+0x145/0x170
[ 97.346210] ? kthread_park+0x90/0x90
[ 97.348454] ret_from_fork+0x3a/0x50
[ 97.350814] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/0:2/144
[ 97.354066] caller is cpumask_any+0x4d/0x70
[ 97.356562] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 97.360002] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 97.363342] Workqueue: events cpuset_hotplug_workfn
[ 97.366045] Call Trace:
[ 97.368053] dump_stack+0x8f/0xcb
[ 97.370361] __this_cpu_preempt_check+0xaf/0xc0
[ 97.372869] cpumask_any+0x4d/0x70
[ 97.375182] partition_sched_domains_locked+0x152/0x500
[ 97.378070] rebuild_sched_domains_locked+0x5a1/0xba0
[ 97.380701] ? down_write+0x38/0x70
[ 97.383118] ? cpumask_next+0x17/0x20
[ 97.385516] ? percpu_down_write+0xa3/0x100
[ 97.387933] rebuild_sched_domains+0x1b/0x30
[ 97.390302] cpuset_hotplug_workfn+0x74e/0x1310
[ 97.392884] ? process_one_work+0x1be/0x5f0
[ 97.395551] process_one_work+0x23e/0x5f0
[ 97.397888] ? worker_thread+0xce/0x390
[ 97.400253] worker_thread+0x3c/0x390
[ 97.402490] ? process_one_work+0x5f0/0x5f0
[ 97.404993] kthread+0x145/0x170
[ 97.407242] ? kthread_park+0x90/0x90
[ 97.409554] ret_from_fork+0x3a/0x50
[ 99.106901] Writes: Total: 35434807 Max/Min: 0/0 Fail: 0
[ 109.353172] smpboot: Booting Node 0 Processor 0 APIC 0x0
[ 109.388740] kvm-clock: cpu 0, msr 23b401001, secondary cpu clock
[ 109.388796] masked ExtINT on CPU#0
[ 109.443615] KVM setup async PF for cpu 0
[ 109.446345] kvm-stealtime: cpu 0, msr 23fc30040
[ 112.508187] Unregister pv shared memory for cpu 0
[ 112.515229] smpboot: CPU 0 is now offline
[ 112.519948] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/0:2/144
[ 112.523383] caller is cpumask_any+0x14/0x70
[ 112.530155] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 112.533776] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 112.537314] Workqueue: events cpuset_hotplug_workfn
[ 112.539926] Call Trace:
[ 112.541903] dump_stack+0x8f/0xcb
[ 112.544231] __this_cpu_preempt_check+0xaf/0xc0
[ 112.547000] cpumask_any+0x14/0x70
[ 112.549359] partition_sched_domains_locked+0x152/0x500
[ 112.552141] rebuild_sched_domains_locked+0x5a1/0xba0
[ 112.554933] ? down_write+0x38/0x70
[ 112.557276] ? cpumask_next+0x17/0x20
[ 112.559628] ? percpu_down_write+0xa3/0x100
[ 112.562486] rebuild_sched_domains+0x1b/0x30
[ 112.565144] cpuset_hotplug_workfn+0x74e/0x1310
[ 112.567700] ? process_one_work+0x1be/0x5f0
[ 112.570089] process_one_work+0x23e/0x5f0
[ 112.572424] ? worker_thread+0xce/0x390
[ 112.574794] worker_thread+0x3c/0x390
[ 112.577083] ? process_one_work+0x5f0/0x5f0
[ 112.579431] kthread+0x145/0x170
[ 112.581443] ? kthread_park+0x90/0x90
[ 112.583466] ret_from_fork+0x3a/0x50
[ 112.585688] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/0:2/144
[ 112.588903] caller is cpumask_any+0x4d/0x70
[ 112.591186] CPU: 1 PID: 144 Comm: kworker/0:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 112.594570] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 112.597845] Workqueue: events cpuset_hotplug_workfn
[ 112.600392] Call Trace:
[ 112.602477] dump_stack+0x8f/0xcb
[ 112.604778] __this_cpu_preempt_check+0xaf/0xc0
[ 112.607346] cpumask_any+0x4d/0x70
[ 112.609670] partition_sched_domains_locked+0x152/0x500
[ 112.612419] rebuild_sched_domains_locked+0x5a1/0xba0
[ 112.615130] ? down_write+0x38/0x70
[ 112.617627] ? cpumask_next+0x17/0x20
[ 112.619936] ? percpu_down_write+0xa3/0x100
[ 112.622448] rebuild_sched_domains+0x1b/0x30
[ 112.624916] cpuset_hotplug_workfn+0x74e/0x1310
[ 112.627483] ? process_one_work+0x1be/0x5f0
[ 112.630192] process_one_work+0x23e/0x5f0
[ 112.632670] ? worker_thread+0xce/0x390
[ 112.634895] worker_thread+0x3c/0x390
[ 112.637239] ? process_one_work+0x5f0/0x5f0
[ 112.639832] kthread+0x145/0x170
[ 112.647876] ? kthread_park+0x90/0x90
[ 112.650142] ret_from_fork+0x3a/0x50
[ 115.561110] smpboot: Booting Node 0 Processor 0 APIC 0x0
[ 115.574240] kvm-clock: cpu 0, msr 23b401001, secondary cpu clock
[ 115.574300] masked ExtINT on CPU#0
[ 115.607548] KVM setup async PF for cpu 0
[ 115.610451] kvm-stealtime: cpu 0, msr 23fc30040
[ 118.648289] Unregister pv shared memory for cpu 1
[ 118.659140] smpboot: CPU 1 is now offline
[ 118.669405] BUG: using __this_cpu_read() in preemptible [00000000] code: kworker/1:2/167
[ 118.672719] caller is cpumask_any+0x14/0x70
[ 118.675145] CPU: 0 PID: 167 Comm: kworker/1:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 118.678321] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 118.681838] Workqueue: events cpuset_hotplug_workfn
[ 118.684491] Call Trace:
[ 118.686463] dump_stack+0x8f/0xcb
[ 118.688602] __this_cpu_preempt_check+0xaf/0xc0
[ 118.690971] cpumask_any+0x14/0x70
[ 118.693063] partition_sched_domains_locked+0x152/0x500
[ 118.695702] rebuild_sched_domains_locked+0x5a1/0xba0
[ 118.698322] ? down_write+0x38/0x70
[ 118.700546] ? cpumask_next+0x17/0x20
[ 118.702883] ? percpu_down_write+0xa3/0x100
[ 118.705310] rebuild_sched_domains+0x1b/0x30
[ 118.707662] cpuset_hotplug_workfn+0x74e/0x1310
[ 118.710009] ? process_one_work+0x1be/0x5f0
[ 118.712400] process_one_work+0x23e/0x5f0
[ 118.714585] ? worker_thread+0xce/0x390
[ 118.716965] worker_thread+0x3c/0x390
[ 118.719188] ? process_one_work+0x5f0/0x5f0
[ 118.721459] kthread+0x145/0x170
[ 118.723631] ? kthread_park+0x90/0x90
[ 118.726020] ret_from_fork+0x3a/0x50
[ 118.728511] BUG: using __this_cpu_write() in preemptible [00000000] code: kworker/1:2/167
[ 118.731747] caller is cpumask_any+0x4d/0x70
[ 118.734313] CPU: 0 PID: 167 Comm: kworker/1:2 Not tainted 5.6.0-rc4-00110-ga7934287d8a6c #2
[ 118.737683] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 118.740914] Workqueue: events cpuset_hotplug_workfn
[ 118.743399] Call Trace:
[ 118.745514] dump_stack+0x8f/0xcb
[ 118.747848] __this_cpu_preempt_check+0xaf/0xc0
[ 118.750522] cpumask_any+0x4d/0x70
[ 118.752752] partition_sched_domains_locked+0x152/0x500
[ 118.755264] rebuild_sched_domains_locked+0x5a1/0xba0
[ 118.757816] ? down_write+0x38/0x70
[ 118.760109] ? cpumask_next+0x17/0x20
[ 118.762669] ? percpu_down_write+0xa3/0x100
[ 118.765308] rebuild_sched_domains+0x1b/0x30
[ 118.767876] cpuset_hotplug_workfn+0x74e/0x1310
[ 118.770286] ? process_one_work+0x1be/0x5f0
[ 118.772723] process_one_work+0x23e/0x5f0
[ 118.775191] ? worker_thread+0xce/0x390
[ 118.777766] worker_thread+0x3c/0x390
[ 118.780116] ? process_one_work+0x5f0/0x5f0
[ 118.782612] kthread+0x145/0x170
[ 118.784938] ? kthread_park+0x90/0x90
[ 118.787058] ret_from_fork+0x3a/0x50
Elapsed time: 120
qemu-img create -f qcow2 disk-vm-snb-60-0 256G
qemu-img create -f qcow2 disk-vm-snb-60-1 256G
qemu-img create -f qcow2 disk-vm-snb-60-2 256G
qemu-img create -f qcow2 disk-vm-snb-60-3 256G
qemu-img create -f qcow2 disk-vm-snb-60-4 256G
qemu-img create -f qcow2 disk-vm-snb-60-5 256G
qemu-img create -f qcow2 disk-vm-snb-60-6 256G
kvm=(
qemu-system-x86_64
-enable-kvm
-cpu SandyBridge
-kernel $kernel
-initrd initrd-vm-snb-60.cgz
-m 8192
-smp 2
-device e1000,netdev=net0
-netdev user,id=net0,hostfwd=tcp::32032-:22
-boot order=nc
-no-reboot
-watchdog i6300esb
-watchdog-action debug
-rtc base=localtime
-drive file=disk-vm-snb-60-0,media=disk,if=virtio
-drive file=disk-vm-snb-60-1,media=disk,if=virtio
-drive file=disk-vm-snb-60-2,media=disk,if=virtio
-drive file=disk-vm-snb-60-3,media=disk,if=virtio
-drive file=disk-vm-snb-60-4,media=disk,if=virtio
-drive file=disk-vm-snb-60-5,media=disk,if=virtio
-drive file=disk-vm-snb-60-6,media=disk,if=virtio
-serial stdio
-display none
-monitor null
)
append=(
ip=::::vm-snb-60::dhcp
root=/dev/ram0
user=lkp
job=/job-script
ARCH=x86_64
kconfig=x86_64-rhel-7.6-kselftests
branch=linux-devel/devel-hourly-2020041507
commit=a7934287d8a6c43811fca8ddf421b3b6091564f2
BOOT_IMAGE=/pkg/linux/x86_64-rhel-7.6-kselftests/gcc-7/a7934287d8a6c43811fca8ddf421b3b6091564f2/vmlinuz-5.6.0-rc4-00110-ga7934287d8a6c
max_uptime=1500
RESULT_ROOT=/result/locktorture/300s-cpuhotplug/vm-snb/yocto-i386-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-7/a7934287d8a6c43811fca8ddf421b3b6091564f2/3
result_service=tmpfs
selinux=0
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
net.ifnames=0
printk.devkmsg=on
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
drbd.minor_count=8
systemd.log_level=err
ignore_loglevel
console=tty0
earlyprintk=ttyS0,115200
console=ttyS0,115200
vga=normal
rw
rcuperf.shutdown=0
watchdog_thresh=60
)
"${kvm[@]}" -append "${append[*]}"
To reproduce:
# build kernel
cd linux
cp config-5.6.0-rc4-00110-ga7934287d8a6c .config
make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 INSTALL_MOD_PATH=<mod-install-dir> modules_install
cd <mod-install-dir>
find lib/ | cpio -o -H newc --quiet | gzip > modules.cgz
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> -m modules.cgz job-script # job-script is attached in this email
Thanks,
Rong Chen
8 months