Re: acf49bb928 ("mm/mlock: split ClearPageLRU from page isolation .."): [ 36.045721] BUG: sleeping function called from invalid context at mm/rmap.c:1861
by Rong Chen
Hi Alex,
You can reproduce with the script
"reproduce-yocto-vm-yocto-61:20200301143758:x86_64-randconfig-a002-20200228:5.6.0-rc3-00009-gacf49bb928471:1":
./reproduce-... $kernel
Best Regards,
Rong Chen
On 3/2/20 2:31 PM, Alex Shi wrote:
> Thanks for the report!
>
> Do you know how to reproduce this bug?
>
>
> Thanks!
>
> 在 2020/3/1 下午8:35, kernel test robot 写道:
>> Greetings,
>>
>> 0day kernel testing robot got the below dmesg and the first bad commit is
>>
>> https://github.com/alexshi/linux.git lrunext
>>
>> commit acf49bb9284710c28524098098bda22eb1602275
>> Author: Alex Shi <alex.shi(a)linux.alibaba.com>
>> AuthorDate: Thu Feb 27 12:24:11 2020 +0800
>> Commit: Alex Shi <alex.shi(a)linux.alibaba.com>
>> CommitDate: Thu Feb 27 19:45:28 2020 +0800
>>
>> mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
>>
>> This is one of effort to split the PageLRU clear from old page
>> isolation.
>>
>> This patch move the lru_lock after get PageLRU, which takes holding
>> PageLRU as precondition for page isolation, as a preparation for later
>> lru_lock replacment. So we have to unfold __munlock_isolate_lru_page.
>>
>> __split_huge_page_refcount doesn't exist, but we still have to guard
>> PageMlocked in __split_huge_page_tail. that make code ugly and bear
>> few unrelated code in lock. anyway still removed few goto's to dress up
>> current code.
>>
>> Signed-off-by: Alex Shi <alex.shi(a)linux.alibaba.com>
>> Cc: Kirill A. Shutemov <kirill(a)shutemov.name>
>> Cc: Andrew Morton <akpm(a)linux-foundation.org>
>> Cc: Johannes Weiner <hannes(a)cmpxchg.org>
>> Cc: Matthew Wilcox <willy(a)infradead.org>
>> Cc: Hugh Dickins <hughd(a)google.com>
>> Cc: linux-mm(a)kvack.org
>> Cc: linux-kernel(a)vger.kernel.org
>>
>> e46563ef83 mm/lru: add page isolation precondition in __isolate_lru_page
>> acf49bb928 mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
>> 4eddfb57a6 mm/memcg: add debug checking in lock_page_memcg
>> +----------------------------------------------------------------+------------+------------+------------+
>> | | e46563ef83 | acf49bb928 | 4eddfb57a6 |
>> +----------------------------------------------------------------+------------+------------+------------+
>> | boot_successes | 32 | 1 | 0 |
>> | boot_failures | 3 | 10 | 2 |
>> | WARNING:at_mm/usercopy.c:#usercopy_warn | 1 | | |
>> | RIP:usercopy_warn | 1 | | |
>> | INFO:rcu_sched_self-detected_stall_on_CPU | 1 | | |
>> | RIP:clear_page_erms | 1 | 2 | |
>> | INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 1 | 3 | |
>> | BUG:kernel_hang_in_boot_stage | 1 | 2 | |
>> | BUG:kernel_timeout_in_boot_stage | 0 | 1 | |
>> | BUG:sleeping_function_called_from_invalid_context_at_mm/rmap.c | 0 | 6 | 2 |
>> | BUG:kernel_hang_in_early-boot_stage | 0 | 1 | |
>> | RIP:copy_user_enhanced_fast_string | 0 | 0 | 1 |
>> +----------------------------------------------------------------+------------+------------+------------+
>>
>> If you fix the issue, kindly add following tag
>> Reported-by: kernel test robot <lkp(a)intel.com>
>>
>> [child5:606] nfsservctl (180) returned ENOSYS, marking as inactive.
>> [child5:606] clock_getres (266:[32BIT]) returned ENOSYS, marking as inactive.
>> [child3:603] mq_getsetattr (245) returned ENOSYS, marking as inactive.
>> [child3:616] mq_timedreceive (243) returned ENOSYS, marking as inactive.
>> [child3:616] kexec_load (246) returned ENOSYS, marking as inactive.
>> [ 36.045721] BUG: sleeping function called from invalid context at mm/rmap.c:1861
>> [ 36.047309] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 606, name: trinity-c5
>> [ 36.048622] CPU: 0 PID: 606 Comm: trinity-c5 Not tainted 5.6.0-rc3-00009-gacf49bb928471 #1
>> [ 36.049991] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
>> [ 36.051424] Call Trace:
>> [ 36.051773] dump_stack+0x7c/0xa5
>> [ 36.052198] ___might_sleep+0x161/0x180
>> [ 36.052682] rmap_walk_anon+0x135/0x320
>> [ 36.053597] rmap_walk+0x51/0x60
>> [ 36.053999] try_to_munlock+0x86/0xb0
>> [ 36.054464] ? page_mkclean+0x140/0x140
>> [ 36.055335] ? page_remove_rmap+0x4a0/0x4a0
>> [ 36.055862] ? anon_vma_ctor+0x70/0x70
>> [ 36.056343] ? page_get_anon_vma+0x180/0x180
>> [ 36.057299] __munlock_isolated_page+0x46/0xd0
>> [ 36.057954] munlock_vma_page+0x3be/0x4f0
>> [ 36.058446] wp_page_copy+0xaba/0xaf0
>> [ 36.059313] ? follow_pfn+0x160/0x160
>> [ 36.059780] ? __kasan_check_read+0x11/0x20
>> [ 36.060294] ? try_to_wake_up+0x183/0xbd0
>> [ 36.061211] do_wp_page+0x292/0x9b0
>> [ 36.061643] ? finish_mkwrite_fault+0x210/0x210
>> [ 36.062199] ? _raw_read_lock_irq+0x40/0x40
>> [ 36.063149] __handle_mm_fault+0x96a/0x18b0
>> [ 36.063659] ? apply_to_existing_page_range+0x10/0x10
>> [ 36.064280] ? _raw_spin_lock+0x75/0xc0
>> [ 36.065163] ? _raw_read_lock_irq+0x40/0x40
>> [ 36.065693] ? update_rq_clock+0x126/0x1f0
>> [ 36.066646] ? __kasan_check_read+0x11/0x20
>> [ 36.067170] ? __count_memcg_events+0x54/0x120
>> [ 36.068041] handle_mm_fault+0x1d2/0x2f0
>> [ 36.068953] __get_user_pages+0x2b8/0xa50
>> [ 36.069466] ? follow_page_mask+0xa00/0xa00
>> [ 36.069993] ? down_read+0xeb/0x1c0
>> [ 36.070873] ? down_read_killable+0x1d0/0x1d0
>> [ 36.071409] populate_vma_page_range+0x96/0xb0
>> [ 36.071955] __mm_populate+0x128/0x1f0
>> [ 36.072850] ? populate_vma_page_range+0xb0/0xb0
>> [ 36.073424] __x64_sys_mlockall+0x215/0x270
>> [ 36.073960] do_syscall_64+0xb7/0x390
>> [ 36.074435] entry_SYSCALL_64_after_hwframe+0x44/0xa9
>> [ 36.075056] RIP: 0033:0x457729
>> [ 36.075445] 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 2b 84 00 00 c3 66 2e 0f 1f 84 00 00 00 00
>> [ 36.077682] RSP: 002b:00007ffedac862c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000097
>> [ 36.078591] RAX: ffffffffffffffda RBX: 0000000000000097 RCX: 0000000000457729
>> [ 36.079434] RDX: 000000000000fffd RSI: 000000000d0d0d0d RDI: 0000000000000001
>> [ 36.080278] RBP: 00007ffedac86370 R08: 0000c8dc6a7819c3 R09: 947ab93afb7ffb80
>> [ 36.081154] R10: 0000000000000038 R11: 0000000000000246 R12: 0000000000000002
>> [ 36.082009] R13: 00007f4b65400058 R14: 0000000001057830 R15: 00007f4b65400000
>> [child3:616] Dumped trace to /boot/trace.txt
>> *** Error in `/bin/trinity': free(): invalid pointer: 0x00000000004b77e0 ***
>> ======= Backtrace: =========
>>
>> # HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
>> git bisect start 0eb7fc20ae4de315c2379e589ce9f184ff635fce f8788d86ab28f61f7b46eb6be375f8a726783636 --
>> git bisect bad 7a9a8c69941e1374e2686376b8137dd20b28cdc8 # 22:25 B 0 3 19 0 Merge 'linux-review/Gustavo-A-R-Silva/s390-Replace-zero-length-array-with-flexible-array-member/20200223-025126' into devel-hourly-2020022819
>> git bisect good 6d7ab7e685c4a4f5f3d3199b184f5499f4b02c85 # 23:19 G 11 0 4 4 Merge 'linux-review/Isaac-J-Manjarres/of-of_reserved_mem-Increase-limit-on-number-of-reserved-regions/20200225-033755' into devel-hourly-2020022819
>> git bisect good 66084a0a5eabcfd704f0bbab048cd9126e7c24ab # 23:53 G 11 0 2 2 Merge 'linux-review/Zhangfei-Gao/MAINTAINERS-add-maintainers-for-uacce/20200226-093543' into devel-hourly-2020022819
>> git bisect good 2c0ff33777d53be39ccd428650598a52b7080a2d # 01:13 G 11 0 3 3 Merge 'linux-review/Suman-Anna/Drop-PRUSS-and-OMAP4-IPU-DSP-hwmod-data/20200225-072420' into devel-hourly-2020022819
>> git bisect bad a346803f887ad079c21179d1fd69586cc2f5147c # 01:36 B 0 3 19 0 Merge 'linux-review/Prarit-Bhargava/x86-tsc-Add-kernel-options-to-disable-CPUID-and-MSR-calibrations/20200227-034607' into devel-hourly-2020022819
>> git bisect bad 360d08b6abbf3adae740222d62ca8032996019e8 # 02:41 B 0 1 17 0 Merge 'linux-review/jack-yu-realtek-com/ASoC-rt1015-modify-some-structure-to-be-static/20200227-101356' into devel-hourly-2020022819
>> git bisect good 86faac9834b0e94a3901cc1db4272ae41b11a48e # 07:51 G 10 0 5 5 Merge 'linux-review/Anson-Huang/arm64-dts-imx8mn-Adjust-1-2GHz-OPP-voltage-to-OD-mode/20200224-101803' into devel-hourly-2020022819
>> git bisect bad 1776718bda27b7f353dc434e8384fbd7a9b3980d # 08:48 B 0 2 18 0 Merge 'linux-review/Qian-Cai/tick-sched-fix-data-races-at-tick_do_timer_cpu/20200225-111352' into devel-hourly-2020022819
>> git bisect bad 0abbb41ee5a632a0cfaa8a0ee59b4e46c9e8544f # 10:00 B 0 2 18 0 Merge 'alexshi/lrunext' into devel-hourly-2020022819
>> git bisect bad b8e71301886b2ad0b0754fbc6884b6a24ac1931b # 10:52 B 0 1 17 0 mm/lru: take PageLRU first in moving page between lru lists
>> git bisect good 602a257cff49bd0349d0dadc1aa4f0393c77457c # 13:15 G 10 0 2 2 mm/thp: clean up lru_add_page_tail
>> git bisect good 2282ec703a69b8c626c8c36fd6a73f3ac95c4206 # 13:55 G 10 0 5 5 mm/lru: introduce TestClearPageLRU
>> git bisect bad acf49bb9284710c28524098098bda22eb1602275 # 14:37 B 0 1 17 0 mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
>> git bisect good e46563ef83b1583c2f2d54e412222cae5b48bc1d # 15:59 G 10 0 2 2 mm/lru: add page isolation precondition in __isolate_lru_page
>> # first bad commit: [acf49bb9284710c28524098098bda22eb1602275] mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
>> git bisect good e46563ef83b1583c2f2d54e412222cae5b48bc1d # 16:05 G 30 0 1 3 mm/lru: add page isolation precondition in __isolate_lru_page
>> # extra tests with debug options
>> git bisect good acf49bb9284710c28524098098bda22eb1602275 # 16:50 G 10 0 10 10 mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
>> # extra tests on head commit of alexshi/lrunext
>> git bisect bad 4eddfb57a6f7eb0e614389fec3be79bc7b7da65b # 18:32 B 0 1 17 0 mm/memcg: add debug checking in lock_page_memcg
>> # bad: [4eddfb57a6f7eb0e614389fec3be79bc7b7da65b] mm/memcg: add debug checking in lock_page_memcg
>>
>> ---
>> 0-DAY CI Kernel Test Service, Intel Corporation
>> https://lists.01.org/hyperkitty/list/lkp@lists.01.org
>>
2 years, 5 months
[ima] 9165b814d2: BUG:kernel_NULL_pointer_dereference,address
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: 9165b814d2bea8cfeb557505bb206396331e8192 ("[PATCH v2 8/8] ima: Use ima_hash_algo for collision detection in the measurement list")
url: https://github.com/0day-ci/linux/commits/Roberto-Sassu/ima-support-strong...
base: https://git.kernel.org/cgit/linux/kernel/git/zohar/linux-integrity.git next-integrity
in testcase: boot
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):
+---------------------------------------------+------------+------------+
| | 40db98707e | 9165b814d2 |
+---------------------------------------------+------------+------------+
| boot_successes | 2 | 0 |
| boot_failures | 2 | 28 |
| INFO:rcu_sched_self-detected_stall_on_CPU | 1 | |
| RIP:__memcpy | 1 | |
| BUG:kernel_hang_in_boot_stage | 2 | 1 |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 27 |
| Oops:#[##] | 0 | 27 |
| RIP:__kmalloc_track_caller | 0 | 27 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 27 |
+---------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <rong.a.chen(a)intel.com>
[ 56.186402] BUG: kernel NULL pointer dereference, address: 0000000000000060
[ 56.187923] #PF: supervisor read access in kernel mode
[ 56.189324] #PF: error_code(0x0000) - not-present page
[ 56.190523] PGD 0 P4D 0
[ 56.192220] Oops: 0000 [#1] SMP PTI
[ 56.193127] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.5.0-rc1-00025-g9165b814d2bea #2
[ 56.195007] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 56.201402] RIP: 0010:__kmalloc_track_caller+0x98/0x270
[ 56.202738] Code: 01 00 00 4d 8b 07 65 49 8b 50 08 65 4c 03 05 af 22 37 45 49 8b 28 48 85 ed 0f 84 9d 01 00 00 41 8b 47 20 4d 8b 07 48 8d 4a 01 <48> 8b 5c 05 00 48 89 e8 65 49 0f c7 08 0f 94 c0 84 c0 74 c5 41 8b
[ 56.206775] RSP: 0018:ffffab64c0013d68 EFLAGS: 00010206
[ 56.208015] RAX: 0000000000000000 RBX: 0000000000000cc0 RCX: 0000000000000b1a
[ 56.209612] RDX: 0000000000000b19 RSI: 0000000000000cc0 RDI: ffff98d687c03a40
[ 56.211207] RBP: 0000000000000060 R08: 0000000000031060 R09: 0000000000000001
[ 56.212754] R10: ffffffffbbd6ad58 R11: 0000000000000000 R12: 0000000000000cc0
[ 56.214368] R13: 000000000000000e R14: ffff98d687c03a40 R15: ffff98d687c03a40
[ 56.215902] FS: 0000000000000000(0000) GS:ffff98d7bfc00000(0000) knlGS:0000000000000000
[ 56.217973] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 56.219420] CR2: 0000000000000060 CR3: 00000001eac0a000 CR4: 00000000000406f0
[ 56.221143] Call Trace:
[ 56.234421] ? securityfs_create_symlink+0x2a/0x80
[ 56.237098] ? set_debug_rodata+0x11/0x11
[ 56.238814] kstrdup+0x2d/0x60
[ 56.240402] securityfs_create_symlink+0x2a/0x80
[ 56.242714] ? hash_setup+0xa6/0xa6
[ 56.243886] ima_fs_init+0x45/0x1b9
[ 56.246533] ima_init+0x5f/0x72
[ 56.247490] init_ima+0x1d/0xaa
[ 56.248488] ? hash_setup+0xa6/0xa6
[ 56.251412] do_one_initcall+0x46/0x214
[ 56.253215] kernel_init_freeable+0x1c2/0x26d
[ 56.256230] ? rest_init+0xd0/0xd0
[ 56.257343] kernel_init+0xa/0x110
[ 56.259701] ret_from_fork+0x35/0x40
[ 56.261256] Modules linked in:
[ 56.262277] CR2: 0000000000000060
[ 56.263340] ---[ end trace e6c4ee5526b448c4 ]---
To reproduce:
# build kernel
cd linux
cp config-5.5.0-rc1-00025-g9165b814d2bea .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
2 years, 5 months
[nl80211] 5c5e52d1bb: hwsim.he80_pwr_constraint.fail
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: 5c5e52d1bb962510fecdc1ebecdde89694d1b223 ("nl80211: add handling for BSS color")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: hwsim
with following parameters:
group: hwsim-21
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>
2020-02-23 01:18:05 ./run-tests.py he80_pwr_constraint
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START he80_pwr_constraint 1/1
Test: HE with 80 MHz channel width and local power constraint
Starting AP wlan3
Connect STA wlan0 to AP
Failed to trigger scan: FAIL-BUSY
Traceback (most recent call last):
File "./run-tests.py", line 521, in main
t(dev, apdev)
File "/lkp/benchmarks/hwsim/tests/hwsim/test_he.py", line 925, in test_he80_pwr_constraint
dev[0].flush_scan_cache()
File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1168, in flush_scan_cache
self.scan(freq=2422, only_new=True)
File "/lkp/benchmarks/hwsim/tests/hwsim/wpasupplicant.py", line 1140, in scan
raise Exception("Failed to trigger scan: " + str(res))
Exception: Failed to trigger scan: FAIL-BUSY
FAIL he80_pwr_constraint 6.598609 2020-02-23 01:18:16.208671
passed 0 test case(s)
skipped 0 test case(s)
failed tests: he80_pwr_constraint
To reproduce:
# build kernel
cd linux
cp config-5.5.0-rc4-00721-g5c5e52d1bb962 .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
2 years, 5 months
eaa9909f2f: kernel_selftests.user_namespace.make_fail
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3 ("selftests: add simple fsid mapping selftests")
https://git.kernel.org/cgit/linux/kernel/git/brauner/linux.git fsid_mappings_v3
in testcase: kernel_selftests
with following parameters:
group: kselftests-03
ucode: 0xd6
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: 8 threads Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz with 16G memory
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>
user :notice: [ 602.693624] make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-7.6-eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3/tools/testing/selftests/user'
user :notice: [ 602.710533] 2020-02-26 10:03:29 make run_tests -C user_namespace
user :notice: [ 602.721950] make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-7.6-eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3/tools/testing/selftests/user_namespace'
user :notice: [ 602.743249] gcc -Wall test_fsid_map.c ../clone3/clone3_selftests.h -o /usr/src/perf_selftests-x86_64-rhel-7.6-eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3/tools/testing/selftests/user_namespace/test_fsid_map
user :notice: [ 602.865143] ../clone3/clone3_selftests.h:30:32: warning: ‘struct clone_args’ declared inside parameter list will not be visible outside of this definition or declaration
user :notice: [ 602.885186] static pid_t sys_clone3(struct clone_args *args, size_t size)
user :notice: [ 602.895606] ^~~~~~~~~~
user :notice: [ 603.002913] ../clone3/clone3_selftests.h: In function ‘sys_clone3’:
user :notice: [ 603.107312] ../clone3/clone3_selftests.h:32:2: warning: implicit declaration of function ‘fflush’ [-Wimplicit-function-declaration]
user :notice: [ 603.122616] fflush(stdout);
user :notice: [ 603.128564] ^~~~~~
user :notice: [ 603.186824] ../clone3/clone3_selftests.h:32:9: error: ‘stdout’ undeclared (first use in this function)
user :notice: [ 603.199657] fflush(stdout);
user :notice: [ 603.205825] ^~~~~~
user :notice: [ 603.213606] ../clone3/clone3_selftests.h:32:9: note: each undeclared identifier is reported only once for each function it appears in
user :notice: [ 603.234634] ../clone3/clone3_selftests.h:33:9: error: ‘stderr’ undeclared (first use in this function)
user :notice: [ 603.247665] fflush(stderr);
user :notice: [ 603.253775] ^~~~~~
user :notice: [ 603.311979] ../clone3/clone3_selftests.h:34:9: warning: implicit declaration of function ‘syscall’ [-Wimplicit-function-declaration]
user :notice: [ 603.328030] return syscall(__NR_clone3, args, size);
user :notice: [ 603.336441] ^~~~~~~
user :notice: [ 603.393646] ../clone3/clone3_selftests.h: In function ‘test_clone3_supported’:
user :notice: [ 603.505744] ../clone3/clone3_selftests.h:40:9: error: variable ‘args’ has initializer but incomplete type
user :notice: [ 603.519153] struct clone_args args = {};
user :notice: [ 603.526614] ^~~~~~~~~~
user :notice: [ 603.636936] ../clone3/clone3_selftests.h:40:20: error: storage size of ‘args’ isn’t known
user :notice: [ 603.649034] struct clone_args args = {};
user :notice: [ 603.656477] ^~~~
user :notice: [ 603.713995] ../clone3/clone3_selftests.h:43:3: warning: implicit declaration of function ‘ksft_exit_skip’ [-Wimplicit-function-declaration]
user :notice: [ 603.730862] ksft_exit_skip("clone3() syscall is not supported\n");
user :notice: [ 603.740601] ^~~~~~~~~~~~~~
user :notice: [ 603.800157] ../clone3/clone3_selftests.h:49:3: warning: implicit declaration of function ‘exit’ [-Wimplicit-function-declaration]
user :notice: [ 603.815544] exit(EXIT_SUCCESS);
user :notice: [ 603.822032] ^~~~
user :notice: [ 603.921143] ../clone3/clone3_selftests.h:49:3: warning: incompatible implicit declaration of built-in function ‘exit’
user :notice: [ 604.086731] ../clone3/clone3_selftests.h:49:3: note: include ‘<stdlib.h>’ or provide a declaration of ‘exit’
user :notice: [ 604.157190] ../clone3/clone3_selftests.h:49:8: error: ‘EXIT_SUCCESS’ undeclared (first use in this function)
user :notice: [ 604.170686] exit(EXIT_SUCCESS);
user :notice: [ 604.177414] ^~~~~~~~~~~~
user :notice: [ 604.192019] ../clone3/clone3_selftests.h:52:3: warning: implicit declaration of function ‘wait’ [-Wimplicit-function-declaration]
user :notice: [ 604.207112] wait(NULL);
user :notice: [ 604.212738] ^~~~
user :notice: [ 604.270449] ../clone3/clone3_selftests.h:53:3: warning: implicit declaration of function ‘ksft_exit_fail_msg’ [-Wimplicit-function-declaration]
user :notice: [ 604.286897] ksft_exit_fail_msg(
user :notice: [ 604.293619] ^~~~~~~~~~~~~~~~~~
user :notice: [ 604.356096] ../clone3/clone3_selftests.h:57:6: error: ‘errno’ undeclared (first use in this function)
user :notice: [ 604.368909] if (errno == ENOSYS)
user :notice: [ 604.375395] ^~~~~
kern :info : [ 604.488634] run_vmtests (13292): drop_caches: 3
user :notice: [ 604.492163] ../clone3/clone3_selftests.h:57:15: error: ‘ENOSYS’ undeclared (first use in this function)
user :notice: [ 604.506756] if (errno == ENOSYS)
user :notice: [ 604.513312] ^~~~~~
user :notice: [ 604.527838] ../clone3/clone3_selftests.h:60:2: warning: implicit declaration of function ‘ksft_print_msg’ [-Wimplicit-function-declaration]
user :notice: [ 604.544280] ksft_print_msg("clone3() syscall supported\n");
user :notice: [ 604.553089] ^~~~~~~~~~~~~~
user :notice: [ 604.664341] ../clone3/clone3_selftests.h:40:20: warning: unused variable ‘args’ [-Wunused-variable]
user :notice: [ 604.677071] struct clone_args args = {};
user :notice: [ 604.684319] ^~~~
user :notice: [ 604.693709] ../lib.mk:138: recipe for target '/usr/src/perf_selftests-x86_64-rhel-7.6-eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3/tools/testing/selftests/user_namespace/test_fsid_map' failed
user :notice: [ 604.716631] make: *** [/usr/src/perf_selftests-x86_64-rhel-7.6-eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3/tools/testing/selftests/user_namespace/test_fsid_map] Error 1
user :notice: [ 604.737570] make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-7.6-eaa9909f2fd5b8ae603189a2f7e2974f3a85ccd3/tools/testing/selftests/user_namespace'
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Rong Chen
2 years, 5 months
[tools/perf/metricgroup] 5dd4f4ab07: stderr.mv:cannot_stat'util/.metricgroup.o.tmp':No_such_file_or_directory
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: 5dd4f4ab07f8257f1d113cc2b9ee95f43d576b9d ("[PATCH v4] tools/perf/metricgroup: Fix printing event names of metric group with multiple events incase of overlapping events")
url: https://github.com/0day-ci/linux/commits/Kajol-Jain/tools-perf-metricgrou...
in testcase: perf-sanity-tests
with following parameters:
perf_compiler: gcc
ucode: 0x27
on test machine: 8 threads Intel(R) Core(TM) i7-4790 v3 @ 3.60GHz with 6G memory
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>
user :notice: [ 58.688905] LD trace/beauty/perf-in.o
user :err : [ 58.694839] util/metricgroup.c: In function 'metricgroup__setup_events':
user :notice: [ 58.696757] CC util/evlist.o
user :err : [ 58.705739] util/metricgroup.c:170:3: error: break statement not within loop or switch
user :notice: [ 58.710154] LD arch/x86/tests/perf-in.o
user :err : [ 58.720491] break;
user :notice: [ 58.722367] LD arch/x86/perf-in.o
user :err : [ 58.727486] ^~~~~
user :notice: [ 58.729854] LD arch/perf-in.o
user :err : [ 58.734440] mv: cannot stat 'util/.metricgroup.o.tmp': No such file or directory
user :notice: [ 58.738730] CC ui/tui/util.o
user :err : [ 58.741991] make[4]: *** [util/metricgroup.o] Error 1
user :notice: [ 58.743544] CC tests/hists_link.o
user :err : [ 58.746796] make[4]: *** Waiting for unfinished jobs....
user :notice: [ 58.749865] CC ui/browsers/map.o
user :notice: [ 58.796537] CC util/evsel.o
user :notice: [ 58.803941] CC ui/tui/helpline.o
user :notice: [ 58.811723] CC ui/tui/progress.o
user :notice: [ 58.819597] CC ui/browsers/scripts.o
user :notice: [ 58.827810] CC tests/hists_filter.o
user :notice: [ 58.835934] CC ui/browsers/header.o
user :notice: [ 58.843797] LD ui/tui/perf-in.o
user :notice: [ 58.851633] CC tests/hists_output.o
user :notice: [ 58.859662] CC ui/browsers/res_sample.o
user :notice: [ 58.868059] CC tests/hists_cumulate.o
user :notice: [ 58.876298] CC util/evsel_fprintf.o
user :notice: [ 58.884794] CC util/perf_event_attr_fprintf.o
user :notice: [ 58.893616] CC util/evswitch.o
user :notice: [ 58.901051] CC util/find_bit.o
user :notice: [ 58.908790] CC util/get_current_dir_name.o
user :notice: [ 58.917030] CC util/kallsyms.o
user :notice: [ 58.924272] CC tests/python-use.o
user :notice: [ 58.931786] CC util/levenshtein.o
user :notice: [ 58.939306] CC util/llvm-utils.o
user :notice: [ 58.946793] CC util/mmap.o
user :notice: [ 58.953880] CC util/memswap.o
user :notice: [ 58.961527] BISON util/parse-events-bison.c
user :notice: [ 58.969835] CC util/perf_regs.o
user :notice: [ 58.977405] CC tests/bp_signal.o
user :notice: [ 58.984747] CC util/path.o
user :notice: [ 58.991911] CC tests/bp_signal_overflow.o
user :notice: [ 59.000134] CC util/print_binary.o
user :notice: [ 59.007613] CC util/rlimit.o
user :notice: [ 59.014591] CC util/argv_split.o
user :notice: [ 59.021979] CC util/rbtree.o
user :notice: [ 59.028985] CC tests/bp_account.o
user :notice: [ 59.036173] CC tests/wp.o
user :notice: [ 59.042871] CC util/libstring.o
user :notice: [ 59.050011] CC util/bitmap.o
user :notice: [ 59.056858] CC util/hweight.o
user :notice: [ 59.063966] CC tests/task-exit.o
user :notice: [ 59.071298] CC tests/sw-clock.o
user :notice: [ 59.078342] CC util/smt.o
user :notice: [ 59.084981] CC util/strbuf.o
user :notice: [ 59.092311] CC tests/mmap-thread-lookup.o
user :notice: [ 59.100343] CC util/string.o
user :notice: [ 59.107456] CC tests/thread-maps-share.o
user :notice: [ 59.115581] CC tests/switch-tracking.o
user :notice: [ 59.123304] CC util/strlist.o
user :notice: [ 59.130429] CC tests/keep-tracking.o
user :notice: [ 59.138249] CC tests/code-reading.o
user :notice: [ 59.145689] CC util/strfilter.o
user :notice: [ 59.152629] CC util/top.o
user :notice: [ 59.159112] CC util/usage.o
user :notice: [ 59.165621] CC tests/sample-parsing.o
user :notice: [ 59.172446] CC util/dso.o
user :notice: [ 59.178526] CC tests/parse-no-sample-id-all.o
user :notice: [ 59.186126] CC tests/kmod-path.o
user :notice: [ 59.192493] CC util/dsos.o
user :notice: [ 59.198456] CC tests/thread-map.o
user :notice: [ 59.204913] CC util/symbol.o
user :notice: [ 59.210930] CC tests/llvm.o
user :notice: [ 59.217000] CC util/symbol_fprintf.o
user :notice: [ 59.223692] CC tests/bpf.o
user :notice: [ 59.229547] CC util/color.o
user :notice: [ 59.235563] CC tests/topology.o
user :notice: [ 59.241827] CC tests/mem.o
user :notice: [ 59.247704] CC tests/cpumap.o
user :notice: [ 59.253922] CC util/color_config.o
user :notice: [ 59.260604] LD ui/browsers/perf-in.o
user :notice: [ 59.267346] CC tests/stat.o
user :notice: [ 59.273288] LD ui/perf-in.o
user :notice: [ 59.279415] CC tests/event_update.o
user :notice: [ 59.286157] CC tests/event-times.o
user :notice: [ 59.292673] CC tests/expr.o
user :notice: [ 59.298749] CC util/metricgroup.o
user :notice: [ 59.305223] CC util/header.o
user :notice: [ 59.311512] CC tests/backward-ring-buffer.o
user :notice: [ 59.318814] CC tests/sdt.o
user :notice: [ 59.327108] /usr/src/perf_selftests-x86_64-rhel-7.6-5dd4f4ab07f8257f1d113cc2b9ee95f43d576b9d/tools/build/Makefile.build:96: recipe for target 'util/metricgroup.o' failed
user :notice: [ 59.344991] CC tests/is_printable_array.o
user :notice: [ 59.352277] CC tests/bitmap.o
user :notice: [ 59.358573] CC tests/perf-hooks.o
user :notice: [ 59.365109] CC tests/clang.o
user :notice: [ 59.371510] CC tests/unit_number__scnprintf.o
user :notice: [ 59.379158] CC tests/mem2node.o
user :notice: [ 59.385517] CC tests/maps.o
user :notice: [ 59.391769] CC tests/time-utils-test.o
user :notice: [ 59.398779] CC tests/genelf.o
user :notice: [ 59.405116] CC tests/dwarf-unwind.o
user :notice: [ 59.411975] CC tests/llvm-src-base.o
user :notice: [ 59.418975] CC tests/llvm-src-kbuild.o
user :notice: [ 59.426189] CC tests/llvm-src-prologue.o
user :notice: [ 59.433635] CC tests/llvm-src-relocation.o
user :notice: [ 59.441006] LD tests/perf-in.o
user :err : [ 60.191397] make[3]: *** [util] Error 2
user :notice: [ 60.193667] /usr/src/perf_selftests-x86_64-rhel-7.6-5dd4f4ab07f8257f1d113cc2b9ee95f43d576b9d/tools/build/Makefile.build:139: recipe for target 'util' failed
user :err : [ 60.196176] make[2]: *** [perf-in.o] Error 2
user :notice: [ 60.198386] Makefile.perf:616: recipe for target 'perf-in.o' failed
user :err : [ 60.212393] make[1]: *** [sub-make] Error 2
user :notice: [ 60.214587] Makefile.perf:224: recipe for target 'sub-make' failed
user :err : [ 60.218764] make: *** [all] Error 2
user :notice: [ 60.221026] Makefile:69: recipe for target 'all' failed
user :err : [ 60.227253] make perf failed
user :notice: [ 60.230837] make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-7.6-5dd4f4ab07f8257f1d113cc2b9ee95f43d576b9d/tools/perf'
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Rong Chen
2 years, 5 months
[locking/qspinlock] 7b6da71157: unixbench.score 8.4% improvement
by kernel test robot
Greeting,
FYI, we noticed a 8.4% improvement of unixbench.score due to commit:
commit: 7b6da7115786ee28ad82638a5dcb2ec1ffda0e96 ("[PATCH v9 5/5] locking/qspinlock: Introduce the shuffle reduction optimization into CNA")
url: https://github.com/0day-ci/linux/commits/Alex-Kogan/Add-NUMA-awareness-to...
in testcase: unixbench
on test machine: 192 threads Intel(R) Xeon(R) Platinum 9242 CPU @ 2.30GHz with 192G memory
with following parameters:
runtime: 300s
nr_task: 30%
test: context1
cpufreq_governor: performance
ucode: 0x500002c
test-description: UnixBench is the original BYTE UNIX benchmark suite aims to test performance of Unix-like system.
test-url: https://github.com/kdlucas/byte-unixbench
In addition to that, the commit also has significant impact on the following tests:
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
=========================================================================================
compiler/cpufreq_governor/kconfig/nr_task/rootfs/runtime/tbox_group/test/testcase/ucode:
gcc-7/performance/x86_64-rhel-7.6/30%/debian-x86_64-20191114.cgz/300s/lkp-csl-2ap3/context1/unixbench/0x500002c
commit:
dfce1eb694 ("locking/qspinlock: Introduce starvation avoidance into CNA")
7b6da71157 ("locking/qspinlock: Introduce the shuffle reduction optimization into CNA")
dfce1eb694321530 7b6da7115786ee28ad82638a5dc
---------------- ---------------------------
fail:runs %reproduction fail:runs
| | |
1:4 -25% :4 kmsg.ipmi_si_dmi-ipmi-si.#:IRQ_index#not_found
:4 25% 1:4 dmesg.WARNING:at#for_ip_swapgs_restore_regs_and_return_to_usermode/0x
:4 50% 2:4 dmesg.WARNING:stack_recursion
%stddev %change %stddev
\ | \
2659 +8.4% 2883 unixbench.score
4016 +1.9% 4092 unixbench.time.percent_of_cpu_this_job_got
15666 +1.6% 15923 unixbench.time.system_time
109.72 ± 2% +10.1% 120.86 ± 2% unixbench.time.user_time
3.053e+08 +9.3% 3.336e+08 unixbench.time.voluntary_context_switches
4.175e+08 +8.2% 4.515e+08 unixbench.workload
111361 ± 3% -7.8% 102620 softirqs.CPU89.SCHED
3085234 +9.7% 3384659 vmstat.system.cs
35.88 ± 8% -12.8% 31.28 ± 4% boot-time.boot
28.29 ± 8% -15.4% 23.92 boot-time.dhcp
5943 ± 9% -14.6% 5073 ± 4% boot-time.idle
5259 ± 78% -80.3% 1035 ± 36% numa-meminfo.node2.Inactive
5132 ± 80% -79.8% 1035 ± 36% numa-meminfo.node2.Inactive(anon)
6664 ± 66% -71.7% 1883 ± 54% numa-meminfo.node2.Shmem
1282 ± 80% -79.8% 258.50 ± 36% numa-vmstat.node2.nr_inactive_anon
1665 ± 66% -71.8% 470.50 ± 54% numa-vmstat.node2.nr_shmem
1282 ± 80% -79.8% 258.50 ± 36% numa-vmstat.node2.nr_zone_inactive_anon
2.05e+08 ± 2% +28.2% 2.628e+08 ± 2% turbostat.C1
5.52 ± 5% +2.5 7.99 turbostat.C1%
16.59 ± 41% +12.8 29.43 turbostat.C1E%
17973386 ± 22% -98.8% 211437 ± 84% turbostat.C6
15.45 ± 46% -15.2 0.26 ± 96% turbostat.C6%
8.15e+09 ± 5% +44.4% 1.177e+10 cpuidle.C1.time
4.037e+08 ± 4% +27.2% 5.134e+08 cpuidle.C1.usage
2.454e+10 ± 40% +77.0% 4.343e+10 cpuidle.C1E.time
2.308e+10 ± 46% -97.7% 5.325e+08 ± 66% cpuidle.C6.time
35252918 ± 22% -98.8% 436570 ± 71% cpuidle.C6.usage
1.829e+08 ± 10% -46.2% 98462878 cpuidle.POLL.time
14828999 ± 20% -42.2% 8563858 ± 4% cpuidle.POLL.usage
309808 ± 14% -22.3% 240665 ± 13% sched_debug.cfs_rq:/.load.max
33894 ± 12% -28.1% 24377 ± 10% sched_debug.cfs_rq:/.load.stddev
0.45 ± 7% +13.5% 0.51 ± 2% sched_debug.cfs_rq:/.nr_running.avg
0.33 ± 69% -55.3% 0.15 ± 14% sched_debug.cfs_rq:/.nr_spread_over.avg
309558 ± 14% -22.7% 239243 ± 12% sched_debug.cfs_rq:/.runnable_weight.max
33905 ± 12% -28.5% 24244 ± 10% sched_debug.cfs_rq:/.runnable_weight.stddev
419.84 ± 8% +14.8% 482.01 sched_debug.cfs_rq:/.util_est_enqueued.avg
521161 ± 3% -14.9% 443373 ± 5% sched_debug.cpu.avg_idle.avg
1410729 ± 15% -27.3% 1025358 sched_debug.cpu.avg_idle.max
740422 ± 17% -30.7% 513046 sched_debug.cpu.max_idle_balance_cost.max
35777 ± 50% -91.3% 3128 ± 62% sched_debug.cpu.max_idle_balance_cost.stddev
3760337 ± 3% +11.4% 4188170 ± 2% sched_debug.cpu.nr_switches.max
3756863 ± 3% +11.4% 4184620 ± 2% sched_debug.cpu.sched_count.max
1877767 ± 3% +11.4% 2091800 ± 2% sched_debug.cpu.sched_goidle.max
1879095 ± 3% +11.4% 2093403 ± 2% sched_debug.cpu.ttwu_count.max
0.79 ± 8% -0.2 0.55 perf-profile.calltrace.cycles-pp.__cna_queued_spin_lock_slowpath._raw_spin_lock.scheduler_tick.update_process_times.tick_sched_handle
0.80 ± 8% -0.2 0.57 perf-profile.calltrace.cycles-pp._raw_spin_lock.scheduler_tick.update_process_times.tick_sched_handle.tick_sched_timer
0.84 ± 8% -0.2 0.62 perf-profile.calltrace.cycles-pp.scheduler_tick.update_process_times.tick_sched_handle.tick_sched_timer.__hrtimer_run_queues
1.09 ± 4% -0.2 0.90 ± 4% perf-profile.calltrace.cycles-pp.__hrtimer_run_queues.hrtimer_interrupt.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter_state
0.92 ± 6% -0.2 0.72 ± 4% perf-profile.calltrace.cycles-pp.update_process_times.tick_sched_handle.tick_sched_timer.__hrtimer_run_queues.hrtimer_interrupt
0.92 ± 5% -0.2 0.73 ± 4% perf-profile.calltrace.cycles-pp.tick_sched_handle.tick_sched_timer.__hrtimer_run_queues.hrtimer_interrupt.smp_apic_timer_interrupt
0.96 ± 7% -0.2 0.79 ± 5% perf-profile.calltrace.cycles-pp.tick_sched_timer.__hrtimer_run_queues.hrtimer_interrupt.smp_apic_timer_interrupt.apic_timer_interrupt
0.43 ± 4% -0.4 0.05 perf-profile.children.cycles-pp.cna_scan_main_queue
1.02 ± 8% -0.2 0.81 perf-profile.children.cycles-pp._raw_spin_lock
0.91 ± 7% -0.2 0.70 perf-profile.children.cycles-pp.scheduler_tick
1.22 ± 3% -0.2 1.03 ± 3% perf-profile.children.cycles-pp.__hrtimer_run_queues
1.01 ± 5% -0.2 0.82 ± 3% perf-profile.children.cycles-pp.tick_sched_handle
1.00 ± 4% -0.2 0.82 ± 4% perf-profile.children.cycles-pp.update_process_times
0.47 ± 19% -0.2 0.30 ± 25% perf-profile.children.cycles-pp.poll_idle
1.06 ± 6% -0.2 0.90 ± 4% perf-profile.children.cycles-pp.tick_sched_timer
0.08 +0.0 0.09 perf-profile.children.cycles-pp.cpus_share_cache
0.14 ± 5% +0.0 0.15 ± 3% perf-profile.children.cycles-pp.sched_clock
0.06 ± 11% +0.0 0.08 ± 6% perf-profile.children.cycles-pp.fsnotify
0.14 ± 3% +0.0 0.15 ± 2% perf-profile.children.cycles-pp.update_cfs_group
0.14 ± 6% +0.0 0.15 ± 3% perf-profile.children.cycles-pp.switch_mm_irqs_off
0.11 ± 6% +0.0 0.13 ± 6% perf-profile.children.cycles-pp.nr_iowait_cpu
0.14 ± 3% +0.0 0.16 ± 5% perf-profile.children.cycles-pp.select_idle_sibling
0.11 ± 7% +0.0 0.13 ± 3% perf-profile.children.cycles-pp.update_ts_time_stats
0.18 ± 7% +0.0 0.21 ± 4% perf-profile.children.cycles-pp.tick_nohz_idle_exit
0.21 ± 7% +0.0 0.24 perf-profile.children.cycles-pp.mutex_unlock
0.24 ± 5% +0.0 0.27 perf-profile.children.cycles-pp.update_rq_clock
0.26 ± 6% +0.0 0.29 ± 3% perf-profile.children.cycles-pp.select_task_rq_fair
0.35 ± 5% +0.0 0.39 ± 3% perf-profile.children.cycles-pp._raw_spin_unlock_irqrestore
0.07 ± 17% +0.0 0.11 ± 14% perf-profile.children.cycles-pp._raw_spin_trylock
0.38 ± 2% +0.0 0.41 ± 3% perf-profile.children.cycles-pp.mutex_lock
0.16 ± 6% +0.1 0.22 ± 3% perf-profile.children.cycles-pp.reweight_entity
0.19 ± 30% +0.1 0.28 ± 10% perf-profile.children.cycles-pp.clockevents_program_event
0.42 ± 21% +0.1 0.55 ± 6% perf-profile.children.cycles-pp.ktime_get
0.42 ± 5% -0.4 0.05 perf-profile.self.cycles-pp.cna_scan_main_queue
0.41 ± 21% -0.2 0.23 ± 31% perf-profile.self.cycles-pp.poll_idle
0.12 ± 3% +0.0 0.14 ± 3% perf-profile.self.cycles-pp.__wake_up_common
0.06 ± 11% +0.0 0.08 ± 6% perf-profile.self.cycles-pp.__unwind_start
0.06 ± 14% +0.0 0.08 ± 6% perf-profile.self.cycles-pp.fsnotify
0.09 ± 5% +0.0 0.11 ± 4% perf-profile.self.cycles-pp.__account_scheduler_latency
0.21 ± 8% +0.0 0.23 ± 3% perf-profile.self.cycles-pp.mutex_unlock
0.25 ± 5% +0.0 0.28 ± 2% perf-profile.self.cycles-pp.stack_trace_save_tsk
0.07 ± 17% +0.0 0.11 ± 14% perf-profile.self.cycles-pp._raw_spin_trylock
0.23 ± 4% +0.0 0.27 ± 3% perf-profile.self.cycles-pp.enqueue_entity
0.01 ±173% +0.0 0.06 ± 9% perf-profile.self.cycles-pp.tick_nohz_next_event
0.16 ± 7% +0.1 0.21 ± 4% perf-profile.self.cycles-pp.reweight_entity
0.32 ± 25% +0.1 0.44 ± 6% perf-profile.self.cycles-pp.ktime_get
0.61 ± 4% +0.2 0.78 perf-profile.self.cycles-pp._raw_spin_lock_irqsave
7.467e+09 +4.5% 7.8e+09 perf-stat.i.branch-instructions
1.52 ± 52% -0.5 1.04 perf-stat.i.branch-miss-rate%
18876088 ± 4% +37.6% 25967363 perf-stat.i.cache-misses
5.782e+08 +9.7% 6.34e+08 perf-stat.i.cache-references
3117860 +9.3% 3407692 perf-stat.i.context-switches
4.95 ± 5% -9.5% 4.48 perf-stat.i.cpi
950.94 ± 11% -14.8% 809.79 ± 3% perf-stat.i.cpu-migrations
8478 ± 5% -34.8% 5528 perf-stat.i.cycles-between-cache-misses
0.10 ± 66% -0.1 0.00 ± 9% perf-stat.i.dTLB-load-miss-rate%
797793 ± 30% -68.3% 252660 ± 4% perf-stat.i.dTLB-load-misses
8.708e+09 +4.7% 9.116e+09 perf-stat.i.dTLB-loads
0.03 ± 64% -0.0 0.00 ± 2% perf-stat.i.dTLB-store-miss-rate%
124658 ± 30% -74.0% 32385 ± 4% perf-stat.i.dTLB-store-misses
3.774e+09 +9.1% 4.118e+09 perf-stat.i.dTLB-stores
64.91 ± 4% -2.3 62.61 perf-stat.i.iTLB-load-miss-rate%
43785961 ± 2% +11.7% 48914532 perf-stat.i.iTLB-load-misses
23149859 ± 4% +8.6% 25133067 perf-stat.i.iTLB-loads
3.291e+10 +4.8% 3.448e+10 perf-stat.i.instructions
738.35 ± 2% -5.5% 697.64 perf-stat.i.instructions-per-iTLB-miss
0.21 ± 2% +8.0% 0.22 perf-stat.i.ipc
84.65 +10.4 95.02 perf-stat.i.node-load-miss-rate%
4397398 +8.0% 4748512 perf-stat.i.node-load-misses
847789 -73.3% 226176 perf-stat.i.node-loads
92.33 +5.7 98.01 perf-stat.i.node-store-miss-rate%
2046078 +98.1% 4054203 perf-stat.i.node-store-misses
99069 -63.5% 36118 perf-stat.i.node-stores
17.58 ± 2% +4.6% 18.39 perf-stat.overall.MPKI
0.97 ± 2% -0.1 0.92 perf-stat.overall.branch-miss-rate%
3.26 ± 5% +0.8 4.10 perf-stat.overall.cache-miss-rate%
4.75 -5.2% 4.50 perf-stat.overall.cpi
8290 ± 3% -27.9% 5974 perf-stat.overall.cycles-between-cache-misses
0.01 ± 32% -0.0 0.00 ± 4% perf-stat.overall.dTLB-load-miss-rate%
0.00 ± 33% -0.0 0.00 ± 5% perf-stat.overall.dTLB-store-miss-rate%
751.69 -6.2% 704.91 perf-stat.overall.instructions-per-iTLB-miss
0.21 +5.5% 0.22 perf-stat.overall.ipc
83.84 +11.6 95.45 perf-stat.overall.node-load-miss-rate%
95.38 +3.7 99.12 perf-stat.overall.node-store-miss-rate%
30797 -3.4% 29764 perf-stat.overall.path-length
7.45e+09 +4.4% 7.782e+09 perf-stat.ps.branch-instructions
18821819 ± 4% +37.6% 25906176 perf-stat.ps.cache-misses
5.769e+08 +9.6% 6.325e+08 perf-stat.ps.cache-references
3111288 +9.3% 3399507 perf-stat.ps.context-switches
948.06 ± 11% -14.8% 807.87 ± 3% perf-stat.ps.cpu-migrations
796174 ± 31% -68.3% 252476 ± 4% perf-stat.ps.dTLB-load-misses
8.688e+09 +4.7% 9.095e+09 perf-stat.ps.dTLB-loads
124340 ± 31% -74.0% 32349 ± 4% perf-stat.ps.dTLB-store-misses
3.766e+09 +9.1% 4.108e+09 perf-stat.ps.dTLB-stores
43689908 ± 2% +11.7% 48794646 perf-stat.ps.iTLB-load-misses
23103357 ± 4% +8.5% 25074278 perf-stat.ps.iTLB-loads
3.283e+10 +4.8% 3.44e+10 perf-stat.ps.instructions
4385696 +8.0% 4738522 perf-stat.ps.node-load-misses
845448 -73.3% 225752 perf-stat.ps.node-loads
2040515 +98.3% 4045447 perf-stat.ps.node-store-misses
98835 -63.5% 36074 perf-stat.ps.node-stores
1.286e+13 +4.5% 1.344e+13 perf-stat.total.instructions
2564 ± 21% +36.9% 3510 ± 12% interrupts.CPU0.TLB:TLB_shootdowns
20.25 ± 44% +1430.9% 310.00 ± 79% interrupts.CPU10.TLB:TLB_shootdowns
104.50 ±124% +201.0% 314.50 ± 53% interrupts.CPU105.TLB:TLB_shootdowns
18.75 ± 35% +418.7% 97.25 ±110% interrupts.CPU108.TLB:TLB_shootdowns
18.75 ± 29% +909.3% 189.25 ± 65% interrupts.CPU110.TLB:TLB_shootdowns
18.75 ± 29% +698.7% 149.75 ± 81% interrupts.CPU113.TLB:TLB_shootdowns
89357 ± 6% +15.9% 103535 ± 5% interrupts.CPU115.RES:Rescheduling_interrupts
88209 ± 9% +20.6% 106340 ± 5% interrupts.CPU116.RES:Rescheduling_interrupts
83630 ± 11% +20.8% 101003 ± 2% interrupts.CPU117.RES:Rescheduling_interrupts
21.00 ± 36% +702.4% 168.50 ± 69% interrupts.CPU117.TLB:TLB_shootdowns
110630 ± 8% +10.8% 122586 ± 3% interrupts.CPU120.RES:Rescheduling_interrupts
106258 ± 9% +14.3% 121460 ± 3% interrupts.CPU122.RES:Rescheduling_interrupts
41.75 ± 55% +476.6% 240.75 ± 96% interrupts.CPU123.TLB:TLB_shootdowns
56.75 ±132% +519.8% 351.75 ± 29% interrupts.CPU124.TLB:TLB_shootdowns
88.75 ±147% +116.3% 192.00 ± 77% interrupts.CPU128.TLB:TLB_shootdowns
19.00 ± 27% +1509.2% 305.75 ± 98% interrupts.CPU129.TLB:TLB_shootdowns
112.25 ±106% +278.0% 424.25 ± 51% interrupts.CPU13.TLB:TLB_shootdowns
18.50 ± 18% +839.2% 173.75 ± 73% interrupts.CPU132.TLB:TLB_shootdowns
92.25 ±142% +499.7% 553.25 ± 98% interrupts.CPU134.TLB:TLB_shootdowns
88357 ± 7% +9.9% 97128 ± 5% interrupts.CPU138.RES:Rescheduling_interrupts
89772 ± 9% +18.5% 106341 ± 4% interrupts.CPU139.RES:Rescheduling_interrupts
2451 ± 32% +66.6% 4084 ± 8% interrupts.CPU140.NMI:Non-maskable_interrupts
2451 ± 32% +66.6% 4084 ± 8% interrupts.CPU140.PMI:Performance_monitoring_interrupts
88.25 ±143% +210.8% 274.25 ± 88% interrupts.CPU140.TLB:TLB_shootdowns
107210 ± 8% +12.3% 120362 ± 4% interrupts.CPU144.RES:Rescheduling_interrupts
96772 ± 7% +11.1% 107553 ± 5% interrupts.CPU145.RES:Rescheduling_interrupts
102245 ± 2% +10.5% 112975 ± 2% interrupts.CPU146.RES:Rescheduling_interrupts
21.00 ± 28% +298.8% 83.75 ± 29% interrupts.CPU146.TLB:TLB_shootdowns
2359 ± 16% +39.6% 3294 ± 18% interrupts.CPU152.NMI:Non-maskable_interrupts
2359 ± 16% +39.6% 3294 ± 18% interrupts.CPU152.PMI:Performance_monitoring_interrupts
23.00 ± 39% +1562.0% 382.25 ± 86% interrupts.CPU159.TLB:TLB_shootdowns
19.00 ± 34% +635.5% 139.75 ± 80% interrupts.CPU160.TLB:TLB_shootdowns
20.50 ± 32% +506.1% 124.25 ± 92% interrupts.CPU161.TLB:TLB_shootdowns
85527 ± 7% +16.3% 99481 interrupts.CPU162.RES:Rescheduling_interrupts
24.00 ± 39% +415.6% 123.75 ±107% interrupts.CPU165.TLB:TLB_shootdowns
83285 ± 17% +22.7% 102187 ± 9% interrupts.CPU166.RES:Rescheduling_interrupts
124.75 ± 99% +173.5% 341.25 ± 66% interrupts.CPU166.TLB:TLB_shootdowns
54.75 ± 80% +543.8% 352.50 ± 52% interrupts.CPU168.TLB:TLB_shootdowns
36.25 ± 64% +510.3% 221.25 ± 66% interrupts.CPU17.TLB:TLB_shootdowns
66.75 ±112% +205.6% 204.00 ± 71% interrupts.CPU170.TLB:TLB_shootdowns
91.00 ±127% +446.4% 497.25 ± 29% interrupts.CPU171.TLB:TLB_shootdowns
108108 ± 7% +10.1% 119063 ± 5% interrupts.CPU173.RES:Rescheduling_interrupts
103866 ± 5% +19.7% 124283 ± 7% interrupts.CPU175.RES:Rescheduling_interrupts
86.50 ±148% +430.9% 459.25 ± 26% interrupts.CPU176.TLB:TLB_shootdowns
100777 ± 10% +13.6% 114467 ± 5% interrupts.CPU180.RES:Rescheduling_interrupts
87385 ± 11% +24.5% 108773 ± 8% interrupts.CPU182.RES:Rescheduling_interrupts
89523 ± 10% +22.9% 110062 ± 7% interrupts.CPU183.RES:Rescheduling_interrupts
18.75 ± 36% +774.7% 164.00 ± 85% interrupts.CPU183.TLB:TLB_shootdowns
89589 ± 12% +25.1% 112078 ± 11% interrupts.CPU184.RES:Rescheduling_interrupts
89109 ± 11% +29.7% 115571 ± 6% interrupts.CPU185.RES:Rescheduling_interrupts
84744 ± 11% +19.9% 101596 ± 9% interrupts.CPU186.RES:Rescheduling_interrupts
85476 ± 15% +19.3% 101991 ± 5% interrupts.CPU189.RES:Rescheduling_interrupts
100.75 ±133% +306.5% 409.50 ± 53% interrupts.CPU19.TLB:TLB_shootdowns
40.00 ± 29% +303.1% 161.25 ± 51% interrupts.CPU190.TLB:TLB_shootdowns
91.75 ±137% +186.6% 263.00 ± 45% interrupts.CPU20.TLB:TLB_shootdowns
3580 ± 16% -18.4% 2920 ± 5% interrupts.CPU22.NMI:Non-maskable_interrupts
3580 ± 16% -18.4% 2920 ± 5% interrupts.CPU22.PMI:Performance_monitoring_interrupts
132.75 ± 95% +236.5% 446.75 ± 24% interrupts.CPU23.TLB:TLB_shootdowns
120.75 ±102% +207.2% 371.00 ± 42% interrupts.CPU29.TLB:TLB_shootdowns
28.25 ± 27% +1029.2% 319.00 ±116% interrupts.CPU30.TLB:TLB_shootdowns
3011 ± 18% -27.0% 2199 ± 31% interrupts.CPU31.NMI:Non-maskable_interrupts
3011 ± 18% -27.0% 2199 ± 31% interrupts.CPU31.PMI:Performance_monitoring_interrupts
49.50 ± 74% +511.1% 302.50 ± 82% interrupts.CPU32.TLB:TLB_shootdowns
23.00 ± 33% +825.0% 212.75 ±100% interrupts.CPU33.TLB:TLB_shootdowns
3077 ± 14% +24.8% 3840 ± 5% interrupts.CPU35.NMI:Non-maskable_interrupts
3077 ± 14% +24.8% 3840 ± 5% interrupts.CPU35.PMI:Performance_monitoring_interrupts
54.25 ± 88% +285.7% 209.25 ± 68% interrupts.CPU36.TLB:TLB_shootdowns
45.75 ± 92% +648.1% 342.25 ± 28% interrupts.CPU38.TLB:TLB_shootdowns
40.50 ± 69% +529.6% 255.00 ± 44% interrupts.CPU41.TLB:TLB_shootdowns
2264 ± 15% +58.7% 3593 ± 10% interrupts.CPU46.NMI:Non-maskable_interrupts
2264 ± 15% +58.7% 3593 ± 10% interrupts.CPU46.PMI:Performance_monitoring_interrupts
274.50 ± 71% +108.7% 572.75 ± 19% interrupts.CPU51.TLB:TLB_shootdowns
86524 ± 4% +7.8% 93252 ± 4% interrupts.CPU57.RES:Rescheduling_interrupts
37.75 ± 30% +1033.8% 428.00 ± 53% interrupts.CPU60.TLB:TLB_shootdowns
80.50 ±117% +602.2% 565.25 ± 77% interrupts.CPU66.TLB:TLB_shootdowns
98.00 ±127% +221.4% 315.00 ± 76% interrupts.CPU69.TLB:TLB_shootdowns
281.75 ± 29% -69.7% 85.25 ± 5% interrupts.CPU7.TLB:TLB_shootdowns
3275 ± 6% -22.6% 2535 ± 26% interrupts.CPU72.NMI:Non-maskable_interrupts
3275 ± 6% -22.6% 2535 ± 26% interrupts.CPU72.PMI:Performance_monitoring_interrupts
51.00 ±115% +383.3% 246.50 ± 44% interrupts.CPU88.TLB:TLB_shootdowns
23.50 ± 71% +368.1% 110.00 ± 32% interrupts.CPU90.TLB:TLB_shootdowns
68.25 ± 38% +231.5% 226.25 ± 58% interrupts.CPU91.TLB:TLB_shootdowns
59.25 ±102% +230.4% 195.75 ± 75% interrupts.CPU92.TLB:TLB_shootdowns
48.00 ± 79% +530.2% 302.50 ± 44% interrupts.CPU95.TLB:TLB_shootdowns
108205 ± 9% +13.5% 122833 ± 4% interrupts.CPU97.RES:Rescheduling_interrupts
55463 ± 22% +42.5% 79045 ± 14% interrupts.TLB:TLB_shootdowns
unixbench.time.voluntary_context_switches
3.5e+08 +-----------------------------------------------------------------+
| O O OO |
3.4e+08 |-+ O OO O O O O |
| O O O OO O O O O |
3.3e+08 |-+ O O |
| |
3.2e+08 |-+ |
| +.+.+.+ |
3.1e+08 |.+.+.++. + : .+ |
| +.+.+.+.++.+.+.+.+.++ : .+ +. |
3e+08 |-+ : ++.+.+.+ +.|
| : + |
2.9e+08 |-+ ++. .+ |
| +.+.+ |
2.8e+08 +-----------------------------------------------------------------+
unixbench.score
3100 +--------------------------------------------------------------------+
| |
3000 |-O O O O |
| O O |
2900 |-+ O OO O O O O O O O OO O O |
| O O |
2800 |-+ |
| +. |
2700 |-+ .+.++.+ + + |
|.+.+. .+.+. +. .+.+. .+.+. .+ : +.+ + .|
2600 |-+ + + + +.+ + : .+. : + |
| : .+.+ + |
2500 |-+ +.+. .+ |
| +.+.+ |
2400 +--------------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
***************************************************************************************************
lkp-skl-fpga01: 104 threads Skylake with 192G memory
=========================================================================================
compiler/cpufreq_governor/kconfig/mode/nr_task/rootfs/tbox_group/test/testcase/ucode:
gcc-7/performance/x86_64-rhel-7.6/process/100%/debian-x86_64-20191114.cgz/lkp-skl-fpga01/mmap1/will-it-scale/0x2000065
commit:
dfce1eb694 ("locking/qspinlock: Introduce starvation avoidance into CNA")
7b6da71157 ("locking/qspinlock: Introduce the shuffle reduction optimization into CNA")
dfce1eb694321530 7b6da7115786ee28ad82638a5dc
---------------- ---------------------------
fail:runs %reproduction fail:runs
| | |
1:2 -50% :2 dmesg.WARNING:at#for_ip_interrupt_entry/0x
***************************************************************************************************
lkp-skl-fpga01: 104 threads Skylake with 192G memory
=========================================================================================
compiler/cpufreq_governor/kconfig/mode/nr_task/rootfs/tbox_group/test/testcase/ucode:
gcc-7/performance/x86_64-rhel-7.6/process/100%/debian-x86_64-20191114.cgz/lkp-skl-fpga01/mmap2/will-it-scale/0x2000065
commit:
dfce1eb694 ("locking/qspinlock: Introduce starvation avoidance into CNA")
7b6da71157 ("locking/qspinlock: Introduce the shuffle reduction optimization into CNA")
dfce1eb694321530 7b6da7115786ee28ad82638a5dc
---------------- ---------------------------
fail:runs %reproduction fail:runs
| | |
1:2 -50% :2 dmesg.WARNING:at#for_ip_interrupt_entry/0x
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Rong Chen
2 years, 5 months
acf49bb928 ("mm/mlock: split ClearPageLRU from page isolation .."): [ 36.045721] BUG: sleeping function called from invalid context at mm/rmap.c:1861
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/alexshi/linux.git lrunext
commit acf49bb9284710c28524098098bda22eb1602275
Author: Alex Shi <alex.shi(a)linux.alibaba.com>
AuthorDate: Thu Feb 27 12:24:11 2020 +0800
Commit: Alex Shi <alex.shi(a)linux.alibaba.com>
CommitDate: Thu Feb 27 19:45:28 2020 +0800
mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
This is one of effort to split the PageLRU clear from old page
isolation.
This patch move the lru_lock after get PageLRU, which takes holding
PageLRU as precondition for page isolation, as a preparation for later
lru_lock replacment. So we have to unfold __munlock_isolate_lru_page.
__split_huge_page_refcount doesn't exist, but we still have to guard
PageMlocked in __split_huge_page_tail. that make code ugly and bear
few unrelated code in lock. anyway still removed few goto's to dress up
current code.
Signed-off-by: Alex Shi <alex.shi(a)linux.alibaba.com>
Cc: Kirill A. Shutemov <kirill(a)shutemov.name>
Cc: Andrew Morton <akpm(a)linux-foundation.org>
Cc: Johannes Weiner <hannes(a)cmpxchg.org>
Cc: Matthew Wilcox <willy(a)infradead.org>
Cc: Hugh Dickins <hughd(a)google.com>
Cc: linux-mm(a)kvack.org
Cc: linux-kernel(a)vger.kernel.org
e46563ef83 mm/lru: add page isolation precondition in __isolate_lru_page
acf49bb928 mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
4eddfb57a6 mm/memcg: add debug checking in lock_page_memcg
+----------------------------------------------------------------+------------+------------+------------+
| | e46563ef83 | acf49bb928 | 4eddfb57a6 |
+----------------------------------------------------------------+------------+------------+------------+
| boot_successes | 32 | 1 | 0 |
| boot_failures | 3 | 10 | 2 |
| WARNING:at_mm/usercopy.c:#usercopy_warn | 1 | | |
| RIP:usercopy_warn | 1 | | |
| INFO:rcu_sched_self-detected_stall_on_CPU | 1 | | |
| RIP:clear_page_erms | 1 | 2 | |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 1 | 3 | |
| BUG:kernel_hang_in_boot_stage | 1 | 2 | |
| BUG:kernel_timeout_in_boot_stage | 0 | 1 | |
| BUG:sleeping_function_called_from_invalid_context_at_mm/rmap.c | 0 | 6 | 2 |
| BUG:kernel_hang_in_early-boot_stage | 0 | 1 | |
| RIP:copy_user_enhanced_fast_string | 0 | 0 | 1 |
+----------------------------------------------------------------+------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[child5:606] nfsservctl (180) returned ENOSYS, marking as inactive.
[child5:606] clock_getres (266:[32BIT]) returned ENOSYS, marking as inactive.
[child3:603] mq_getsetattr (245) returned ENOSYS, marking as inactive.
[child3:616] mq_timedreceive (243) returned ENOSYS, marking as inactive.
[child3:616] kexec_load (246) returned ENOSYS, marking as inactive.
[ 36.045721] BUG: sleeping function called from invalid context at mm/rmap.c:1861
[ 36.047309] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 606, name: trinity-c5
[ 36.048622] CPU: 0 PID: 606 Comm: trinity-c5 Not tainted 5.6.0-rc3-00009-gacf49bb928471 #1
[ 36.049991] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 36.051424] Call Trace:
[ 36.051773] dump_stack+0x7c/0xa5
[ 36.052198] ___might_sleep+0x161/0x180
[ 36.052682] rmap_walk_anon+0x135/0x320
[ 36.053597] rmap_walk+0x51/0x60
[ 36.053999] try_to_munlock+0x86/0xb0
[ 36.054464] ? page_mkclean+0x140/0x140
[ 36.055335] ? page_remove_rmap+0x4a0/0x4a0
[ 36.055862] ? anon_vma_ctor+0x70/0x70
[ 36.056343] ? page_get_anon_vma+0x180/0x180
[ 36.057299] __munlock_isolated_page+0x46/0xd0
[ 36.057954] munlock_vma_page+0x3be/0x4f0
[ 36.058446] wp_page_copy+0xaba/0xaf0
[ 36.059313] ? follow_pfn+0x160/0x160
[ 36.059780] ? __kasan_check_read+0x11/0x20
[ 36.060294] ? try_to_wake_up+0x183/0xbd0
[ 36.061211] do_wp_page+0x292/0x9b0
[ 36.061643] ? finish_mkwrite_fault+0x210/0x210
[ 36.062199] ? _raw_read_lock_irq+0x40/0x40
[ 36.063149] __handle_mm_fault+0x96a/0x18b0
[ 36.063659] ? apply_to_existing_page_range+0x10/0x10
[ 36.064280] ? _raw_spin_lock+0x75/0xc0
[ 36.065163] ? _raw_read_lock_irq+0x40/0x40
[ 36.065693] ? update_rq_clock+0x126/0x1f0
[ 36.066646] ? __kasan_check_read+0x11/0x20
[ 36.067170] ? __count_memcg_events+0x54/0x120
[ 36.068041] handle_mm_fault+0x1d2/0x2f0
[ 36.068953] __get_user_pages+0x2b8/0xa50
[ 36.069466] ? follow_page_mask+0xa00/0xa00
[ 36.069993] ? down_read+0xeb/0x1c0
[ 36.070873] ? down_read_killable+0x1d0/0x1d0
[ 36.071409] populate_vma_page_range+0x96/0xb0
[ 36.071955] __mm_populate+0x128/0x1f0
[ 36.072850] ? populate_vma_page_range+0xb0/0xb0
[ 36.073424] __x64_sys_mlockall+0x215/0x270
[ 36.073960] do_syscall_64+0xb7/0x390
[ 36.074435] entry_SYSCALL_64_after_hwframe+0x44/0xa9
[ 36.075056] RIP: 0033:0x457729
[ 36.075445] 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 2b 84 00 00 c3 66 2e 0f 1f 84 00 00 00 00
[ 36.077682] RSP: 002b:00007ffedac862c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000097
[ 36.078591] RAX: ffffffffffffffda RBX: 0000000000000097 RCX: 0000000000457729
[ 36.079434] RDX: 000000000000fffd RSI: 000000000d0d0d0d RDI: 0000000000000001
[ 36.080278] RBP: 00007ffedac86370 R08: 0000c8dc6a7819c3 R09: 947ab93afb7ffb80
[ 36.081154] R10: 0000000000000038 R11: 0000000000000246 R12: 0000000000000002
[ 36.082009] R13: 00007f4b65400058 R14: 0000000001057830 R15: 00007f4b65400000
[child3:616] Dumped trace to /boot/trace.txt
*** Error in `/bin/trinity': free(): invalid pointer: 0x00000000004b77e0 ***
======= Backtrace: =========
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 0eb7fc20ae4de315c2379e589ce9f184ff635fce f8788d86ab28f61f7b46eb6be375f8a726783636 --
git bisect bad 7a9a8c69941e1374e2686376b8137dd20b28cdc8 # 22:25 B 0 3 19 0 Merge 'linux-review/Gustavo-A-R-Silva/s390-Replace-zero-length-array-with-flexible-array-member/20200223-025126' into devel-hourly-2020022819
git bisect good 6d7ab7e685c4a4f5f3d3199b184f5499f4b02c85 # 23:19 G 11 0 4 4 Merge 'linux-review/Isaac-J-Manjarres/of-of_reserved_mem-Increase-limit-on-number-of-reserved-regions/20200225-033755' into devel-hourly-2020022819
git bisect good 66084a0a5eabcfd704f0bbab048cd9126e7c24ab # 23:53 G 11 0 2 2 Merge 'linux-review/Zhangfei-Gao/MAINTAINERS-add-maintainers-for-uacce/20200226-093543' into devel-hourly-2020022819
git bisect good 2c0ff33777d53be39ccd428650598a52b7080a2d # 01:13 G 11 0 3 3 Merge 'linux-review/Suman-Anna/Drop-PRUSS-and-OMAP4-IPU-DSP-hwmod-data/20200225-072420' into devel-hourly-2020022819
git bisect bad a346803f887ad079c21179d1fd69586cc2f5147c # 01:36 B 0 3 19 0 Merge 'linux-review/Prarit-Bhargava/x86-tsc-Add-kernel-options-to-disable-CPUID-and-MSR-calibrations/20200227-034607' into devel-hourly-2020022819
git bisect bad 360d08b6abbf3adae740222d62ca8032996019e8 # 02:41 B 0 1 17 0 Merge 'linux-review/jack-yu-realtek-com/ASoC-rt1015-modify-some-structure-to-be-static/20200227-101356' into devel-hourly-2020022819
git bisect good 86faac9834b0e94a3901cc1db4272ae41b11a48e # 07:51 G 10 0 5 5 Merge 'linux-review/Anson-Huang/arm64-dts-imx8mn-Adjust-1-2GHz-OPP-voltage-to-OD-mode/20200224-101803' into devel-hourly-2020022819
git bisect bad 1776718bda27b7f353dc434e8384fbd7a9b3980d # 08:48 B 0 2 18 0 Merge 'linux-review/Qian-Cai/tick-sched-fix-data-races-at-tick_do_timer_cpu/20200225-111352' into devel-hourly-2020022819
git bisect bad 0abbb41ee5a632a0cfaa8a0ee59b4e46c9e8544f # 10:00 B 0 2 18 0 Merge 'alexshi/lrunext' into devel-hourly-2020022819
git bisect bad b8e71301886b2ad0b0754fbc6884b6a24ac1931b # 10:52 B 0 1 17 0 mm/lru: take PageLRU first in moving page between lru lists
git bisect good 602a257cff49bd0349d0dadc1aa4f0393c77457c # 13:15 G 10 0 2 2 mm/thp: clean up lru_add_page_tail
git bisect good 2282ec703a69b8c626c8c36fd6a73f3ac95c4206 # 13:55 G 10 0 5 5 mm/lru: introduce TestClearPageLRU
git bisect bad acf49bb9284710c28524098098bda22eb1602275 # 14:37 B 0 1 17 0 mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
git bisect good e46563ef83b1583c2f2d54e412222cae5b48bc1d # 15:59 G 10 0 2 2 mm/lru: add page isolation precondition in __isolate_lru_page
# first bad commit: [acf49bb9284710c28524098098bda22eb1602275] mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
git bisect good e46563ef83b1583c2f2d54e412222cae5b48bc1d # 16:05 G 30 0 1 3 mm/lru: add page isolation precondition in __isolate_lru_page
# extra tests with debug options
git bisect good acf49bb9284710c28524098098bda22eb1602275 # 16:50 G 10 0 10 10 mm/mlock: split ClearPageLRU from page isolation and remain Mlocked guard
# extra tests on head commit of alexshi/lrunext
git bisect bad 4eddfb57a6f7eb0e614389fec3be79bc7b7da65b # 18:32 B 0 1 17 0 mm/memcg: add debug checking in lock_page_memcg
# bad: [4eddfb57a6f7eb0e614389fec3be79bc7b7da65b] mm/memcg: add debug checking in lock_page_memcg
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
2 years, 5 months