[mm] 86cda95957: BUG:sleeping_function_called_from_invalid_context_at_include/linux/sched/mm.h
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: 86cda9595796e709c444b93df1f27a2343c5fa06 ("[PATCH v4 11/17] mm: list_lru: allocate list_lru_one only when needed")
url: https://github.com/0day-ci/linux/commits/Muchun-Song/Optimize-list-lru-me...
base: https://git.kernel.org/cgit/linux/kernel/git/jaegeuk/f2fs.git dev-test
patch link: https://lore.kernel.org/linux-fsdevel/20211213165342.74704-12-songmuchun@...
in testcase: xfstests
version: xfstests-x86_64-972d710-1_20211215
with following parameters:
disk: 4HDD
fs: xfs
test: xfs-reflink-25
ucode: 0x28
test-description: xfstests is a regression test suite for xfs and other files ystems.
test-url: git://git.kernel.org/pub/scm/fs/xfs/xfstests-dev.git
on test machine: 8 threads 1 sockets 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 <oliver.sang(a)intel.com>
erial console /d[ 14.815233][ T356] BUG: sleeping function called from invalid context at include/linux/sched/mm.h:230
[ 14.827152][ T356] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 356, name: useradd
[ 14.835607][ T356] preempt_count: 1, expected: 0
[ 14.840274][ T356] CPU: 4 PID: 356 Comm: useradd Not tainted 5.16.0-rc1-00032-g86cda9595796 #1
ev/ttyS0
[ 14.848903][ T356] Hardware name: Dell Inc. OptiPlex 9020/03CPWF, BIOS A11 04/01/2015
[ 14.857606][ T356] Call Trace:
[ 14.860732][ T356] <TASK>
[ 14.863515][ T356] dump_stack_lvl (lib/dump_stack.c:107)
[ 14.867859][ T356] __might_resched.cold (kernel/sched/core.c:9543 kernel/sched/core.c:9496)
[ 14.872889][ T356] ? memcg_list_lru_alloc (include/linux/slab.h:598 mm/list_lru.c:354 mm/list_lru.c:586)
[ 14.878083][ T356] __kmalloc (include/linux/sched/mm.h:230 mm/slab.h:509 mm/slub.c:3148 mm/slub.c:3242 mm/slub.c:4433)
[ 14.882177][ T356] ? is_bpf_text_address (arch/x86/include/asm/preempt.h:85 include/linux/rcupdate.h:73 include/linux/rcupdate.h:720 kernel/bpf/core.c:717)
[ 14.887129][ T356] memcg_list_lru_alloc (include/linux/slab.h:598 mm/list_lru.c:354 mm/list_lru.c:586)
[ 14.892166][ T356] ? xas_alloc (lib/xarray.c:374)
[ 14.896421][ T356] kmem_cache_alloc_lru (include/linux/cgroup.h:403 mm/slab.h:295 mm/slab.h:514 mm/slub.c:3148 mm/slub.c:3242 mm/slub.c:3249 mm/slub.c:3266)
[ 14.901367][ T356] xas_alloc (lib/xarray.c:374)
[ 14.905454][ T356] xas_create (lib/xarray.c:676)
[ 14.909624][ T356] xas_store (lib/xarray.c:784 (discriminator 6))
[ 14.913709][ T356] ? _raw_spin_lock_irq (arch/x86/include/asm/atomic.h:202 include/linux/atomic/atomic-instrumented.h:513 include/asm-generic/qspinlock.h:82 include/linux/spinlock.h:185 include/linux/spinlock_api_smp.h:120 kernel/locking/spinlock.c:170)
[ 14.918567][ T356] ? xas_find_conflict (lib/xarray.c:1401)
[ 14.923511][ T356] __filemap_add_folio (mm/filemap.c:943)
[ 14.928458][ T356] ? folio_wait_private_2 (mm/filemap.c:891)
[ 14.933664][ T356] ? scan_shadow_nodes (mm/workingset.c:435)
[ 14.938436][ T356] ? __alloc_pages (mm/page_alloc.c:5370)
[ 14.943038][ T356] ? __alloc_pages_slowpath+0x1f80/0x1f80
[ 14.949620][ T356] filemap_add_folio (include/linux/instrumented.h:41 include/asm-generic/bitops/instrumented-non-atomic.h:42 include/linux/page-flags.h:417 mm/filemap.c:1001)
[ 14.954311][ T356] ? add_to_page_cache_locked (mm/filemap.c:994)
[ 14.959686][ T356] __filemap_get_folio (mm/filemap.c:1963)
[ 14.964637][ T356] ? __folio_lock_killable (mm/filemap.c:1901)
[ 14.969756][ T356] ? __vfs_setxattr (fs/xattr.c:391)
[ 14.974449][ T356] ? inode_owner_or_capable (fs/inode.c:2291)
[ 14.979826][ T356] pagecache_get_page (mm/folio-compat.c:125)
[ 14.984516][ T356] simple_write_begin (fs/libfs.c:561)
[ 14.989287][ T356] ? fault_in_iov_iter_readable (lib/iov_iter.c:460 lib/iov_iter.c:445)
[ 14.994929][ T356] generic_perform_write (mm/filemap.c:3758)
[ 15.000054][ T356] ? trace_event_raw_event_file_check_and_advance_wb_err (mm/filemap.c:3721)
[ 15.007926][ T356] ? inode_update_time (fs/inode.c:1987)
[ 15.012703][ T356] ? generic_write_checks (fs/read_write.c:1649)
[ 15.017909][ T356] __generic_file_write_iter (mm/filemap.c:3884)
[ 15.023376][ T356] generic_file_write_iter (include/linux/fs.h:789 mm/filemap.c:3916)
[ 15.028586][ T356] ? _raw_spin_lock (arch/x86/include/asm/atomic.h:202 include/linux/atomic/atomic-instrumented.h:513 include/asm-generic/qspinlock.h:82 include/linux/spinlock.h:185 include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154)
[ 15.033201][ T356] new_sync_write (fs/read_write.c:504 (discriminator 1))
[ 15.037718][ T356] ? __check_object_size (mm/usercopy.c:240 mm/usercopy.c:286 mm/usercopy.c:256)
[ 15.042839][ T356] ? new_sync_read (fs/read_write.c:493)
[ 15.047445][ T356] ? kasan_set_track (mm/kasan/common.c:46)
[ 15.052053][ T356] ? file_open_root (fs/open.c:1198)
[ 15.056745][ T356] vfs_write (fs/read_write.c:590)
[ 15.060837][ T356] ksys_write (fs/read_write.c:643)
[ 15.064928][ T356] ? __ia32_sys_read (fs/read_write.c:633)
[ 15.069536][ T356] ? __fget_light (arch/x86/include/asm/atomic.h:29 include/linux/atomic/atomic-instrumented.h:28 fs/file.c:959)
[ 15.073970][ T356] do_syscall_64 (arch/x86/entry/common.c:50 arch/x86/entry/common.c:80)
[ 15.078234][ T356] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:113)
[ 15.083962][ T356] RIP: 0033:0x7f4751044504
[ 15.088220][ T356] Code: 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb b3 0f 1f 80 00 00 00 00 48 8d 05 f9 61 0d 00 8b 00 85 c0 75 13 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 54 c3 0f 1f 00 41 54 49 89 d4 55 48 89 f5 53
All code
========
0: 00 f7 add %dh,%bh
2: d8 64 89 02 fsubs 0x2(%rcx,%rcx,4)
6: 48 c7 c0 ff ff ff ff mov $0xffffffffffffffff,%rax
d: eb b3 jmp 0xffffffffffffffc2
f: 0f 1f 80 00 00 00 00 nopl 0x0(%rax)
16: 48 8d 05 f9 61 0d 00 lea 0xd61f9(%rip),%rax # 0xd6216
1d: 8b 00 mov (%rax),%eax
1f: 85 c0 test %eax,%eax
21: 75 13 jne 0x36
23: b8 01 00 00 00 mov $0x1,%eax
28: 0f 05 syscall
2a:* 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax <-- trapping instruction
30: 77 54 ja 0x86
32: c3 retq
33: 0f 1f 00 nopl (%rax)
36: 41 54 push %r12
38: 49 89 d4 mov %rdx,%r12
3b: 55 push %rbp
3c: 48 89 f5 mov %rsi,%rbp
3f: 53 push %rbx
Code starting with the faulting instruction
===========================================
0: 48 3d 00 f0 ff ff cmp $0xfffffffffffff000,%rax
6: 77 54 ja 0x5c
8: c3 retq
9: 0f 1f 00 nopl (%rax)
c: 41 54 push %r12
e: 49 89 d4 mov %rdx,%r12
11: 55 push %rbp
12: 48 89 f5 mov %rsi,%rbp
15: 53 push %rbx
[ 15.107521][ T356] RSP: 002b:00007ffcd1b45278 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[ 15.115736][ T356] RAX: ffffffffffffffda RBX: 00007ffcd1b452b0 RCX: 00007f4751044504
[ 15.123515][ T356] RDX: 0000000000000124 RSI: 00007ffcd1b45300 RDI: 000000000000000c
[ 15.131295][ T356] RBP: 0000000000000442 R08: 0000000000000002 R09: 0000000000000000
[ 15.139072][ T356] R10: 0000000000000000 R11: 0000000000000246 R12: 00007ffcd1b45300
[ 15.146847][ T356] R13: 000000000000000c R14: 000000000004db48 R15: 0000000000000000
[ 15.154633][ T356] </TASK>
[ 15.160137][ T231] scsi 0:0:0:0: Attached scsi generic sg0 type 0
Startin[ 15.167839][ T231] scsi 2:0:0:0: Attached scsi generic sg1 type 0
[ 15.193722][ T57] sd 0:0:0:0: [sda] 7814037168 512-byte logical blocks: (4.00 TB/3.64 TiB)
[ 15.195091][ T56] ata3.00: Enabling discard_zeroes_data
[ 15.207674][ T57] sd 0:0:0:0: [sda] Write Protect is off
[ 15.207701][ T57] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 15.207787][ T57] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 15.207851][ T56] sd 2:0:0:0: [sdb] 1562824368 512-byte logical blocks: (800 GB/745 GiB)
[ 15.207866][ T56] sd 2:0:0:0: [sdb] 4096-byte physical blocks
[ 15.207900][ T56] sd 2:0:0:0: [sdb] Write Protect is off
[ 15.207910][ T56] sd 2:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[ 15.207960][ T56] sd 2:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 15.269219][ T56] ata3.00: Enabling discard_zeroes_data
e command to reb[ 15.290068][ T56] ata3.00: Enabling discard_zeroes_data
[ 15.333302][ T57] sda: sda1 sda2 sda3 sda4 sda5 sda6
[ 15.474103][ T413] raid6: avx2x4 gen() 14302 MB/s
[ 15.495104][ T413] raid6: avx2x4 xor() 3413 MB/s
[ 15.516107][ T413] raid6: avx2x2 gen() 13976 MB/s
[ 15.537110][ T413] raid6: avx2x2 xor() 14885 MB/s
[ 15.558107][ T413] raid6: avx2x1 gen() 11717 MB/s
[ 15.579110][ T413] raid6: avx2x1 xor() 11126 MB/s
[ 15.600107][ T413] raid6: sse2x4 gen() 9496 MB/s
[ 15.621109][ T413] raid6: sse2x4 xor() 2777 MB/s
[ 15.642108][ T413] raid6: sse2x2 gen() 9889 MB/s
[ 15.663109][ T413] raid6: sse2x2 xor() 9114 MB/s
[ 15.684104][ T413] raid6: sse2x1 gen() 8027 MB/s
[ 15.705106][ T413] raid6: sse2x1 xor() 6892 MB/s
[ 15.710054][ T413] raid6: using algorithm avx2x4 gen() 14302 MB/s
[ 15.716224][ T413] raid6: .... xor() 3413 MB/s, rmw enabled
[ 15.721887][ T413] raid6: using avx2x2 recovery algorithm
[ 15.729474][ T413] xor: automatically using best checksumming function avx
[ 15.867090][ T472] IPMI message handler: version 39.2
[ 15.875744][ T472] ipmi device interface
[ 15.883698][ T413] Btrfs loaded, crc32c=crc32c-intel, zoned=yes, fsverity=no
[ 15.892425][ T242] BTRFS: device fsid 3d7007c8-874e-4961-914f-c38ddb1e40d8 devid 1 transid 8599 /dev/sdb2 scanned by systemd-udevd (242)
[ 15.909086][ T487] ipmi_si: IPMI System Interface driver
[ 15.915587][ T487] ipmi_si: Unable to find any System Interface(s)
See 'systemctl status openipmi.service' for details.
[ 16.356154][ C3] random: crng init done
[ 16.360258][ C3] random: 1 urandom warning(s) missed due to ratelimiting
[ 20.465582][ T334] Kernel tests: Boot OK!
[ 20.465592][ T334]
[ 23.872773][ T334] install debs round one: dpkg -i --force-confdef --force-depends /opt/deb/ntpdate_1%3a4.2.8p12+dfsg-4_amd64.deb
[ 23.872784][ T334]
[ 23.887308][ T334] /opt/deb/gawk_1%3a4.2.1+dfsg-1_amd64.deb
[ 23.887314][ T334]
[ 23.895838][ T334] /opt/deb/libssl1.1_1.1.1d-0+deb10u7_amd64.deb
[ 23.895843][ T334]
[ 23.904753][ T334] /opt/deb/uuid-runtime_2.33.1-0.1_amd64.deb
[ 23.904758][ T334]
[ 23.913322][ T334] /opt/deb/attr_1%3a2.4.48-4_amd64.deb
[ 23.913326][ T334]
[ 23.921362][ T334] /opt/deb/libdpkg-perl_1.19.7_all.deb
[ 23.921367][ T334]
[ 23.929463][ T334] /opt/deb/patch_2.7.6-3+deb10u1_amd64.deb
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 2
- 1
[fs] 7db4f49247: WARNING:at_mm/slub.c:#kfree
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: 7db4f4924732b9d808323c194d01ba46cb0a6804 ("[PATCH] fs: xattr: use vmemdup_user instead of kvmalloc and copy_from_user")
url: https://github.com/0day-ci/linux/commits/Qing-Wang/fs-xattr-use-vmemdup_u...
base: https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git 5472f14a37421d1bca3dddf33cabd3bd6dbefbbc
patch link: https://lore.kernel.org/linux-fsdevel/1639484357-76013-1-git-send-email-w...
in testcase: trinity
version: trinity-x86_64-608712d8-1_20211207
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 16G
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 <oliver.sang(a)intel.com>
[ 167.936478][ T765] WARNING: CPU: 0 PID: 765 at mm/slub.c:3546 kfree (mm/slub.c:3546 mm/slub.c:4558)
[ 167.944125][ T765] Modules linked in: mpls_router ip_tunnel vsock_loopback vmw_vsock_virtio_transport_common vmw_vsock_vmci_transport vsock vmw_vmci ieee802154_socket ieee802154 hidp bnep rfcomm bluetooth ecdh_generic ecc rfkill can_bcm can_raw can crypto_user ib_core nfnetlink scsi_transport_iscsi atm sctp ip6_udp_tunnel udp_tunnel libcrc32c bochs drm_vram_helper drm_ttm_helper sr_mod cdrom ttm sg drm_kms_helper intel_rapl_msr ppdev syscopyarea sysfillrect sysimgblt fb_sys_fops intel_rapl_common crct10dif_pclmul ata_generic crc32_pclmul crc32c_intel drm ghash_clmulni_intel ata_piix rapl libata joydev ipmi_devintf ipmi_msghandler parport_pc parport serio_raw i2c_piix4 ip_tables
[ 167.979813][ T765] CPU: 0 PID: 765 Comm: trinity-c0 Not tainted 5.16.0-rc5-00011-g7db4f4924732 #1
[ 167.985942][ T765] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 168.003434][ T765] RIP: 0010:kfree (mm/slub.c:3546 mm/slub.c:4558)
[ 168.008352][ T765] Code: 5b 5d 41 5c 41 5d 41 5e 41 5f e9 2a 56 f8 ff 48 c7 c0 00 00 00 80 48 2b 05 1c 14 94 02 e9 cb fd ff ff 48 8b 45 08 a8 01 75 9c <0f> 0b 80 3d ea c1 8c 03 00 75 91 e9 c8 4f c3 01 48 83 c4 20 4d 89
All code
========
0: 5b pop %rbx
1: 5d pop %rbp
2: 41 5c pop %r12
4: 41 5d pop %r13
6: 41 5e pop %r14
8: 41 5f pop %r15
a: e9 2a 56 f8 ff jmpq 0xfffffffffff85639
f: 48 c7 c0 00 00 00 80 mov $0xffffffff80000000,%rax
16: 48 2b 05 1c 14 94 02 sub 0x294141c(%rip),%rax # 0x2941439
1d: e9 cb fd ff ff jmpq 0xfffffffffffffded
22: 48 8b 45 08 mov 0x8(%rbp),%rax
26: a8 01 test $0x1,%al
28: 75 9c jne 0xffffffffffffffc6
2a:* 0f 0b ud2 <-- trapping instruction
2c: 80 3d ea c1 8c 03 00 cmpb $0x0,0x38cc1ea(%rip) # 0x38cc21d
33: 75 91 jne 0xffffffffffffffc6
35: e9 c8 4f c3 01 jmpq 0x1c35002
3a: 48 83 c4 20 add $0x20,%rsp
3e: 4d rex.WRB
3f: 89 .byte 0x89
Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: 80 3d ea c1 8c 03 00 cmpb $0x0,0x38cc1ea(%rip) # 0x38cc1f3
9: 75 91 jne 0xffffffffffffff9c
b: e9 c8 4f c3 01 jmpq 0x1c34fd8
10: 48 83 c4 20 add $0x20,%rsp
14: 4d rex.WRB
15: 89 .byte 0x89
[ 168.024132][ T765] RSP: 0018:ffffc900007bfce0 EFLAGS: 00010246
[ 168.029363][ T765] RAX: ffffea000d587fc8 RBX: fffffffffffffff2 RCX: ffff88813e712000
[ 168.036716][ T765] RDX: 0000000000000000 RSI: ffffffffad1c9c41 RDI: fffffffffffffff2
[ 168.043435][ T765] RBP: ffffea000d587fc0 R08: 0000000000000000 R09: 00000000800000b1
[ 168.049825][ T765] R10: fffffffffffffff2 R11: fffff520000f7f32 R12: 00000000fffff000
[ 168.058150][ T765] R13: 0000000000000000 R14: 00007fc0e7b75000 R15: 0000000000000118
[ 168.064474][ T765] FS: 00007fc0e9a0a740(0000) GS:ffff88839d600000(0000) knlGS:0000000000000000
[ 168.080763][ T765] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 168.086854][ T765] CR2: 00007fc0e7b75000 CR3: 000000017088c000 CR4: 00000000000406f0
[ 168.096288][ T765] DR0: 00007fc0e7b79000 DR1: 0000000000000000 DR2: 0000000000000000
[ 168.102811][ T765] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
[ 168.112088][ T765] Call Trace:
[ 168.117553][ T765] <TASK>
[ 168.124123][ T765] setxattr (fs/xattr.c:577)
[ 168.129544][ T765] ? vfs_setxattr (fs/xattr.c:546)
[ 168.136661][ T765] ? hrtimer_run_softirq (kernel/time/hrtimer.c:1282)
[ 168.143200][ T765] ? _raw_spin_lock_irq (arch/x86/include/asm/atomic.h:202 include/linux/atomic/atomic-instrumented.h:513 include/asm-generic/qspinlock.h:82 include/linux/spinlock.h:185 include/linux/spinlock_api_smp.h:120 kernel/locking/spinlock.c:170)
[ 168.148495][ T765] ? _raw_spin_lock_bh (kernel/locking/spinlock.c:169)
[ 168.155573][ T765] ? do_setitimer (arch/x86/include/asm/jump_label.h:27 include/linux/jump_label.h:212 include/trace/events/timer.h:304 kernel/time/itimer.c:237)
[ 168.160453][ T765] ? perf_syscall_exit (arch/x86/include/asm/bitops.h:214 include/asm-generic/bitops/instrumented-non-atomic.h:135 kernel/trace/trace_syscalls.c:701)
[ 168.167183][ T765] ? ftrace_syscall_enter (kernel/trace/trace_syscalls.c:689)
[ 168.172090][ T765] ? do_setitimer (kernel/time/itimer.c:278)
[ 168.178594][ T765] __x64_sys_fsetxattr (fs/xattr.c:633 fs/xattr.c:619 fs/xattr.c:619)
[ 168.183397][ T765] do_syscall_64 (arch/x86/entry/common.c:50 arch/x86/entry/common.c:80)
[ 168.189609][ T765] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:113)
[ 168.194470][ T765] RIP: 0033:0x7fc0e9b21f59
[ 168.201233][ T765] Code: 00 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 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 73 01 c3 48 8b 0d 07 6f 0c 00 f7 d8 64 89 01 48
All code
========
0: 00 c3 add %al,%bl
2: 66 2e 0f 1f 84 00 00 nopw %cs:0x0(%rax,%rax,1)
9: 00 00 00
c: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1)
11: 48 89 f8 mov %rdi,%rax
14: 48 89 f7 mov %rsi,%rdi
17: 48 89 d6 mov %rdx,%rsi
1a: 48 89 ca mov %rcx,%rdx
1d: 4d 89 c2 mov %r8,%r10
20: 4d 89 c8 mov %r9,%r8
23: 4c 8b 4c 24 08 mov 0x8(%rsp),%r9
28: 0f 05 syscall
2a:* 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax <-- trapping instruction
30: 73 01 jae 0x33
32: c3 retq
33: 48 8b 0d 07 6f 0c 00 mov 0xc6f07(%rip),%rcx # 0xc6f41
3a: f7 d8 neg %eax
3c: 64 89 01 mov %eax,%fs:(%rcx)
3f: 48 rex.W
Code starting with the faulting instruction
===========================================
0: 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax
6: 73 01 jae 0x9
8: c3 retq
9: 48 8b 0d 07 6f 0c 00 mov 0xc6f07(%rip),%rcx # 0xc6f17
10: f7 d8 neg %eax
12: 64 89 01 mov %eax,%fs:(%rcx)
15: 48 rex.W
[ 168.213071][ T765] RSP: 002b:00007fff477e7e28 EFLAGS: 00000246 ORIG_RAX: 00000000000000be
[ 168.223301][ T765] RAX: ffffffffffffffda RBX: 00000000000000be RCX: 00007fc0e9b21f59
[ 168.228861][ T765] RDX: 00007fc0e7b75000 RSI: 00007fc0e8379000 RDI: 0000000000000047
[ 168.237714][ T765] RBP: 00000000000000be R08: 0000000000000001 R09: 0000000074000000
[ 168.244590][ T765] R10: 0000000000000118 R11: 0000000000000246 R12: 0000000000000002
[ 168.249970][ T765] R13: 00007fc0e84ae058 R14: 00007fc0e9a0a6c0 R15: 00007fc0e84ae000
[ 168.258232][ T765] </TASK>
[ 168.262635][ T765] ---[ end trace 7d9d01eb3000a5e3 ]---
[ 168.268992][ T765] object pointer: 0xfffffffffffffff2
[ 168.273757][ T765] ==================================================================
To reproduce:
# build kernel
cd linux
cp config-5.16.0-rc5-00011-g7db4f4924732 .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-9 CC=gcc-9 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
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 1
- 0
[cgroup] 27183b4e07: WARNING:at_mm/slab.c:#___cache_free
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: 27183b4e0735229f7ab300f000f78c9badf2a110 ("[PATCH 2/6] cgroup: Allocate cgroup_file_ctx for kernfs_open_file->priv")
url: https://github.com/0day-ci/linux/commits/Tejun-Heo/cgroup-Use-open-time-c...
base: https://git.kernel.org/cgit/linux/kernel/git/tj/cgroup.git for-next
patch link: https://lore.kernel.org/lkml/20211213191833.916632-3-tj@kernel.org
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G
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 <oliver.sang(a)intel.com>
[ 52.345653][ T1] WARNING: CPU: 0 PID: 1 at mm/slab.c:597 ___cache_free (mm/slab.c:597 mm/slab.c:3492)
[ 52.346695][ T1] Modules linked in:
[ 52.347196][ T1] CPU: 0 PID: 1 Comm: systemd Not tainted 5.16.0-rc1-00009-g27183b4e0735 #1
[ 52.348386][ T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 52.349576][ T1] RIP: 0010:___cache_free (mm/slab.c:597 mm/slab.c:3492)
[ 52.350274][ T1] Code: 50 ff 48 83 05 8b c8 4b 06 01 4c 39 7c d3 10 75 cd 48 83 05 84 c8 4b 06 01 48 83 05 8c c8 4b 06 01 90 48 83 05 8b c8 4b 06 01 <0f> 0b 48 83 05 89 c8 4b 06 01 48 83 05 89 c8 4b 06 01 90 48 83 05
All code
========
0: 50 push %rax
1: ff 48 83 decl -0x7d(%rax)
4: 05 8b c8 4b 06 add $0x64bc88b,%eax
9: 01 4c 39 7c add %ecx,0x7c(%rcx,%rdi,1)
d: d3 10 rcll %cl,(%rax)
f: 75 cd jne 0xffffffffffffffde
11: 48 83 05 84 c8 4b 06 addq $0x1,0x64bc884(%rip) # 0x64bc89d
18: 01
19: 48 83 05 8c c8 4b 06 addq $0x1,0x64bc88c(%rip) # 0x64bc8ad
20: 01
21: 90 nop
22: 48 83 05 8b c8 4b 06 addq $0x1,0x64bc88b(%rip) # 0x64bc8b5
29: 01
2a:* 0f 0b ud2 <-- trapping instruction
2c: 48 83 05 89 c8 4b 06 addq $0x1,0x64bc889(%rip) # 0x64bc8bd
33: 01
34: 48 83 05 89 c8 4b 06 addq $0x1,0x64bc889(%rip) # 0x64bc8c5
3b: 01
3c: 90 nop
3d: 48 rex.W
3e: 83 .byte 0x83
3f: 05 .byte 0x5
Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: 48 83 05 89 c8 4b 06 addq $0x1,0x64bc889(%rip) # 0x64bc893
9: 01
a: 48 83 05 89 c8 4b 06 addq $0x1,0x64bc889(%rip) # 0x64bc89b
11: 01
12: 90 nop
13: 48 rex.W
14: 83 .byte 0x83
15: 05 .byte 0x5
[ 52.352800][ T1] RSP: 0018:ffff888100363d40 EFLAGS: 00010002
[ 52.353567][ T1] RAX: 0000000000000004 RBX: ffff888100258000 RCX: 0000000000000000
[ 52.354553][ T1] RDX: 0000000000000003 RSI: ffff8881298a9f00 RDI: ffff8881000403c0
[ 52.355577][ T1] RBP: ffff888100363d98 R08: ffff88810004f3e8 R09: ffff888100958d20
[ 52.356627][ T1] R10: 0000000000000000 R11: ffffffff87bab640 R12: ffff8881000403c0
[ 52.357643][ T1] R13: ffff8881000403c0 R14: ffffffff812c055d R15: ffff8881298a9f00
[ 52.358670][ T1] FS: 0000000000000000(0000) GS:ffffffff854fa000(0063) knlGS:00000000f784b6c0
[ 52.359828][ T1] CS: 0010 DS: 002b ES: 002b CR0: 0000000080050033
[ 52.360680][ T1] CR2: 00000000f7ddce32 CR3: 0000000129f42000 CR4: 00000000000406b0
[ 52.361731][ T1] Call Trace:
[ 52.362185][ T1] <TASK>
[ 52.362580][ T1] ? debug_check_no_obj_freed (lib/debugobjects.c:1002 lib/debugobjects.c:1023)
[ 52.363317][ T1] ? cgroup_file_release (kernel/cgroup/cgroup.c:3843)
[ 52.363974][ T1] kfree (mm/slab.c:3453 mm/slab.c:3803)
[ 52.364459][ T1] cgroup_file_release (kernel/cgroup/cgroup.c:3843)
[ 52.365119][ T1] kernfs_release_file+0x40/0xc0
[ 52.365866][ T1] kernfs_fop_release (fs/kernfs/file.c:757)
[ 52.366506][ T1] __fput (fs/file_table.c:281)
[ 52.367019][ T1] ____fput (fs/file_table.c:313)
[ 52.367541][ T1] task_work_run (kernel/task_work.c:166 (discriminator 1))
[ 52.368166][ T1] exit_to_user_mode_prepare (include/linux/tracehook.h:189 kernel/entry/common.c:175 kernel/entry/common.c:207)
[ 52.368910][ T1] syscall_exit_to_user_mode (kernel/entry/common.c:301)
[ 52.369622][ T1] __do_fast_syscall_32 (arch/x86/entry/common.c:183)
[ 52.370272][ T1] do_fast_syscall_32 (arch/x86/entry/common.c:203)
[ 52.370886][ T1] do_SYSENTER_32 (arch/x86/entry/common.c:247)
[ 52.371481][ T1] entry_SYSENTER_compat_after_hwframe (arch/x86/entry/entry_64_compat.S:141)
[ 52.372337][ T1] RIP: 0023:0xf7fb7549
[ 52.372878][ T1] Code: 03 74 c0 01 10 05 03 74 b8 01 10 06 03 74 b4 01 10 07 03 74 b0 01 10 08 03 74 d8 01 00 00 00 00 00 51 52 55 89 e5 0f 34 cd 80 <5d> 5a 59 c3 90 90 90 90 8d b4 26 00 00 00 00 8d b4 26 00 00 00 00
All code
========
0: 03 74 c0 01 add 0x1(%rax,%rax,8),%esi
4: 10 05 03 74 b8 01 adc %al,0x1b87403(%rip) # 0x1b8740d
a: 10 06 adc %al,(%rsi)
c: 03 74 b4 01 add 0x1(%rsp,%rsi,4),%esi
10: 10 07 adc %al,(%rdi)
12: 03 74 b0 01 add 0x1(%rax,%rsi,4),%esi
16: 10 08 adc %cl,(%rax)
18: 03 74 d8 01 add 0x1(%rax,%rbx,8),%esi
1c: 00 00 add %al,(%rax)
1e: 00 00 add %al,(%rax)
20: 00 51 52 add %dl,0x52(%rcx)
23: 55 push %rbp
24: 89 e5 mov %esp,%ebp
26: 0f 34 sysenter
28: cd 80 int $0x80
2a:* 5d pop %rbp <-- trapping instruction
2b: 5a pop %rdx
2c: 59 pop %rcx
2d: c3 retq
2e: 90 nop
2f: 90 nop
30: 90 nop
31: 90 nop
32: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
39: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
Code starting with the faulting instruction
===========================================
0: 5d pop %rbp
1: 5a pop %rdx
2: 59 pop %rcx
3: c3 retq
4: 90 nop
5: 90 nop
6: 90 nop
7: 90 nop
8: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
f: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
[ 52.375395][ T1] RSP: 002b:00000000fff9a478 EFLAGS: 00000206 ORIG_RAX: 0000000000000006
[ 52.376465][ T1] RAX: 0000000000000000 RBX: 000000000000001c RCX: 0000000000000660
[ 52.377503][ T1] RDX: 00000000f7c48300 RSI: 00000000f7c48960 RDI: 0000000000000000
[ 52.378542][ T1] RBP: 00000000f7c4a000 R08: 0000000000000000 R09: 0000000000000000
[ 52.379652][ T1] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 52.380688][ T1] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[ 52.381710][ T1] </TASK>
[ 52.382097][ T1] irq event stamp: 47735052
[ 52.382649][ T1] hardirqs last enabled at (47735051): _raw_spin_unlock_irq (include/linux/spinlock_api_smp.h:159 kernel/locking/spinlock.c:202)
[ 52.383953][ T1] hardirqs last disabled at (47735052): kfree (mm/slab.c:3793 (discriminator 1))
[ 52.385104][ T1] softirqs last enabled at (47734810): cgroup_idr_replace (kernel/cgroup/cgroup.c:339)
[ 52.386365][ T1] softirqs last disabled at (47734808): cgroup_idr_replace (kernel/cgroup/cgroup.c:336)
[ 52.387667][ T1] ---[ end trace 08fad742e8d71fba ]---
Mounting RPC Pipe File System...
[ OK ] Reached target Swap.
[ OK ] Listening on udev Kernel Socket.
[ OK ] Listening on Journal Socket.
Starting Remount Root and Kernel File Systems...
Starting Journal Service...
Starting Load Kernel Modules...
Starting Create Static Device Nodes in /dev...
[ OK ] Started Forward Password Requests to Wall Directory Watch.
[ OK ] Reached target Encrypted Volumes.
[ OK ] Reached target Paths.
[ OK ] Listening on RPCbind Server Activation Socket.
[ OK ] Mounted RPC Pipe File System.
[ OK ] Started Remount Root and Kernel File Systems.
[ OK ] Started Load Kernel Modules.
[ OK ] Started Create Static Device Nodes in /dev.
To reproduce:
# build kernel
cd linux
cp config-5.16.0-rc1-00009-g27183b4e0735 .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-9 CC=gcc-9 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
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 2
- 1
[tracing] 85c62c8c37: unixbench.score 2.4% improvement
by kernel test robot
Greeting,
FYI, we noticed a 2.4% improvement of unixbench.score due to commit:
commit: 85c62c8c3749eec02ba81217bdcac26867dc262e ("tracing: Have existing event_command.parse() implementations use helpers")
https://git.kernel.org/cgit/linux/kernel/git/rostedt/linux-trace.git ftrace/core
in testcase: unixbench
on test machine: 128 threads 2 sockets Intel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz with 256G memory
with following parameters:
runtime: 300s
nr_task: 30%
test: pipe
cpufreq_governor: performance
ucode: 0xd000280
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
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
=========================================================================================
compiler/cpufreq_governor/kconfig/nr_task/rootfs/runtime/tbox_group/test/testcase/ucode:
gcc-9/performance/x86_64-rhel-8.3/30%/debian-10.4-x86_64-20200603.cgz/300s/lkp-icl-2sp2/pipe/unixbench/0xd000280
commit:
70b3c6b691 ("tracing: Add helper functions to simplify event_command.parse() callback handling")
85c62c8c37 ("tracing: Have existing event_command.parse() implementations use helpers")
70b3c6b69157039d 85c62c8c3749eec02ba81217bdc
---------------- ---------------------------
%stddev %change %stddev
\ | \
60620 +2.4% 62065 unixbench.score
2.947e+10 +2.3% 3.016e+10 unixbench.workload
36554 ± 7% -10.8% 32602 ± 4% softirqs.CPU123.SCHED
46257 ± 4% -10.3% 41506 ± 7% softirqs.CPU7.SCHED
32380 ± 12% +14.7% 37134 ± 6% softirqs.CPU81.SCHED
2.794e+10 +2.3% 2.858e+10 perf-stat.i.branch-instructions
13343338 -23.8% 10167419 ± 2% perf-stat.i.branch-misses
662823 -17.5% 546757 perf-stat.i.cache-misses
7192051 -20.0% 5751089 ± 2% perf-stat.i.cache-references
129484 +35.1% 174921 perf-stat.i.cycles-between-cache-misses
0.00 ± 2% -0.0 0.00 ± 2% perf-stat.i.dTLB-load-miss-rate%
665427 -46.7% 354693 perf-stat.i.dTLB-load-misses
4.435e+10 +2.3% 4.537e+10 perf-stat.i.dTLB-loads
2.665e+10 +2.3% 2.726e+10 perf-stat.i.dTLB-stores
1.438e+11 +2.3% 1.471e+11 perf-stat.i.instructions
1.58 +2.0% 1.62 perf-stat.i.ipc
59.02 -20.2% 47.12 ± 2% perf-stat.i.metric.K/sec
772.85 +2.3% 790.56 perf-stat.i.metric.M/sec
89.73 -2.2 87.53 perf-stat.i.node-load-miss-rate%
128386 -21.9% 100239 ± 2% perf-stat.i.node-load-misses
88458 ± 5% -34.6% 57889 ± 8% perf-stat.i.node-store-misses
0.05 -21.8% 0.04 ± 2% perf-stat.overall.MPKI
0.05 -0.0 0.04 ± 2% perf-stat.overall.branch-miss-rate%
0.54 -2.3% 0.53 perf-stat.overall.cpi
117918 +21.1% 142796 perf-stat.overall.cycles-between-cache-misses
0.00 -0.0 0.00 perf-stat.overall.dTLB-load-miss-rate%
1.84 +2.4% 1.89 perf-stat.overall.ipc
86.82 -3.5 83.34 perf-stat.overall.node-load-miss-rate%
48.41 ± 6% -9.0 39.39 ± 8% perf-stat.overall.node-store-miss-rate%
2.794e+10 +2.3% 2.857e+10 perf-stat.ps.branch-instructions
13329890 -23.8% 10154768 ± 2% perf-stat.ps.branch-misses
661626 -17.5% 545780 perf-stat.ps.cache-misses
7176900 -20.1% 5735850 ± 2% perf-stat.ps.cache-references
665319 -46.7% 354481 perf-stat.ps.dTLB-load-misses
4.435e+10 +2.3% 4.535e+10 perf-stat.ps.dTLB-loads
2.665e+10 +2.3% 2.725e+10 perf-stat.ps.dTLB-stores
1.438e+11 +2.3% 1.47e+11 perf-stat.ps.instructions
128207 -21.9% 100146 ± 2% perf-stat.ps.node-load-misses
88398 ± 5% -34.6% 57822 ± 8% perf-stat.ps.node-store-misses
5.652e+13 +2.3% 5.785e+13 perf-stat.total.instructions
3.19 -0.3 2.86 perf-profile.calltrace.cycles-pp.security_file_permission.vfs_read.ksys_read.do_syscall_64.entry_SYSCALL_64_after_hwframe
2.91 -0.3 2.62 perf-profile.calltrace.cycles-pp.security_file_permission.vfs_write.ksys_write.do_syscall_64.entry_SYSCALL_64_after_hwframe
6.37 -0.2 6.13 perf-profile.calltrace.cycles-pp.__entry_text_start.read
33.05 -0.2 32.82 perf-profile.calltrace.cycles-pp.vfs_write.ksys_write.do_syscall_64.entry_SYSCALL_64_after_hwframe.write
1.86 ± 2% -0.2 1.66 perf-profile.calltrace.cycles-pp.common_file_perm.security_file_permission.vfs_read.ksys_read.do_syscall_64
1.84 -0.2 1.66 perf-profile.calltrace.cycles-pp.common_file_perm.security_file_permission.vfs_write.ksys_write.do_syscall_64
1.63 -0.1 1.53 ± 2% perf-profile.calltrace.cycles-pp._raw_spin_lock_irq.pipe_write.new_sync_write.vfs_write.ksys_write
1.99 -0.1 1.91 perf-profile.calltrace.cycles-pp.main
0.85 ± 2% -0.1 0.77 ± 2% perf-profile.calltrace.cycles-pp.__wake_up_common.__wake_up_common_lock.pipe_write.new_sync_write.vfs_write
1.26 -0.0 1.22 ± 2% perf-profile.calltrace.cycles-pp.current_time.file_update_time.pipe_write.new_sync_write.vfs_write
1.12 +0.0 1.16 perf-profile.calltrace.cycles-pp.syscall_exit_to_user_mode.do_syscall_64.entry_SYSCALL_64_after_hwframe.read
1.73 +0.1 1.80 ± 2% perf-profile.calltrace.cycles-pp.__fget_light.__fdget_pos.ksys_write.do_syscall_64.entry_SYSCALL_64_after_hwframe
2.91 +0.1 2.98 perf-profile.calltrace.cycles-pp.mutex_lock.pipe_read.new_sync_read.vfs_read.ksys_read
4.16 +0.1 4.23 perf-profile.calltrace.cycles-pp.atime_needs_update.touch_atime.pipe_read.new_sync_read.vfs_read
2.02 +0.1 2.10 perf-profile.calltrace.cycles-pp.__fdget_pos.ksys_write.do_syscall_64.entry_SYSCALL_64_after_hwframe.write
4.89 +0.1 4.99 perf-profile.calltrace.cycles-pp.touch_atime.pipe_read.new_sync_read.vfs_read.ksys_read
2.42 +0.1 2.53 perf-profile.calltrace.cycles-pp._raw_spin_lock_irqsave.__wake_up_common_lock.pipe_write.new_sync_write.vfs_write
4.50 +0.1 4.63 perf-profile.calltrace.cycles-pp.__wake_up_common_lock.pipe_write.new_sync_write.vfs_write.ksys_write
37.34 +0.3 37.63 perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe.read
38.45 +0.3 38.76 perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe.read
24.57 +0.4 24.93 perf-profile.calltrace.cycles-pp.pipe_read.new_sync_read.vfs_read.ksys_read.do_syscall_64
26.85 +0.4 27.25 perf-profile.calltrace.cycles-pp.new_sync_read.vfs_read.ksys_read.do_syscall_64.entry_SYSCALL_64_after_hwframe
0.00 +0.5 0.52 perf-profile.calltrace.cycles-pp._raw_spin_unlock_irqrestore.__wake_up_common_lock.pipe_write.new_sync_write.vfs_write
6.40 -0.6 5.79 perf-profile.children.cycles-pp.security_file_permission
4.12 -0.4 3.76 perf-profile.children.cycles-pp.common_file_perm
50.62 -0.3 50.34 perf-profile.children.cycles-pp.write
33.42 -0.2 33.22 perf-profile.children.cycles-pp.vfs_write
7.06 -0.2 6.85 perf-profile.children.cycles-pp.__entry_text_start
0.90 ± 2% -0.1 0.81 perf-profile.children.cycles-pp.__wake_up_common
2.14 -0.1 2.06 perf-profile.children.cycles-pp.main
1.52 -0.1 1.46 perf-profile.children.cycles-pp.__cond_resched
1.09 -0.0 1.05 perf-profile.children.cycles-pp.entry_SYSCALL_64_safe_stack
0.13 ± 5% -0.0 0.11 perf-profile.children.cycles-pp.write@plt
1.20 +0.0 1.23 perf-profile.children.cycles-pp.exit_to_user_mode_prepare
0.56 +0.0 0.61 perf-profile.children.cycles-pp._raw_spin_unlock_irqrestore
2.67 +0.1 2.73 perf-profile.children.cycles-pp.mutex_unlock
2.70 +0.1 2.77 perf-profile.children.cycles-pp.syscall_exit_to_user_mode
4.58 +0.1 4.68 perf-profile.children.cycles-pp.atime_needs_update
5.11 +0.1 5.22 perf-profile.children.cycles-pp.touch_atime
2.54 +0.1 2.66 perf-profile.children.cycles-pp._raw_spin_lock_irqsave
6.30 +0.1 6.41 perf-profile.children.cycles-pp.mutex_lock
4.87 +0.1 5.00 perf-profile.children.cycles-pp.__wake_up_common_lock
25.30 +0.4 25.65 perf-profile.children.cycles-pp.pipe_read
27.07 +0.4 27.48 perf-profile.children.cycles-pp.new_sync_read
2.44 ± 2% -0.4 2.08 perf-profile.self.cycles-pp.common_file_perm
1.98 ± 2% -0.3 1.72 perf-profile.self.cycles-pp.security_file_permission
3.06 -0.1 2.95 perf-profile.self.cycles-pp.write
1.62 -0.1 1.53 ± 2% perf-profile.self.cycles-pp.__entry_text_start
3.89 -0.1 3.79 perf-profile.self.cycles-pp.pipe_write
1.99 -0.1 1.91 perf-profile.self.cycles-pp.main
1.72 -0.1 1.65 perf-profile.self.cycles-pp.copy_page_from_iter
2.22 -0.1 2.17 perf-profile.self.cycles-pp.copy_page_to_iter
0.78 ± 2% -0.0 0.73 perf-profile.self.cycles-pp.__wake_up_common
0.32 ± 3% -0.0 0.29 ± 4% perf-profile.self.cycles-pp.__might_fault
0.22 ± 3% +0.0 0.24 perf-profile.self.cycles-pp.make_kgid
1.56 +0.0 1.60 perf-profile.self.cycles-pp.new_sync_write
1.92 +0.0 1.97 perf-profile.self.cycles-pp.entry_SYSCALL_64_after_hwframe
1.54 +0.1 1.60 perf-profile.self.cycles-pp.new_sync_read
3.36 +0.1 3.46 perf-profile.self.cycles-pp.mutex_lock
2.46 +0.1 2.57 perf-profile.self.cycles-pp._raw_spin_lock_irqsave
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.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 1
- 0
[driver core] ef446f19e7: BUG:kernel_NULL_pointer_dereference,address
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: ef446f19e7249c44e8088d49a1042f5d37edc6d2 ("driver core: Add dma_cleanup callback in bus_type")
https://github.com/luxis1999/iommufd iommufd-v5.16-rc3
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+---------------------------------------------+------------+------------+
| | 54e936574b | ef446f19e7 |
+---------------------------------------------+------------+------------+
| boot_successes | 22 | 0 |
| boot_failures | 0 | 20 |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 20 |
| Oops:#[##] | 0 | 20 |
| EIP:device_release_driver_internal | 0 | 20 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 20 |
+---------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang(a)intel.com>
[ 118.619747][ T1] BUG: kernel NULL pointer dereference, address: 00000048
[ 118.620877][ T1] #PF: supervisor read access in kernel mode
[ 118.621799][ T1] #PF: error_code(0x0000) - not-present page
[ 118.622312][ T1] *pdpt = 0000000000000000 *pde = f000ff53f000ff53
[ 118.622312][ T1] Oops: 0000 [#1] PREEMPT SMP PTI
[ 118.622312][ T1] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.16.0-rc3-00003-gef446f19e724 #1
[ 118.622312][ T1] EIP: device_release_driver_internal (drivers/base/dd.c:1209 drivers/base/dd.c:1241)
[ 118.622312][ T1] Code: 80 ff ff 8b 57 3c 89 d8 e8 ff 7c ff ff 8b 43 34 85 c0 0f 84 c4 00 00 00 8b 50 28 85 d2 0f 84 b9 00 00 00 89 d8 ff d2 8b 43 34 <8b> 50 48 85 d2 74 04 89 d8 ff d2 89 d8 e8 50 ac ff ff 89 d8 e8 c9
All code
========
0: 80 ff ff cmp $0xff,%bh
3: 8b 57 3c mov 0x3c(%rdi),%edx
6: 89 d8 mov %ebx,%eax
8: e8 ff 7c ff ff callq 0xffffffffffff7d0c
d: 8b 43 34 mov 0x34(%rbx),%eax
10: 85 c0 test %eax,%eax
12: 0f 84 c4 00 00 00 je 0xdc
18: 8b 50 28 mov 0x28(%rax),%edx
1b: 85 d2 test %edx,%edx
1d: 0f 84 b9 00 00 00 je 0xdc
23: 89 d8 mov %ebx,%eax
25: ff d2 callq *%rdx
27: 8b 43 34 mov 0x34(%rbx),%eax
2a:* 8b 50 48 mov 0x48(%rax),%edx <-- trapping instruction
2d: 85 d2 test %edx,%edx
2f: 74 04 je 0x35
31: 89 d8 mov %ebx,%eax
33: ff d2 callq *%rdx
35: 89 d8 mov %ebx,%eax
37: e8 50 ac ff ff callq 0xffffffffffffac8c
3c: 89 d8 mov %ebx,%eax
3e: e8 .byte 0xe8
3f: c9 leaveq
Code starting with the faulting instruction
===========================================
0: 8b 50 48 mov 0x48(%rax),%edx
3: 85 d2 test %edx,%edx
5: 74 04 je 0xb
7: 89 d8 mov %ebx,%eax
9: ff d2 callq *%rdx
b: 89 d8 mov %ebx,%eax
d: e8 50 ac ff ff callq 0xffffffffffffac62
12: 89 d8 mov %ebx,%eax
14: e8 .byte 0xe8
15: c9 leaveq
[ 118.622312][ T1] EAX: 00000000 EBX: 84e0e000 ECX: 000002ce EDX: 00000000
[ 118.622312][ T1] ESI: 00000000 EDI: 9798a714 EBP: 81119e70 ESP: 81119e64
[ 118.622312][ T1] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010246
[ 118.622312][ T1] CR0: 80050033 CR2: 00000048 CR3: 17d06000 CR4: 000006b0
[ 118.622312][ T1] Call Trace:
[ 118.622312][ T1] device_release_driver (drivers/base/dd.c:1265)
[ 118.622312][ T1] mac80211_hwsim_new_radio (drivers/net/wireless/mac80211_hwsim.c:3533)
[ 118.622312][ T1] ? mac80211_hwsim_new_radio (include/linux/rcupdate.h:720 include/net/netns/generic.h:47 drivers/net/wireless/mac80211_hwsim.c:270 drivers/net/wireless/mac80211_hwsim.c:3452)
[ 118.622312][ T1] init_mac80211_hwsim (drivers/net/wireless/mac80211_hwsim.c:4706)
[ 118.622312][ T1] ? hwsim_init_net (drivers/net/wireless/mac80211_hwsim.c:4591)
[ 118.622312][ T1] do_one_initcall (init/main.c:1297)
[ 118.622312][ T1] ? rcu_read_lock_sched_held (include/linux/lockdep.h:283 kernel/rcu/update.c:125)
[ 118.622312][ T1] kernel_init_freeable (init/main.c:1369 init/main.c:1386 init/main.c:1405 init/main.c:1610)
[ 118.622312][ T1] ? rest_init (init/main.c:1491)
[ 118.622312][ T1] kernel_init (init/main.c:1501)
[ 118.622312][ T1] ? schedule_tail_wrapper (arch/x86/entry/entry_32.S:740)
[ 118.622312][ T1] ret_from_fork (arch/x86/entry/entry_32.S:775)
[ 118.622312][ T1] Modules linked in:
[ 118.622312][ T1] CR2: 0000000000000048
[ 118.622312][ T1] ---[ end trace ef61ac6e9c41aa4e ]---
[ 118.622312][ T1] EIP: device_release_driver_internal (drivers/base/dd.c:1209 drivers/base/dd.c:1241)
[ 118.622312][ T1] Code: 80 ff ff 8b 57 3c 89 d8 e8 ff 7c ff ff 8b 43 34 85 c0 0f 84 c4 00 00 00 8b 50 28 85 d2 0f 84 b9 00 00 00 89 d8 ff d2 8b 43 34 <8b> 50 48 85 d2 74 04 89 d8 ff d2 89 d8 e8 50 ac ff ff 89 d8 e8 c9
All code
========
0: 80 ff ff cmp $0xff,%bh
3: 8b 57 3c mov 0x3c(%rdi),%edx
6: 89 d8 mov %ebx,%eax
8: e8 ff 7c ff ff callq 0xffffffffffff7d0c
d: 8b 43 34 mov 0x34(%rbx),%eax
10: 85 c0 test %eax,%eax
12: 0f 84 c4 00 00 00 je 0xdc
18: 8b 50 28 mov 0x28(%rax),%edx
1b: 85 d2 test %edx,%edx
1d: 0f 84 b9 00 00 00 je 0xdc
23: 89 d8 mov %ebx,%eax
25: ff d2 callq *%rdx
27: 8b 43 34 mov 0x34(%rbx),%eax
2a:* 8b 50 48 mov 0x48(%rax),%edx <-- trapping instruction
2d: 85 d2 test %edx,%edx
2f: 74 04 je 0x35
31: 89 d8 mov %ebx,%eax
33: ff d2 callq *%rdx
35: 89 d8 mov %ebx,%eax
37: e8 50 ac ff ff callq 0xffffffffffffac8c
3c: 89 d8 mov %ebx,%eax
3e: e8 .byte 0xe8
3f: c9 leaveq
Code starting with the faulting instruction
===========================================
0: 8b 50 48 mov 0x48(%rax),%edx
3: 85 d2 test %edx,%edx
5: 74 04 je 0xb
7: 89 d8 mov %ebx,%eax
9: ff d2 callq *%rdx
b: 89 d8 mov %ebx,%eax
d: e8 50 ac ff ff callq 0xffffffffffffac62
12: 89 d8 mov %ebx,%eax
14: e8 .byte 0xe8
15: c9 leaveq
To reproduce:
# build kernel
cd linux
cp config-5.16.0-rc3-00003-gef446f19e724 .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 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
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 1
- 0
[NFS] 9bdd9a5105: WARNING:suspicious_RCU_usage
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: 9bdd9a51056372b70798f2aeb6a175189b3fa52d ("NFS: Add a "tls=" NFS mount option")
git://git.kernel.org/cgit/linux/kernel/git/cel/linux topic-rpc-with-tls-upcall
in testcase: kernel-selftests
version: kernel-selftests-x86_64-99d09ee9-1_20211206
with following parameters:
group: bpf
ucode: 0xde
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 1 sockets Intel(R) Core(TM) i7-7700 CPU @ 3.60GHz with 32G 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 <oliver.sang(a)intel.com>
[ 61.239639][ T1256] WARNING: suspicious RCU usage
[ 61.244471][ T1256] 5.16.0-rc4-00012-g9bdd9a510563 #1 Tainted: G I
[ 61.251946][ T1256] -----------------------------
[ 61.256784][ T1256] net/sunrpc/clnt.c:2834 suspicious rcu_dereference_check() usage!
[ 61.264504][ T1256]
[ 61.264504][ T1256] other info that might help us debug this:
[ 61.264504][ T1256]
[ 61.274580][ T1256]
[ 61.274580][ T1256] rcu_scheduler_active = 2, debug_locks = 1
[ 61.282474][ T1256] no locks held by mount.nfs/1256.
[ 61.287432][ T1256]
[ 61.287432][ T1256] stack backtrace:
[ 61.293178][ T1256] CPU: 3 PID: 1256 Comm: mount.nfs Tainted: G I 5.16.0-rc4-00012-g9bdd9a510563 #1
[ 61.303446][ T1256] Hardware name: Dell Inc. OptiPlex 7050/062KRH, BIOS 1.2.0 12/22/2016
[ 61.311483][ T1256] Call Trace:
[ 61.314603][ T1256] <TASK>
[ 61.317382][ T1256] dump_stack_lvl (lib/dump_stack.c:107)
[ 61.321715][ T1256] rpc_starttls_sync (net/sunrpc/clnt.c:2834 (discriminator 7))
[ 61.326482][ T1256] ? rpc_call_sync (net/sunrpc/clnt.c:2833)
[ 61.331087][ T1256] ? rpc_new_client (include/trace/events/sunrpc.h:166 net/sunrpc/clnt.c:440)
[ 61.335849][ T1256] rpc_create_xprt (net/sunrpc/clnt.c:497)
[ 61.340434][ T1256] rpc_create (net/sunrpc/clnt.c:632)
[ 61.344589][ T1256] ? rpc_create_xprt (net/sunrpc/clnt.c:553)
[ 61.349351][ T1256] ? rcu_read_lock_bh_held (kernel/rcu/update.c:120)
[ 61.354453][ T1256] ? lock_is_held_type (kernel/locking/lockdep.c:438 kernel/locking/lockdep.c:5681)
[ 61.359302][ T1256] nfs_create_rpc_client (fs/nfs/client.c:552)
[ 61.364401][ T1256] ? lock_is_held_type (kernel/locking/lockdep.c:438 kernel/locking/lockdep.c:5681)
[ 61.369244][ T1256] ? nfs_mark_client_ready (fs/nfs/client.c:508)
[ 61.374352][ T1256] ? lockdep_init_map_type (kernel/locking/lockdep.c:4810)
[ 61.379629][ T1256] nfs4_alloc_client (fs/nfs/nfs4client.c:240) nfsv4
[ 61.385128][ T1256] ? nfs40_shutdown_client (fs/nfs/nfs4client.c:199) nfsv4
[ 61.390948][ T1256] ? rcu_read_lock_sched_held (include/linux/lockdep.h:283 kernel/rcu/update.c:125)
[ 61.396394][ T1256] ? rcu_read_lock_bh_held (kernel/rcu/update.c:120)
[ 61.401490][ T1256] ? rcu_read_lock_bh_held (kernel/rcu/update.c:120)
[ 61.406587][ T1256] ? find_held_lock (kernel/locking/lockdep.c:5130)
[ 61.411185][ T1256] ? lock_release (kernel/locking/lockdep.c:438 kernel/locking/lockdep.c:5659)
[ 61.415685][ T1256] ? lock_downgrade (kernel/locking/lockdep.c:5645)
[ 61.420353][ T1256] ? lock_downgrade (kernel/locking/lockdep.c:5645)
[ 61.425026][ T1256] ? rcu_read_lock_sched_held (kernel/rcu/update.c:306)
[ 61.430560][ T1256] nfs_get_client (fs/nfs/client.c:442)
[ 61.435171][ T1256] nfs4_set_client (fs/nfs/nfs4client.c:932) nfsv4
[ 61.440478][ T1256] ? nfs4_match_client (fs/nfs/nfs4client.c:900) nfsv4
[ 61.446140][ T1256] ? queue_work_node (kernel/workqueue.c:1641)
[ 61.450906][ T1256] ? do_init_timer (kernel/time/timer.c:798)
[ 61.455409][ T1256] nfs4_create_server (fs/nfs/nfs4client.c:1163 fs/nfs/nfs4client.c:1201) nfsv4
[ 61.460981][ T1256] ? try_module_get (kernel/module.c:1401)
[ 61.466165][ T1256] ? get_nfs_version (fs/nfs/client.c:114 (discriminator 1))
[ 61.470748][ T1256] ? preempt_count_sub (kernel/sched/core.c:5450 kernel/sched/core.c:5447 kernel/sched/core.c:5469)
[ 61.475677][ T1256] ? nfs4_server_common_setup (fs/nfs/nfs4client.c:1186) nfsv4
[ 61.481927][ T1256] ? try_module_get (kernel/module.c:1401)
[ 61.487114][ T1256] ? get_nfs_version (fs/nfs/client.c:114 (discriminator 1))
[ 61.491697][ T1256] ? nfs_fs_context_validate (fs/nfs/fs_context.c:1434)
[ 61.497232][ T1256] nfs4_try_get_tree (fs/nfs/nfs4super.c:226 (discriminator 3)) nfsv4
[ 61.502625][ T1256] vfs_get_tree (fs/super.c:1501)
[ 61.506861][ T1256] ? ns_capable_common (kernel/capability.c:375)
[ 61.511703][ T1256] path_mount (fs/namespace.c:2988 fs/namespace.c:3318)
[ 61.515942][ T1256] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4356)
[ 61.520959][ T1256] ? finish_automount (fs/namespace.c:3245)
[ 61.525802][ T1256] ? kmem_cache_free (mm/slub.c:1749 mm/slub.c:3513 mm/slub.c:3530)
[ 61.530563][ T1256] do_mount (fs/namespace.c:3331)
[ 61.534458][ T1256] ? path_mount (fs/namespace.c:3324)
[ 61.538957][ T1256] ? copy_mount_options (fs/namespace.c:3200)
[ 61.543892][ T1256] __x64_sys_mount (fs/namespace.c:3541 fs/namespace.c:3516 fs/namespace.c:3516)
[ 61.548484][ T1256] do_syscall_64 (arch/x86/entry/common.c:50 arch/x86/entry/common.c:80)
[ 61.552728][ T1256] ? do_syscall_64 (arch/x86/entry/common.c:87)
[ 61.557157][ T1256] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4356)
[ 61.562178][ T1256] ? do_syscall_64 (arch/x86/entry/common.c:87)
[ 61.566599][ T1256] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4356)
[ 61.571616][ T1256] ? do_syscall_64 (arch/x86/entry/common.c:87)
[ 61.576026][ T1256] ? do_syscall_64 (arch/x86/entry/common.c:87)
[ 61.580438][ T1256] ? asm_exc_page_fault (arch/x86/include/asm/idtentry.h:568)
[ 61.585279][ T1256] ? asm_exc_page_fault (arch/x86/include/asm/idtentry.h:568)
[ 61.590032][ T1256] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4356)
[ 61.595046][ T1256] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:113)
[ 61.600749][ T1256] RIP: 0033:0x7f0d407d8fea
[ 61.604986][ T1256] Code: 48 8b 0d a9 0e 0c 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 76 0e 0c 00 f7 d8 64 89 01 48
All code
========
0: 48 8b 0d a9 0e 0c 00 mov 0xc0ea9(%rip),%rcx # 0xc0eb0
7: f7 d8 neg %eax
9: 64 89 01 mov %eax,%fs:(%rcx)
c: 48 83 c8 ff or $0xffffffffffffffff,%rax
10: c3 retq
11: 66 2e 0f 1f 84 00 00 nopw %cs:0x0(%rax,%rax,1)
18: 00 00 00
1b: 0f 1f 44 00 00 nopl 0x0(%rax,%rax,1)
20: 49 89 ca mov %rcx,%r10
23: b8 a5 00 00 00 mov $0xa5,%eax
28: 0f 05 syscall
2a:* 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax <-- trapping instruction
30: 73 01 jae 0x33
32: c3 retq
33: 48 8b 0d 76 0e 0c 00 mov 0xc0e76(%rip),%rcx # 0xc0eb0
3a: f7 d8 neg %eax
3c: 64 89 01 mov %eax,%fs:(%rcx)
3f: 48 rex.W
Code starting with the faulting instruction
===========================================
0: 48 3d 01 f0 ff ff cmp $0xfffffffffffff001,%rax
6: 73 01 jae 0x9
8: c3 retq
9: 48 8b 0d 76 0e 0c 00 mov 0xc0e76(%rip),%rcx # 0xc0e86
10: f7 d8 neg %eax
12: 64 89 01 mov %eax,%fs:(%rcx)
15: 48 rex.W
[ 61.624290][ T1256] RSP: 002b:00007ffcf4516058 EFLAGS: 00000202 ORIG_RAX: 00000000000000a5
[ 61.632493][ T1256] RAX: ffffffffffffffda RBX: 00007ffcf45161b0 RCX: 00007f0d407d8fea
[ 61.640261][ T1256] RDX: 000055acebf33b50 RSI: 000055acebf33b70 RDI: 000055acebf35880
[ 61.648025][ T1256] RBP: 0000000000000000 R08: 000055acebf36370 R09: 000055acebf36960
[ 61.655792][ T1256] R10: 0000000000000000 R11: 0000000000000202 R12: 00007ffcf45161b0
[ 61.663558][ T1256] R13: 000055acebf36160 R14: 0000000000000010 R15: 00007ffcf45160c0
[ 61.671341][ T1256] </TASK>
[ 62.241100][ T443] result_service: raw_upload, RESULT_MNT: /internal-lkp-server/result, RESULT_ROOT: /internal-lkp-server/result/kernel-selftests/bpf-ucode=0xde/lkp-kbl-d01/debian-10.4-x86_64-20200603.cgz/x86_64-rhel-8.3-kselftests/gcc-9/9bdd9a51056372b70798f2aeb6a175189b3fa52d/3, TMP_RESULT_ROOT: /tmp/lkp/result
[ 62.241115][ T443]
[ 62.274426][ T443] run-job /lkp/jobs/scheduled/lkp-kbl-d01/kernel-selftests-bpf-ucode=0xde-debian-10.4-x86_64-20200603.cgz-9bdd9a51056372b70798f2aeb6a175189b3fa52d-20211211-57446-1srdis8-2.yaml
[ 62.274438][ T443]
[ 63.133122][ T443] /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 http://internal-lkp-server:80/~lkp/cgi-bin/lkp-jobfile-append-var?job_fil... -O /dev/null
[ 63.133150][ T443]
[ 63.167140][ T443] target ucode: 0xde
[ 63.167150][ T443]
[ 63.173817][ T443] current_version: de, target_version: de
[ 63.173826][ T443]
[ 63.184138][ T443] KERNEL SELFTESTS: linux_headers_dir is /usr/src/linux-headers-x86_64-rhel-8.3-kselftests-9bdd9a51056372b70798f2aeb6a175189b3fa52d
[ 63.184148][ T443]
[ 120.130968][ T443] IPMI BMC is not supported on this machine, skip bmc-watchdog setup!
[ 120.130988][ T443]
[ 122.174262][ T443] 2021-12-11 17:08:58 mount --bind /lib/modules/5.16.0-rc4-00012-g9bdd9a510563/kernel/lib /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-9bdd9a51056372b70798f2aeb6a175189b3fa52d/lib
[ 122.174283][ T443]
[ 122.209328][ T443] 2021-12-11 17:08:58 sed -i s/default_timeout=45/default_timeout=300/ kselftest/runner.sh
[ 122.209341][ T443]
[ 122.673245][ T443] 2021-12-11 17:08:58 make -C ../../../tools/bpf/bpftool
[ 122.673266][ T443]
[ 122.685043][ T443] make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-9bdd9a51056372b70798f2aeb6a175189b3fa52d/tools/bpf/bpftool'
[ 122.685055][ T443]
[ 122.761184][ T446] 7953412 blocks
[ 122.761198][ T446]
[ 124.007890][ T443]
[ 124.007902][ T443]
[ 124.012921][ T443] Auto-detecting system features:
[ 124.012930][ T443]
[ 124.020950][ T443]
[ 124.030616][ T443]
[ 124.040667][ T443]
[ 124.051349][ T443]
[ 124.062929][ T443]
[ 124.071672][ T443]
[ 124.071681][ T443]
[ 124.077027][ T443]
[ 124.085762][ T443]
[ 124.085770][ T443]
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 1
- 0
[loop] e3f9387aea: stress-ng.loop.ops_per_sec 78.9% improvement
by kernel test robot
Greeting,
FYI, we noticed a 78.9% improvement of stress-ng.loop.ops_per_sec due to commit:
commit: e3f9387aea67742b9d1f4de8e5bb2fd08a8a4584 ("loop: Use pr_warn_once() for loop_control_remove() warning")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: stress-ng
on test machine: 96 threads 2 sockets Ice Lake with 256G memory
with following parameters:
nr_threads: 100%
disk: 1HDD
testtime: 60s
class: device
test: loop
cpufreq_governor: performance
ucode: 0xb000280
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
=========================================================================================
class/compiler/cpufreq_governor/disk/kconfig/nr_threads/rootfs/tbox_group/test/testcase/testtime/ucode:
device/gcc-9/performance/1HDD/x86_64-rhel-8.3/100%/debian-10.4-x86_64-20200603.cgz/lkp-icl-2sp1/loop/stress-ng/60s/0xb000280
commit:
d422f40163 ("zram: only make zram_wb_devops for CONFIG_ZRAM_WRITEBACK")
e3f9387aea ("loop: Use pr_warn_once() for loop_control_remove() warning")
d422f40163087408 e3f9387aea67742b9d1f4de8e5b
---------------- ---------------------------
%stddev %change %stddev
\ | \
3361 +79.7% 6041 ± 2% stress-ng.loop.ops
55.12 +78.9% 98.63 stress-ng.loop.ops_per_sec
4244 +61.3% 6847 ± 2% stress-ng.time.involuntary_context_switches
140.71 ± 2% +25.1% 176.00 ± 11% stress-ng.time.percent_of_cpu_this_job_got
90.04 ± 2% +24.7% 112.27 ± 12% stress-ng.time.system_time
152534 ± 8% +38.8% 211722 ± 13% stress-ng.time.voluntary_context_switches
8000 ± 4% +20.0% 9598 ± 13% meminfo.Active
7396 ± 3% +20.8% 8933 ± 14% meminfo.Active(anon)
1.78 ± 4% +0.5 2.30 ± 9% mpstat.cpu.all.sys%
0.36 ± 2% +0.1 0.50 ± 6% mpstat.cpu.all.usr%
61315 ± 2% +29.6% 79471 ± 4% turbostat.C1
0.05 +0.0 0.08 ± 11% turbostat.C1%
3804 ± 3% +56.8% 5965 ± 6% vmstat.io.bi
17445 ± 4% +40.1% 24441 ± 6% vmstat.system.cs
30900 ± 2% +56.3% 48285 ± 6% softirqs.BLOCK
10068 ± 8% -14.0% 8663 ± 11% softirqs.CPU15.SCHED
9690 ± 4% -10.3% 8692 ± 8% softirqs.CPU32.SCHED
9637 ± 7% -14.8% 8207 ± 11% softirqs.CPU52.SCHED
9340 ± 10% -14.3% 8007 ± 6% softirqs.CPU72.SCHED
9936 ± 8% -14.4% 8506 ± 11% softirqs.CPU82.SCHED
9724 ± 9% -12.5% 8510 ± 10% softirqs.CPU93.SCHED
207351 ± 9% +24.3% 257838 ± 8% softirqs.RCU
1844 ± 3% +21.1% 2233 ± 14% proc-vmstat.nr_active_anon
5929 ± 4% +9.3% 6479 ± 3% proc-vmstat.nr_page_table_pages
1844 ± 3% +21.1% 2233 ± 14% proc-vmstat.nr_zone_active_anon
645257 +14.3% 737465 ± 3% proc-vmstat.numa_hit
554490 +16.5% 645922 ± 3% proc-vmstat.numa_local
27004 +56.1% 42164 ± 4% proc-vmstat.pgactivate
682350 +17.4% 800875 ± 3% proc-vmstat.pgalloc_normal
579709 +20.2% 696873 ± 3% proc-vmstat.pgfree
261468 ± 3% +54.9% 404974 ± 7% proc-vmstat.pgpgin
30452 ± 4% +48.5% 45231 ± 11% proc-vmstat.unevictable_pgs_culled
1.351e+09 ± 8% +22.3% 1.651e+09 ± 4% perf-stat.i.branch-instructions
21750 ± 8% +30.1% 28299 ± 8% perf-stat.i.context-switches
903.42 ± 10% +37.4% 1241 ± 9% perf-stat.i.cpu-migrations
1.463e+09 ± 8% +22.8% 1.796e+09 ± 4% perf-stat.i.dTLB-loads
6.545e+08 ± 7% +22.0% 7.983e+08 ± 4% perf-stat.i.dTLB-stores
6.28e+09 ± 8% +20.9% 7.595e+09 ± 4% perf-stat.i.instructions
0.38 ± 6% +14.1% 0.43 ± 8% perf-stat.i.ipc
24.95 ± 7% -15.6% 21.06 ± 9% perf-stat.i.major-faults
32.26 ± 7% +29.9% 41.91 ± 3% perf-stat.i.metric.M/sec
986939 ± 7% +33.0% 1312402 ± 6% perf-stat.i.node-load-misses
320022 ± 7% +34.4% 430212 ± 4% perf-stat.i.node-loads
1097382 ± 7% +39.2% 1527172 ± 11% perf-stat.i.node-store-misses
1.068e+09 ± 2% +31.8% 1.408e+09 ± 4% perf-stat.ps.branch-instructions
6396422 ± 8% +29.6% 8290131 ± 5% perf-stat.ps.cache-misses
17520 ± 4% +41.0% 24709 ± 7% perf-stat.ps.context-switches
1.412e+10 ± 7% +13.9% 1.609e+10 ± 6% perf-stat.ps.cpu-cycles
732.74 ± 4% +48.3% 1086 ± 7% perf-stat.ps.cpu-migrations
1.162e+09 ± 2% +32.4% 1.539e+09 ± 3% perf-stat.ps.dTLB-loads
5.203e+08 +31.1% 6.821e+08 ± 3% perf-stat.ps.dTLB-stores
4.946e+09 ± 2% +30.6% 6.458e+09 ± 3% perf-stat.ps.instructions
838233 ± 7% +40.1% 1174167 ± 5% perf-stat.ps.node-load-misses
258560 ± 2% +44.7% 374131 perf-stat.ps.node-loads
874444 ± 9% +49.8% 1310136 ± 7% perf-stat.ps.node-store-misses
987545 ± 9% +25.4% 1238042 ± 8% perf-stat.ps.node-stores
3.284e+11 +29.0% 4.238e+11 ± 4% perf-stat.total.instructions
36.05 ± 11% -9.1 26.95 ± 18% perf-profile.calltrace.cycles-pp.secondary_startup_64_no_verify
35.61 ± 10% -8.9 26.66 ± 18% perf-profile.calltrace.cycles-pp.cpu_startup_entry.start_secondary.secondary_startup_64_no_verify
35.61 ± 10% -8.9 26.66 ± 18% perf-profile.calltrace.cycles-pp.start_secondary.secondary_startup_64_no_verify
35.55 ± 10% -8.9 26.62 ± 18% perf-profile.calltrace.cycles-pp.do_idle.cpu_startup_entry.start_secondary.secondary_startup_64_no_verify
31.96 ± 10% -8.4 23.53 ± 18% perf-profile.calltrace.cycles-pp.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry.start_secondary
32.49 ± 9% -8.3 24.19 ± 18% perf-profile.calltrace.cycles-pp.cpuidle_enter.do_idle.cpu_startup_entry.start_secondary.secondary_startup_64_no_verify
8.21 ± 77% -8.2 0.00 perf-profile.calltrace.cycles-pp._printk.loop_control_ioctl.cold.__x64_sys_ioctl.do_syscall_64.entry_SYSCALL_64_after_hwframe
8.21 ± 77% -8.2 0.00 perf-profile.calltrace.cycles-pp.vprintk_emit._printk.loop_control_ioctl.cold.__x64_sys_ioctl.do_syscall_64
8.21 ± 77% -8.2 0.00 perf-profile.calltrace.cycles-pp.loop_control_ioctl.cold.__x64_sys_ioctl.do_syscall_64.entry_SYSCALL_64_after_hwframe.ioctl
7.66 ± 81% -7.7 0.00 perf-profile.calltrace.cycles-pp.console_unlock.vprintk_emit._printk.loop_control_ioctl.cold.__x64_sys_ioctl
7.28 ± 81% -7.3 0.00 perf-profile.calltrace.cycles-pp.serial8250_console_write.console_unlock.vprintk_emit._printk.loop_control_ioctl.cold
19.03 ± 6% -4.7 14.35 ± 17% perf-profile.calltrace.cycles-pp.intel_idle.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry
0.71 ± 8% -0.4 0.32 ± 86% perf-profile.calltrace.cycles-pp.rebalance_domains.__softirqentry_text_start.irq_exit_rcu.sysvec_apic_timer_interrupt.asm_sysvec_apic_timer_interrupt
1.12 ± 22% -0.4 0.76 ± 25% perf-profile.calltrace.cycles-pp.scheduler_tick.update_process_times.tick_sched_handle.tick_sched_timer.__hrtimer_run_queues
1.23 ± 17% +3.2 4.45 ±107% perf-profile.calltrace.cycles-pp.kernfs_remove.__kobject_del.kobject_del.blk_mq_unregister_hctx.blk_mq_unregister_dev
1.31 ± 17% +3.2 4.54 ±105% perf-profile.calltrace.cycles-pp.__kobject_del.kobject_del.blk_mq_unregister_hctx.blk_mq_unregister_dev.blk_unregister_queue
1.32 ± 17% +3.2 4.55 ±104% perf-profile.calltrace.cycles-pp.kobject_del.blk_mq_unregister_hctx.blk_mq_unregister_dev.blk_unregister_queue.del_gendisk
36.05 ± 11% -9.1 26.95 ± 18% perf-profile.children.cycles-pp.secondary_startup_64_no_verify
36.05 ± 11% -9.1 26.95 ± 18% perf-profile.children.cycles-pp.cpu_startup_entry
36.04 ± 11% -9.1 26.95 ± 18% perf-profile.children.cycles-pp.do_idle
35.61 ± 10% -8.9 26.66 ± 18% perf-profile.children.cycles-pp.start_secondary
32.91 ± 10% -8.4 24.47 ± 18% perf-profile.children.cycles-pp.cpuidle_enter
32.87 ± 10% -8.4 24.44 ± 18% perf-profile.children.cycles-pp.cpuidle_enter_state
8.21 ± 77% -8.2 0.00 perf-profile.children.cycles-pp.loop_control_ioctl.cold
19.26 ± 6% -4.7 14.52 ± 17% perf-profile.children.cycles-pp.intel_idle
1.18 ± 22% -0.4 0.82 ± 23% perf-profile.children.cycles-pp.scheduler_tick
0.73 ± 8% -0.2 0.50 ± 20% perf-profile.children.cycles-pp.rebalance_domains
0.60 ± 12% -0.2 0.44 ± 15% perf-profile.children.cycles-pp.native_irq_return_iret
0.43 ± 8% -0.1 0.31 ± 15% perf-profile.children.cycles-pp.lapic_next_deadline
0.39 ± 7% -0.1 0.29 ± 21% perf-profile.children.cycles-pp.read_tsc
0.26 ± 11% -0.1 0.18 ± 22% perf-profile.children.cycles-pp.arch_scale_freq_tick
0.29 ± 7% -0.1 0.22 ± 17% perf-profile.children.cycles-pp.native_apic_msr_eoi_write
0.10 ± 11% -0.0 0.06 ± 44% perf-profile.children.cycles-pp.call_cpuidle
0.09 ± 11% -0.0 0.06 ± 43% perf-profile.children.cycles-pp.schedule_timeout
0.22 ± 24% +0.4 0.64 ± 84% perf-profile.children.cycles-pp.device_add
0.67 ± 22% +0.7 1.38 ± 60% perf-profile.children.cycles-pp.kernfs_add_one
1.81 ± 17% +1.0 2.81 ± 27% perf-profile.children.cycles-pp.device_add_disk
1.32 ± 17% +3.2 4.55 ±104% perf-profile.children.cycles-pp.blk_mq_unregister_hctx
1.38 ± 16% +3.2 4.62 ±102% perf-profile.children.cycles-pp.blk_mq_unregister_dev
1.50 ± 18% +3.3 4.81 ±100% perf-profile.children.cycles-pp.kernfs_remove
1.57 ± 17% +3.3 4.90 ± 98% perf-profile.children.cycles-pp.blk_unregister_queue
1.61 ± 17% +3.4 5.05 ± 98% perf-profile.children.cycles-pp.kobject_del
2.38 ± 20% +6.7 9.05 ±115% perf-profile.children.cycles-pp.rwsem_down_write_slowpath
2.38 ± 17% +7.1 9.50 ±129% perf-profile.children.cycles-pp.del_gendisk
19.24 ± 6% -4.7 14.51 ± 17% perf-profile.self.cycles-pp.intel_idle
1.69 ± 9% -0.5 1.22 ± 17% perf-profile.self.cycles-pp.cpuidle_enter_state
0.60 ± 12% -0.2 0.44 ± 15% perf-profile.self.cycles-pp.native_irq_return_iret
0.43 ± 8% -0.1 0.31 ± 15% perf-profile.self.cycles-pp.lapic_next_deadline
0.38 ± 7% -0.1 0.28 ± 21% perf-profile.self.cycles-pp.read_tsc
0.26 ± 12% -0.1 0.17 ± 21% perf-profile.self.cycles-pp.arch_scale_freq_tick
0.29 ± 6% -0.1 0.22 ± 19% perf-profile.self.cycles-pp.native_apic_msr_eoi_write
0.09 ± 9% -0.0 0.06 ± 44% perf-profile.self.cycles-pp.call_cpuidle
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.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 2
- 1
[KVM] feb627e8d6: kernel-selftests.kvm.vmx_pmu_msrs_test.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: feb627e8d6f69c9a319fe279710959efb3eba873 ("KVM: x86: Forbid KVM_SET_CPUID{,2} after KVM_RUN")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: kernel-selftests
version: kernel-selftests-x86_64-99d09ee9-1_20211206
with following parameters:
group: kvm
ucode: 0xe2
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: 4 threads Intel(R) Xeon(R) CPU E3-1225 v5 @ 3.30GHz 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 <oliver.sang(a)intel.com>
# selftests: kvm: vmx_pmu_msrs_test
# ==== Test Assertion Failure ====
# lib/x86_64/processor.c:874: rc == 0
# pid=10415 tid=10415 errno=22 - Invalid argument
# 1 0x000000000040b24f: vcpu_set_cpuid at processor.c:873
# 2 0x000000000040260a: main at vmx_pmu_msrs_test.c:115
# 3 0x00007f07e1aec09a: ?? ??:0
# 4 0x0000000000402759: _start at ??:?
# KVM_SET_CPUID2 failed, rc: -1 errno: 22
not ok 33 selftests: kvm: vmx_pmu_msrs_test # exit=254
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 2
- 1
[selftests/sgx] f0ff2447b8: kernel-selftests.sgx.make_fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: f0ff2447b8613b883f41ae845b6cc7540d6e5f71 ("selftests/sgx: Add a new kselftest: Unclobbered_vdso_oversubscribed")
https://git.kernel.org/cgit/linux/kernel/git/tip/tip.git x86/sgx
in testcase: kernel-selftests
version: kernel-selftests-x86_64-99d09ee9-1_20211206
with following parameters:
group: sgx
ucode: 0xde
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: 16 threads 1 sockets Intel(R) Xeon(R) E-2278G CPU @ 3.40GHz with 32G 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 <oliver.sang(a)intel.com>
KERNEL SELFTESTS: linux_headers_dir is /usr/src/linux-headers-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71
2021-12-11 16:33:38 ln -sf /usr/bin/clang
2021-12-11 16:33:38 ln -sf /usr/bin/llc
2021-12-11 16:33:39 sed -i s/default_timeout=45/default_timeout=300/ kselftest/runner.sh
2021-12-11 16:33:39 make -C sgx
make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx'
gcc -Wall -Werror -g -I../../../../tools/include -fPIC -z noexecstack -c main.c -o /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx/main.o
main.c: In function ‘get_total_epc_mem’:
main.c:275:3: error: implicit declaration of function ‘__cpuid’ [-Werror=implicit-function-declaration]
__cpuid(&eax, &ebx, &ecx, &edx);
^~~~~~~
cc1: all warnings being treated as errors
make: *** [Makefile:33: /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx/main.o] Error 1
make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx'
2021-12-11 16:33:39 make run_tests -C sgx
make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx'
gcc -Wall -Werror -g -I../../../../tools/include -fPIC -z noexecstack -c main.c -o /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx/main.o
main.c: In function ‘get_total_epc_mem’:
main.c:275:3: error: implicit declaration of function ‘__cpuid’ [-Werror=implicit-function-declaration]
__cpuid(&eax, &ebx, &ecx, &edx);
^~~~~~~
cc1: all warnings being treated as errors
make: *** [Makefile:33: /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx/main.o] Error 1
make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-f0ff2447b8613b883f41ae845b6cc7540d6e5f71/tools/testing/selftests/sgx'
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 2
- 1
[cgroup] 26b1b4f9c8: WARNING:at_lib/refcount.c:#refcount_warn_saturate
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: 26b1b4f9c86e294d1e9b07478d725412601e804d ("cgroup: Use open-time cgroup namespace for process migration perm checks")
https://git.kernel.org/cgit/linux/kernel/git/tj/cgroup.git review-migration-perms
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G
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 <oliver.sang(a)intel.com>
[ 7.207892][ T1] WARNING: CPU: 0 PID: 1 at lib/refcount.c:28 refcount_warn_saturate (lib/refcount.c:28 (discriminator 3))
[ 7.208794][ T1] Modules linked in: ip_tables
[ 7.209281][ T1] CPU: 0 PID: 1 Comm: systemd Not tainted 5.16.0-rc4-00166-g26b1b4f9c86e #1
[ 7.210135][ T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 7.211044][ T1] RIP: 0010:refcount_warn_saturate (lib/refcount.c:28 (discriminator 3))
[ 7.211638][ T1] Code: 05 4d 42 77 01 01 e8 4a 5e 65 00 0f 0b c3 80 3d 3b 42 77 01 00 75 95 48 c7 c7 a0 6f ba 8f c6 05 2b 42 77 01 01 e8 2b 5e 65 00 <0f> 0b c3 80 3d 1a 42 77 01 00 0f 85 72 ff ff ff 48 c7 c7 f8 6f ba
All code
========
0: 05 4d 42 77 01 add $0x177424d,%eax
5: 01 e8 add %ebp,%eax
7: 4a 5e rex.WX pop %rsi
9: 65 00 0f add %cl,%gs:(%rdi)
c: 0b c3 or %ebx,%eax
e: 80 3d 3b 42 77 01 00 cmpb $0x0,0x177423b(%rip) # 0x1774250
15: 75 95 jne 0xffffffffffffffac
17: 48 c7 c7 a0 6f ba 8f mov $0xffffffff8fba6fa0,%rdi
1e: c6 05 2b 42 77 01 01 movb $0x1,0x177422b(%rip) # 0x1774250
25: e8 2b 5e 65 00 callq 0x655e55
2a:* 0f 0b ud2 <-- trapping instruction
2c: c3 retq
2d: 80 3d 1a 42 77 01 00 cmpb $0x0,0x177421a(%rip) # 0x177424e
34: 0f 85 72 ff ff ff jne 0xffffffffffffffac
3a: 48 rex.W
3b: c7 .byte 0xc7
3c: c7 .byte 0xc7
3d: f8 clc
3e: 6f outsl %ds:(%rsi),(%dx)
3f: ba .byte 0xba
Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: c3 retq
3: 80 3d 1a 42 77 01 00 cmpb $0x0,0x177421a(%rip) # 0x1774224
a: 0f 85 72 ff ff ff jne 0xffffffffffffff82
10: 48 rex.W
11: c7 .byte 0xc7
12: c7 .byte 0xc7
13: f8 clc
14: 6f outsl %ds:(%rsi),(%dx)
15: ba .byte 0xba
[ 7.213432][ T1] RSP: 0018:ffffb7be40013e48 EFLAGS: 00010286
[ 7.214142][ T1] RAX: 0000000000000000 RBX: ffff9677729f9200 RCX: c0000000ffff7fff
[ 7.214995][ T1] RDX: ffffb7be40013c70 RSI: 00000000ffff7fff RDI: 0000000000000000
[ 7.215825][ T1] RBP: ffff9678fafafa80 R08: 0000000000000000 R09: ffffb7be40013c68
[ 7.216687][ T1] R10: 0000000000000001 R11: 0000000000000001 R12: ffff96777297c500
[ 7.217499][ T1] R13: ffff9678fafaf540 R14: ffff96776f912600 R15: ffff967740290000
[ 7.218309][ T1] FS: 0000000000000000(0000) GS:ffff967a6fc00000(0063) knlGS:00000000f77736c0
[ 7.219217][ T1] CS: 0010 DS: 002b ES: 002b CR0: 0000000080050033
[ 7.219876][ T1] CR2: 0000000057b5f724 CR3: 0000000100066000 CR4: 00000000000406f0
[ 7.220694][ T1] Call Trace:
[ 7.221066][ T1] <TASK>
[ 7.221400][ T1] cgroup_file_release (include/linux/refcount.h:283 include/linux/refcount.h:315 include/linux/refcount.h:333 include/linux/cgroup.h:889 include/linux/cgroup.h:887 kernel/cgroup/cgroup.c:3848)
[ 7.221926][ T1] kernfs_fop_release (fs/kernfs/file.c:745 fs/kernfs/file.c:726 fs/kernfs/file.c:756)
[ 7.222474][ T1] __fput (fs/file_table.c:281)
[ 7.222899][ T1] task_work_run (kernel/task_work.c:166 (discriminator 1))
[ 7.223358][ T1] exit_to_user_mode_prepare (include/linux/tracehook.h:189 kernel/entry/common.c:175 kernel/entry/common.c:207)
[ 7.223964][ T1] syscall_exit_to_user_mode (arch/x86/include/asm/jump_label.h:27 include/linux/context_tracking_state.h:31 include/linux/context_tracking.h:40 kernel/entry/common.c:130 kernel/entry/common.c:302)
[ 7.224555][ T1] __do_fast_syscall_32 (arch/x86/entry/common.c:183)
[ 7.225089][ T1] do_fast_syscall_32 (arch/x86/entry/common.c:203)
[ 7.225601][ T1] entry_SYSENTER_compat_after_hwframe (arch/x86/entry/entry_64_compat.S:141)
[ 7.226222][ T1] RIP: 0023:0xf7edf549
[ 7.226687][ T1] Code: 03 74 c0 01 10 05 03 74 b8 01 10 06 03 74 b4 01 10 07 03 74 b0 01 10 08 03 74 d8 01 00 00 00 00 00 51 52 55 89 e5 0f 34 cd 80 <5d> 5a 59 c3 90 90 90 90 8d b4 26 00 00 00 00 8d b4 26 00 00 00 00
All code
========
0: 03 74 c0 01 add 0x1(%rax,%rax,8),%esi
4: 10 05 03 74 b8 01 adc %al,0x1b87403(%rip) # 0x1b8740d
a: 10 06 adc %al,(%rsi)
c: 03 74 b4 01 add 0x1(%rsp,%rsi,4),%esi
10: 10 07 adc %al,(%rdi)
12: 03 74 b0 01 add 0x1(%rax,%rsi,4),%esi
16: 10 08 adc %cl,(%rax)
18: 03 74 d8 01 add 0x1(%rax,%rbx,8),%esi
1c: 00 00 add %al,(%rax)
1e: 00 00 add %al,(%rax)
20: 00 51 52 add %dl,0x52(%rcx)
23: 55 push %rbp
24: 89 e5 mov %esp,%ebp
26: 0f 34 sysenter
28: cd 80 int $0x80
2a:* 5d pop %rbp <-- trapping instruction
2b: 5a pop %rdx
2c: 59 pop %rcx
2d: c3 retq
2e: 90 nop
2f: 90 nop
30: 90 nop
31: 90 nop
32: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
39: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
Code starting with the faulting instruction
===========================================
0: 5d pop %rbp
1: 5a pop %rdx
2: 59 pop %rcx
3: c3 retq
4: 90 nop
5: 90 nop
6: 90 nop
7: 90 nop
8: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
f: 8d b4 26 00 00 00 00 lea 0x0(%rsi,%riz,1),%esi
[ 7.228546][ T1] RSP: 002b:00000000ffaebba8 EFLAGS: 00000206 ORIG_RAX: 0000000000000006
[ 7.229383][ T1] RAX: 0000000000000000 RBX: 000000000000001e RCX: 0000000000000660
[ 7.230197][ T1] RDX: 00000000f7b70300 RSI: 00000000f7b70960 RDI: 0000000000000000
[ 7.231031][ T1] RBP: 00000000f7b72000 R08: 0000000000000000 R09: 0000000000000000
[ 7.231848][ T1] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 7.232663][ T1] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[ 7.233526][ T1] </TASK>
[ 7.233888][ T1] ---[ end trace 41a8ced2c1edd838 ]---
[ 7.251575][ T1] list_add corruption. next->prev should be prev (ffff96777261ab38), but was 0000000000000000. (next=ffff9677724c5da0).
[ 7.252805][ T1] ------------[ cut here ]------------
To reproduce:
# build kernel
cd linux
cp config-5.16.0-rc4-00166-g26b1b4f9c86e .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-9 CC=gcc-9 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
# if come across any failure that blocks the test,
# please remove ~/.lkp and /lkp dir to run from a clean state.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
5 months
- 1
- 0