[lkp] [x86] 73e1ae3538: BUG: unable to handle kernel paging requestpaging request at b15be1c0
by kernel test robot
FYI, we noticed the following commit:
https://git.kernel.org/pub/scm/linux/kernel/git/kees/linux.git kspp/ro_after_init
commit 73e1ae35381284e2fe0a6adf8d534c96a2715880 ("x86: apply more __ro_after_init and const")
on test machine: vm-kbuild-yocto-i386: 2 threads qemu-system-i386 -enable-kvm with 320M memory
caused below changes:
+-------------------------------------------------------------------------------------------+------------+------------+
| | 28165ec7a9 | 73e1ae3538 |
+-------------------------------------------------------------------------------------------+------------+------------+
| boot_successes | 363 | 6 |
| boot_failures | 203 | 560 |
| BUG:workqueue_lockup-pool | 175 | 125 |
| BUG:workqueue_lockup-pool_cpus=#cpus=#node=#node=#flags=#nice=#flags=#nice=#stuck_for#s | 172 | 124 |
| BUG:kernel_test_crashed | 18 | |
| INFO:task_blocked_for_more_than#seconds | 3 | 2 |
| BUG:kernel_test_hang | 9 | 2 |
| backtrace:lock_torture_stats | 2 | |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 2 | 4 |
| backtrace:lock_torture_writer | 2 | 4 |
| backtrace:schedule_timeout | 2 | 4 |
| backtrace:ring_buffer_producer_thread | 1 | 2 |
| BUG:workqueue_lockup-pool_cpus=#node=#flags=#nice=#stuck_for#s | 1 | |
| BUG:workqueue_lockup-pool_cpus=#-#cpus=#-#flags=#nice=#flags=#nice=#stuck_for#s | 7 | 3 |
| BUG:workqueue_lockup-pool_cpus=#cpus=#node=#node=#flags=#nice=-#flags=#nice=-#stuck_for#s | 1 | |
| BUG:unable_to_handle_kernel | 0 | 410 |
| Oops | 0 | 433 |
| EIP_is_at_native_set_pte_at | 0 | 432 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 433 |
| backtrace:pcpu_balance_workfn | 0 | 428 |
| ops:#[##]SMP | 0 | 2 |
| backtrace:thread | 0 | 1 |
| backtrace:Setsos_one_work | 0 | 1 |
| backtrace:trace_hardirqs_on | 0 | 1 |
| backtrace:uer_thread | 0 | 1 |
| backtrace:d | 0 | 1 |
| backtrace:pcp00u_balance_workfn | 0 | 1 |
| backtrace:scuer_thread | 0 | 1 |
| backtrace:_thread | 0 | 1 |
| Oops:#[##] | 0 | 1 |
| backtrace:rdirqs_on | 0 | 1 |
| backtrace:SYSC_perf_event_open | 0 | 1 |
| backtrace:SyS_perf_event_open | 0 | 1 |
| backtrace:k_is_held | 0 | 1 |
+-------------------------------------------------------------------------------------------+------------+------------+
[ 63.900921] Writes: Total: 4 Max/Min: 0/0 Fail: 0
[ 63.900921] Writes: Total: 4 Max/Min: 0/0 Fail: 0
[ 68.[main] Setsockopt(1 b 8e76000 cc) on fd 176 [1:5:1]262351] BUG: unable to handle kernel
[ 68.262351] BUG: unable to handle kernel paging requestpaging request at b15be1c0
at b15be1c0
[ 68.283065] IP:
[ 68.283065] IP: [<b1030ec0>] native_set_pte_at+0x7/0xa
[<b1030ec0>] native_set_pte_at+0x7/0xa
[ 68.284387] *pde = 0edd5063
[ 68.284387] *pde = 0edd5063 *pte = 015be161 *pte = 015be161
[ 68.301682] Oops: 0003 [#1] SMP
[ 68.301682] Oops: 0003 [#1] SMP
[ 68.302479] Modules linked in:
[ 68.302479] Modules linked in:
[ 68.303268] CPU: 0 PID: 4 Comm: kworker/0:0 Not tainted 4.6.0-10531-g73e1ae3 #1
[ 68.303268] CPU: 0 PID: 4 Comm: kworker/0:0 Not tainted 4.6.0-10531-g73e1ae3 #1
FYI, raw QEMU command line is:
qemu-system-i386 -enable-kvm -kernel /pkg/linux/i386-randconfig-c0-05261310/gcc-6/73e1ae35381284e2fe0a6adf8d534c96a2715880/vmlinuz-4.6.0-10531-g73e1ae3 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-i386-11/reconfirm_boot-1-yocto-minimal-i386.cgz-i386-randconfig-c0-05261310-73e1ae35381284e2fe0a6adf8d534c96a2715880-20160528-20313-pt6qb5-21.yaml ARCH=i386 kconfig=i386-randconfig-c0-05261310 branch=linux-devel/devel-hourly-2016052611 commit=73e1ae35381284e2fe0a6adf8d534c96a2715880 BOOT_IMAGE=/pkg/linux/i386-randconfig-c0-05261310/gcc-6/73e1ae35381284e2fe0a6adf8d534c96a2715880/vmlinuz-4.6.0-10531-g73e1ae3 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-i386/yocto-minimal-i386.cgz/i386-randconfig-c0-05261310/gcc-6/73e1ae35381284e2fe0a6adf8d534c96a2715880/115 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-kbuild-yocto-i386-11::dhcp drbd.minor_count=8' -initrd /fs/sdc1/initrd-vm-kbuild-yocto-i386-11 -m 320 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/sdc1/disk0-vm-kbuild-yocto-i386-11,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-i386-11 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-i386-11 -daemonize -display none -monitor null
Thanks,
Xiaolong
4 years, 7 months
[lkp] [chrdev] 65e5b1e9eb: BUG: unable to handle kernel NULL pointer dereference at 0000000000000034
by kernel test robot
FYI, we noticed the following commit:
https://git.kernel.org/pub/scm/linux/kernel/git/linusw/linux-gpio.git chrdev-warn
commit 65e5b1e9eb3f777ab7535b74b490e882eeec79d7 ("chrdev: allocate dynamic chardevs in all unused holes")
on test machine: vm-lkp-wsx03-2G: 2 threads qemu-system-x86_64 -enable-kvm -cpu host with 2G memory
caused below changes:
+------------------------------------------------------------------+------------+------------+
| | 7639dad93a | 65e5b1e9eb |
+------------------------------------------------------------------+------------+------------+
| boot_successes | 29 | 0 |
| boot_failures | 39 | 30 |
| Mem-Info | 4 | |
| Out_of_memory:Kill_process | 4 | |
| backtrace:__mm_populate | 3 | |
| backtrace:SyS_mlockall | 3 | |
| BUG:kernel_test_crashed | 1 | |
| invoked_oom-killer:gfp_mask=0x | 2 | |
| backtrace:SYSC_newfstatat | 1 | |
| backtrace:SyS_newfstatat | 1 | |
| Kernel_panic-not_syncing:Out_of_memory_and_no_killable_processes | 1 | |
| backtrace:_do_fork | 1 | |
| backtrace:SyS_clone | 1 | |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 34 | |
| BUG:unable_to_handle_kernel | 0 | 30 |
| Oops | 0 | 30 |
| RIP:tty_port_link_device | 0 | 30 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 30 |
| backtrace:init | 0 | 30 |
| backtrace:kernel_init_freeable | 0 | 30 |
+------------------------------------------------------------------+------------+------------+
[ 21.363761] hub 1-0:1.0: USB hub found
[ 21.364285] hub 1-0:1.0: 1 port detected
[ 21.366121] userial_init: cannot register, err -16
[ 21.366730] BUG: unable to handle kernel NULL pointer dereference at 0000000000000034
[ 21.367741] IP: [<ffffffff99467a51>] tty_port_link_device+0x16/0x52
[ 21.368520] PGD 0
[ 21.368799] Oops: 0000 [#1] SMP DEBUG_PAGEALLOC
[ 21.369379] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 4.6.0-08908-g65e5b1e #1
[ 21.370227] task: ffff880075f78000 ti: ffff880075f54000 task.ti: ffff880075f54000
[ 21.371117] RIP: 0010:[<ffffffff99467a51>] [<ffffffff99467a51>] tty_port_link_device+0x16/0x52
[ 21.372226] RSP: 0000:ffff880075f57c90 EFLAGS: 00010296
[ 21.372863] RAX: 00000000ffffffff RBX: 0000000000000000 RCX: 0000000000000000
[ 21.373723] RDX: ffff880075f78000 RSI: 0000000000000000 RDI: ffff880059d9b000
[ 21.374616] RBP: ffff880075f57ca8 R08: 0000000000000002 R09: 0000000000716391
[ 21.375457] R10: ffff880075f57ce8 R11: 00000000001d53a0 R12: 0000000000000000
[ 21.376261] R13: ffff880059d9b000 R14: ffff880059c9a170 R15: ffff880059d9b000
[ 21.377094] FS: 0000000000000000(0000) GS:ffff880078400000(0000) knlGS:0000000000000000
[ 21.378064] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 21.378733] CR2: 0000000000000034 CR3: 000000001a406000 CR4: 00000000000006e0
[ 21.379614] Stack:
[ 21.379890] 0000000000000000 0000000000000000 0000000000000000 ffff880075f57cd8
[ 21.380844] ffffffff99467ab8 ffff880059d9b000 0000000000000000 ffffffff9c3e1d40
[ 21.381769] 0000000000000000 ffff880075f57d10 ffffffff9996a258 fffffffffffffff4
[ 21.382706] Call Trace:
[ 21.383020] [<ffffffff99467ab8>] tty_port_register_device+0x2b/0x41
[ 21.383766] [<ffffffff9996a258>] gserial_alloc_line+0x1b5/0x222
[ 21.384487] [<ffffffff999683da>] acm_alloc_instance+0x4a/0x8b
[ 21.385183] [<ffffffff9993faab>] usb_get_function_instance+0x64/0xc0
[ 21.386011] [<ffffffff9996b144>] serial_register_ports+0x66/0x173
[ 21.386877] [<ffffffff9996b33c>] gs_bind+0xeb/0x196
[ 21.387460] [<ffffffff9993f590>] composite_bind+0xa6/0x217
[ 21.388121] [<ffffffff99942ba6>] udc_bind_to_driver+0x38/0x107
[ 21.388817] [<ffffffff99943a74>] usb_gadget_probe_driver+0x17e/0x19c
[ 21.389554] [<ffffffff9a78c922>] ? set_debug_rodata+0x20/0x20
[ 21.390255] [<ffffffff9993f7b9>] usb_composite_probe+0xb8/0xc7
[ 21.390956] [<ffffffff9a7d490a>] ? obexmod_init+0x17/0x17
[ 21.391599] [<ffffffff9a7d49c2>] init+0xb8/0xba
[ 21.392199] [<ffffffff9a78d22c>] do_one_initcall+0xa2/0x14f
[ 21.392882] [<ffffffff9a78c922>] ? set_debug_rodata+0x20/0x20
[ 21.393557] [<ffffffff9a78d41f>] kernel_init_freeable+0x146/0x1ec
[ 21.394300] [<ffffffff99d8c409>] kernel_init+0xf/0x147
[ 21.394919] [<ffffffff99d9261f>] ret_from_fork+0x1f/0x40
[ 21.395556] [<ffffffff99d8c3fa>] ? rest_init+0xd1/0xd1
[ 21.396166] Code: b4 03 00 00 4c 1d 00 00 c7 83 bc 03 00 00 01 00 00 00 5b 5d c3 55 48 89 e5 41 55 41 54 53 49 89 f4 89 d3 49 89 fd e8 b2 f9 cd ff <41> 39 5c 24 34 77 18 e8 a6 f9 cd ff be 31 00 00 00 48 c7 c7 06
[ 21.399494] RIP [<ffffffff99467a51>] tty_port_link_device+0x16/0x52
[ 21.400273] RSP <ffff880075f57c90>
[ 21.400691] CR2: 0000000000000034
[ 21.401105] ---[ end trace 46d7785ef88d7377 ]---
[ 21.401657] Kernel panic - not syncing: Fatal exception
FYI, raw QEMU command line is:
qemu-system-x86_64 -enable-kvm -cpu host -kernel /pkg/linux/x86_64-randconfig-s4-05261647/gcc-6/65e5b1e9eb3f777ab7535b74b490e882eeec79d7/vmlinuz-4.6.0-08908-g65e5b1e -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-wsx03-2G-11/bisect_boot-1-debian-x86_64-2015-02-07.cgz-x86_64-randconfig-s4-05261647-65e5b1e9eb3f777ab7535b74b490e882eeec79d7-20160526-105676-cttolm-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s4-05261647 branch=linux-devel/devel-hourly-2016052613 commit=65e5b1e9eb3f777ab7535b74b490e882eeec79d7 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s4-05261647/gcc-6/65e5b1e9eb3f777ab7535b74b490e882eeec79d7/vmlinuz-4.6.0-08908-g65e5b1e max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-2G/debian-x86_64-2015-02-07.cgz/x86_64-randconfig-s4-05261647/gcc-6/65e5b1e9eb3f777ab7535b74b490e882eeec79d7/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-lkp-wsx03-2G-11::dhcp' -initrd /fs/sdc1/initrd-vm-lkp-wsx03-2G-11 -m 2048 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0,hostfwd=tcp::23630-:22 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/sdc1/disk0-vm-lkp-wsx03-2G-11,media=disk,if=virtio -drive file=/fs/sdc1/disk1-vm-lkp-wsx03-2G-11,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-lkp-wsx03-2G-11 -serial file:/dev/shm/kboot/serial-vm-lkp-wsx03-2G-11 -daemonize -display none -monitor null
Thanks,
Xiaolong
4 years, 7 months
[lkp] [posix_acl] c6ae1b8724: xfstests.generic.314.fail
by kernel test robot
FYI, we noticed the following commit:
https://github.com/0day-ci/linux Jan-Kara/posix_acl-Add-inode-parameter-to-posix_acl_equiv_mode/20160526-231213
commit c6ae1b87246086fbf09b3075edd5b3bf3339e71f ("posix_acl: Clear SGID bit when modifying file permissions")
in testcase: xfstests
with following parameters: disk=4HDD/fs=btrfs/test=generic-quick2
on test machine: lkp-ws02: threads Westmere-EP with 16G memory
caused below changes:
2016-05-29 14:47:10 export TEST_DIR=/fs/sdd1
2016-05-29 14:47:10 export TEST_DEV=/dev/sdd1
2016-05-29 14:47:10 export FSTYP=btrfs
2016-05-29 14:47:10 export SCRATCH_MNT=/fs/scratch
2016-05-29 14:47:10 mkdir /fs/scratch -p
2016-05-29 14:47:10 export SCRATCH_DEV_POOL="/dev/sdh1 /dev/sdk1 /dev/sdg1"
2016-05-29 14:47:10 ./check generic/088 generic/089 generic/090 generic/091 generic/092 generic/096 generic/098 generic/100 generic/101 generic/102 generic/103 generic/104 generic/105 generic/106 generic/107 generic/109 generic/120 generic/123 generic/124 generic/126 generic/129 generic/130 generic/131 generic/135 generic/141 generic/169 generic/184 generic/193 generic/198 generic/204 generic/207 generic/210 generic/211 generic/212 generic/213 generic/214 generic/215 generic/219 generic/221 generic/228 generic/234 generic/235 generic/236 generic/237 generic/239 generic/240 generic/245 generic/246 generic/247 generic/248 generic/249 generic/255 generic/257 generic/258 generic/277 generic/280 generic/285 generic/286 generic/294 generic/300 generic/306 generic/307 generic/308 generic/309 generic/312 generic/313 generic/314 generic/315 generic/316 generic/317 generic/318 generic/319 generic/320 generic/321 generic/322 generic/325
FSTYP -- btrfs
PLATFORM -- Linux/x86_64 lkp-ws02 4.6.0-rc7-00098-gc6ae1b8
MKFS_OPTIONS -- /dev/sdh1
MOUNT_OPTIONS -- /dev/sdh1 /fs/scratch
generic/088 1s
generic/089 8s
generic/090 1s
generic/091 157s
generic/092 1s
generic/096 [not run] xfs_io fzero failed (old kernel/wrong fs?)
generic/098 1s
generic/100 16s
generic/101 1s
generic/102 2s
generic/103 1s
generic/104 1s
generic/105 1s
generic/106 1s
generic/107 1s
generic/109 1s
generic/120 16s
generic/123 1s
generic/124 2s
generic/126 0s
generic/129 3s
generic/130 11s
generic/131 2s
generic/135 1s
generic/141 1s
generic/169 1s
generic/184 0s
generic/193 1s
generic/198 1s
generic/204 3s
generic/207 17s
generic/210 1s
generic/211 0s
generic/212 0s
generic/213 1s
generic/214 1s
generic/215 3s
generic/219 [not run] disk quotas not supported by this filesystem type: btrfs
generic/221 2s
generic/228 1s
generic/234 [not run] disk quotas not supported by this filesystem type: btrfs
generic/235 [not run] disk quotas not supported by this filesystem type: btrfs
generic/236 1s
generic/237 0s
generic/239 10s
generic/240 1s
generic/245 1s
generic/246 0s
generic/247 20s
generic/248 0s
generic/249 1s
generic/255 1s
generic/257 0s
generic/258 0s
generic/277 2s
generic/280 [not run] disk quotas not supported by this filesystem type: btrfs
generic/285 0s
generic/286 2s
generic/294 1s
generic/300 30s
generic/306 1s
generic/307 2s
generic/308 0s
generic/309 2s
generic/312 1s
generic/313 4s
generic/314 - output mismatch (see /lkp/benchmarks/xfstests/results//generic/314.out.bad)
--- tests/generic/314.out 2015-12-18 15:28:50.000000000 +0800
+++ /lkp/benchmarks/xfstests/results//generic/314.out.bad 2016-05-29 14:53:26.566920434 +0800
@@ -1,3 +1,3 @@
QA output created by 314
drwxr-sr-x subdir
-drwxrwsr-x+ subdir2
+drwxrwxr-x+ subdir2
...
(Run 'diff -u tests/generic/314.out /lkp/benchmarks/xfstests/results//generic/314.out.bad' to see the entire diff)
generic/315 1s
generic/316 1s
generic/317 1s
generic/318 1s
generic/319 0s
generic/320 63s
generic/321 2s
generic/322 2s
generic/325 1s
Ran: generic/088 generic/089 generic/090 generic/091 generic/092 generic/098 generic/100 generic/101 generic/102 generic/103 generic/104 generic/105 generic/106 generic/107 generic/109 generic/120 generic/123 generic/124 generic/126 generic/129 generic/130 generic/131 generic/135 generic/141 generic/169 generic/184 generic/193 generic/198 generic/204 generic/207 generic/210 generic/211 generic/212 generic/213 generic/214 generic/215 generic/221 generic/228 generic/236 generic/237 generic/239 generic/240 generic/245 generic/246 generic/247 generic/248 generic/249 generic/255 generic/257 generic/258 generic/277 generic/285 generic/286 generic/294 generic/300 generic/306 generic/307 generic/308 generic/309 generic/312 generic/313 generic/314 generic/315 generic/316 generic/317 generic/318 generic/319 generic/320 generic/321 generic/322 generic/325
Not run: generic/096 generic/219 generic/234 generic/235 generic/280
Failures: generic/314
Failed 1 of 71 tests
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Xiaolong
4 years, 7 months
[fs] 465b34d93f: BUG: unable to handle kernel paging request at 00000000f000023a
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/ebiederm/user-namespace.git for-testing
commit 465b34d93fba71aa0bd3bd120c7e4eef7ef5920e
Author: Eric W. Biederman <ebiederm(a)xmission.com>
AuthorDate: Tue May 24 09:29:01 2016 -0500
Commit: Eric W. Biederman <ebiederm(a)xmission.com>
CommitDate: Fri May 27 11:52:29 2016 -0500
fs: Add user namesapace member to struct super_block
Start marking filesystems with a user namespace owner, s_user_ns. In
this change this is only used for permission checks of who may mount a
filesystem. Ultimately s_user_ns will be used for translating ids and
checking capabilities for filesystems mounted from user namespaces.
The default policy for setting s_user_ns is implemented in sget(),
which arranges for s_user_ns to be set to current_user_ns() and to
ensure that the mounter of the filesystem has CAP_SYS_ADMIN in that
user_ns.
The guts of sget are split out into another function sget_userns().
The function sget_userns calls alloc_super with the specified user
namespace or it verifies the existing superblock that was found
has the expected user namespace, and fails with EBUSY when it is not.
This failing prevents users with the wrong privileges mounting a
filesystem.
The reason for the split of sget_userns from sget is that in some
cases such as mount_ns and kernfs_mount_ns a different policy for
permission checking of mounts and setting s_user_ns is necessary, and
the existence of sget_userns() allows those policies to be
implemented.
The helper mount_ns is expected to be used for filesystems such as
proc and mqueuefs which present per namespace information. The
function mount_ns is modified to call sget_userns instead of sget to
ensure the user namespace owner of the namespace whose information is
presented by the filesystem is used on the superblock.
For sysfs and cgroup the appropriate permission checks are already in
place, and kernfs_mount_ns is modified to call sget_userns so that
the init_user_ns is the only user namespace used.
For the cgroup filesystem cgroup namespace mounts are bind mounts of a
subset of the full cgroup filesystem and as such s_user_ns must be the
same for all of them as there is only a single superblock.
Mounts of sysfs that vary based on the network namespace could in principle
change s_user_ns but it keeps the analysis and implementation of kernfs
simpler if that is not supported, and at present there appear to be no
benefits from supporting a different s_user_ns on any sysfs mount.
Getting the details of setting s_user_ns correct has been
a long process. Thanks to Pavel Tikhorirorv who spotted a leak
in sget_userns. Thanks to Seth Forshee who has kept the work alive.
Thanks-to: Seth Forshee <seth.forshee(a)canonical.com>
Thanks-to: Pavel Tikhomirov <ptikhomirov(a)virtuozzo.com>
Signed-off-by: Eric W. Biederman <ebiederm(a)xmission.com>
+--------------------------------------------------------------------------+------------+------------+-----------------+
| | 8251ce8a7d | 465b34d93f | v4.7-rc1_053003 |
+--------------------------------------------------------------------------+------------+------------+-----------------+
| boot_successes | 1216 | 302 | 123 |
| boot_failures | 8 | 12 | 9 |
| BUG:kernel_test_crashed | 8 | 3 | 1 |
| general_protection_fault:#[##]SMP | 0 | 8 | 3 |
| RIP:sget_userns | 0 | 9 | 3 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 9 | 7 |
| backtrace:kern_mount_data | 0 | 9 | 3 |
| backtrace:mq_init_ns | 0 | 9 | 3 |
| backtrace:unshare_nsproxy_namespaces | 0 | 9 | 3 |
| backtrace:SyS_unshare | 0 | 9 | 3 |
| BUG:unable_to_handle_kernel | 0 | 1 | 4 |
| Oops | 0 | 1 | 4 |
| RIP:__alloc_pages_nodemask | 0 | 0 | 4 |
| backtrace:pcpu_balance_workfn | 0 | 0 | 4 |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/irq/manage.c | 0 | 0 | 1 |
| backtrace:register_console | 0 | 0 | 1 |
| backtrace:init_netconsole | 0 | 0 | 1 |
| backtrace:do_init_module | 0 | 0 | 1 |
| backtrace:load_module | 0 | 0 | 1 |
| backtrace:SYSC_finit_module | 0 | 0 | 1 |
| backtrace:SyS_finit_module | 0 | 0 | 1 |
+--------------------------------------------------------------------------+------------+------------+-----------------+
[ 2.672184] init: Failed to create pty - disabling logging for job
[ 2.676953] init: Failed to create pty - disabling logging for job
[ 2.681036] init: Failed to create pty - disabling logging for job
[ 13.266013] BUG: unable to handle kernel paging request at 00000000f000023a
[ 13.268588] IP: [<ffffffff811fed5c>] sget_userns+0xdc/0x490
[ 13.270542] PGD 11f7c067 PUD 0
[ 13.272301] Oops: 0002 [#1] SMP
[ 13.273922] Modules linked in:
[ 13.275451] CPU: 0 PID: 3159 Comm: trinity-c0 Not tainted 4.6.0-00004-g465b34d #1
[ 13.278533] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 13.283978] task: ffff880011c20000 ti: ffff88000a500000 task.ti: ffff88000a500000
[ 13.287291] RIP: 0010:[<ffffffff811fed5c>] [<ffffffff811fed5c>] sget_userns+0xdc/0x490
[ 13.290706] RSP: 0018:ffff88000a503ce8 EFLAGS: 00010202
[ 13.292723] RAX: ffff880011a7b8c0 RBX: 0000000000000000 RCX: 0000000000000000
[ 13.294950] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff880011a7c000
[ 13.297092] RBP: ffff88000a503d38 R08: 000000000001a8a0 R09: ffff880010002000
[ 13.299217] R10: ffff880011a7b800 R11: 0000000000000000 R12: ffff880011a7b800
[ 13.311548] R13: ffffffff811fde90 R14: 00000000f000017a R15: ffff8800123aa400
[ 13.313448] FS: 00007f956f15c700(0000) GS:ffff880011200000(0000) knlGS:0000000000000000
[ 13.316346] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 13.318256] CR2: 00000000f000023a CR3: 00000000123e1000 CR4: 00000000000006f0
[ 13.320410] Stack:
[ 13.321590] ffffffff811fe700 0000000000400000 ffffffff81edfc38 ffffffff81edfc00
[ 13.324933] ffff88000a503d60 ffffffff81edfc00 0000000000400000 ffffffff813ab320
[ 13.328318] 0000000000000000 ffff8800123aa400 ffff88000a503d78 ffffffff811ff452
[ 13.331662] Call Trace:
[ 13.332911] [<ffffffff811fe700>] ? set_anon_super+0x20/0x20
[ 13.334746] [<ffffffff813ab320>] ? mqueue_get_inode+0x2f0/0x2f0
[ 13.336600] [<ffffffff811ff452>] mount_ns+0x62/0xe0
[ 13.338127] [<ffffffff813aa65d>] mqueue_mount+0x3d/0x40
[ 13.339716] [<ffffffff811ffdc8>] mount_fs+0x38/0x170
[ 13.341416] [<ffffffff8121c204>] vfs_kern_mount+0x64/0x110
[ 13.343244] [<ffffffff8121c2c9>] kern_mount_data+0x19/0x30
[ 13.345122] [<ffffffff813ac9a8>] mq_init_ns+0x58/0x80
[ 13.346888] [<ffffffff813acf69>] copy_ipcs+0x89/0xf0
[ 13.348634] [<ffffffff8109bced>] create_new_namespaces+0xad/0x1e0
[ 13.350624] [<ffffffff8109bfba>] unshare_nsproxy_namespaces+0x5a/0xb0
[ 13.352655] [<ffffffff8107b252>] SyS_unshare+0x1b2/0x350
[ 13.354484] [<ffffffff81003cc6>] do_syscall_64+0x66/0x1e0
[ 13.356347] [<ffffffff81907761>] entry_SYSCALL64_slow_path+0x25/0x25
[ 13.358399] Code: a3 fd ff 48 85 c0 49 89 c4 0f 84 87 02 00 00 48 8d 80 c0 00 00 00 4d 85 f6 49 89 84 24 c0 00 00 00 49 89 84 24 c8 00 00 00 74 08 <f0> 41 ff 86 c0 00 00 00 4d 89 b4 24 20 05 00 00 4c 89 e7 e8 1c
[ 13.371303] RIP [<ffffffff811fed5c>] sget_userns+0xdc/0x490
[ 13.373287] RSP <ffff88000a503ce8>
[ 13.374732] CR2: 00000000f000023a
[ 13.376200] ---[ end trace 831292727d0e5506 ]---
[ 13.378139] Kernel panic - not syncing: Fatal exception
git bisect start 0eabf5f986ec2c76fd2467f884db02af487b6a04 1a695a905c18548062509178b98bc91e67510864 --
git bisect bad 5bbb153006a85c7393fdd43a3a9ae8048ff9c89d # 06:14 9- 2 Merge 'linux-review/Michael-S-Tsirkin/virtio_balloon-fix-PFN-format-for-virtio-1/20160518-204549' into devel-hourly-2016053003
git bisect bad b7ccfda50c82b744431449d9f03c77c8e1b5a7f7 # 06:24 0- 3 Merge 'linux-review/Shubham-Bansal/Staging-android-ion-fixed-a-kzalloc-coding-style-issue/20160526-160416' into devel-hourly-2016053003
git bisect bad 6dc7c25b57b0781316fbdcd50cceed9fe9fdb333 # 06:34 5- 1 Merge 'linux-review/Bhaktipriya-Shridhar/xen-xen-pciback-Remove-create_workqueue/20160527-235704' into devel-hourly-2016053003
git bisect good 4d6d1544a5f6bc3ec19c55d4dec7fc995471de2d # 06:47 310+ 4 Merge 'linux-review/Kefeng-Wang/Support-hisilicon-64bit-mode-timer/20160528-174812' into devel-hourly-2016053003
git bisect good edbdf10044476c76eadef2879e77d0b85cf500ac # 07:03 310+ 5 Merge 'linux-review/Shuah-Khan/media-Media-Device-Allocator-API/20160528-042738' into devel-hourly-2016053003
git bisect good 75dcbc5741becba2dfce5fb2f7bc3ea1970a351a # 07:13 310+ 0 Merge 'linux-review/Andrew-F-Davis/ARM-dts-am437x-idk-evm-Mark-MAC-as-having-only-one-PHY/20160528-022047' into devel-hourly-2016053003
git bisect bad dd7e5dee1784a8b0985fa8218f73a140cc18393f # 07:18 1- 5 Merge 'linux-review/Josef-Bacik/Btrfs-fill-relocation-block-rsv-after-allocation/20160528-011026' into devel-hourly-2016053003
git bisect good bc1d6ba0c3b9fc1b66d393005d165df573d4aaf0 # 07:31 310+ 3 Merge 'wireless-drivers/master' into devel-hourly-2016053003
git bisect bad 480cfa15e65139d97edeb5c0dd60ef42bd40d6ae # 07:40 105- 3 Merge 'userns/for-testing' into devel-hourly-2016053003
git bisect bad 465b34d93fba71aa0bd3bd120c7e4eef7ef5920e # 07:50 1- 1 fs: Add user namesapace member to struct super_block
git bisect good 683457a345b2f34912b7579b11fe820dd4480ec5 # 08:04 310+ 1 vfs: Pass data, ns, and ns->userns to mount_ns
git bisect good 8251ce8a7d7bfb1a927d31ca411301290a339223 # 08:13 310+ 3 proc: Convert proc_mount to use mount_ns.
# first bad commit: [465b34d93fba71aa0bd3bd120c7e4eef7ef5920e] fs: Add user namesapace member to struct super_block
git bisect good 8251ce8a7d7bfb1a927d31ca411301290a339223 # 08:37 910+ 8 proc: Convert proc_mount to use mount_ns.
# extra tests on HEAD of linux-devel/devel-hourly-2016053003
git bisect bad 0eabf5f986ec2c76fd2467f884db02af487b6a04 # 08:37 0- 9 0day head guard for 'devel-hourly-2016053003'
# extra tests on tree/branch userns/for-testing
git bisect bad a801068414f951592d437a74320bc34b20ccd8c8 # 08:39 3- 10 userns: Remove implicit MNT_NODEV fragility.
# extra tests with first bad commit reverted
# extra tests on tree/branch linus/master
git bisect good b02b1fbdd338f70e49efa9ca9899214134526701 # 09:09 910+ 7 Merge tag 'scsi-fixes' of git://git.kernel.org/pub/scm/linux/kernel/git/jejb/scsi
# extra tests on tree/branch linux-next/master
git bisect good b5631e1f2c1c8bac5bc866d4a7f8c6f415cae9e9 # 09:30 910+ 24 Add linux-next specific files for 20160527
This script may reproduce the error.
----------------------------------------------------------------------------
#!/bin/bash
kernel=$1
initrd=quantal-core-x86_64.cgz
wget --no-clobber https://github.com/fengguang/reproduce-kernel-bug/raw/master/initrd/$initrd
kvm=(
qemu-system-x86_64
-enable-kvm
-cpu kvm64
-kernel $kernel
-initrd $initrd
-m 300
-smp 2
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)
append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
systemd.log_level=err
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
console=ttyS0,115200
console=tty0
vga=normal
root=/dev/ram0
rw
drbd.minor_count=8
)
"${kvm[@]}" --append "${append[*]}"
----------------------------------------------------------------------------
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years, 7 months
[x86/uaccess] 3964262746: BUG: uaccess fault at kernel address 0x8011e000 with KERNEL_DS
by kernel test robot
FYI, we noticed the following commit:
https://git.kernel.org/pub/scm/linux/kernel/git/luto/linux.git x86/uaccess
commit 396426274682b471f3fb5ed2f4c3295c8e360d63 ("x86/uaccess: OOPS or warn on a fault with KERNEL_DS and !pagefault_disabled()")
on test machine: vm-intel12-openwrt-i386: 1 threads qemu-system-i386 -enable-kvm with 192M memory
caused below changes:
+----------------+------------+------------+
| | b50e80af2f | 3964262746 |
+----------------+------------+------------+
| boot_successes | 8 | 12 |
+----------------+------------+------------+
[ 0.763229] ..... CPU clock speed is 2926.3110 MHz.
[ 0.764520] ..... host bus clock speed is 999.9966 MHz.
[ 0.764520] ..... host bus clock speed is 999.9966 MHz.
[ 0.766600] BUG: uaccess fault at kernel address 0x8011e000 with KERNEL_DS
[ 0.766600] BUG: uaccess fault at kernel address 0x8011e000 with KERNEL_DS
[ 0.768496] BUG: unable to handle kernel
[ 0.768496] BUG: unable to handle kernel paging requestpaging request at 8011e000
at 8011e000
[ 0.770097] IP:
[ 0.770097] IP: [<8114ea21>] copy_mount_options+0x91/0x260
[<8114ea21>] copy_mount_options+0x91/0x260
[ 0.771632] *pde = 0210d063
[ 0.771632] *pde = 0210d063 *pte = 0011e060 *pte = 0011e060
[ 0.772808] Oops: 0000 [#1]
[ 0.772808] Oops: 0000 [#1] DEBUG_PAGEALLOC DEBUG_PAGEALLOC
[ 0.785071] Modules linked in:
[ 0.785071] Modules linked in:
[ 0.785890] CPU: 0 PID: 7 Comm: kdevtmpfs Not tainted 4.6.0-rc6-00083-g3964262 #1
[ 0.785890] CPU: 0 PID: 7 Comm: kdevtmpfs Not tainted 4.6.0-rc6-00083-g3964262 #1
[ 0.787809] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 0.787809] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 0.790111] task: 8010e640 ti: 8011c000 task.ti: 8011c000
[ 0.790111] task: 8010e640 ti: 8011c000 task.ti: 8011c000
[ 0.791632] task.addr_limit: 0xffffffff
[ 0.791632] task.addr_limit: 0xffffffff
[ 0.792582] EIP: 0060:[<8114ea21>] EFLAGS: 00210202 CPU: 0
[ 0.792582] EIP: 0060:[<8114ea21>] EFLAGS: 00210202 CPU: 0
[ 0.804091] EIP is at copy_mount_options+0x91/0x260
[ 0.804091] EIP is at copy_mount_options+0x91/0x260
[ 0.805404] EAX: 8011e000 EBX: 00000efe ECX: 000010c6 EDX: 00000000
[ 0.805404] EAX: 8011e000 EBX: 00000efe ECX: 000010c6 EDX: 00000000
[ 0.806989] ESI: 00000000 EDI: 8001655a EBP: 8011de60 ESP: 8011de4c
[ 0.806989] ESI: 00000000 EDI: 8001655a EBP: 8011de60 ESP: 8011de4c
[ 0.808686] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068
[ 0.808686] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068
[ 0.810043] CR0: 80050033 CR2: 8011e000 CR3: 01924000 CR4: 00000690
[ 0.810043] CR0: 80050033 CR2: 8011e000 CR3: 01924000 CR4: 00000690
[ 0.811788] Stack:
[ 0.811788] Stack:
[ 0.812262] 00001000
[ 0.812262] 00001000 80016458 80016458 80114a30 80114a30 81674e04 81674e04 80114648 80114648 8011de80 8011de80 8114fbdd 8114fbdd 81861c84 81861c84
[ 0.824612] 00000000
[ 0.824612] 00000000 80118008 80118008 8006bf68 8006bf68 8006bf68 8006bf68 812c7020 812c7020 8011df18 8011df18 812c708d 812c708d 81674e04 81674e04
[ 0.826707] 81661211
[ 0.826707] 81661211 81674e04 81674e04 00008000 00008000 8011defe 8011defe 80070040 80070040 8011dea8 8011dea8 8108403b 8108403b 8011deb4 8011deb4
[ 0.828998] Call Trace:
[ 0.828998] Call Trace:
[ 0.829682] [<8114fbdd>] SyS_mount+0x4d/0xd0
[ 0.829682] [<8114fbdd>] SyS_mount+0x4d/0xd0
[ 0.834912] [<812c7020>] ? handle_remove+0x270/0x270
[ 0.834912] [<812c7020>] ? handle_remove+0x270/0x270
[ 0.836115] [<812c708d>] devtmpfsd+0x6d/0x300
[ 0.836115] [<812c708d>] devtmpfsd+0x6d/0x300
[ 0.837225] [<8108403b>] ? trace_hardirqs_on+0xb/0x10
[ 0.837225] [<8108403b>] ? trace_hardirqs_on+0xb/0x10
[ 0.838684] [<8149f1c2>] ? _raw_spin_unlock_irq+0x22/0x50
[ 0.838684] [<8149f1c2>] ? _raw_spin_unlock_irq+0x22/0x50
[ 0.850179] [<8106967d>] ? finish_task_switch+0x9d/0x200
[ 0.850179] [<8106967d>] ? finish_task_switch+0x9d/0x200
[ 0.851504] [<8106963c>] ? finish_task_switch+0x5c/0x200
[ 0.851504] [<8106963c>] ? finish_task_switch+0x5c/0x200
[ 0.852983] [<81499856>] ? __schedule+0x356/0x890
[ 0.852983] [<81499856>] ? __schedule+0x356/0x890
[ 0.854127] [<8108403b>] ? trace_hardirqs_on+0xb/0x10
[ 0.854127] [<8108403b>] ? trace_hardirqs_on+0xb/0x10
[ 0.855571] [<812c7020>] ? handle_remove+0x270/0x270
[ 0.855571] [<812c7020>] ? handle_remove+0x270/0x270
[ 0.856924] [<81064982>] kthread+0xb2/0xd0
[ 0.856924] [<81064982>] kthread+0xb2/0xd0
[ 0.858129] [<8108403b>] ? trace_hardirqs_on+0xb/0x10
[ 0.858129] [<8108403b>] ? trace_hardirqs_on+0xb/0x10
[ 0.859455] [<8149f782>] ret_from_kernel_thread+0xe/0x24
[ 0.859455] [<8149f782>] ret_from_kernel_thread+0xe/0x24
[ 0.871022] [<810648d0>] ? kthread_create_on_node+0x150/0x150
[ 0.871022] [<810648d0>] ? kthread_create_on_node+0x150/0x150
[ 0.872587] Code:
[ 0.872587] Code: 84 84 35 35 01 01 00 00 00 00 89 89 f0 f0 8b 8b 5d 5d ec ec 31 31 f6 f6 8b 8b 7d 7d f0 f0 eb eb 15 15 89 89 f6 f6 8d 8d bc bc 27 27 00 00 00 00 00 00 00 00 47 47 40 40 4b 4b 88 88 4f 4f ff ff 0f 0f 84 84 14 14 01 01 00 00 00 00 8d 8d 76 76 00 00 89 89 f2 f2 <8a> <8a> 08 08 8d 8d 76 76 00 00 85 85 d2 d2 74 74 e6 e6 83 83 fb fb 08 08 89 89 da da 0f 0f 83 83 c3 c3 00 00 00 00 00 00 f6 f6
[ 0.878619] EIP: [<8114ea21>]
[ 0.878619] EIP: [<8114ea21>] copy_mount_options+0x91/0x260copy_mount_options+0x91/0x260 SS:ESP 0068:8011de4c
SS:ESP 0068:8011de4c
[ 0.890678] CR2: 000000008011e000
[ 0.890678] CR2: 000000008011e000
[ 0.891488] ---[ end trace d0ffd25e930c69d8 ]---
[ 0.891488] ---[ end trace d0ffd25e930c69d8 ]---
FYI, raw QEMU command line is:
qemu-system-i386 -enable-kvm -kernel /pkg/linux/i386-randconfig-n0-201622/gcc-6/396426274682b471f3fb5ed2f4c3295c8e360d63/vmlinuz-4.6.0-rc6-00083-g3964262 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-intel12-openwrt-i386-7/bisect_boot-1-openwrt-i386.cgz-i386-randconfig-n0-201622-396426274682b471f3fb5ed2f4c3295c8e360d63-20160530-6476-1adtvs3-0.yaml ARCH=i386 kconfig=i386-randconfig-n0-201622 branch=luto/x86/uaccess commit=396426274682b471f3fb5ed2f4c3295c8e360d63 BOOT_IMAGE=/pkg/linux/i386-randconfig-n0-201622/gcc-6/396426274682b471f3fb5ed2f4c3295c8e360d63/vmlinuz-4.6.0-rc6-00083-g3964262 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-intel12-openwrt-i386/openwrt-i386.cgz/i386-randconfig-n0-201622/gcc-6/396426274682b471f3fb5ed2f4c3295c8e360d63/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-intel12-openwrt-i386-7::dhcp drbd.minor_count=8' -initrd /fs/sda2/initrd-vm-intel12-openwrt-i386-7 -m 192 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/sda2/disk0-vm-intel12-openwrt-i386-7,media=disk,if=virtio -drive file=/fs/sda2/disk1-vm-intel12-openwrt-i386-7,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-intel12-openwrt-i386-7 -serial file:/dev/shm/kboot/serial-vm-intel12-openwrt-i386-7 -daemonize -display none -monitor null
Thanks,
Kernel Test Robot
4 years, 7 months
[[DEBUG] force CONFIG_DEBUG_UACCESS] 8829c7a53e: BUG: tried to access memory at 0x7f962a0f while not in USER_DS
by kernel test robot
FYI, we noticed the following commit:
https://git.kernel.org/pub/scm/linux/kernel/git/luto/linux.git x86/uaccess
commit 8829c7a53e1b4e44f6c24c6d165cf9d1cf8b1f14 ("[DEBUG] force CONFIG_DEBUG_UACCESS")
on test machine: vm-lkp-wsx03-yocto-i386: 1 threads qemu-system-i386 -enable-kvm with 320M memory
caused below changes:
+----------------+------------+------------+
| | d126f75418 | 8829c7a53e |
+----------------+------------+------------+
| boot_successes | 10 | 0 |
+----------------+------------+------------+
[ 4.297648] Write protecting the kernel text: 4744k
[ 4.298607] Write protecting the kernel read-only data: 2404k
[ 4.298607] Write protecting the kernel read-only data: 2404k
[ 4.307394] BUG: tried to access memory at 0x7f962a0f while not in USER_DS
[ 4.307394] BUG: tried to access memory at 0x7f962a0f while not in USER_DS
[ 4.308810] ------------[ cut here ]------------
[ 4.308810] ------------[ cut here ]------------
[ 4.309748] kernel BUG at arch/x86/mm/extable.c:189!
[ 4.309748] kernel BUG at arch/x86/mm/extable.c:189!
[ 4.311080] invalid opcode: 0000 [#1]
[ 4.311080] invalid opcode: 0000 [#1] DEBUG_PAGEALLOC DEBUG_PAGEALLOC
[ 4.312088] Modules linked in:
[ 4.312088] Modules linked in:
[ 4.312684] CPU: 0 PID: 89 Comm: init Not tainted 4.6.0-rc6-00086-g8829c7a #1
[ 4.312684] CPU: 0 PID: 89 Comm: init Not tainted 4.6.0-rc6-00086-g8829c7a #1
[ 4.314033] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 4.314033] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 4.315738] task: 9042ccc0 ti: 904aa000 task.ti: 904aa000
[ 4.315738] task: 9042ccc0 ti: 904aa000 task.ti: 904aa000
[ 4.316763] EIP: 0060:[<8103bd06>] EFLAGS: 00010296 CPU: 0
[ 4.316763] EIP: 0060:[<8103bd06>] EFLAGS: 00010296 CPU: 0
[ 4.317826] EIP is at bad_uaccess_kernel_ds+0x16/0x20
[ 4.317826] EIP is at bad_uaccess_kernel_ds+0x16/0x20
[ 4.318795] EAX: 0000003e EBX: 7f962a0c ECX: 9042ccc0 EDX: 00000001
[ 4.318795] EAX: 0000003e EBX: 7f962a0c ECX: 9042ccc0 EDX: 00000001
[ 4.319973] ESI: 00000000 EDI: 9042ccc0 EBP: 904abf18 ESP: 904abf10
[ 4.319973] ESI: 00000000 EDI: 9042ccc0 EBP: 904abf18 ESP: 904abf10
[ 4.321150] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068
[ 4.321150] DS: 007b ES: 007b FS: 0000 GS: 00e0 SS: 0068
[ 4.322170] CR0: 80050033 CR2: 0804f520 CR3: 1049f000 CR4: 00000690
[ 4.322170] CR0: 80050033 CR2: 0804f520 CR3: 1049f000 CR4: 00000690
[ 4.323358] Stack:
[ 4.323358] Stack:
[ 4.323746] 81646e0c
[ 4.323746] 81646e0c 7f962a0f 7f962a0f 904abf2c 904abf2c 811312b6 811312b6 90b87c10 90b87c10 00000001 00000001 80130020 80130020 904abf68 904abf68
[ 4.325319] 811323d7
[ 4.325319] 811323d7 00000002 00000002 00000000 00000000 00000000 00000000 81132006 81132006 9048f97c 9048f97c 00000000 00000000 90b87c10 90b87c10
[ 4.326898] 7f962a0c
[ 4.326898] 7f962a0c 9048f920 9048f920 00000000 00000000 904abfac 904abfac 904aa000 904aa000 47fdcff4 47fdcff4 904abf78 904abf78 811328e9 811328e9
[ 4.328489] Call Trace:
[ 4.328489] Call Trace:
[ 4.328958] [<811312b6>] count+0x66/0xa0
[ 4.328958] [<811312b6>] count+0x66/0xa0
[ 4.329948] [<811323d7>] do_execveat_common+0x4a7/0x740
[ 4.329948] [<811323d7>] do_execveat_common+0x4a7/0x740
[ 4.330947] [<81132006>] ? do_execveat_common+0xd6/0x740
[ 4.330947] [<81132006>] ? do_execveat_common+0xd6/0x740
[ 4.331962] [<811328e9>] SyS_execve+0x29/0x30
[ 4.331962] [<811328e9>] SyS_execve+0x29/0x30
[ 4.332801] [<81001360>] do_int80_syscall_32+0x70/0x1c0
[ 4.332801] [<81001360>] do_int80_syscall_32+0x70/0x1c0
[ 4.333811] [<814a04a6>] entry_INT80_32+0x36/0x36
[ 4.333811] [<814a04a6>] entry_INT80_32+0x36/0x36
[ 4.334711] Code:
[ 4.334711] Code: 90 90 8d 8d 74 74 26 26 00 00 31 31 c0 c0 5d 5d c3 c3 8d 8d b6 b6 00 00 00 00 00 00 00 00 8d 8d bf bf 00 00 00 00 00 00 00 00 55 55 89 89 e5 e5 83 83 ec ec 08 08 89 89 44 44 24 24 04 04 c7 c7 04 04 24 24 0c 0c 6e 6e 64 64 81 81 e8 e8 26 26 b2 b2 0a 0a 00 00 <0f> <0f> 0b 0b 90 90 8d 8d b4 b4 26 26 00 00 00 00 00 00 00 00 55 55 89 89 e5 e5 83 83 ec ec 18 18 89 89 5d 5d f4 f4 89 89 c3 c3
[ 4.339197] EIP: [<8103bd06>]
[ 4.339197] EIP: [<8103bd06>] bad_uaccess_kernel_ds+0x16/0x20bad_uaccess_kernel_ds+0x16/0x20 SS:ESP 0068:904abf10
SS:ESP 0068:904abf10
[ 4.340676] ---[ end trace ee8a6b2c126871eb ]---
[ 4.340676] ---[ end trace ee8a6b2c126871eb ]---
FYI, raw QEMU command line is:
qemu-system-i386 -enable-kvm -kernel /pkg/linux/i386-randconfig-n0-201622/gcc-6/8829c7a53e1b4e44f6c24c6d165cf9d1cf8b1f14/vmlinuz-4.6.0-rc6-00086-g8829c7a -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-wsx03-yocto-i386-11/bisect_boot-1-yocto-minimal-i386.cgz-i386-randconfig-n0-201622-8829c7a53e1b4e44f6c24c6d165cf9d1cf8b1f14-20160530-94983-1lh2mjs-0.yaml ARCH=i386 kconfig=i386-randconfig-n0-201622 branch=luto/x86/uaccess commit=8829c7a53e1b4e44f6c24c6d165cf9d1cf8b1f14 BOOT_IMAGE=/pkg/linux/i386-randconfig-n0-201622/gcc-6/8829c7a53e1b4e44f6c24c6d165cf9d1cf8b1f14/vmlinuz-4.6.0-rc6-00086-g8829c7a max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-yocto-i386/yocto-minimal-i386.cgz/i386-randconfig-n0-201622/gcc-6/8829c7a53e1b4e44f6c24c6d165cf9d1cf8b1f14/0 LKP_SERVER=inn earlyprintk=ttyS0,115200 systemd.log_level=err debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 console=ttyS0,115200 console=tty0 vga=normal rw ip=::::vm-lkp-wsx03-yocto-i386-11::dhcp drbd.minor_count=8' -initrd /fs/sdc1/initrd-vm-lkp-wsx03-yocto-i386-11 -m 320 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -drive file=/fs/sdc1/disk0-vm-lkp-wsx03-yocto-i386-11,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-lkp-wsx03-yocto-i386-11 -serial file:/dev/shm/kboot/serial-vm-lkp-wsx03-yocto-i386-11 -daemonize -display none -monitor null
Thanks,
Kernel Test Robot
4 years, 7 months
[i2c: dev] d6760b14d4: BUG: KASAN: slab-out-of-bounds in of_device_uevent at addr ffff8800091b4c49
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit d6760b14d4a1243f918d983bba1e35c5a5cd5a6d
Author: Erico Nunes <erico.nunes(a)datacom.ind.br>
AuthorDate: Tue May 3 15:45:43 2016 -0300
Commit: Wolfram Sang <wsa(a)the-dreams.de>
CommitDate: Thu May 26 21:18:57 2016 +0200
i2c: dev: switch from register_chrdev to cdev API
i2c-dev had never moved away from the older register_chrdev interface to
implement its char device registration. The register_chrdev API has the
limitation of enabling only up to 256 i2c-dev busses to exist.
Large platforms with lots of i2c devices (i.e. pluggable transceivers)
with dedicated busses may have to exceed that limit.
In particular, there are also platforms making use of the i2c bus
multiplexing API, which instantiates a virtual bus for each possible
multiplexed selection.
This patch removes the register_chrdev usage and replaces it with the
less old cdev API, which takes away the 256 i2c-dev bus limitation.
It should not have any other impact for i2c bus drivers or user space.
This patch has been tested on qemu x86 and qemu powerpc platforms with
the aid of a module which adds and removes 5000 virtual i2c busses, as
well as validated on an existing powerpc hardware platform which makes
use of the i2c bus multiplexing API.
i2c-dev busses with device minor numbers larger than 256 have also been
validated to work with the existing i2c-tools.
Signed-off-by: Erico Nunes <erico.nunes(a)datacom.ind.br>
[wsa: kept includes sorted]
Signed-off-by: Wolfram Sang <wsa(a)the-dreams.de>
+------------------------------------------------------------------+------------+------------+------------+
| | e3879e4f31 | d6760b14d4 | c5311a944e |
+------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 0 | 0 | 0 |
| boot_failures | 96 | 27 | 21 |
| BUG:KASAN:slab-out-of-bounds_in_of_device_uevent_at_addr | 94 | 27 | 21 |
| backtrace:of_unittest | 94 | 27 | 21 |
| backtrace:kernel_init_freeable | 96 | 27 | 21 |
| INFO:suspicious_RCU_usage | 2 | | |
| backtrace:rcu_torture_writer | 2 | | |
| INFO:rcu_sched_self-detected_stall_on_CPU | 1 | | |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 1 | | |
| backtrace:__pci_register_driver | 1 | | |
| backtrace:virtio_pci_driver_init | 1 | | |
| invoked_oom-killer:gfp_mask=0x | 2 | | |
| Mem-Info | 2 | | |
| Kernel_panic-not_syncing:Out_of_memory_and_no_killable_processes | 2 | | |
| backtrace:vfs_write | 2 | | |
| backtrace:SyS_write | 2 | | |
| backtrace:populate_rootfs | 2 | | |
| BUG:KASAN:use-after-free_in_cdev_del_at_addr | 0 | 26 | 21 |
| BUG:KASAN:use-after-free_in_kobject_put_at_addr | 0 | 25 | 21 |
| BUG:KASAN:use-after-free_in_cdev_default_release_at_addr | 0 | 21 | 20 |
| BUG:KASAN:use-after-free_in_cdev_purge_at_addr | 0 | 21 | 20 |
+------------------------------------------------------------------+------------+------------+------------+
[ 70.613944] /testcase-data/phandle-tests/consumer-a: arguments longer than property
[ 70.622462] irq: no irq domain found for /testcase-data/interrupts/intc0 !
[ 70.755208] ==================================================================
[ 70.757418] BUG: KASAN: slab-out-of-bounds in of_device_uevent+0x1c9/0x2dc at addr ffff8800091b4c49
[ 70.759372] Read of size 1 by task swapper/0/1
[ 70.764683] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.6.0-10859-gd6760b1 #1
[ 70.772916] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 70.774885] 0000000000000000 ffff88000999f350 ffffffff8a49bf09 ffffffff00000009
[ 70.777048] ffff880009800100 ffffed0001236989 ffff8800091b4c40 ffff88000999f3c8
[ 70.779212] ffffffff89e60664 ffffffff8ada9499 0000000000000286 ffff88000999f3a0
[ 70.781323] Call Trace:
[ 70.791845] [<ffffffff8a49bf09>] dump_stack+0x148/0x1e2
[ 70.793055] [<ffffffff89e60664>] kasan_report+0x2ea/0x515
[ 70.798326] [<ffffffff8ada9499>] ? of_device_uevent+0x1c9/0x2dc
[ 70.800646] [<ffffffff8ada5247>] ? of_find_property+0x4d/0x58
[ 70.801874] [<ffffffff89e5ff6f>] __asan_load1+0x45/0x47
[ 70.813884] [<ffffffff8ada9499>] of_device_uevent+0x1c9/0x2dc
[ 70.815115] [<ffffffff8ada92d0>] ? of_device_get_modalias+0x26f/0x26f
[ 70.820197] [<ffffffff8a4ae85a>] ? vsnprintf+0x9cd/0x9ff
[ 70.821433] [<ffffffff8a790cf0>] dev_uevent+0x2ad/0x4ee
[ 70.829809] [<ffffffff8a790a43>] ? device_get_devnode+0x19b/0x19b
[ 70.834311] [<ffffffff8a4a1916>] ? add_uevent_var+0x1c1/0x1f0
[ 70.835635] [<ffffffff8a4a1755>] ? kobject_action_type+0xf6/0xf6
[ 70.847664] [<ffffffff8a4a93fc>] ? strncpy+0x33/0x51
[ 70.848768] [<ffffffff8a790a43>] ? device_get_devnode+0x19b/0x19b
[ 70.850118] [<ffffffff8a4a1d06>] kobject_uevent_env+0x3c1/0x895
[ 70.860750] [<ffffffff8a4a21fc>] kobject_uevent+0x22/0x24
[ 70.861960] [<ffffffff8a792ffd>] device_add+0x606/0xaa9
[ 70.894054] [<ffffffff8a7929f7>] ? dev_warn+0xfa/0xfa
[ 70.895478] [<ffffffff8ada999b>] ? of_device_make_bus_id+0x198/0x198
[ 70.900209] [<ffffffff89d44723>] ? trace_hardirqs_on_caller+0x27d/0x2c4
[ 70.906060] [<ffffffff8ada8c55>] of_device_add+0xa3/0xaa
[ 70.907678] [<ffffffff8ada9d2c>] of_platform_device_create_pdata+0xd5/0x10a
[ 70.909768] [<ffffffff8adaa1cd>] of_platform_device_create+0x2b/0x30
[ 70.921685] [<ffffffff8adaa2de>] of_platform_notify+0x10c/0x1df
[ 70.923298] [<ffffffff8adaa1d2>] ? of_platform_device_create+0x30/0x30
[ 70.929593] [<ffffffff89d48f1c>] ? lock_acquire+0xd4/0x11c
[ 70.931112] [<ffffffff89d48f1c>] ? lock_acquire+0xd4/0x11c
[ 70.951893] [<ffffffff89d0472a>] ? __blocking_notifier_call_chain+0x52/0x88
[ 70.961551] [<ffffffff89d042de>] notifier_call_chain+0x75/0xbc
[ 70.966243] [<ffffffff89d04740>] __blocking_notifier_call_chain+0x68/0x88
[ 70.968020] [<ffffffff89d04790>] blocking_notifier_call_chain+0x30/0x32
[ 70.969607] [<ffffffff8adaa990>] of_reconfig_notify+0x24/0x4a
[ 70.970835] [<ffffffff8adaae4a>] __of_changeset_entry_notify+0x14a/0x1f3
[ 70.972343] [<ffffffff8adaad00>] ? of_property_notify+0xe0/0xe0
[ 70.975869] [<ffffffff8af5ca06>] ? __mutex_unlock_slowpath+0x2a4/0x2cc
[ 70.982674] [<ffffffff8af5c762>] ? wait_for_completion_killable_timeout+0x10/0x10
[ 70.984549] [<ffffffff8adabf49>] __of_changeset_apply+0x19c/0x21c
[ 70.990166] [<ffffffff8adabf49>] ? __of_changeset_apply+0x19c/0x21c
[ 70.991479] [<ffffffff8adabdad>] ? of_changeset_destroy+0xce/0xce
[ 70.996828] [<ffffffff89d44777>] ? trace_hardirqs_on+0xd/0xf
[ 70.998377] [<ffffffff8ada59b5>] ? of_get_next_child+0x42/0x4c
[ 71.003005] [<ffffffff8adb4311>] of_overlay_create+0x4ee/0x5fc
[ 71.004872] [<ffffffff8adb4311>] ? of_overlay_create+0x4ee/0x5fc
[ 71.006479] [<ffffffff8adb3e23>] ? of_overlay_apply_one+0x2ff/0x2ff
[ 71.016412] [<ffffffff89d44723>] ? trace_hardirqs_on_caller+0x27d/0x2c4
[ 71.017791] [<ffffffff89d44777>] ? trace_hardirqs_on+0xd/0xf
[ 71.022493] [<ffffffff8ada5de8>] ? of_find_node_opts_by_path+0x2e6/0x2f8
[ 71.024266] [<ffffffff8ae88571>] of_unittest_apply_overlay+0x76/0xf4
[ 71.028045] [<ffffffff8ae88692>] of_unittest_apply_overlay_check+0xa3/0x13b
[ 71.029540] [<ffffffff8ce573c7>] of_unittest+0x2772/0x3480
[ 71.030788] [<ffffffff8ce54c55>] ? of_unittest_check_tree_linkage+0x158/0x158
[ 71.032654] [<ffffffff8a4a0834>] ? kobject_add_internal+0x4e6/0x4e6
[ 71.034051] [<ffffffff8a4a21fc>] ? kobject_uevent+0x22/0x24
[ 71.035278] [<ffffffff8a4a0a78>] ? kset_register+0x4e/0x56
[ 71.036509] [<ffffffff8cdd2bae>] ? set_debug_rodata+0x20/0x20
[ 71.037812] [<ffffffff8ae8818f>] ? add_sysfs_fw_map_entry+0xce/0xd6
[ 71.043278] [<ffffffff8ce54c55>] ? of_unittest_check_tree_linkage+0x158/0x158
[ 71.045152] [<ffffffff8cdd2bae>] ? set_debug_rodata+0x20/0x20
[ 71.056264] [<ffffffff8cdd373a>] do_one_initcall+0x114/0x252
[ 71.057549] [<ffffffff8cdd3626>] ? start_kernel+0x637/0x637
[ 71.065513] [<ffffffff8cdd2c40>] ? repair_env_string+0x92/0x9d
[ 71.066841] [<ffffffff89d01df7>] ? parse_args+0x5a6/0x5b9
[ 71.070327] [<ffffffff8cdd2bae>] ? set_debug_rodata+0x20/0x20
[ 71.075364] [<ffffffff8cdd3a6b>] kernel_init_freeable+0x1f3/0x2ab
[ 71.076718] [<ffffffff8af4e186>] kernel_init+0x11/0x15c
[ 71.077922] [<ffffffff8af6354f>] ret_from_fork+0x1f/0x40
[ 71.085098] [<ffffffff8af4e175>] ? rest_init+0x17c/0x17c
[ 71.086576] Object at ffff8800091b4c40, in cache kmalloc-32
[ 71.088079] Object allocated with size 9 bytes.
[ 71.089348] Allocation:
[ 71.090224] PID = 1
[ 71.091019] [<ffffffff89c3bfbf>] save_stack_trace+0x26/0x41
[ 71.092508] [<ffffffff89e5f5b6>] kasan_kmalloc+0x80/0x10c
[ 71.093881] [<ffffffff89e5fbd2>] kasan_kmalloc+0x85/0x91
[ 71.095157] [<ffffffff89e5d787>] __kmalloc_track_caller+0x1b5/0x1c9
[ 71.096776] [<ffffffff89e134da>] kmemdup+0x24/0x4e
[ 71.098287] [<ffffffff8adab9df>] __of_prop_dup+0xe0/0x169
[ 71.101716] [<ffffffff8adb3bf6>] of_overlay_apply_one+0xd2/0x2ff
[ 71.109820] [<ffffffff8adb3dac>] of_overlay_apply_one+0x288/0x2ff
[ 71.118779] [<ffffffff8adb42a9>] of_overlay_create+0x486/0x5fc
[ 71.120137] [<ffffffff8ae88571>] of_unittest_apply_overlay+0x76/0xf4
[ 71.122042] [<ffffffff8ae88692>] of_unittest_apply_overlay_check+0xa3/0x13b
[ 71.127825] [<ffffffff8ce573c7>] of_unittest+0x2772/0x3480
[ 71.129106] [<ffffffff8cdd373a>] do_one_initcall+0x114/0x252
[ 71.131270] [<ffffffff8cdd3a6b>] kernel_init_freeable+0x1f3/0x2ab
[ 71.133851] [<ffffffff8af4e186>] kernel_init+0x11/0x15c
[ 71.135085] [<ffffffff8af6354f>] ret_from_fork+0x1f/0x40
[ 71.136492] Memory state around the buggy address:
[ 71.146901] ffff8800091b4b00: fb fb fb fb fc fc fc fc fb fb fb fb fc fc fc fc
[ 71.156678] ffff8800091b4b80: fb fb fb fb fc fc fc fc fb fb fb fb fc fc fc fc
git bisect start c5311a944e65241db0c1d6777ba8dc678e4b95ce 2dcd0af568b0cf583645c8a317dd12e344b1c72a --
git bisect good 165884dee0c0ca098e86853542e5a66aebea1882 # 12:12 21+ 25 Merge 'sound/for-next' into devel-spot-201605281009
git bisect bad 2eb9daf8a36c42f56363126db4d0951ae268d1f2 # 12:21 0- 21 Merge 'linux-review/William-Wu/support-rockchip-dwc3-driver/20160527-193349' into devel-spot-201605281009
git bisect good 9f550046a4a630521250f8c888c5e0d4338d2fa8 # 12:35 22+ 24 Merge 'linux-review/Javier-Martinez-Canillas/mwifiex-Fix-some-error-handling-issues-in-mwifiex_sdio_probe-function/20160527-222338' into devel-spot-201605281009
git bisect bad 34b019584b93b0815e3fd335d261eac21034c067 # 12:54 0- 22 Merge 'drm-intel/drm-intel-nightly' into devel-spot-201605281009
git bisect good 025de5b31b692cd182c8c1ca85f40f9a1be76cca # 13:10 22+ 22 Merge 'linux-review/Srinivas-Kandagatla/ASoC-msm8916-Add-codec-Device-Tree-bindings/20160527-215246' into devel-spot-201605281009
git bisect bad 4301b354cf48a772cdd27ae07c7f17240f202dfe # 13:19 4- 14 Merge 'linux-review/Shardar-Shariff-Md/i2c-tegra-use-readx_poll_timeout-after-config_load-reg-programmed/20160527-215125' into devel-spot-201605281009
git bisect good 67fed0da5ac23ab6187c362b7ade08339872f718 # 13:30 22+ 24 i2c: at91: change log when dma configuration fails
git bisect bad d6760b14d4a1243f918d983bba1e35c5a5cd5a6d # 13:46 1- 4 i2c: dev: switch from register_chrdev to cdev API
git bisect good e3879e4f3179121b1b59fd0033379d0ee700dead # 13:54 22+ 26 i2c: xlr: rename ARCH_TANGOX to ARCH_TANGO
# first bad commit: [d6760b14d4a1243f918d983bba1e35c5a5cd5a6d] i2c: dev: switch from register_chrdev to cdev API
git bisect good e3879e4f3179121b1b59fd0033379d0ee700dead # 14:03 70+ 96 i2c: xlr: rename ARCH_TANGOX to ARCH_TANGO
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad d6760b14d4a1243f918d983bba1e35c5a5cd5a6d # 14:09 0- 12 i2c: dev: switch from register_chrdev to cdev API
# extra tests on HEAD of linux-devel/devel-spot-201605281009
git bisect bad c5311a944e65241db0c1d6777ba8dc678e4b95ce # 14:10 0- 21 0day head guard for 'devel-spot-201605281009'
# extra tests on tree/branch linus/master
git bisect bad ed2608faa0f701b1dbc65277a9e5c7ff7118bfd4 # 14:21 0- 3 Merge branch 'for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/dtor/input
# extra tests on tree/branch linus/master
git bisect bad ed2608faa0f701b1dbc65277a9e5c7ff7118bfd4 # 14:21 0- 29 Merge branch 'for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/dtor/input
# extra tests on tree/branch linux-next/master
git bisect bad b5631e1f2c1c8bac5bc866d4a7f8c6f415cae9e9 # 14:29 0- 22 Add linux-next specific files for 20160527
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years, 7 months
[sched] a552935c0e: BUG: spinlock lockup suspected on CPU#1, swapper/1/0
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.linaro.org/people/vincent.guittot/kernel.git sched/pelt
commit a552935c0e1ef5ef53a4b4e74782182a6c83704d
Author: Vincent Guittot <vincent.guittot(a)linaro.org>
AuthorDate: Wed May 25 16:45:30 2016 +0200
Commit: Vincent Guittot <vincent.guittot(a)linaro.org>
CommitDate: Wed May 25 16:46:06 2016 +0200
sched: fix first task of a task group is attached twice
The cfs_rq->avg.last_update_time is intialize to 0 with the main effect
that the 1st sched_entity that will be attached, will keep its
last_update_time set to 0 and will attached once again during the
enqueue.
Initialize cfs_rq->avg.last_update_time to 1 instead.
Signed-off-by: Vincent Guittot <vincent.guittot(a)linaro.org>
+-----------------------------------------------------------------------------------------+------------+------------+------------+
| | ef0491ea17 | a552935c0e | 906241951f |
+-----------------------------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 980 | 0 | 0 |
| boot_failures | 29 | 396 | 11 |
| BUG:unable_to_handle_kernel | 26 | | |
| Oops | 26 | | |
| EIP_is_at_perf_prepare_sample | 26 | | |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 11 | | |
| backtrace:trace_apic_timer_interrupt | 1 | | |
| backtrace:inode_init_once | 1 | | |
| backtrace:init_once | 1 | | |
| backtrace:iterate_dir | 9 | | |
| backtrace:SyS_getdents64 | 9 | | |
| Kernel_panic-not_syncing:Fatal_exception | 15 | | |
| BUG:workqueue_lockup-pool | 3 | 1 | |
| BUG:workqueue_lockup-pool_cpus=#cpus=#node=#node=#flags=#nice=#flags=#nice=#stuck_for#s | 3 | 1 | |
| BUG:workqueue_lockup-pool_cpus=#-#cpus=#-#flags=#nice=#flags=#nice=#stuck_for#s | 1 | | |
| backtrace:vfs_fstatat | 2 | | |
| backtrace:SyS_fstatat64 | 2 | | |
| BUG:spinlock_lockup_suspected_on_CPU | 0 | 156 | 11 |
| EIP_is_at_native_apic_mem_write | 0 | 156 | 11 |
| EIP_is_at_set_task_rq_fair | 0 | 156 | 11 |
| backtrace:cpu_startup_entry | 0 | 59 | 8 |
| backtrace:ring_buffer_producer_thread | 0 | 41 | |
| backtrace:ring_buffer_consumer_thread | 0 | 3 | |
| backtrace:schedule_timeout | 0 | 5 | |
| BUG:kernel_boot_hang | 0 | 239 | |
| backtrace:smpboot_thread_fn | 0 | 2 | |
| backtrace:apic_timer_interrupt | 0 | 1 | |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 0 | 4 | |
+-----------------------------------------------------------------------------------------+------------+------------+------------+
[ 90.944485] NX-protecting the kernel data: 8808k
[ 90.982969] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[ 90.982969] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[ 599.715979] BUG: spinlock lockup suspected on CPU#1, swapper/1/0
[ 599.715979] BUG: spinlock lockup suspected on CPU#1, swapper/1/0
[ 599.729478] lock: 0xd1120ec0, .magic: dead4ead, .owner: init/1, .owner_cpu: 0
[ 599.729478] lock: 0xd1120ec0, .magic: dead4ead, .owner: init/1, .owner_cpu: 0
[ 599.741301] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.6.0-rc7-00127-ga552935 #2
[ 599.741301] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.6.0-rc7-00127-ga552935 #2
[ 599.743118] 00000001
[ 599.743118] 00000001 00200046 00200046 00000000 00000000 c02d5dfc c02d5dfc c145ae3c c145ae3c c026738c c026738c d1120ec0 d1120ec0 c02d5e28 c02d5e28
[ 599.764055] c10b1e02
[ 599.764055] c10b1e02 c1b52624 c1b52624 d1120ec0 d1120ec0 dead4ead dead4ead c026738c c026738c 00000001 00000001 00000000 00000000 d1120ec0 d1120ec0
[ 599.766128] 00000000
[ 599.766128] 00000000 00000000 00000000 c02d5e44 c02d5e44 c10b2059 c10b2059 a08ba36c a08ba36c 00000000 00000000 d1120ec0 d1120ec0 c10a1ec7 c10a1ec7
[ 599.790216] Call Trace:
[ 599.790216] Call Trace:
[ 599.790826] [<c145ae3c>] dump_stack+0x86/0xb3
[ 599.790826] [<c145ae3c>] dump_stack+0x86/0xb3
[ 599.791922] [<c10b1e02>] spin_dump+0x92/0x9d
[ 599.791922] [<c10b1e02>] spin_dump+0x92/0x9d
[ 599.793003] [<c10b2059>] do_raw_spin_lock+0x1aa/0x210
[ 599.793003] [<c10b2059>] do_raw_spin_lock+0x1aa/0x210
[ 599.794264] [<c10a1ec7>] ? sched_rt_rq_enqueue+0xcd/0xcd
[ 599.794264] [<c10a1ec7>] ? sched_rt_rq_enqueue+0xcd/0xcd
[ 599.811642] [<c176331e>] _raw_spin_lock+0x2e/0x36
[ 599.811642] [<c176331e>] _raw_spin_lock+0x2e/0x36
[ 599.812830] [<c10a1fae>] ? sched_rt_period_timer+0xe7/0x3e1
[ 599.812830] [<c10a1fae>] ? sched_rt_period_timer+0xe7/0x3e1
[ 599.814228] [<c10a1fae>] sched_rt_period_timer+0xe7/0x3e1
[ 599.814228] [<c10a1fae>] sched_rt_period_timer+0xe7/0x3e1
[ 599.815576] [<c10a1ec7>] ? sched_rt_rq_enqueue+0xcd/0xcd
[ 599.815576] [<c10a1ec7>] ? sched_rt_rq_enqueue+0xcd/0xcd
[ 599.835967] [<c10db0a8>] __hrtimer_run_queues+0x1ff/0x396
[ 599.835967] [<c10db0a8>] __hrtimer_run_queues+0x1ff/0x396
[ 599.837330] [<c10dbb18>] hrtimer_interrupt+0x9a/0x1e9
[ 599.837330] [<c10dbb18>] hrtimer_interrupt+0x9a/0x1e9
[ 599.849004] [<c10960f6>] ? irqtime_account_irq+0xf0/0xf7
[ 599.849004] [<c10960f6>] ? irqtime_account_irq+0xf0/0xf7
[ 599.850338] [<c103ee95>] local_apic_timer_interrupt+0x5c/0x63
[ 599.850338] [<c103ee95>] local_apic_timer_interrupt+0x5c/0x63
[ 599.861812] [<c103f906>] smp_apic_timer_interrupt+0x25/0x34
[ 599.861812] [<c103f906>] smp_apic_timer_interrupt+0x25/0x34
[ 599.863213] [<c1764596>] apic_timer_interrupt+0x2a/0x30
[ 599.863213] [<c1764596>] apic_timer_interrupt+0x2a/0x30
[ 599.883286] [<c10d007b>] ? synchronize_sched_expedited+0x179/0x9f5
[ 599.883286] [<c10d007b>] ? synchronize_sched_expedited+0x179/0x9f5
[ 599.884820] [<c104a8cb>] ? native_safe_halt+0x5/0x7
[ 599.884820] [<c104a8cb>] ? native_safe_halt+0x5/0x7
[ 599.886230] [<c1029a70>] default_idle+0x1e/0x30
[ 599.886230] [<c1029a70>] default_idle+0x1e/0x30
[ 599.887556] [<c102a0be>] arch_cpu_idle+0xe/0x10
[ 599.887556] [<c102a0be>] arch_cpu_idle+0xe/0x10
[ 599.914744] [<c10a7d40>] default_idle_call+0x53/0x56
[ 599.914744] [<c10a7d40>] default_idle_call+0x53/0x56
[ 599.915985] [<c10a7ebb>] cpu_startup_entry+0x178/0x253
[ 599.915985] [<c10a7ebb>] cpu_startup_entry+0x178/0x253
[ 599.917337] [<c103d33e>] start_secondary+0x15f/0x166
[ 599.917337] [<c103d33e>] start_secondary+0x15f/0x166
[ 599.932068] Sending NMI to all CPUs:
[ 599.932068] Sending NMI to all CPUs:
[ 599.933169] NMI backtrace for cpu 0
git bisect start 906241951fb6bc8c79e004ff20531ae2ee669417 2dcd0af568b0cf583645c8a317dd12e344b1c72a --
git bisect bad 6eb5a468fc5244546f8f0c86eb96c1fe9a1b10bf # 08:19 0- 52 Merge 'linux-review/Mario-Limonciello/dell_rbu-Don-t-fallback-to-userhelper/20160517-023154' into devel-spot-201605260216
git bisect bad 954c48eff63e25c9ad503d3a75636aa590ad61da # 08:19 0- 450 Merge 'linux-review/Laurent-Pinchart/adv7604-Don-t-ignore-pad-number-in-subdev-DV-timings-pad-operations/20160525-133613' into devel-spot-201605260216
git bisect bad 467c9a273234493ef1f746cd3cb55b881cee12be # 08:37 11- 15 Merge 'renesas/devel' into devel-spot-201605260216
git bisect good 883c59cd20472da106fd583297207ce46d97cdf5 # 08:50 400+ 15 Merge 'kees/kaslr/highmem' into devel-spot-201605260216
git bisect good 035e169dac05a7aac0fb0acbf20c4f5b6ba8987b # 09:06 398+ 8 Merge 'linux-review/Lijun-Ou/Add-HiSilicon-RoCE-driver/20160525-233508' into devel-spot-201605260216
git bisect bad d895411873af5ef6c93b430f250426d07845b01b # 09:21 1- 4 Merge 'linux-review/Peter-Ujfalusi/ARM-OMAP3-hwmod-data-Fix-McBSP2-3-sidetone-data/20160525-232753' into devel-spot-201605260216
git bisect good 167e48e4589693d2dfe274751dd37866f1c30153 # 09:37 393+ 17 Merge 'linux-review/Arnd-Bergmann/ipv6-hide-ip6_encap_hlen-ip6_tnl_encap-definitions/20160525-233329' into devel-spot-201605260216
git bisect good d379c5dcd30e9670814b0d7afeee89245ae0a008 # 09:53 390+ 19 Merge 'linux-review/Minfei-Huang/MAINTAINERS-add-kexec_core-c-and-kexec_file-c/20160525-233213' into devel-spot-201605260216
git bisect bad fb78006f583c75428ce30df9552f49b24b967a2d # 10:10 0- 1 Merge 'vincent.guittot/sched/pelt' into devel-spot-201605260216
git bisect bad 622183a3739ef74e641574ed75732d19e5d55d46 # 10:26 4- 5 sched: fix hierarchical order in rq->leaf_cfs_rq_list
git bisect bad a552935c0e1ef5ef53a4b4e74782182a6c83704d # 10:40 2- 3 sched: fix first task of a task group is attached twice
# first bad commit: [a552935c0e1ef5ef53a4b4e74782182a6c83704d] sched: fix first task of a task group is attached twice
git bisect good ef0491ea17f8019821c7e9c8e801184ecf17f85a # 11:07 1001+ 28 ARM: Hide finish_arch_post_lock_switch() from modules
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad a552935c0e1ef5ef53a4b4e74782182a6c83704d # 11:27 6- 11 sched: fix first task of a task group is attached twice
# extra tests on HEAD of linux-devel/devel-spot-201605260216
git bisect bad 906241951fb6bc8c79e004ff20531ae2ee669417 # 11:27 0- 11 0day head guard for 'devel-spot-201605260216'
# extra tests on tree/branch vincent.guittot/sched/pelt
git bisect bad 6de5441e77a1db9dfdb530177846727d1debd97f # 11:42 1- 2 sched: reflect sched_entity movement into task_group's utilization
# extra tests with first bad commit reverted
git bisect good b999f7869fb78f6faae6164994d05e4711400150 # 13:09 1007+ 26 Revert "sched: fix first task of a task group is attached twice"
# extra tests on tree/branch linus/master
git bisect good 2f7c3a18a2dc79ddf7b83ae199b099a675e1adb2 # 13:28 1002+ 7 Merge branch 'x86-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
# extra tests on tree/branch linux-next/master
git bisect good 08389fe28f2ce76e68fe744f513101c1348ae3ab # 13:54 1010+ 16 Add linux-next specific files for 20160525
This script may reproduce the error.
----------------------------------------------------------------------------
#!/bin/bash
kernel=$1
initrd=quantal-core-i386.cgz
wget --no-clobber https://github.com/fengguang/reproduce-kernel-bug/raw/master/initrd/$initrd
kvm=(
qemu-system-x86_64
-enable-kvm
-cpu kvm64
-kernel $kernel
-initrd $initrd
-m 300
-smp 2
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)
append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
systemd.log_level=err
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
load_ramdisk=2
prompt_ramdisk=0
console=ttyS0,115200
console=tty0
vga=normal
root=/dev/ram0
rw
drbd.minor_count=8
)
"${kvm[@]}" --append "${append[*]}"
----------------------------------------------------------------------------
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years, 7 months
[mm] 23047a96d7: vm-scalability.throughput -23.8% regression
by kernel test robot
FYI, we noticed vm-scalability.throughput -23.8% regression due to commit:
commit 23047a96d7cfcfca1a6d026ecaec526ea4803e9e ("mm: workingset: per-cgroup cache thrash detection")
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
in testcase: vm-scalability
on test machine: lkp-hsw01: 56 threads Grantley Haswell-EP with 64G memory
with following conditions: cpufreq_governor=performance/runtime=300s/test=lru-file-readtwice
Details are as below:
-------------------------------------------------------------------------------------------------->
=========================================================================================
compiler/cpufreq_governor/kconfig/rootfs/runtime/tbox_group/test/testcase:
gcc-4.9/performance/x86_64-rhel/debian-x86_64-2015-02-07.cgz/300s/lkp-hsw01/lru-file-readtwice/vm-scalability
commit:
612e44939c3c77245ac80843c0c7876c8cf97282
23047a96d7cfcfca1a6d026ecaec526ea4803e9e
612e44939c3c7724 23047a96d7cfcfca1a6d026eca
---------------- --------------------------
%stddev %change %stddev
\ | \
28384711 ± 0% -23.8% 21621405 ± 0% vm-scalability.throughput
1854112 ± 0% -7.7% 1711141 ± 0% vm-scalability.time.involuntary_context_switches
176.03 ± 0% -22.2% 136.95 ± 1% vm-scalability.time.user_time
302905 ± 2% -31.2% 208386 ± 0% vm-scalability.time.voluntary_context_switches
0.92 ± 2% +51.0% 1.38 ± 2% perf-profile.cycles-pp.kswapd
754212 ± 1% -29.2% 533832 ± 2% softirqs.RCU
20518 ± 2% -8.1% 18866 ± 2% vmstat.system.cs
10574 ± 19% +29.9% 13737 ± 8% numa-meminfo.node0.Mapped
13490 ± 13% -36.6% 8549 ± 17% numa-meminfo.node1.Mapped
583.00 ± 8% +18.8% 692.50 ± 5% slabinfo.avc_xperms_node.active_objs
583.00 ± 8% +18.8% 692.50 ± 5% slabinfo.avc_xperms_node.num_objs
176.03 ± 0% -22.2% 136.95 ± 1% time.user_time
302905 ± 2% -31.2% 208386 ± 0% time.voluntary_context_switches
263.42 ± 0% -3.0% 255.52 ± 0% turbostat.PkgWatt
61.05 ± 0% -12.7% 53.26 ± 0% turbostat.RAMWatt
1868 ± 16% -43.7% 1052 ± 13% cpuidle.C1-HSW.usage
1499 ± 9% -30.3% 1045 ± 12% cpuidle.C3-HSW.usage
16071 ± 4% -15.0% 13664 ± 3% cpuidle.C6-HSW.usage
17572 ± 27% -59.1% 7179 ± 5% cpuidle.POLL.usage
4.896e+08 ± 0% -20.7% 3.884e+08 ± 0% numa-numastat.node0.local_node
71305376 ± 2% -19.7% 57223573 ± 4% numa-numastat.node0.numa_foreign
4.896e+08 ± 0% -20.7% 3.884e+08 ± 0% numa-numastat.node0.numa_hit
43760475 ± 3% -22.1% 34074417 ± 5% numa-numastat.node0.numa_miss
43765010 ± 3% -22.1% 34078937 ± 5% numa-numastat.node0.other_node
4.586e+08 ± 0% -25.7% 3.408e+08 ± 1% numa-numastat.node1.local_node
43760472 ± 3% -22.1% 34074417 ± 5% numa-numastat.node1.numa_foreign
4.586e+08 ± 0% -25.7% 3.408e+08 ± 1% numa-numastat.node1.numa_hit
71305376 ± 2% -19.7% 57223573 ± 4% numa-numastat.node1.numa_miss
71311721 ± 2% -19.7% 57229904 ± 4% numa-numastat.node1.other_node
543.25 ± 3% -15.0% 461.50 ± 3% numa-vmstat.node0.nr_isolated_file
2651 ± 19% +30.2% 3451 ± 8% numa-vmstat.node0.nr_mapped
1226 ± 6% -31.7% 837.25 ± 9% numa-vmstat.node0.nr_pages_scanned
37111278 ± 1% -20.6% 29474561 ± 3% numa-vmstat.node0.numa_foreign
2.568e+08 ± 0% -21.0% 2.028e+08 ± 0% numa-vmstat.node0.numa_hit
2.567e+08 ± 0% -21.0% 2.027e+08 ± 0% numa-vmstat.node0.numa_local
22595209 ± 2% -22.9% 17420980 ± 4% numa-vmstat.node0.numa_miss
22665391 ± 2% -22.8% 17490378 ± 4% numa-vmstat.node0.numa_other
88.25 ±173% +1029.7% 997.00 ± 63% numa-vmstat.node0.workingset_activate
3965715 ± 0% -24.9% 2977998 ± 0% numa-vmstat.node0.workingset_nodereclaim
90.25 ±170% +1006.4% 998.50 ± 63% numa-vmstat.node0.workingset_refault
612.50 ± 3% -9.4% 554.75 ± 4% numa-vmstat.node1.nr_alloc_batch
3279 ± 14% -34.1% 2161 ± 17% numa-vmstat.node1.nr_mapped
22597658 ± 2% -22.9% 17423271 ± 4% numa-vmstat.node1.numa_foreign
2.403e+08 ± 0% -25.9% 1.781e+08 ± 1% numa-vmstat.node1.numa_hit
2.403e+08 ± 0% -25.9% 1.781e+08 ± 1% numa-vmstat.node1.numa_local
37115261 ± 1% -20.6% 29478460 ± 3% numa-vmstat.node1.numa_miss
37136533 ± 1% -20.6% 29500409 ± 3% numa-vmstat.node1.numa_other
6137 ±173% +257.3% 21927 ± 60% numa-vmstat.node1.workingset_activate
3237162 ± 0% -30.6% 2246385 ± 1% numa-vmstat.node1.workingset_nodereclaim
6139 ±173% +257.2% 21930 ± 60% numa-vmstat.node1.workingset_refault
501243 ± 0% -26.9% 366510 ± 1% proc-vmstat.allocstall
28483 ± 0% -50.7% 14047 ± 3% proc-vmstat.kswapd_low_wmark_hit_quickly
1.151e+08 ± 0% -20.7% 91297990 ± 0% proc-vmstat.numa_foreign
9.482e+08 ± 0% -23.1% 7.293e+08 ± 0% proc-vmstat.numa_hit
9.482e+08 ± 0% -23.1% 7.293e+08 ± 0% proc-vmstat.numa_local
1.151e+08 ± 0% -20.7% 91297990 ± 0% proc-vmstat.numa_miss
1.151e+08 ± 0% -20.7% 91308842 ± 0% proc-vmstat.numa_other
31562 ± 0% -47.1% 16687 ± 2% proc-vmstat.pageoutrun
1.048e+09 ± 0% -22.8% 8.088e+08 ± 0% proc-vmstat.pgactivate
28481000 ± 0% -21.3% 22422907 ± 0% proc-vmstat.pgalloc_dma32
1.035e+09 ± 0% -22.9% 7.984e+08 ± 0% proc-vmstat.pgalloc_normal
1.041e+09 ± 0% -23.0% 8.024e+08 ± 0% proc-vmstat.pgdeactivate
1.063e+09 ± 0% -22.8% 8.2e+08 ± 0% proc-vmstat.pgfree
2458 ± 91% -93.5% 160.75 ± 29% proc-vmstat.pgmigrate_success
27571690 ± 0% -20.6% 21889554 ± 0% proc-vmstat.pgrefill_dma32
1.014e+09 ± 0% -23.0% 7.805e+08 ± 0% proc-vmstat.pgrefill_normal
25263166 ± 0% -27.4% 18337251 ± 1% proc-vmstat.pgscan_direct_dma32
9.377e+08 ± 0% -26.9% 6.852e+08 ± 1% proc-vmstat.pgscan_direct_normal
2134103 ± 1% +57.6% 3363418 ± 6% proc-vmstat.pgscan_kswapd_dma32
69594167 ± 0% +26.7% 88192786 ± 2% proc-vmstat.pgscan_kswapd_normal
25260851 ± 0% -27.4% 18335464 ± 1% proc-vmstat.pgsteal_direct_dma32
9.376e+08 ± 0% -26.9% 6.852e+08 ± 1% proc-vmstat.pgsteal_direct_normal
2133563 ± 1% +57.6% 3362346 ± 6% proc-vmstat.pgsteal_kswapd_dma32
69585316 ± 0% +26.7% 88176045 ± 2% proc-vmstat.pgsteal_kswapd_normal
17530080 ± 0% -23.3% 13440416 ± 0% proc-vmstat.slabs_scanned
6226 ±173% +268.2% 22924 ± 58% proc-vmstat.workingset_activate
7202139 ± 0% -27.5% 5223203 ± 0% proc-vmstat.workingset_nodereclaim
6230 ±173% +268.0% 22929 ± 58% proc-vmstat.workingset_refault
123.70 ± 12% +26.7% 156.79 ± 11% sched_debug.cfs_rq:/.load.stddev
42.08 ± 1% +23.3% 51.90 ± 8% sched_debug.cfs_rq:/.load_avg.avg
779.50 ± 2% +20.7% 940.83 ± 5% sched_debug.cfs_rq:/.load_avg.max
9.46 ± 8% -13.7% 8.17 ± 1% sched_debug.cfs_rq:/.load_avg.min
123.38 ± 2% +31.4% 162.10 ± 6% sched_debug.cfs_rq:/.load_avg.stddev
304497 ± 22% +65.6% 504169 ± 7% sched_debug.cfs_rq:/.min_vruntime.stddev
25.74 ± 8% +33.9% 34.46 ± 8% sched_debug.cfs_rq:/.runnable_load_avg.avg
481.33 ± 11% +50.5% 724.54 ± 11% sched_debug.cfs_rq:/.runnable_load_avg.max
69.65 ± 15% +62.2% 112.95 ± 12% sched_debug.cfs_rq:/.runnable_load_avg.stddev
-1363122 ±-14% +52.6% -2080627 ±-10% sched_debug.cfs_rq:/.spread0.min
304448 ± 22% +65.6% 504111 ± 7% sched_debug.cfs_rq:/.spread0.stddev
733220 ± 5% +13.0% 828548 ± 1% sched_debug.cpu.avg_idle.avg
123344 ± 11% +73.4% 213827 ± 27% sched_debug.cpu.avg_idle.min
233732 ± 5% -13.5% 202264 ± 6% sched_debug.cpu.avg_idle.stddev
26.93 ± 9% +27.8% 34.42 ± 8% sched_debug.cpu.cpu_load[0].avg
78.79 ± 19% +43.7% 113.20 ± 12% sched_debug.cpu.cpu_load[0].stddev
26.23 ± 8% +30.5% 34.23 ± 7% sched_debug.cpu.cpu_load[1].avg
513.17 ± 12% +38.6% 711.12 ± 11% sched_debug.cpu.cpu_load[1].max
73.34 ± 15% +50.7% 110.55 ± 11% sched_debug.cpu.cpu_load[1].stddev
25.93 ± 6% +32.6% 34.40 ± 6% sched_debug.cpu.cpu_load[2].avg
488.38 ± 8% +44.8% 706.96 ± 10% sched_debug.cpu.cpu_load[2].max
69.79 ± 10% +56.9% 109.52 ± 10% sched_debug.cpu.cpu_load[2].stddev
25.89 ± 4% +35.1% 34.97 ± 4% sched_debug.cpu.cpu_load[3].avg
467.83 ± 7% +50.2% 702.71 ± 9% sched_debug.cpu.cpu_load[3].max
67.27 ± 9% +63.6% 110.03 ± 8% sched_debug.cpu.cpu_load[3].stddev
25.83 ± 4% +37.2% 35.44 ± 3% sched_debug.cpu.cpu_load[4].avg
445.29 ± 9% +56.7% 697.88 ± 8% sched_debug.cpu.cpu_load[4].max
64.41 ± 9% +72.4% 111.02 ± 6% sched_debug.cpu.cpu_load[4].stddev
123.66 ± 12% +28.2% 158.54 ± 11% sched_debug.cpu.load.stddev
1.56 ± 1% +9.8% 1.71 ± 0% sched_debug.cpu.nr_running.avg
0.46 ± 12% +28.4% 0.59 ± 6% sched_debug.cpu.nr_running.stddev
57967 ± 3% -9.8% 52290 ± 2% sched_debug.cpu.nr_switches.avg
270099 ± 9% -16.4% 225748 ± 7% sched_debug.cpu.nr_switches.max
27370 ± 1% -13.3% 23723 ± 0% sched_debug.cpu.nr_switches.min
55749 ± 7% -14.3% 47767 ± 5% sched_debug.cpu.nr_switches.stddev
-55.33 ±-19% -40.4% -32.96 ± -2% sched_debug.cpu.nr_uninterruptible.min
=========================================================================================
compiler/kconfig/rootfs/sleep/tbox_group/testcase:
gcc-5/x86_64-randconfig-a0-04240012/yocto-minimal-i386.cgz/1/vm-kbuild-yocto-ia32/boot
commit:
612e44939c3c77245ac80843c0c7876c8cf97282
23047a96d7cfcfca1a6d026ecaec526ea4803e9e
612e44939c3c7724 23047a96d7cfcfca1a6d026eca
---------------- --------------------------
fail:runs %reproduction fail:runs
| | |
:50 2% 1:180 kmsg.augmented_rbtree_testing
:50 216% 108:180 last_state.is_incomplete_run
vm-scalability.time.user_time
180 *+**-*-----*-*-*--*-*---*----*-*-**------**-*-**-**------*-**---------+
175 ++ **.* * *.* *.* **.* *.** + .*.**.*
| ** |
170 ++ |
165 ++ |
| |
160 ++ |
155 ++ |
150 ++ |
| O |
145 O+ O O OO O |
140 ++ OO O |
| OO O O O O O OO O O |
135 ++ O O O O OO O O O |
130 ++-------------O------------------------------------------------------+
vm-scalability.throughput
2.9e+07 ++------*--------------------------*---------------*--------------+
|.* * *.* .**.**.* .*.**. *. .* **. *. .* * *.* .* .**.**.*
2.8e+07 *+ *.* * * * ** * * *.* * * |
2.7e+07 ++ |
| |
2.6e+07 ++ |
| |
2.5e+07 ++ |
| |
2.4e+07 ++ |
2.3e+07 ++O OO O |
O O OO O |
2.2e+07 ++ |
| OO OO OO O OO OO OO OO OO OO O OO |
2.1e+07 ++----------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Xiaolong
4 years, 7 months
[fix] 1dfc8570aa: BUG: unable to handle kernel paging request at 00007fffffffbd40
by kernel test robot
FYI, we noticed the following commit:
https://git.kernel.org/pub/scm/linux/kernel/git/jolsa/perf.git sched/affine_6
commit 1dfc8570aa5bcc00d48fd25adead5cdcb962d0a9 ("fix")
on test machine: ivb42: 48 threads Ivytown Ivy Bridge-EP with 64G memory
caused below changes:
+-------------------------------------------------------------+------------+------------+
| | 50605ffbda | 1dfc8570aa |
+-------------------------------------------------------------+------------+------------+
| boot_successes | 15 | 11 |
| boot_failures | 0 | 4 |
| BUG:unable_to_handle_kernel | 0 | 4 |
| Oops | 0 | 4 |
| RIP:__set_task_blocked | 0 | 1 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 4 |
| WARNING:at_arch/x86/include/asm/fpu/internal.h:#__switch_to | 0 | 3 |
| RIP:show_stack_log_lvl | 0 | 1 |
+-------------------------------------------------------------+------------+------------+
[ 28.547729] ipmi device interface
[ 30.562319] ------------[ cut here ]------------
[ 30.567709] kernel tried to execute NX-protected page - exploit attempt? (uid: 0)
[ 30.576326] BUG: unable to handle kernel paging request at 00007fffffffbd40
[ 30.584390] IP: [<00007fffffffbd40>] 0x7fffffffbd40
[ 30.590125] PGD 8043e2067 PUD 804a13067 PMD 807849067 PTE 8000000806d26067
[ 30.598162] Oops: 0011 [#1] SMP
[ 30.602101] Modules linked in: ipmi_devintf rpcsec_gss_krb5 auth_rpcgss nfsv4 dns_resolver sg sd_mod mgag200 ttm drm_kms_helper syscopyarea x86_pkg_temp_thermal sysfillrect sysimgblt coretemp fb_sys_fops kvm_intel isci kvm irqbypass libsas ahci snd_pcm crct10dif_pclmul crc32_pclmul scsi_transport_sas libahci drm crc32c_intel ghash_clmulni_intel snd_timer aesni_intel lrw gf128mul ipmi_si libata glue_helper snd ablk_helper ipmi_msghandler sb_edac soundcore cryptd pcspkr wmi edac_core shpchp
[ 30.652708] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.6.0-rc7-00126-g1dfc857 #1
[ 30.661571] Hardware name: Intel Corporation S2600WP/S2600WP, BIOS SE5C600.86B.02.02.0002.122320131210 12/23/2013
[ 30.673578] task: ffffffff81e0d500 ti: ffffffff81e00000 task.ti: ffffffff81e00000
[ 30.682508] RIP: 0246:[<ffffffff81089202>] [<ffffffff81089202>] __set_task_blocked+0x32/0x80
[ 30.692650] RSP: 6083a0:0000000000000001 EFLAGS: 006083a0
[ 30.699394] RAX: 0000000000000000 RBX: 0000034446505853 RCX: ffff880808747eb0
[ 30.708008] RDX: ffff880808747e70 RSI: ffffffff810888ab RDI: ffff8808038acb00
[ 30.716637] RBP: 0000034000000000 R08: 0000000000000000 R09: 0000000000000000
[ 30.725284] R10: 0000000000000340 R11: 0000000000000007 R12: 0000000000000007
[ 30.733940] R13: ffffffff81039a8d R14: ffff880808747eb8 R15: ffffffff811a4347
[ 30.742613] FS: 0000000000000000(0000) GS:ffff88081e000000(0000) knlGS:0000000000000000
[ 30.752373] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 30.759518] CR2: 00007fffffffbd40 CR3: 0000000808f74000 CR4: 00000000001406f0
[ 30.768245]
[ 30.770673] RIP [<ffffffff81089202>] __set_task_blocked+0x32/0x80
[ 30.778383] RSP <0000000000000001>
[ 30.783081] kernel tried to execute NX-protected page - exploit attempt? (uid: 0)
[ 30.792277] BUG: unable to handle kernel paging request at ffff880806630780
[ 30.800938] IP: [<ffff880806630780>] 0xffff880806630780
[ 30.807669] PGD 23b2067 PUD 1018536063 PMD 806734063 PTE 8000000806630163
[ 30.816189] Oops: 0011 [#2] SMP
[ 30.820726] Modules linked in: ipmi_devintf rpcsec_gss_krb5 auth_rpcgss nfsv4 dns_resolver sg sd_mod mgag200 ttm drm_kms_helper syscopyarea x86_pkg_temp_thermal sysfillrect sysimgblt coretemp fb_sys_fops kvm_intel isci kvm irqbypass libsas ahci snd_pcm crct10dif_pclmul crc32_pclmul scsi_transport_sas libahci drm crc32c_intel ghash_clmulni_intel snd_timer aesni_intel lrw gf128mul ipmi_si libata glue_helper snd ablk_helper ipmi_msghandler sb_edac soundcore cryptd pcspkr wmi edac_core shpchp
[ 30.872857] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.6.0-rc7-00126-g1dfc857 #1
[ 30.881884] Hardware name: Intel Corporation S2600WP/S2600WP, BIOS SE5C600.86B.02.02.0002.122320131210 12/23/2013
[ 30.894042] task: ffffffff81e0d500 ti: ffffffff81e00000 task.ti: ffffffff81e00000
[ 30.903110] RIP: 0010:[<ffff880806630780>] [<ffff880806630780>] 0xffff880806630780
[ 30.912391] RSP: 0018:ffff880808747ca8 EFLAGS: 00010046
[ 30.919056] RAX: 0000000000000000 RBX: ffff880808747df8 RCX: 0000000000000006
[ 30.927771] RDX: 0000000000000017 RSI: 0000000000000046 RDI: ffff88081e00e190
[ 30.936493] RBP: ffff880808747cb8 R08: 0000000000000000 R09: 0000000000000000
[ 30.945224] R10: 00003ffffffff000 R11: 00000000000006fb R12: ffffffff81e42f00
[ 30.953963] R13: 0000000000000086 R14: 0000000000000046 R15: 00007fffffffbd40
[ 30.962712] FS: 0000000000000000(0000) GS:ffff88081e000000(0000) knlGS:0000000000000000
[ 30.972521] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 30.979707] CR2: ffff880806630780 CR3: 0000000808f74000 CR4: 00000000001406f0
[ 30.988450] Stack:
[ 30.991461] ffff880806630780 ffff880808747e28 ffff880808747cd0 ffffffff81088193
[ 31.000538] 000000000000000e ffff880808747d00 ffffffff810886a6 0000000e81e0d500
[ 31.009612] ffff880808747d00 ffffffff810888ab 000000000000000e ffff880808747d38
[ 31.018686] Call Trace:
[ 31.022171] <UNK>
[ 31.024322] Code: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2f e4 81 ff ff ff ff <20> 08 63 06 08 88 ff ff 80 07 63 06 08 88 ff ff 00 00 00 00 00
[ 31.048556] RIP [<ffff880806630780>] 0xffff880806630780
[ 31.055230] RSP <ffff880808747ca8>
[ 31.059838] CR2: ffff880806630780
[ 31.064213] ---[ end trace 5ac639aeae8b0b39 ]---
[ 31.072479] Kernel panic - not syncing: Fatal exception
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Kernel Test Robot
4 years, 7 months