[block] 3500eb4b84: blktests.scsi/004.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 3500eb4b84d89dbe827a04329ef8a1435c408a5b ("block: untangle request_queue refcounting from sysfs")
git://git.infradead.org/users/hch/block.git block-sysfs-cleanups
in testcase: blktests
version: blktests-x86_64-bd6b882-1_20220323
with following parameters:
disk: 1HDD
test: scsi-group-02
ucode: 0x700001c
on test machine: 16 threads 1 sockets Intel(R) Xeon(R) CPU D-1541 @ 2.10GHz with 48G 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>
please be noted blktests.scsi/005 is also failed while pass on parent as below
2022-05-24 18:04:11 sed "s:^:scsi/:" /lkp/benchmarks/blktests/tests/scsi-group-02
2022-05-24 18:04:11 ./check scsi/004 scsi/005
scsi/004 (ensure repeated TASK SET FULL results in EIO on timing out command)
scsi/004 (ensure repeated TASK SET FULL results in EIO on timing out command) [failed]
runtime ... 0.329s
--- tests/scsi/004.out 2022-03-23 15:05:02.000000000 +0000
+++ /lkp/benchmarks/blktests/results/nodev/scsi/004.out.bad 2022-05-24 18:04:12.434842901 +0000
@@ -1,3 +1,5 @@
Running scsi/004
-Input/output error
+ls: cannot access '/sys/class/scsi_device/6:*/device/block': No such file or directory
+tests/scsi/004: line 29: /sys/block//device/timeout: No such file or directory
+tests/scsi/004: line 36: /sys/block//device/queue_depth: No such file or directory
Test complete
scsi/005 (test SCSI device blacklisting)
scsi/005 (test SCSI device blacklisting) [failed]
runtime ... 2.862s
--- tests/scsi/005.out 2022-03-23 15:05:02.000000000 +0000
+++ /lkp/benchmarks/blktests/results/nodev/scsi/005.out.bad 2022-05-24 18:04:15.401842797 +0000
@@ -1,10 +1,42 @@
Running scsi/005
-
-AAAAAAAA BBBBBBBBBBBBBBBB
-HITACHI OPEN-V REPORTLUN2 TRY_VPD_PAGES
- Scanner NOLUN
-Inateck
-Promise STEX SPARSELUN
...
(Run 'diff -u tests/scsi/005.out /lkp/benchmarks/blktests/results/nodev/scsi/005.out.bad' to see the entire diff)
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[mm] bec0ae1210: WARNING:possible_recursive_locking_detected
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: bec0ae12106e0cf12dd4e0e21eb0754b99be0ba2 ("[PATCH v4 09/11] mm: memcontrol: use obj_cgroup APIs to charge the LRU pages")
url: https://github.com/intel-lab-lkp/linux/commits/Muchun-Song/Use-obj_cgroup...
patch link: https://lore.kernel.org/linux-mm/[email protected]
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>
[ 41.024908][ T135] WARNING: possible recursive locking detected
[ 41.025923][ T135] 5.18.0-00009-gbec0ae12106e #1 Not tainted
[ 41.026805][ T135] --------------------------------------------
[ 41.027780][ T135] kworker/1:2/135 is trying to acquire lock:
[ 41.028743][ T135] ffff88815b545068 (&lruvec->lru_lock){....}-{2:2}, at: lruvec_reparent_lock (include/linux/nodemask.h:271 mm/memcontrol.c:376)
[ 41.030324][ T135]
[ 41.030324][ T135] but task is already holding lock:
[ 41.031629][ T135] ffff8881a1c43068 (&lruvec->lru_lock){....}-{2:2}, at: lruvec_reparent_lock (mm/memcontrol.c:378)
[ 41.033231][ T135]
[ 41.033231][ T135] other info that might help us debug this:
[ 41.034551][ T135] Possible unsafe locking scenario:
[ 41.034551][ T135]
[ 41.035818][ T135] CPU0
[ 41.036409][ T135] ----
[ 41.037045][ T135] lock(&lruvec->lru_lock);
[ 41.037866][ T135] lock(&lruvec->lru_lock);
[ 41.039123][ T135]
[ 41.039123][ T135] *** DEADLOCK ***
[ 41.039123][ T135]
[ 41.040984][ T135] May be due to missing lock nesting notation
[ 41.040984][ T135]
[ 41.042567][ T135] 5 locks held by kworker/1:2/135:
[ 41.043472][ T135] #0: ffff88839d54b538 ((wq_completion)cgroup_destroy){+.+.}-{0:0}, at: process_one_work (arch/x86/include/asm/atomic64_64.h:34 include/linux/atomic/atomic-long.h:41 include/linux/atomic/atomic-instrumented.h:1280 kernel/workqueue.c:636 kernel/workqueue.c:663 kernel/workqueue.c:2260)
[ 41.045556][ T135] #1: ffffc90000e9fdb8 ((work_completion)(&css->destroy_work)){+.+.}-{0:0}, at: process_one_work (kernel/workqueue.c:2264)
[ 41.047649][ T135] #2: ffffffffa46931c8 (cgroup_mutex){+.+.}-{3:3}, at: css_killed_work_fn (kernel/cgroup/cgroup.c:5271 kernel/cgroup/cgroup.c:5554)
[ 41.049171][ T135] #3: ffffffffa47fe2d8 (objcg_lock){....}-{2:2}, at: mem_cgroup_css_offline (mm/memcontrol.c:453 mm/memcontrol.c:463 mm/memcontrol.c:5382)
[ 41.050617][ T135] #4: ffff8881a1c43068 (&lruvec->lru_lock){....}-{2:2}, at: lruvec_reparent_lock (mm/memcontrol.c:378)
[ 41.052031][ T135]
[ 41.052031][ T135] stack backtrace:
[ 41.052926][ T135] CPU: 1 PID: 135 Comm: kworker/1:2 Not tainted 5.18.0-00009-gbec0ae12106e #1
[ 41.054190][ T135] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.0-debian-1.16.0-4 04/01/2014
[ 41.055742][ T135] Workqueue: cgroup_destroy css_killed_work_fn
[ 41.056645][ T135] Call Trace:
[ 41.057138][ T135] <TASK>
[ 41.057628][ T135] dump_stack_lvl (lib/dump_stack.c:107 (discriminator 4))
[ 41.058392][ T135] validate_chain.cold (kernel/locking/lockdep.c:2958 kernel/locking/lockdep.c:3001 kernel/locking/lockdep.c:3790)
[ 41.059117][ T135] ? check_prev_add (kernel/locking/lockdep.c:3759)
[ 41.059888][ T135] __lock_acquire (kernel/locking/lockdep.c:5029)
[ 41.060579][ T135] lock_acquire (kernel/locking/lockdep.c:436 kernel/locking/lockdep.c:5643 kernel/locking/lockdep.c:5606)
[ 41.061280][ T135] ? lruvec_reparent_lock (include/linux/nodemask.h:271 mm/memcontrol.c:376)
[ 41.062081][ T135] ? rcu_read_unlock (include/linux/rcupdate.h:723 (discriminator 5))
[ 41.062915][ T135] ? lock_acquire (kernel/locking/lockdep.c:436 kernel/locking/lockdep.c:5643 kernel/locking/lockdep.c:5606)
[ 41.063653][ T135] ? mem_cgroup_css_offline (mm/memcontrol.c:453 mm/memcontrol.c:463 mm/memcontrol.c:5382)
[ 41.064504][ T135] ? do_raw_spin_lock (arch/x86/include/asm/atomic.h:202 include/linux/atomic/atomic-instrumented.h:543 include/asm-generic/qspinlock.h:82 kernel/locking/spinlock_debug.c:115)
[ 41.065190][ T135] ? rwlock_bug+0xc0/0xc0
[ 41.065923][ T135] _raw_spin_lock (include/linux/spinlock_api_smp.h:134 kernel/locking/spinlock.c:154)
[ 41.066676][ T135] ? lruvec_reparent_lock (include/linux/nodemask.h:271 mm/memcontrol.c:376)
[ 41.067455][ T135] lruvec_reparent_lock (include/linux/nodemask.h:271 mm/memcontrol.c:376)
[ 41.068227][ T135] mem_cgroup_css_offline (mm/memcontrol.c:453 mm/memcontrol.c:463 mm/memcontrol.c:5382)
[ 41.069103][ T135] ? lock_is_held_type (kernel/locking/lockdep.c:5382 kernel/locking/lockdep.c:5684)
[ 41.069858][ T135] css_killed_work_fn (kernel/cgroup/cgroup.c:5279 kernel/cgroup/cgroup.c:5554)
[ 41.070637][ T135] process_one_work (arch/x86/include/asm/jump_label.h:27 include/linux/jump_label.h:207 include/trace/events/workqueue.h:108 kernel/workqueue.c:2294)
[ 41.071459][ T135] ? rcu_read_unlock (include/linux/rcupdate.h:723 (discriminator 5))
[ 41.072308][ T135] ? pwq_dec_nr_in_flight (kernel/workqueue.c:2184)
[ 41.073231][ T135] ? rwlock_bug+0xc0/0xc0
[ 41.073922][ T135] worker_thread (include/linux/list.h:292 kernel/workqueue.c:2437)
[ 41.074572][ T135] ? __kthread_parkme (arch/x86/include/asm/bitops.h:207 (discriminator 4) include/asm-generic/bitops/instrumented-non-atomic.h:135 (discriminator 4) kernel/kthread.c:270 (discriminator 4))
[ 41.075220][ T135] ? schedule (arch/x86/include/asm/bitops.h:207 (discriminator 1) include/asm-generic/bitops/instrumented-non-atomic.h:135 (discriminator 1) include/linux/thread_info.h:118 (discriminator 1) include/linux/sched.h:2154 (discriminator 1) kernel/sched/core.c:6462 (discriminator 1))
[ 41.075942][ T135] ? process_one_work (kernel/workqueue.c:2379)
[ 41.076755][ T135] ? process_one_work (kernel/workqueue.c:2379)
[ 41.077600][ T135] kthread (kernel/kthread.c:376)
[ 41.078174][ T135] ? kthread_complete_and_exit (kernel/kthread.c:331)
[ 41.078951][ T135] ret_from_fork (arch/x86/entry/entry_64.S:304)
[ 41.079668][ T135] </TASK>
[ OK ] Started Load Kernel Modules.
[ OK ] Mounted RPC Pipe File System.
[ OK ] Started Remount Root and Kernel File Systems.
[ OK ] Mounted Kernel Debug File System.
[ OK ] Mounted Huge Pages File System.
Starting Load/Save Random Seed...
Starting Create System Users...
Starting Apply Kernel Variables...
Mounting Kernel Configuration File System...
[ OK ] Started Load/Save Random Seed.
[ OK ] Started Create System Users.
[ OK ] Started Apply Kernel Variables.
[ OK ] Mounted Kernel Configuration File System.
Starting Create Static Device Nodes in /dev...
[ OK ] Started Create Static Device Nodes in /dev.
[ OK ] Reached target Local File Systems (Pre).
[ OK ] Reached target Local File Systems.
Starting Preprocess NFS configuration...
Starting udev Kernel Device Manager...
[ OK ] Started Journal Service.
[ OK ] Started Preprocess NFS configuration.
[ OK ] Reached target NFS client services.
Starting Flush Journal to Persistent Storage...
[ OK ] Started udev Kernel Device Manager.
[ OK ] Started Flush Journal to Persistent Storage.
Starting Create Volatile Files and Directories...
[ OK ] Started Create Volatile Files and Directories.
Starting Network Time Synchronization...
Starting RPC bind portmap service...
Starting Update UTMP about System Boot/Shutdown...
[ OK ] Started RPC bind portmap service.
[ OK ] Reached target RPC Port Mapper.
[ OK ] Reached target Remote File Systems (Pre).
[ OK ] Reached target Remote File Systems.
[ OK ] Started Update UTMP about System Boot/Shutdown.
[ OK ] Started Network Time Synchronization.
[ OK ] Reached target System Time Synchronized.
To reproduce:
# build kernel
cd linux
cp config-5.18.0-00009-gbec0ae12106e .config
make HOSTCC=gcc-11 CC=gcc-11 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-11 CC=gcc-11 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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[KVM] 34e0280921: kernel-selftests.kvm.evmcs_test.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 34e02809217325da2186f6470cf9eaee61d30f9a ("KVM: x86/pmu: Add IA32_PEBS_ENABLE MSR emulation for extended PEBS")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: kernel-selftests
version: kernel-selftests-x86_64-8d3977ef-1_20220523
with following parameters:
group: kvm
ucode: 0xec
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>
please be noted, besides kvm.evmcs_test, we also noticed below tests failed on
this commit, while pass on parent.
db2265f3a9ed46b3 34e02809217325da2186f6470cf
---------------- ---------------------------
fail:runs %reproduction fail:runs
| | |
:6 50% 3:3 kernel-selftests.kvm.evmcs_test.fail
:6 50% 3:3 kernel-selftests.kvm.hyperv_clock.fail
:6 50% 3:3 kernel-selftests.kvm.smm_test.fail
:6 50% 3:3 kernel-selftests.kvm.state_test.fail
:6 50% 3:3 kernel-selftests.kvm.vmx_preemption_timer_test.fail
# selftests: kvm: evmcs_test
# ==== Test Assertion Failure ====
# lib/x86_64/processor.c:1207: r == nmsrs
# pid=9769 tid=9769 errno=7 - Argument list too long
# 1 0x000000000040d471: vcpu_save_state at processor.c:1207 (discriminator 4)
# 2 0x00000000004027eb: save_restore_vm at evmcs_test.c:180
# 3 0x000000000040253e: main at evmcs_test.c:259 (discriminator 6)
# 4 0x00007fab93f38d09: ?? ??:0
# 5 0x0000000000402639: _start at ??:?
# Unexpected result from KVM_GET_MSRS, r: 37 (failed MSR was 0x3f1)
# Running L1 which uses EVMCS to run L2
not ok 4 selftests: kvm: evmcs_test # exit=254
...
# selftests: kvm: hyperv_clock
# ==== Test Assertion Failure ====
# x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
# pid=9859 tid=9859 errno=0 - Success
# 1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
# 2 (inlined by) main at hyperv_clock.c:223
# 3 0x00007f41b4175d09: ?? ??:0
# 4 0x0000000000402749: _start at ??:?
# Elapsed time does not match (MSR=332900, TSC=346021)
not ok 7 selftests: kvm: hyperv_clock # exit=254
...
# selftests: kvm: smm_test
# ==== Test Assertion Failure ====
# lib/x86_64/processor.c:1207: r == nmsrs
# pid=10252 tid=10252 errno=7 - Argument list too long
# 1 0x000000000040c4c1: vcpu_save_state at processor.c:1207 (discriminator 4)
# 2 0x00000000004024bc: main at smm_test.c:207
# 3 0x00007fd3ac98fd09: ?? ??:0
# 4 0x0000000000402699: _start at ??:?
# Unexpected result from KVM_GET_MSRS, r: 37 (failed MSR was 0x3f1)
not ok 19 selftests: kvm: smm_test # exit=254
# selftests: kvm: state_test
# ==== Test Assertion Failure ====
# lib/x86_64/processor.c:1207: r == nmsrs
# pid=10283 tid=10283 errno=7 - Argument list too long
# 1 0x000000000040d731: vcpu_save_state at processor.c:1207 (discriminator 4)
# 2 0x00000000004024e5: main at state_test.c:209 (discriminator 6)
# 3 0x00007f3d757d1d09: ?? ??:0
# 4 0x00000000004026d9: _start at ??:?
# Unexpected result from KVM_GET_MSRS, r: 37 (failed MSR was 0x3f1)
not ok 20 selftests: kvm: state_test # exit=254
# selftests: kvm: vmx_preemption_timer_test
# ==== Test Assertion Failure ====
# lib/x86_64/processor.c:1207: r == nmsrs
# pid=10317 tid=10317 errno=7 - Argument list too long
# 1 0x000000000040da21: vcpu_save_state at processor.c:1207 (discriminator 4)
# 2 0x00000000004024fa: main at vmx_preemption_timer_test.c:235
# 3 0x00007f876fcf4d09: ?? ??:0
# 4 0x0000000000402759: _start at ??:?
# Unexpected result from KVM_GET_MSRS, r: 37 (failed MSR was 0x3f1)
not ok 21 selftests: kvm: vmx_preemption_timer_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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[KVM] db16e9b28b: kvm-unit-tests.pmu.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: db16e9b28b05f069d01b76886b683599fd7bbf4e ("[PATCH 2/3] KVM: x86/pmu: Don't pre-set the pmu->global_ctrl when refreshing")
url: https://github.com/intel-lab-lkp/linux/commits/Like-Xu/KVM-x86-pmu-Ignore...
base: https://git.kernel.org/cgit/virt/kvm/kvm.git master
patch link: https://lore.kernel.org/kvm/[email protected]
in testcase: kvm-unit-tests
version: kvm-unit-tests-x86_64-1a4529c-1_20220412
with following parameters:
ucode: 0x28
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>
2022-05-14 21:03:37 ./run_tests.sh
...
[32mPASS[0m msr (17 tests)
[31mFAIL[0m pmu
[32mPASS[0m pmu_lbr (3 tests)
[32mPASS[0m pmu_emulation (4 tests)
...
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
379b0fd8ed: blktests.block/024.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 379b0fd8ed0954b3147d47fe5a316dae267f7374 ("Re: [RFC] what to do with IOCB_DSYNC?")
url: https://github.com/intel-lab-lkp/linux/commits/Al-Viro/Re-RFC-what-to-do-...
base: https://git.kernel.org/cgit/linux/kernel/git/axboe/linux-block.git for-next
patch link: https://lore.kernel.org/linux-fsdevel/Yokl%[email protected]
in testcase: blktests
version: blktests-x86_64-bd6b882-1_20220323
with following parameters:
disk: 1HDD
test: block-group-12
ucode: 0xec
on test machine: 4 threads Intel(R) Core(TM) i5-6500 CPU @ 3.20GHz 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>
2022-05-22 23:34:19 sed "s:^:block/:" /lkp/benchmarks/blktests/tests/block-group-12
2022-05-22 23:34:19 ./check block/024 block/025
block/024 (do I/O faster than a jiffy and check iostats times)
block/024 (do I/O faster than a jiffy and check iostats times) [failed]
runtime ... 0.211s
--- tests/block/024.out 2022-03-23 15:05:02.000000000 +0000
+++ /lkp/benchmarks/blktests/results/nodev/block/024.out.bad 2022-05-22 23:34:19.435699977 +0000
@@ -1,10 +1,10 @@
Running block/024
read 0 s
write 0 s
-read 1 s
+read 0 s
+write 0 s
+read 0 s
...
(Run 'diff -u tests/block/024.out /lkp/benchmarks/blktests/results/nodev/block/024.out.bad' to see the entire diff)
block/025 (do a huge discard with 4k sector size)
block/025 (do a huge discard with 4k sector size) [passed]
runtime ... 7.393s
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[NFSD] c6138abff4: fsmark.files_per_sec -6.5% regression
by kernel test robot
Greeting,
FYI, we noticed a -6.5% regression of fsmark.files_per_sec due to commit:
commit: c6138abff45e497e14575b6ac321b17899a5944c ("[PATCH v2 1/1] NFSD: sleeping function called from invalid context at kernel/locking/rwsem.c")
url: https://github.com/intel-lab-lkp/linux/commits/Dai-Ngo/NFSD-sleeping-func...
base: https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git 3b5e1590a26713a8c76896f0f1b99f52ec24e72f
patch link: https://lore.kernel.org/linux-nfs/1653079929-18283-1-git-send-email-dai.n...
in testcase: fsmark
on test machine: 144 threads 4 sockets Intel(R) Xeon(R) Gold 5318H CPU @ 2.50GHz with 128G memory
with following parameters:
iterations: 1x
disk: 1SSD
nr_threads: 6t
fs: xfs
filesize: 8K
test_size: 60G
sync_method: NoSync
cpufreq_governor: performance
ucode: 0x7002402
fs2: nfsv4
test-description: The fsmark is a file system benchmark to test synchronous write workloads, for example, mail servers workload.
test-url: https://sourceforge.net/projects/fsmark/
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang(a)intel.com>
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/disk/filesize/fs2/fs/iterations/kconfig/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase/ucode:
gcc-11/performance/1SSD/8K/nfsv4/xfs/1x/x86_64-rhel-8.3/6t/debian-10.4-x86_64-20200603.cgz/NoSync/lkp-cpl-4sp1/60G/fsmark/0x7002402
commit:
3b5e1590a2 ("Merge tag 'gpio-fixes-for-v5.18' of git://git.kernel.org/pub/scm/linux/kernel/git/brgl/linux")
c6138abff4 ("NFSD: sleeping function called from invalid context at kernel/locking/rwsem.c")
3b5e1590a26713a8 c6138abff45e497e14575b6ac32
---------------- ---------------------------
%stddev %change %stddev
\ | \
3861 -6.5% 3612 fsmark.files_per_sec
1554 +6.9% 1661 fsmark.time.elapsed_time
1554 +6.9% 1661 fsmark.time.elapsed_time.max
90439 -6.5% 84537 vmstat.io.bo
330422 -6.0% 310581 vmstat.system.cs
1.309e+09 -6.5% 1.224e+09 ± 2% perf-stat.i.branch-instructions
333399 -6.3% 312399 perf-stat.i.context-switches
419.54 -5.5% 396.45 perf-stat.i.cpu-migrations
1.728e+09 -6.3% 1.619e+09 ± 2% perf-stat.i.dTLB-loads
8.609e+08 -6.3% 8.066e+08 ± 2% perf-stat.i.dTLB-stores
6.143e+09 -6.4% 5.748e+09 ± 3% perf-stat.i.instructions
28.45 -6.3% 26.66 ± 2% perf-stat.i.metric.M/sec
1.306e+09 -6.2% 1.224e+09 ± 3% perf-stat.ps.branch-instructions
330583 -6.0% 310704 perf-stat.ps.context-switches
415.90 -5.3% 393.96 perf-stat.ps.cpu-migrations
1.726e+09 -6.1% 1.62e+09 ± 2% perf-stat.ps.dTLB-loads
8.575e+08 -6.1% 8.056e+08 ± 2% perf-stat.ps.dTLB-stores
6.126e+09 -6.2% 5.747e+09 ± 3% perf-stat.ps.instructions
245690 -1.8% 241299 proc-vmstat.nr_anon_pages
13392029 -2.5% 13055008 proc-vmstat.nr_file_pages
14449706 +3.1% 14903918 proc-vmstat.nr_free_pages
252964 -2.0% 247951 proc-vmstat.nr_inactive_anon
12791936 -2.6% 12455581 proc-vmstat.nr_inactive_file
3110850 -2.6% 3031433 proc-vmstat.nr_slab_reclaimable
1086429 -2.0% 1064320 proc-vmstat.nr_slab_unreclaimable
252965 -2.0% 247951 proc-vmstat.nr_zone_inactive_anon
12791941 -2.6% 12455588 proc-vmstat.nr_zone_inactive_file
36318 ± 25% -41.2% 21359 ± 25% proc-vmstat.numa_hint_faults
357725 ± 4% -20.2% 285481 ± 4% proc-vmstat.pgactivate
6109087 +6.7% 6516788 proc-vmstat.pgfault
484834 +7.6% 521446 proc-vmstat.pgreuse
1.60 ± 14% -0.7 0.92 ± 22% perf-profile.calltrace.cycles-pp.perf_callchain_kernel.get_perf_callchain.perf_callchain.perf_prepare_sample.perf_event_output_forward
1.75 ± 17% -0.6 1.13 ± 25% perf-profile.calltrace.cycles-pp.perf_callchain.perf_prepare_sample.perf_event_output_forward.__perf_event_overflow.perf_tp_event
1.74 ± 18% -0.6 1.12 ± 25% perf-profile.calltrace.cycles-pp.get_perf_callchain.perf_callchain.perf_prepare_sample.perf_event_output_forward.__perf_event_overflow
1.88 ± 19% -0.6 1.28 ± 21% perf-profile.calltrace.cycles-pp.find_busiest_group.load_balance.newidle_balance.pick_next_task_fair.__schedule
1.86 ± 19% -0.6 1.27 ± 21% perf-profile.calltrace.cycles-pp.update_sd_lb_stats.find_busiest_group.load_balance.newidle_balance.pick_next_task_fair
3.74 ± 5% -0.5 3.19 ± 5% perf-profile.calltrace.cycles-pp.schedule.worker_thread.kthread.ret_from_fork
3.71 ± 5% -0.5 3.17 ± 5% perf-profile.calltrace.cycles-pp.__schedule.schedule.worker_thread.kthread.ret_from_fork
1.36 ± 24% -0.4 0.94 ± 4% perf-profile.calltrace.cycles-pp.perf_prepare_sample.perf_event_output_forward.__perf_event_overflow.perf_tp_event.perf_trace_sched_switch
1.67 ± 5% -0.3 1.37 ± 5% perf-profile.calltrace.cycles-pp.__close
1.65 ± 5% -0.3 1.35 ± 5% perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe.__close
1.65 ± 5% -0.3 1.35 ± 5% perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe.__close
2.12 ± 6% -0.3 1.85 ± 5% perf-profile.calltrace.cycles-pp.perf_event_output_forward.__perf_event_overflow.perf_tp_event.perf_trace_sched_switch.__schedule
1.57 ± 6% -0.3 1.31 ± 8% perf-profile.calltrace.cycles-pp.newidle_balance.pick_next_task_fair.__schedule.schedule.worker_thread
1.60 ± 6% -0.3 1.33 ± 8% perf-profile.calltrace.cycles-pp.pick_next_task_fair.__schedule.schedule.worker_thread.kthread
2.75 ± 6% -0.2 2.53 ± 6% perf-profile.calltrace.cycles-pp.do_nfsd_create.do_open_lookup.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch
2.80 ± 6% -0.2 2.58 ± 6% perf-profile.calltrace.cycles-pp.do_open_lookup.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch.svc_process_common
1.30 ± 6% -0.2 1.09 ± 8% perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe.open64
1.30 ± 6% -0.2 1.09 ± 8% perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe.open64
1.30 ± 6% -0.2 1.09 ± 8% perf-profile.calltrace.cycles-pp.__x64_sys_openat.do_syscall_64.entry_SYSCALL_64_after_hwframe.open64
1.31 ± 6% -0.2 1.10 ± 8% perf-profile.calltrace.cycles-pp.open64
0.68 ± 5% -0.2 0.47 ± 44% perf-profile.calltrace.cycles-pp.nfs4_file_flush.filp_close.__x64_sys_close.do_syscall_64.entry_SYSCALL_64_after_hwframe
1.30 ± 6% -0.2 1.09 ± 8% perf-profile.calltrace.cycles-pp.do_sys_openat2.__x64_sys_openat.do_syscall_64.entry_SYSCALL_64_after_hwframe.open64
0.66 ± 5% -0.2 0.46 ± 45% perf-profile.calltrace.cycles-pp.filemap_write_and_wait_range.nfs_wb_all.nfs4_file_flush.filp_close.__x64_sys_close
0.67 ± 5% -0.2 0.46 ± 45% perf-profile.calltrace.cycles-pp.nfs_wb_all.nfs4_file_flush.filp_close.__x64_sys_close.do_syscall_64
1.27 ± 6% -0.2 1.07 ± 8% perf-profile.calltrace.cycles-pp.path_openat.do_filp_open.do_sys_openat2.__x64_sys_openat.do_syscall_64
1.28 ± 6% -0.2 1.07 ± 8% perf-profile.calltrace.cycles-pp.do_filp_open.do_sys_openat2.__x64_sys_openat.do_syscall_64.entry_SYSCALL_64_after_hwframe
1.48 ± 5% -0.2 1.29 ± 5% perf-profile.calltrace.cycles-pp.perf_tp_event.perf_trace_sched_switch.__schedule.schedule_idle.do_idle
1.44 ± 5% -0.2 1.25 ± 5% perf-profile.calltrace.cycles-pp.__perf_event_overflow.perf_tp_event.perf_trace_sched_switch.__schedule.schedule_idle
1.19 ± 6% -0.2 1.00 ± 8% perf-profile.calltrace.cycles-pp.open_last_lookups.path_openat.do_filp_open.do_sys_openat2.__x64_sys_openat
1.62 ± 5% -0.2 1.44 ± 4% perf-profile.calltrace.cycles-pp.perf_trace_sched_switch.__schedule.schedule_idle.do_idle.cpu_startup_entry
1.17 ± 6% -0.2 0.98 ± 9% perf-profile.calltrace.cycles-pp.lookup_open.open_last_lookups.path_openat.do_filp_open.do_sys_openat2
0.92 ± 7% -0.2 0.74 ± 6% perf-profile.calltrace.cycles-pp.nfs_file_release.__fput.task_work_run.exit_to_user_mode_loop.exit_to_user_mode_prepare
0.91 ± 7% -0.2 0.73 ± 6% perf-profile.calltrace.cycles-pp.__put_nfs_open_context.nfs_file_release.__fput.task_work_run.exit_to_user_mode_loop
0.96 ± 7% -0.2 0.78 ± 6% perf-profile.calltrace.cycles-pp.syscall_exit_to_user_mode.do_syscall_64.entry_SYSCALL_64_after_hwframe.__close
1.12 ± 7% -0.2 0.94 ± 8% perf-profile.calltrace.cycles-pp.nfs_atomic_open.lookup_open.open_last_lookups.path_openat.do_filp_open
0.96 ± 7% -0.2 0.78 ± 6% perf-profile.calltrace.cycles-pp.exit_to_user_mode_prepare.syscall_exit_to_user_mode.do_syscall_64.entry_SYSCALL_64_after_hwframe.__close
0.88 ± 8% -0.2 0.71 ± 7% perf-profile.calltrace.cycles-pp.nfs4_do_close.__put_nfs_open_context.nfs_file_release.__fput.task_work_run
0.95 ± 7% -0.2 0.78 ± 6% perf-profile.calltrace.cycles-pp.task_work_run.exit_to_user_mode_loop.exit_to_user_mode_prepare.syscall_exit_to_user_mode.do_syscall_64
1.02 ± 7% -0.2 0.84 ± 9% perf-profile.calltrace.cycles-pp._nfs4_open_and_get_state._nfs4_do_open.nfs4_do_open.nfs4_atomic_open.nfs_atomic_open
0.94 ± 7% -0.2 0.77 ± 5% perf-profile.calltrace.cycles-pp.__fput.task_work_run.exit_to_user_mode_loop.exit_to_user_mode_prepare.syscall_exit_to_user_mode
1.08 ± 7% -0.2 0.91 ± 8% perf-profile.calltrace.cycles-pp.nfs4_atomic_open.nfs_atomic_open.lookup_open.open_last_lookups.path_openat
1.08 ± 6% -0.2 0.90 ± 8% perf-profile.calltrace.cycles-pp.nfs4_do_open.nfs4_atomic_open.nfs_atomic_open.lookup_open.open_last_lookups
1.08 ± 6% -0.2 0.90 ± 8% perf-profile.calltrace.cycles-pp._nfs4_do_open.nfs4_do_open.nfs4_atomic_open.nfs_atomic_open.lookup_open
0.95 ± 7% -0.2 0.78 ± 6% perf-profile.calltrace.cycles-pp.exit_to_user_mode_loop.exit_to_user_mode_prepare.syscall_exit_to_user_mode.do_syscall_64.entry_SYSCALL_64_after_hwframe
1.04 ± 5% -0.2 0.88 ± 6% perf-profile.calltrace.cycles-pp.dequeue_task_fair.__schedule.schedule.worker_thread.kthread
0.62 ± 6% -0.2 0.45 ± 45% perf-profile.calltrace.cycles-pp.perf_prepare_sample.perf_event_output_forward.__perf_event_overflow.perf_tp_event.perf_trace_sched_stat_runtime
1.01 ± 5% -0.2 0.85 ± 6% perf-profile.calltrace.cycles-pp.dequeue_entity.dequeue_task_fair.__schedule.schedule.worker_thread
1.83 ± 5% -0.2 1.67 ± 5% perf-profile.calltrace.cycles-pp.__local_bh_enable_ip.ip6_finish_output2.ip6_xmit.inet6_csk_xmit.__tcp_transmit_skb
1.82 ± 5% -0.2 1.65 ± 5% perf-profile.calltrace.cycles-pp.__softirqentry_text_start.do_softirq.__local_bh_enable_ip.ip6_finish_output2.ip6_xmit
1.82 ± 5% -0.2 1.67 ± 5% perf-profile.calltrace.cycles-pp.do_softirq.__local_bh_enable_ip.ip6_finish_output2.ip6_xmit.inet6_csk_xmit
1.76 ± 5% -0.2 1.61 ± 5% perf-profile.calltrace.cycles-pp.net_rx_action.__softirqentry_text_start.do_softirq.__local_bh_enable_ip.ip6_finish_output2
1.74 ± 5% -0.1 1.60 ± 5% perf-profile.calltrace.cycles-pp.process_backlog.__napi_poll.net_rx_action.__softirqentry_text_start.do_softirq
0.92 ± 4% -0.1 0.78 ± 6% perf-profile.calltrace.cycles-pp.update_curr.dequeue_entity.dequeue_task_fair.__schedule.schedule
0.89 ± 4% -0.1 0.75 ± 6% perf-profile.calltrace.cycles-pp.perf_trace_sched_stat_runtime.update_curr.dequeue_entity.dequeue_task_fair.__schedule
0.84 ± 5% -0.1 0.70 ± 6% perf-profile.calltrace.cycles-pp.perf_tp_event.perf_trace_sched_stat_runtime.update_curr.dequeue_entity.dequeue_task_fair
0.69 ± 5% -0.1 0.56 ± 5% perf-profile.calltrace.cycles-pp.filp_close.__x64_sys_close.do_syscall_64.entry_SYSCALL_64_after_hwframe.__close
0.69 ± 5% -0.1 0.56 ± 4% perf-profile.calltrace.cycles-pp.__x64_sys_close.do_syscall_64.entry_SYSCALL_64_after_hwframe.__close
0.80 ± 4% -0.1 0.68 ± 7% perf-profile.calltrace.cycles-pp.__perf_event_overflow.perf_tp_event.perf_trace_sched_stat_runtime.update_curr.dequeue_entity
0.80 ± 4% -0.1 0.68 ± 6% perf-profile.calltrace.cycles-pp.perf_event_output_forward.__perf_event_overflow.perf_tp_event.perf_trace_sched_stat_runtime.update_curr
0.77 ± 9% -0.1 0.66 ± 7% perf-profile.calltrace.cycles-pp.poll_idle.cpuidle_enter_state.cpuidle_enter.cpuidle_idle_call.do_idle
1.12 ± 4% -0.1 1.04 ± 3% perf-profile.calltrace.cycles-pp.xfs_log_force_seq.xfs_file_fsync.xfs_file_buffered_write.do_iter_readv_writev.do_iter_write
0.67 ± 13% +0.2 0.82 ± 10% perf-profile.calltrace.cycles-pp.nfsd_file_lru_cb.__list_lru_walk_one.list_lru_walk_node.nfsd_file_lru_walk_list.nfsd_file_acquire
11.69 ± 6% +1.7 13.37 ± 5% perf-profile.calltrace.cycles-pp.svc_process_common.svc_process.nfsd.kthread.ret_from_fork
11.70 ± 6% +1.7 13.38 ± 5% perf-profile.calltrace.cycles-pp.svc_process.nfsd.kthread.ret_from_fork
11.18 ± 6% +1.7 12.89 ± 5% perf-profile.calltrace.cycles-pp.nfsd_dispatch.svc_process_common.svc_process.nfsd.kthread
10.84 ± 6% +1.7 12.58 ± 5% perf-profile.calltrace.cycles-pp.nfsd4_proc_compound.nfsd_dispatch.svc_process_common.svc_process.nfsd
6.58 ± 8% +2.0 8.60 ± 6% perf-profile.calltrace.cycles-pp.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch.svc_process_common.svc_process
3.70 ± 10% +2.2 5.92 ± 7% perf-profile.calltrace.cycles-pp.nfsd4_process_open2.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch.svc_process_common
3.47 ± 11% +2.2 5.69 ± 7% perf-profile.calltrace.cycles-pp.nfsd_file_acquire.nfs4_get_vfs_file.nfsd4_process_open2.nfsd4_open.nfsd4_proc_compound
3.48 ± 11% +2.2 5.70 ± 7% perf-profile.calltrace.cycles-pp.nfs4_get_vfs_file.nfsd4_process_open2.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch
3.21 ± 11% +2.3 5.47 ± 7% perf-profile.calltrace.cycles-pp.nfsd_file_lru_walk_list.nfsd_file_acquire.nfs4_get_vfs_file.nfsd4_process_open2.nfsd4_open
3.00 ± 10% +2.3 5.32 ± 6% perf-profile.calltrace.cycles-pp.list_lru_walk_node.nfsd_file_lru_walk_list.nfsd_file_acquire.nfs4_get_vfs_file.nfsd4_process_open2
2.96 ± 10% +2.3 5.30 ± 6% perf-profile.calltrace.cycles-pp.__list_lru_walk_one.list_lru_walk_node.nfsd_file_lru_walk_list.nfsd_file_acquire.nfs4_get_vfs_file
12.12 ± 7% -1.6 10.48 ± 5% perf-profile.children.cycles-pp.__schedule
9.30 ± 7% -1.3 8.03 ± 5% perf-profile.children.cycles-pp.schedule
9.74 ± 6% -1.0 8.72 ± 4% perf-profile.children.cycles-pp.perf_tp_event
9.37 ± 6% -1.0 8.38 ± 5% perf-profile.children.cycles-pp.__perf_event_overflow
9.33 ± 6% -1.0 8.33 ± 5% perf-profile.children.cycles-pp.perf_event_output_forward
7.75 ± 6% -0.9 6.88 ± 5% perf-profile.children.cycles-pp.perf_prepare_sample
7.35 ± 6% -0.8 6.54 ± 5% perf-profile.children.cycles-pp.perf_callchain
7.32 ± 6% -0.8 6.52 ± 5% perf-profile.children.cycles-pp.get_perf_callchain
6.85 ± 6% -0.8 6.09 ± 5% perf-profile.children.cycles-pp.perf_callchain_kernel
3.58 ± 8% -0.7 2.88 ± 7% perf-profile.children.cycles-pp.pick_next_task_fair
3.29 ± 8% -0.7 2.63 ± 7% perf-profile.children.cycles-pp.newidle_balance
6.50 ± 6% -0.6 5.89 ± 5% perf-profile.children.cycles-pp.do_syscall_64
6.51 ± 6% -0.6 5.90 ± 5% perf-profile.children.cycles-pp.entry_SYSCALL_64_after_hwframe
3.28 ± 7% -0.6 2.67 ± 7% perf-profile.children.cycles-pp.load_balance
5.49 ± 6% -0.6 4.90 ± 5% perf-profile.children.cycles-pp.unwind_next_frame
3.14 ± 7% -0.6 2.56 ± 7% perf-profile.children.cycles-pp.find_busiest_group
3.10 ± 6% -0.6 2.53 ± 7% perf-profile.children.cycles-pp.update_sd_lb_stats
2.96 ± 7% -0.5 2.42 ± 7% perf-profile.children.cycles-pp.update_sg_lb_stats
3.12 ± 5% -0.4 2.76 ± 5% perf-profile.children.cycles-pp.update_curr
2.96 ± 5% -0.3 2.63 ± 5% perf-profile.children.cycles-pp.perf_trace_sched_stat_runtime
3.01 ± 4% -0.3 2.69 ± 4% perf-profile.children.cycles-pp.dequeue_task_fair
2.94 ± 4% -0.3 2.62 ± 4% perf-profile.children.cycles-pp.dequeue_entity
1.67 ± 5% -0.3 1.37 ± 5% perf-profile.children.cycles-pp.__close
3.20 ± 5% -0.3 2.90 ± 4% perf-profile.children.cycles-pp.perf_trace_sched_wakeup_template
2.42 ± 7% -0.3 2.12 ± 4% perf-profile.children.cycles-pp.__unwind_start
1.21 ± 9% -0.3 0.95 ± 11% perf-profile.children.cycles-pp.rpc_wait_bit_killable
1.27 ± 8% -0.3 1.01 ± 9% perf-profile.children.cycles-pp.__wait_on_bit
2.76 ± 3% -0.3 2.50 ± 5% perf-profile.children.cycles-pp.__queue_work
1.27 ± 8% -0.3 1.01 ± 9% perf-profile.children.cycles-pp.out_of_line_wait_on_bit
2.70 ± 2% -0.2 2.47 ± 4% perf-profile.children.cycles-pp.queue_work_on
2.75 ± 6% -0.2 2.53 ± 6% perf-profile.children.cycles-pp.do_nfsd_create
2.80 ± 6% -0.2 2.58 ± 6% perf-profile.children.cycles-pp.do_open_lookup
1.31 ± 6% -0.2 1.10 ± 8% perf-profile.children.cycles-pp.open64
1.34 ± 6% -0.2 1.13 ± 8% perf-profile.children.cycles-pp.__x64_sys_openat
2.28 ± 7% -0.2 2.07 ± 5% perf-profile.children.cycles-pp.xfs_log_force_seq
1.34 ± 6% -0.2 1.13 ± 8% perf-profile.children.cycles-pp.do_sys_openat2
1.31 ± 6% -0.2 1.11 ± 7% perf-profile.children.cycles-pp.do_filp_open
2.03 ± 6% -0.2 1.83 ± 7% perf-profile.children.cycles-pp.__orc_find
1.30 ± 6% -0.2 1.11 ± 7% perf-profile.children.cycles-pp.path_openat
1.17 ± 6% -0.2 0.98 ± 9% perf-profile.children.cycles-pp.lookup_open
1.20 ± 6% -0.2 1.01 ± 8% perf-profile.children.cycles-pp.open_last_lookups
0.92 ± 7% -0.2 0.74 ± 6% perf-profile.children.cycles-pp.nfs_file_release
0.98 ± 7% -0.2 0.80 ± 6% perf-profile.children.cycles-pp.syscall_exit_to_user_mode
1.12 ± 7% -0.2 0.94 ± 8% perf-profile.children.cycles-pp.nfs_atomic_open
0.91 ± 8% -0.2 0.74 ± 7% perf-profile.children.cycles-pp.__put_nfs_open_context
0.88 ± 8% -0.2 0.71 ± 7% perf-profile.children.cycles-pp.nfs4_do_close
0.98 ± 7% -0.2 0.80 ± 6% perf-profile.children.cycles-pp.exit_to_user_mode_prepare
0.97 ± 7% -0.2 0.80 ± 6% perf-profile.children.cycles-pp.exit_to_user_mode_loop
1.02 ± 7% -0.2 0.84 ± 9% perf-profile.children.cycles-pp._nfs4_open_and_get_state
1.08 ± 7% -0.2 0.91 ± 8% perf-profile.children.cycles-pp.nfs4_atomic_open
1.08 ± 6% -0.2 0.90 ± 8% perf-profile.children.cycles-pp.nfs4_do_open
1.08 ± 6% -0.2 0.90 ± 8% perf-profile.children.cycles-pp._nfs4_do_open
0.99 ± 7% -0.2 0.82 ± 6% perf-profile.children.cycles-pp.__fput
0.96 ± 7% -0.2 0.79 ± 6% perf-profile.children.cycles-pp.task_work_run
1.33 ± 8% -0.2 1.17 ± 7% perf-profile.children.cycles-pp.orc_find
2.31 ± 3% -0.2 2.15 ± 4% perf-profile.children.cycles-pp.__local_bh_enable_ip
2.29 ± 3% -0.2 2.13 ± 4% perf-profile.children.cycles-pp.do_softirq
0.69 ± 5% -0.1 0.57 ± 5% perf-profile.children.cycles-pp.__x64_sys_close
0.68 ± 5% -0.1 0.55 ± 5% perf-profile.children.cycles-pp.nfs4_file_flush
0.65 ± 9% -0.1 0.53 ± 7% perf-profile.children.cycles-pp.__filemap_fdatawait_range
0.69 ± 5% -0.1 0.57 ± 5% perf-profile.children.cycles-pp.filp_close
1.06 ± 5% -0.1 0.94 ± 5% perf-profile.children.cycles-pp.filemap_fdatawrite_wbc
0.66 ± 5% -0.1 0.54 ± 6% perf-profile.children.cycles-pp.filemap_write_and_wait_range
0.67 ± 5% -0.1 0.55 ± 5% perf-profile.children.cycles-pp.nfs_wb_all
0.64 ± 8% -0.1 0.56 ± 6% perf-profile.children.cycles-pp.stack_access_ok
0.22 ± 30% -0.1 0.14 ± 35% perf-profile.children.cycles-pp.process_srcu
0.23 ± 21% -0.1 0.16 ± 18% perf-profile.children.cycles-pp.flush_workqueue_prep_pwqs
0.23 ± 13% -0.1 0.18 ± 23% perf-profile.children.cycles-pp.__cond_resched
0.22 ± 17% -0.0 0.17 ± 6% perf-profile.children.cycles-pp.__filemap_get_folio
0.14 ± 15% -0.0 0.09 ± 30% perf-profile.children.cycles-pp.nfsd_file_mark_find_or_create
0.25 ± 6% -0.0 0.22 ± 10% perf-profile.children.cycles-pp.nfs_end_delegation_return
0.25 ± 6% -0.0 0.22 ± 10% perf-profile.children.cycles-pp.nfs_do_return_delegation
0.15 ± 5% -0.0 0.12 ± 7% perf-profile.children.cycles-pp.___slab_alloc
0.29 ± 7% -0.0 0.26 ± 6% perf-profile.children.cycles-pp.xlog_write
0.12 ± 9% -0.0 0.09 ± 11% perf-profile.children.cycles-pp.pagecache_get_page
0.12 ± 7% -0.0 0.10 ± 6% perf-profile.children.cycles-pp.kmem_cache_alloc_lru
0.08 ± 5% -0.0 0.07 ± 11% perf-profile.children.cycles-pp.d_alloc_parallel
0.42 ± 12% +0.2 0.66 ± 31% perf-profile.children.cycles-pp.queue_event
0.44 ± 12% +0.2 0.68 ± 29% perf-profile.children.cycles-pp.ordered_events__queue
11.69 ± 6% +1.7 13.37 ± 5% perf-profile.children.cycles-pp.svc_process_common
11.70 ± 6% +1.7 13.38 ± 5% perf-profile.children.cycles-pp.svc_process
11.18 ± 6% +1.7 12.90 ± 5% perf-profile.children.cycles-pp.nfsd_dispatch
10.84 ± 6% +1.7 12.58 ± 5% perf-profile.children.cycles-pp.nfsd4_proc_compound
6.58 ± 8% +2.0 8.60 ± 6% perf-profile.children.cycles-pp.nfsd4_open
3.70 ± 10% +2.2 5.92 ± 7% perf-profile.children.cycles-pp.nfsd4_process_open2
3.47 ± 11% +2.2 5.69 ± 7% perf-profile.children.cycles-pp.nfsd_file_acquire
3.48 ± 11% +2.2 5.70 ± 7% perf-profile.children.cycles-pp.nfs4_get_vfs_file
3.21 ± 11% +2.3 5.47 ± 7% perf-profile.children.cycles-pp.nfsd_file_lru_walk_list
2.99 ± 10% +2.3 5.31 ± 6% perf-profile.children.cycles-pp.__list_lru_walk_one
3.00 ± 10% +2.3 5.32 ± 6% perf-profile.children.cycles-pp.list_lru_walk_node
2.22 ± 6% -0.4 1.80 ± 5% perf-profile.self.cycles-pp.update_sg_lb_stats
1.91 ± 7% -0.2 1.70 ± 5% perf-profile.self.cycles-pp.unwind_next_frame
2.01 ± 6% -0.2 1.81 ± 7% perf-profile.self.cycles-pp.__orc_find
0.61 ± 9% -0.1 0.52 ± 7% perf-profile.self.cycles-pp.stack_access_ok
0.38 ± 6% -0.1 0.32 ± 8% perf-profile.self.cycles-pp.__schedule
0.25 ± 7% -0.0 0.22 ± 11% perf-profile.self.cycles-pp.perf_output_sample
0.10 ± 10% -0.0 0.07 ± 16% perf-profile.self.cycles-pp.core_kernel_text
0.11 ± 6% -0.0 0.08 ± 11% perf-profile.self.cycles-pp.finish_task_switch
0.69 ± 11% +0.1 0.83 ± 9% perf-profile.self.cycles-pp.nfsd_file_lru_cb
0.41 ± 12% +0.2 0.64 ± 30% perf-profile.self.cycles-pp.queue_event
2.26 ± 12% +2.1 4.38 ± 5% perf-profile.self.cycles-pp.__list_lru_walk_one
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[rseq] 3bb11f3f68: kernel-selftests.rseq.make_fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 3bb11f3f6872a692759f653f90d10674deb330a4 ("rseq: Remove broken uapi field layout on 32-bit little endian")
https://git.kernel.org/cgit/linux/kernel/git/stable/linux-stable-rc.git linux-5.15.y
in testcase: kernel-selftests
version: kernel-selftests-x86_64-8d3977ef-1_20220520
with following parameters:
group: rseq
ucode: 0xec
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 <oliver.sang(a)intel.com>
KERNEL SELFTESTS: linux_headers_dir is /usr/src/linux-headers-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4
2022-05-21 14:37:09 ln -sf /usr/bin/clang
2022-05-21 14:37:09 ln -sf /usr/bin/llc
2022-05-21 14:37:09 sed -i s/default_timeout=45/default_timeout=300/ kselftest/runner.sh
2022-05-21 14:37:09 make -C rseq
make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq'
gcc -O2 -Wall -g -I./ -I../../../../usr/include/ -L/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq -Wl,-rpath=./ -shared -fPIC rseq.c -lpthread -o /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq/librseq.so
In file included from rseq.c:30:
rseq.h: In function ‘rseq_clear_rseq_cs’:
rseq.h:143:20: error: request for member ‘ptr’ in something not a structure or union
143 | __rseq_abi.rseq_cs.ptr = 0;
| ^
make: *** [Makefile:27: /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq/librseq.so] Error 1
make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq'
2022-05-21 14:37:10 make run_tests -C rseq
make: Entering directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq'
gcc -O2 -Wall -g -I./ -I../../../../usr/include/ -L/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq -Wl,-rpath=./ -shared -fPIC rseq.c -lpthread -o /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq/librseq.so
In file included from rseq.c:30:
rseq.h: In function ‘rseq_clear_rseq_cs’:
rseq.h:143:20: error: request for member ‘ptr’ in something not a structure or union
143 | __rseq_abi.rseq_cs.ptr = 0;
| ^
make: *** [Makefile:27: /usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq/librseq.so] Error 1
make: Leaving directory '/usr/src/perf_selftests-x86_64-rhel-8.3-kselftests-3bb11f3f6872a692759f653f90d10674deb330a4/tools/testing/selftests/rseq'
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[cpuidle] 838eb0275b: WARNING:at_drivers/cpuidle/cpuidle.c:#cpuidle_enter_state
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 838eb0275bd0de47d42070585861f210596949d7 ("cpuidle: Move IRQ state validation")
https://git.kernel.org/cgit/linux/kernel/git/peterz/queue.git sched/idle
in testcase: xfstests
version: xfstests-x86_64-64f2596-1_20220520
with following parameters:
nr_pmem: 4
fs: xfs
test: generic-dax
ucode: 0x700001c
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: 16 threads 1 sockets Intel(R) Xeon(R) CPU D-1541 @ 2.10GHz with 48G 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>
[ 9.816269][ T0] WARNING: CPU: 0 PID: 0 at drivers/cpuidle/cpuidle.c:239 cpuidle_enter_state (drivers/cpuidle/cpuidle.c:239 (discriminator 1))
[ 9.817232][ T1] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
[ 9.826033][ T0] Modules linked in:
[ 9.835413][ T1] ACPI: button: Power Button [PWRB]
[ 9.838845][ T0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.18.0-rc7-00334-g838eb0275bd0 #1
[ 9.844142][ T1] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[ 9.852620][ T0] Hardware name: Supermicro SYS-5018D-FN4T/X10SDV-8C-TLN4F, BIOS 1.1 03/02/2016
[ 9.860977][ T1] ACPI: button: Power Button [PWRF]
[ 9.869591][ T0] RIP: 0010:cpuidle_enter_state (drivers/cpuidle/cpuidle.c:239 (discriminator 1))
[ 9.880379][ T0] Code: 24 08 48 8d 44 6d 00 48 8d 44 85 00 4c 8d 3c c5 18 00 00 00 48 83 fd 0a 0f 87 11 04 00 00 c6 04 24 00 4d 01 e7 e9 f3 f7 ff ff <0f> 0b fa e9 a4 f8 ff ff 83 c0 01 48 83 c1 40 44 39 c0 0f 8d c3 fa
All code
========
0: 24 08 and $0x8,%al
2: 48 8d 44 6d 00 lea 0x0(%rbp,%rbp,2),%rax
7: 48 8d 44 85 00 lea 0x0(%rbp,%rax,4),%rax
c: 4c 8d 3c c5 18 00 00 lea 0x18(,%rax,8),%r15
13: 00
14: 48 83 fd 0a cmp $0xa,%rbp
18: 0f 87 11 04 00 00 ja 0x42f
1e: c6 04 24 00 movb $0x0,(%rsp)
22: 4d 01 e7 add %r12,%r15
25: e9 f3 f7 ff ff jmpq 0xfffffffffffff81d
2a:* 0f 0b ud2 <-- trapping instruction
2c: fa cli
2d: e9 a4 f8 ff ff jmpq 0xfffffffffffff8d6
32: 83 c0 01 add $0x1,%eax
35: 48 83 c1 40 add $0x40,%rcx
39: 44 39 c0 cmp %r8d,%eax
3c: 0f .byte 0xf
3d: 8d (bad)
3e: c3 retq
3f: fa cli
Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: fa cli
3: e9 a4 f8 ff ff jmpq 0xfffffffffffff8ac
8: 83 c0 01 add $0x1,%eax
b: 48 83 c1 40 add $0x40,%rcx
f: 44 39 c0 cmp %r8d,%eax
12: 0f .byte 0xf
13: 8d (bad)
14: c3 retq
15: fa cli
[ 9.899818][ T0] RSP: 0000:ffffffff84407db8 EFLAGS: 00010202
[ 9.905739][ T0] RAX: 0000000000000292 RBX: ffffe8ffff600000 RCX: ffffffff835d9307
[ 9.913565][ T0] RDX: 1ffffffff0883858 RSI: 0000000000000008 RDI: ffffffff8441c2c0
[ 9.921394][ T0] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff8441c2c7
[ 9.929221][ T0] R10: fffffbfff0883858 R11: 0000000000000001 R12: ffffffff84d19400
[ 9.937046][ T0] R13: 0000000000000000 R14: ffffffff84d19458 R15: ffffffff84d19418
[ 9.944875][ T0] FS: 0000000000000000(0000) GS:ffff888b20000000(0000) knlGS:0000000000000000
[ 9.953654][ T0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 9.960094][ T0] CR2: ffff888c7fc01000 CR3: 0000000c7e00e001 CR4: 00000000003706f0
[ 9.967920][ T0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 9.975748][ T0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 9.983574][ T0] Call Trace:
[ 9.986722][ T0] <TASK>
[ 9.989521][ T0] ? menu_reflect (drivers/cpuidle/governors/menu.c:441)
[ 9.993975][ T0] ? __schedule (kernel/sched/core.c:6270)
[ 9.998421][ T0] cpuidle_enter (drivers/cpuidle/cpuidle.c:353)
[ 10.002695][ T0] cpuidle_idle_call (kernel/sched/idle.c:155 kernel/sched/idle.c:236)
[ 10.007487][ T0] ? arch_cpu_idle_exit+0xc0/0xc0
[ 10.012366][ T0] ? sched_clock_cpu (kernel/sched/clock.c:380)
[ 10.017161][ T0] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:58)
[ 10.022395][ T0] do_idle (kernel/sched/idle.c:303)
[ 10.026234][ T0] cpu_startup_entry (kernel/sched/idle.c:399 (discriminator 1))
[ 10.030855][ T0] rest_init (init/main.c:699)
[ 10.034953][ T0] arch_call_rest_init+0xf/0x15
[ 10.039660][ T0] start_kernel (init/main.c:1142)
[ 10.044020][ T0] secondary_startup_64_no_verify (arch/x86/kernel/head_64.S:358)
[ 10.049769][ T0] </TASK>
[ 10.052654][ T0] ---[ end trace 0000000000000000 ]---
[ 10.082035][ T1] ERST: Error Record Serialization Table (ERST) support is initialized.
[ 10.090228][ T1] pstore: Registered erst as persistent store backend
[ 10.097247][ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 10.104354][ T1] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 10.112783][ T1] 00:04: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[ 10.123272][ T1] Non-volatile memory driver v1.3
[ 10.134644][ T1] ACPI Warning: SystemIO range 0x0000000000000428-0x000000000000042F conflicts with OpRegion 0x0000000000000428-0x000000000000042F (GPE0) (20211217/utaddress-204)
[ 10.150815][ T1] ACPI: OSL: Resource conflict; ACPI support missing from driver?
[ 10.158474][ T1] ACPI Warning: SystemIO range 0x0000000000000500-0x000000000000052F conflicts with OpRegion 0x000000000000052C-0x000000000000052D (GPIV) (20211217/utaddress-204)
[ 10.174636][ T1] ACPI: OSL: Resource conflict; ACPI support missing from driver?
[ 10.182442][ T1] lpc_ich: Resource conflict(s) found affecting gpio_ich
[ 10.189781][ T1] rdac: device handler registered
[ 10.194881][ T1] hp_sw: device handler registered
[ 10.199846][ T1] emc: device handler registered
[ 10.204794][ T1] alua: device handler registered
[ 10.211059][ T1] e1000: Intel(R) PRO/1000 Network Driver
[ 10.216633][ T1] e1000: Copyright (c) 1999-2006 Intel Corporation.
[ 10.223160][ T1] e1000e: Intel(R) PRO/1000 Network Driver
[ 10.228819][ T1] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[ 10.235536][ T1] igb: Intel(R) Gigabit Ethernet Network Driver
[ 10.241629][ T1] igb: Copyright (c) 2007-2014 Intel Corporation.
[ 10.309124][ T1] igb 0000:05:00.0: added PHC on eth0
[ 10.314365][ T1] igb 0000:05:00.0: Intel(R) Gigabit Ethernet Network Connection
[ 10.321934][ T1] igb 0000:05:00.0: eth0: (PCIe:5.0Gb/s:Width x4) 0c:c4:7a:c4:ab:7a
[ 10.329841][ T1] igb 0000:05:00.0: eth0: PBA No: 010A00-000
[ 10.335671][ T1] igb 0000:05:00.0: Using MSI-X interrupts. 8 rx queue(s), 8 tx queue(s)
[ 10.344631][ T1] IOAPIC[8]: Set IRTE entry (P:1 FPD:0 Dst_Mode:0 Redir_hint:1 Trig_Mode:0 Dlvry_Mode:0 Avail:0 Vector:EF Dest:00000000 SID:F0FF SQ:0 SVT:1)
[ 10.358804][ T1] IOAPIC[0]: Preconfigured routing entry (8-17 -> IRQ 17 Level:1 ActiveLow:1)
[ 10.427383][ T1] igb 0000:05:00.1: added PHC on eth1
[ 10.432624][ T1] igb 0000:05:00.1: Intel(R) Gigabit Ethernet Network Connection
[ 10.440194][ T1] igb 0000:05:00.1: eth1: (PCIe:5.0Gb/s:Width x4) 0c:c4:7a:c4:ab:7b
[ 10.448097][ T1] igb 0000:05:00.1: eth1: PBA No: 010A00-000
[ 10.453929][ T1] igb 0000:05:00.1: Using MSI-X interrupts. 8 rx queue(s), 8 tx queue(s)
[ 10.462271][ T1] Intel(R) 2.5G Ethernet Linux Driver
[ 10.467496][ T1] Copyright(c) 2018 Intel Corporation.
[ 10.472883][ T1] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver
[ 10.479674][ T1] ixgbe: Copyright (c) 1999-2016 Intel Corporation.
[ 10.486717][ T1] ACPI Warning: _SB.PCI0.BR2C._PRT: Return Package has no elements (empty) (20211217/nsprepkg-94)
[ 10.499114][ T1] pmd_set_huge: Cannot satisfy [mem 0xfbc00000-0xfbe00000] with a huge-page mapping due to MTRR override.
[ 10.579121][ T122] tsc: Refined TSC clocksource calibration: 2099.998 MHz
[ 10.586023][ T122] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1e452ea631d, max_idle_ns: 440795244572 ns
[ 10.596813][ T122] clocksource: Switched to clocksource tsc
[ 11.893003][ T1] ixgbe 0000:03:00.0: Multiqueue Enabled: Rx Queue count = 16, Tx Queue count = 16 XDP Queue count = 0
[ 12.031135][ T1] ixgbe 0000:03:00.0: MAC: 5, PHY: 7, PBA No: 020C00-000
[ 12.038024][ T1] ixgbe 0000:03:00.0: 0c:c4:7a:c4:ad:e6
[ 12.106654][ T1] ixgbe 0000:03:00.0: Intel(R) 10 Gigabit Network Connection
[ 12.115142][ T1] ACPI Warning: _SB.PCI0.BR2C._PRT: Return Package has no elements (empty) (20211217/nsprepkg-94)
[ 12.127487][ T1] IOAPIC[9]: Set IRTE entry (P:1 FPD:0 Dst_Mode:0 Redir_hint:1 Trig_Mode:0 Dlvry_Mode:0 Avail:0 Vector:EF Dest:00000000 SID:002C SQ:0 SVT:1)
[ 12.141652][ T1] IOAPIC[1]: Preconfigured routing entry (9-12 -> IRQ 67 Level:1 ActiveLow:1)
[ 13.892952][ T1] ixgbe 0000:03:00.1: Multiqueue Enabled: Rx Queue count = 16, Tx Queue count = 16 XDP Queue count = 0
[ 14.031151][ T1] ixgbe 0000:03:00.1: MAC: 5, PHY: 7, PBA No: 020C00-000
[ 14.038043][ T1] ixgbe 0000:03:00.1: 0c:c4:7a:c4:ad:e7
[ 14.106642][ T1] ixgbe 0000:03:00.1: Intel(R) 10 Gigabit Network Connection
[ 14.114815][ T1] i40e: Intel(R) Ethernet Connection XL710 Network Driver
[ 14.121774][ T1] i40e: Copyright (c) 2013 - 2019 Intel Corporation.
[ 14.128711][ T1] usbcore: registered new interface driver r8152
[ 14.134951][ T1] usbcore: registered new interface driver asix
[ 14.141072][ T1] usbcore: registered new interface driver ax88179_178a
[ 14.148111][ T1] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 14.155339][ T1] ehci-pci: EHCI PCI platform driver
[ 14.162354][ T1] IOAPIC[8]: Set IRTE entry (P:1 FPD:0 Dst_Mode:0 Redir_hint:1 Trig_Mode:0 Dlvry_Mode:0 Avail:0 Vector:EF Dest:00000000 SID:F0FF SQ:0 SVT:1)
[ 14.176529][ T1] IOAPIC[0]: Preconfigured routing entry (8-18 -> IRQ 18 Level:1 ActiveLow:1)
[ 14.185346][ T1] ehci-pci 0000:00:1a.0: EHCI Host Controller
[ 14.191539][ T1] ehci-pci 0000:00:1a.0: new USB bus registered, assigned bus number 1
[ 14.199644][ T1] ehci-pci 0000:00:1a.0: debug port 2
[ 14.208883][ T1] ehci-pci 0000:00:1a.0: irq 18, io mem 0xfb414000
[ 14.222124][ T1] ehci-pci 0000:00:1a.0: USB 2.0 started, EHCI 1.00
[ 14.229019][ T1] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.18
[ 14.237977][ T1] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 14.245886][ T1] usb usb1: Product: EHCI Host Controller
[ 14.251458][ T1] usb usb1: Manufacturer: Linux 5.18.0-rc7-00334-g838eb0275bd0 ehci_hcd
[ 14.259632][ T1] usb usb1: SerialNumber: 0000:00:1a.0
[ 14.265743][ T1] hub 1-0:1.0: USB hub found
[ 14.270265][ T1] hub 1-0:1.0: 2 ports detected
[ 14.277856][ T1] ehci-pci 0000:00:1d.0: EHCI Host Controller
[ 14.284031][ T1] ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 14.292159][ T1] ehci-pci 0000:00:1d.0: debug port 2
[ 14.301412][ T1] ehci-pci 0000:00:1d.0: irq 18, io mem 0xfb413000
[ 14.314125][ T1] ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 2 weeks
[drm/ttm] 47e8c5019b: BUG:kernel_NULL_pointer_dereference,address
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 47e8c5019b432cfa8f875fe068254b8d4e2dd3c6 ("[PATCH 10/11] drm/ttm: stop allocating dummy resources during BO creation")
url: https://github.com/intel-lab-lkp/linux/commits/Christian-K-nig/drm-radeon...
base: git://anongit.freedesktop.org/drm/drm-tip drm-tip
patch link: https://lore.kernel.org/intel-gfx/20220519095508.115203-11-christian.koen...
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):
+---------------------------------------------+------------+------------+
| | abd7815e9a | 47e8c5019b |
+---------------------------------------------+------------+------------+
| boot_successes | 36 | 0 |
| boot_failures | 0 | 36 |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 36 |
| Oops:#[##] | 0 | 36 |
| RIP:ttm_bo_move_memcpy[ttm] | 0 | 36 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 36 |
+---------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang(a)intel.com>
[ 9.741361][ T197] BUG: kernel NULL pointer dereference, address: 0000000000000010
[ 9.742532][ T197] #PF: supervisor read access in kernel mode
[ 9.743345][ T197] #PF: error_code(0x0000) - not-present page
[ 9.744148][ T197] PGD 0 P4D 0
[ 9.744608][ T197] Oops: 0000 [#1] SMP PTI
[ 9.745191][ T197] CPU: 0 PID: 197 Comm: systemd-udevd Not tainted 5.18.0-rc7-01546-g47e8c5019b43 #1
[ 9.746444][ T197] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.0-debian-1.16.0-4 04/01/2014
[ 9.747818][ T197] RIP: 0010:ttm_bo_move_memcpy (include/drm/ttm/ttm_device.h:285 drivers/gpu/drm/ttm/ttm_bo_util.c:141) ttm
[ 9.748653][ T197] Code: 01 00 00 65 48 8b 04 25 28 00 00 00 48 89 44 24 50 31 c0 48 63 42 10 4d 8b bc c6 90 00 00 00 48 8b 87 58 01 00 00 48 89 04 24 <48> 63 40 10 49 8b 84 c6 90 00 00 00 48 89 44 24 08 4d 85 ed 74 16
All code
========
0: 01 00 add %eax,(%rax)
2: 00 65 48 add %ah,0x48(%rbp)
5: 8b 04 25 28 00 00 00 mov 0x28,%eax
c: 48 89 44 24 50 mov %rax,0x50(%rsp)
11: 31 c0 xor %eax,%eax
13: 48 63 42 10 movslq 0x10(%rdx),%rax
17: 4d 8b bc c6 90 00 00 mov 0x90(%r14,%rax,8),%r15
1e: 00
1f: 48 8b 87 58 01 00 00 mov 0x158(%rdi),%rax
26: 48 89 04 24 mov %rax,(%rsp)
2a:* 48 63 40 10 movslq 0x10(%rax),%rax <-- trapping instruction
2e: 49 8b 84 c6 90 00 00 mov 0x90(%r14,%rax,8),%rax
35: 00
36: 48 89 44 24 08 mov %rax,0x8(%rsp)
3b: 4d 85 ed test %r13,%r13
3e: 74 16 je 0x56
Code starting with the faulting instruction
===========================================
0: 48 63 40 10 movslq 0x10(%rax),%rax
4: 49 8b 84 c6 90 00 00 mov 0x90(%r14,%rax,8),%rax
b: 00
c: 48 89 44 24 08 mov %rax,0x8(%rsp)
11: 4d 85 ed test %r13,%r13
14: 74 16 je 0x2c
[ 9.751280][ T197] RSP: 0000:ffffa9e28060b880 EFLAGS: 00010246
[ 9.752060][ T197] RAX: 0000000000000000 RBX: ffff9781d1227010 RCX: ffff9781cb56aba0
[ 9.753116][ T197] RDX: ffff9781cb56aba0 RSI: ffffa9e28060b9e8 RDI: ffff978180874200
[ 9.754196][ T197] RBP: ffff978180874200 R08: ffffa9e28060b968 R09: ffff9781d2aa8000
[ 9.755274][ T197] R10: 00000000001003e8 R11: 0000000000000000 R12: ffff9781cb56aba0
[ 9.756329][ T197] R13: ffff9781d2e51780 R14: ffff9781d1227010 R15: ffff9781d1227028
[ 9.757385][ T197] FS: 00007f0da77c1d40(0000) GS:ffff9784afc00000(0000) knlGS:0000000000000000
[ 9.758553][ T197] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 9.759459][ T197] CR2: 0000000000000010 CR3: 000000042fd9a000 CR4: 00000000000406f0
[ 9.760463][ T197] Call Trace:
[ 9.760909][ T197] <TASK>
[ 9.761302][ T197] ? kvmalloc_node (mm/util.c:586)
[ 9.761951][ T197] ttm_bo_handle_move_mem (drivers/gpu/drm/ttm/ttm_bo.c:154) ttm
[ 9.762735][ T197] ttm_bo_validate (drivers/gpu/drm/ttm/ttm_bo.c:871 drivers/gpu/drm/ttm/ttm_bo.c:902) ttm
[ 9.763462][ T197] ? drm_vma_offset_add (include/drm/drm_mm.h:439 include/drm/drm_mm.h:462 drivers/gpu/drm/drm_vma_manager.c:209) drm
[ 9.764276][ T197] ttm_bo_init_validate (drivers/gpu/drm/ttm/ttm_bo.c:994) ttm
[ 9.765052][ T197] drm_gem_vram_create (drivers/gpu/drm/drm_gem_vram_helper.c:232) drm_vram_helper
[ 9.765932][ T197] ? bo_driver_evict_flags (drivers/gpu/drm/drm_gem_vram_helper.c:131) drm_vram_helper
[ 9.766866][ T197] drm_gem_vram_fill_create_dumb (drivers/gpu/drm/drm_gem_vram_helper.c:526) drm_vram_helper
[ 9.767857][ T197] drm_client_framebuffer_create (drivers/gpu/drm/drm_client.c:269 drivers/gpu/drm/drm_client.c:419) drm
[ 9.768773][ T197] drm_fb_helper_generic_probe (drivers/gpu/drm/drm_fb_helper.c:2375 (discriminator 4)) drm_kms_helper
[ 9.769762][ T197] drm_fb_helper_single_fb_probe (drivers/gpu/drm/drm_fb_helper.c:1706) drm_kms_helper
[ 9.770775][ T197] __drm_fb_helper_initial_config_and_unlock (drivers/gpu/drm/drm_fb_helper.c:1870) drm_kms_helper
[ 9.771940][ T197] drm_fbdev_client_hotplug (drivers/gpu/drm/drm_fb_helper.c:1964 drivers/gpu/drm/drm_fb_helper.c:1956 drivers/gpu/drm/drm_fb_helper.c:2478) drm_kms_helper
[ 9.772899][ T197] drm_fbdev_generic_setup (drivers/gpu/drm/drm_fb_helper.c:2565) drm_kms_helper
[ 9.773835][ T197] bochs_pci_probe (drivers/gpu/drm/tiny/bochs.c:667 drivers/gpu/drm/tiny/bochs.c:632) bochs
[ 9.774572][ T197] local_pci_probe (drivers/pci/pci-driver.c:323)
[ 9.777192][ T197] pci_call_probe (drivers/pci/pci-driver.c:391)
[ 9.777890][ T197] ? kernfs_create_link (fs/kernfs/symlink.c:48)
[ 9.778587][ T197] pci_device_probe (drivers/pci/pci-driver.c:460)
[ 9.779279][ T197] really_probe (drivers/base/dd.c:542 drivers/base/dd.c:621)
[ 9.779889][ T197] __driver_probe_device (drivers/base/dd.c:752)
[ 9.780598][ T197] driver_probe_device (drivers/base/dd.c:782)
[ 9.781283][ T197] __driver_attach (drivers/base/dd.c:1142)
[ 9.781924][ T197] ? __device_attach_driver (drivers/base/dd.c:1094)
[ 9.782704][ T197] ? __device_attach_driver (drivers/base/dd.c:1094)
[ 9.783436][ T197] bus_for_each_dev (drivers/base/bus.c:301)
[ 9.783998][ T197] bus_add_driver (drivers/base/bus.c:619)
[ 9.784631][ T197] driver_register (drivers/base/driver.c:171)
[ 9.785273][ T197] ? 0xffffffffc0532000
[ 9.785837][ T197] do_one_initcall (init/main.c:1298)
[ 9.786481][ T197] ? kmem_cache_alloc_trace (mm/slub.c:3219 mm/slub.c:3225 mm/slub.c:3256)
[ 9.787268][ T197] do_init_module (kernel/module.c:3731)
[ 9.787931][ T197] __do_sys_finit_module (kernel/module.c:4222)
[ 9.788650][ T197] do_syscall_64 (arch/x86/entry/common.c:50 arch/x86/entry/common.c:80)
[ 9.789258][ T197] entry_SYSCALL_64_after_hwframe (arch/x86/entry/entry_64.S:115)
[ 9.790062][ T197] RIP: 0033:0x7f0da7fabf59
[ 9.790654][ T197] 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
To reproduce:
# build kernel
cd linux
cp config-5.18.0-rc7-01546-g47e8c5019b43 .config
make HOSTCC=gcc-11 CC=gcc-11 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-11 CC=gcc-11 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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 3 weeks
[perf vendor events] 8f5e6110e1: perf-sanity-tests.Parsing_of_PMU_event_table_metrics_with_fake_PMUs.fail
by kernel test robot
(please be noted we reported
"[perf vendor events] 3f5f0df7bf: perf-sanity-tests.perf_all_metrics_test.fail"
on:
https://lore.kernel.org/all/[email protected]/
for:
commit: 3f5f0df7bf0f8c48d33d43454fc0b7d0f3ab9537 ("perf vendor events: Update metrics for Skylake")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
which rasied a lot of discussion at that time.
we noticed there are obvious difference between two commits, failed on
different cases. we just report this out FYI)
Greeting,
FYI, we noticed the following commit (built with gcc-11):
commit: 8f5e6110e108ba69e59aa04c49697b3477710d27 ("perf vendor events: Update metrics for SkyLake Server")
https://git.kernel.org/cgit/linux/kernel/git/stable/linux-stable-rc.git linux-5.15.y
in testcase: perf-sanity-tests
version: perf-x86_64-2fe1020d73ca-1_20220514
with following parameters:
perf_compiler: clang
ucode: 0xec
on test machine: 4 threads Intel(R) Core(TM) i5-6500 CPU @ 3.20GHz 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>
2022-05-20 01:50:38 sudo /usr/src/perf_selftests-x86_64-rhel-8.3-func-8f5e6110e108ba69e59aa04c49697b3477710d27/tools/perf/perf test 10
10: PMU events :
10.1: PMU event table sanity : Ok
10.2: PMU event map aliases : Ok
10.3: Parsing of PMU event table metrics : Skip (some metrics failed)
10.4: Parsing of PMU event table metrics with fake PMUs : FAILED!
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.
--
0-DAY CI Kernel Test Service
https://01.org/lkp
2 months, 3 weeks