[lkp] [chrdev] af427b8e3a: kmsg.ide-tape:Failed_to_register_chrdev_interface
by kernel test robot
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/linusw/linux-gpio.git chrdev-warn
commit af427b8e3a4e1fc4f7e893a617acf9520cdd616c ("chrdev: allocate dynamic chardevs in all unused holes")
As below, the log "ide-tape: Failed to register chrdev interface" showed with your commit.
[ 5.180939] hdc: QEMU DVD-ROM, ATAPI CD/DVD-ROM drive
[ 5.853022] hdc: host max PIO4 wanted PIO255(auto-tune) selected PIO0
[ 5.854273] hdc: MWDMA2 mode selected
[ 5.855154] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
[ 5.856004] ide1 at 0x170-0x177,0x376 on irq 15
[ 5.862154] ide-gd driver 1.18
[ 5.862765] ide-tape: Failed to register chrdev interface
[ 5.863789] Loading iSCSI transport class v2.0-870.
[ 5.881544] fnic: Cisco FCoE HBA Driver, ver 1.6.0.17a
[ 5.882531] fnic: Successfully Initialized Trace Buffer
[ 5.884415] fnic: Successfully Initialized FC_CTLR Trace Buffer
[ 5.894058] Loading Adaptec I2O RAID: Version 2.4 Build 5go
[ 5.895042] Detecting Adaptec I2O RAID controllers...
[ 5.895900] Adaptec aacraid driver 1.2-1[41010]-ms
[ 5.897116] qla2xxx [0000:00:00.0]-0005: : QLogic Fibre Channel HBA Driver: 8.07.00.26-k.
[ 5.898534] csiostor: Chelsio FCoE driver 1.0.0
[ 5.899479] megasas: 06.808.16.00-rc1
[ 5.900172] mpt3sas version 09.102.00.00 loaded
[ 5.901225] 3ware 9000 Storage Controller device driver for Linux v2.26.02.014.
[ 5.902498] ipr: IBM Power RAID SCSI Device Driver version: 2.6.3 (October 17, 2015)
[ 5.903896] libcxgbi:libcxgbi_init_module: Chelsio iSCSI driver library libcxgbi v0.9.1-ko (Apr. 2015)
[ 5.905462] libcxgbi:libcxgbi_init_module: tag itt 0x1fff, 13 bits, age 0xf, 4 bits.
[ 5.919807] libcxgbi:ddp_setup_host_page_size: system PAGE 4096, ddp idx 0.
[ 5.920991] Chelsio T3 iSCSI Driver cxgb3i v2.0.1-ko (Apr. 2015)
FYI, raw QEMU command line is:
qemu-system-x86_64 -enable-kvm -cpu SandyBridge -kernel /pkg/linux/x86_64-acpi-redef/gcc-5/af427b8e3a4e1fc4f7e893a617acf9520cdd616c/vmlinuz-4.5.0-rc2-00207-gaf427b8 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-28/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-acpi-redef-af427b8e3a4e1fc4f7e893a617acf9520cdd616c-20160319-21157-140zqnh-0.yaml ARCH=x86_64 kconfig=x86_64-acpi-redef branch=linux-devel/devel-catchup-201603190348 commit=af427b8e3a4e1fc4f7e893a617acf9520cdd616c BOOT_IMAGE=/pkg/linux/x86_64-acpi-redef/gcc-5/af427b8e3a4e1fc4f7e893a617acf9520cdd616c/vmlinuz-4.5.0-rc2-00207-gaf427b8 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-x86_64/yocto-minimal-x86_64.cgz/x86_64-acpi-redef/gcc-5/af427b8e3a4e1fc4f7e893a617acf9520cdd616c/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-kbuild-yocto-x86_64-28::dhcp drbd.minor_count=8' -initrd /fs/sdc1/initrd-vm-kbuild-yocto-x86_64-28 -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-kbuild-yocto-x86_64-28,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-x86_64-28 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-x86_64-28 -daemonize -display none -monitor null
Thanks,
Xiaolong Ye
5 years, 8 months
[lkp] [x86/mm] e5809dfe26: BUG: sleeping function called from invalid context at kernel/locking/mutex.c:617
by kernel test robot
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/luto/linux.git x86/pcid
commit e5809dfe266f4ab66b20db540663298d909c7b8c ("x86/mm: Rework ASID")
+-----------------------------------------------------------------------------+------------+------------+
| | 80d0fe1f83 | e5809dfe26 |
+-----------------------------------------------------------------------------+------------+------------+
| boot_successes | 2 | 0 |
| boot_failures | 1 | 34 |
| BUG:kernel_test_crashed | 1 | |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/mutex.c | 0 | 34 |
| backtrace:do_execve | 0 | 34 |
| backtrace:run_init_process | 0 | 34 |
| backtrace:do_group_exit | 0 | 9 |
| backtrace:SyS_exit_group | 0 | 9 |
| backtrace:_do_fork | 0 | 22 |
| backtrace:SyS_clone | 0 | 22 |
| backtrace:do_execveat_common | 0 | 1 |
| backtrace:compat_SyS_execve | 0 | 1 |
| backtrace:vm_munmap | 0 | 27 |
| backtrace:SyS_munmap | 0 | 27 |
| backtrace:SyS_execve | 0 | 7 |
+-----------------------------------------------------------------------------+------------+------------+
As below, the log "BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/mutex.c" showed with your commit.
[ 19.078534] ALSA device list:
[ 19.079430] No soundcards found.
[ 19.089897] Freeing unused kernel memory: 3452K (ffffffff82453000 - ffffffff827b2000)
[ 19.094018] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:617
[ 19.098702] in_atomic(): 1, irqs_disabled(): 0, pid: 1, name: init
[ 19.100989] 2 locks held by init/1:
[ 19.102597] #0: (&sig->cred_guard_mutex){+.+.+.}, at: [<ffffffff811e1ce8>] prepare_bprm_creds+0x35/0x6e
[ 19.106614] #1: (&mm->mmap_sem){+.+.+.}, at: [<ffffffff811e064e>] setup_arg_pages+0xc1/0x1e7
[ 19.110226] CPU: 0 PID: 1 Comm: init Not tainted 4.5.0-rc2-00216-ge5809df #85
[ 19.112416] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 19.115924] 0000000000000000 ffff88001200faa0 ffffffff81520f7f ffff880012018000
[ 19.119587] ffff88001200fac8 ffffffff810be484 ffffffff820d3bcf 0000000000000269
[ 19.123320] 0000000000000000 ffff88001200faf0 ffffffff810be500 ffff88000c0803a0
[ 19.127074] Call Trace:
[ 19.128472] [<ffffffff81520f7f>] dump_stack+0x4b/0x63
[ 19.130435] [<ffffffff810be484>] ___might_sleep+0x1f9/0x200
[ 19.132523] [<ffffffff810be500>] __might_sleep+0x75/0x7c
[ 19.134538] [<ffffffff81c67f69>] mutex_lock_nested+0x3e/0x35f
[ 19.136624] [<ffffffff81085ce6>] ? kvm_clock_read+0x25/0x2e
[ 19.138677] [<ffffffff81085d03>] ? kvm_sched_clock_read+0x9/0x12
[ 19.140863] [<ffffffff810548c6>] ? sched_clock+0x9/0xd
[ 19.142856] [<ffffffff8108f51d>] propagate_tlb_flush+0x27/0xa6
[ 19.145102] [<ffffffff8108f51d>] ? propagate_tlb_flush+0x27/0xa6
[ 19.147385] [<ffffffff81090099>] flush_tlb_mm_range+0x1aa/0x213
[ 19.149550] [<ffffffff811b0b80>] move_page_tables+0x518/0x549
[ 19.151667] [<ffffffff811e04e7>] shift_arg_pages+0xc0/0x166
[ 19.153752] [<ffffffff810e2576>] ? lock_acquire+0x113/0x1a1
[ 19.155826] [<ffffffff811e064e>] ? setup_arg_pages+0xc1/0x1e7
[ 19.157930] [<ffffffff811e064e>] ? setup_arg_pages+0xc1/0x1e7
[ 19.160026] [<ffffffff811e0747>] setup_arg_pages+0x1ba/0x1e7
[ 19.162111] [<ffffffff81228b1a>] load_elf_binary+0x356/0xf24
[ 19.164178] [<ffffffff81085d03>] ? kvm_sched_clock_read+0x9/0x12
[ 19.166319] [<ffffffff810548c6>] ? sched_clock+0x9/0xd
[ 19.168266] [<ffffffff810c87b1>] ? local_clock+0x20/0x22
[ 19.170279] [<ffffffff811e0975>] search_binary_handler+0x79/0x182
[ 19.172459] [<ffffffff811e230d>] do_execveat_common+0x5ec/0x859
[ 19.195109] [<ffffffff81c5e7c9>] ? rest_init+0x140/0x140
[ 19.197145] [<ffffffff811e259d>] do_execve+0x23/0x25
[ 19.199114] [<ffffffff810002e3>] run_init_process+0x2b/0x2d
[ 19.201207] [<ffffffff81c5e80b>] kernel_init+0x42/0xd9
[ 19.203208] [<ffffffff81c6c41f>] ret_from_fork+0x3f/0x70
[ 19.205244] [<ffffffff81c5e7c9>] ? rest_init+0x140/0x140
[ 19.217441] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
[ 20.094744] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:617
[ 20.098021] in_atomic(): 1, irqs_disabled(): 0, pid: 2071, name: udevd
[ 20.100044] 2 locks held by udevd/2071:
[ 20.101405] #0: (&cgroup_threadgroup_rwsem){.+.+.+}, at: [<ffffffff810976ee>] copy_process+0x546/0x18b8
[ 20.105297] #1: (&mm->mmap_sem){++++++}, at: [<ffffffff81097ee9>] copy_process+0xd41/0x18b8
[ 20.108847] CPU: 0 PID: 2071 Comm: udevd Not tainted 4.5.0-rc2-00216-ge5809df #85
[ 20.111694] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 20.114691] 0000000000000000 ffff88000c3dbc80 ffffffff81520f7f ffff88000c39aa40
[ 20.118032] ffff88000c3dbca8 ffffffff810be484 ffffffff820d3bcf 0000000000000269
[ 20.121303] 0000000000000000 ffff88000c3dbcd0 ffffffff810be500 ffff88000c30dfa0
[ 20.124604] Call Trace:
[ 20.125970] [<ffffffff81520f7f>] dump_stack+0x4b/0x63
[ 20.127606] [<ffffffff810be484>] ___might_sleep+0x1f9/0x200
[ 20.129410] [<ffffffff810be500>] __might_sleep+0x75/0x7c
[ 20.131124] [<ffffffff81c67f69>] mutex_lock_nested+0x3e/0x35f
[ 20.132948] [<ffffffff81085ce6>] ? kvm_clock_read+0x25/0x2e
[ 20.134798] [<ffffffff81085d03>] ? kvm_sched_clock_read+0x9/0x12
[ 20.136590] [<ffffffff810548c6>] ? sched_clock+0x9/0xd
[ 20.138323] [<ffffffff8108f51d>] propagate_tlb_flush+0x27/0xa6
[ 20.140291] [<ffffffff8108f51d>] ? propagate_tlb_flush+0x27/0xa6
[ 20.142244] [<ffffffff81090099>] flush_tlb_mm_range+0x1aa/0x213
[ 20.144105] [<ffffffff810981b0>] copy_process+0x1008/0x18b8
[ 20.145945] [<ffffffff81098bf3>] _do_fork+0xbd/0x5d4
[ 20.147686] [<ffffffff81c6cbc4>] ? retint_user+0x18/0x20
[ 20.149402] [<ffffffff810e01ef>] ? trace_hardirqs_on_caller+0x17d/0x199
[ 20.151373] [<ffffffff81001017>] ? trace_hardirqs_on_thunk+0x17/0x19
[ 20.153309] [<ffffffff81099190>] SyS_clone+0x19/0x1b
[ 20.155064] [<ffffffff81c6c0b2>] entry_SYSCALL_64_fastpath+0x12/0x72
[ 21.094778] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:617
[ 21.100371] in_atomic(): 1, irqs_disabled(): 0, pid: 2292, name: mount.sh
[ 21.103857] 2 locks held by mount.sh/2292:
[ 21.106265] #0: (&cgroup_threadgroup_rwsem){.+.+.+}, at: [<ffffffff810976ee>] copy_process+0x546/0x18b8
[ 21.112531] #1: (&mm->mmap_sem){++++++}, at: [<ffffffff81097ee9>] copy_process+0xd41/0x18b8
[ 21.118074] CPU: 0 PID: 2292 Comm: mount.sh Not tainted 4.5.0-rc2-00216-ge5809df #85
[ 21.122721] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 21.127422] 0000000000000000 ffff88000b07fc80 ffffffff81520f7f ffff88000b7f0000
[ 21.132282] ffff88000b07fca8 ffffffff810be484 ffffffff820d3bcf 0000000000000269
[ 21.137007] 0000000000000000 ffff88000b07fcd0 ffffffff810be500 ffff8800009634a0
[ 21.141808] Call Trace:
[ 21.143582] [<ffffffff81520f7f>] dump_stack+0x4b/0x63
[ 21.146393] [<ffffffff810be484>] ___might_sleep+0x1f9/0x200
[ 21.149581] [<ffffffff810be500>] __might_sleep+0x75/0x7c
[ 21.152686] [<ffffffff81c67f69>] mutex_lock_nested+0x3e/0x35f
[ 21.155795] [<ffffffff81085ce6>] ? kvm_clock_read+0x25/0x2e
[ 21.158841] [<ffffffff81085d03>] ? kvm_sched_clock_read+0x9/0x12
[ 21.162026] [<ffffffff810548c6>] ? sched_clock+0x9/0xd
[ 21.164890] [<ffffffff8108f51d>] propagate_tlb_flush+0x27/0xa6
[ 21.168325] [<ffffffff8108f51d>] ? propagate_tlb_flush+0x27/0xa6
[ 21.172010] [<ffffffff81090099>] flush_tlb_mm_range+0x1aa/0x213
[ 21.175213] [<ffffffff810981b0>] copy_process+0x1008/0x18b8
[ 21.178618] [<ffffffff81098bf3>] _do_fork+0xbd/0x5d4
[ 21.181445] [<ffffffff811a58b1>] ? __might_fault+0x40/0x8d
[ 21.184399] [<ffffffff81001044>] ? lockdep_sys_exit_thunk+0x12/0x14
[ 21.187857] [<ffffffff81099190>] SyS_clone+0x19/0x1b
[ 21.190601] [<ffffffff81c6c0b2>] entry_SYSCALL_64_fastpath+0x12/0x72
[ 21.214523] blk_update_request: I/O error, dev fd0, sector 0
FYI, raw QEMU command line is:
qemu-system-x86_64 -enable-kvm -cpu SandyBridge -kernel /pkg/linux/x86_64-nfsroot/gcc-5/e5809dfe266f4ab66b20db540663298d909c7b8c/vmlinuz-4.5.0-rc2-00216-ge5809df -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-x86_64-34/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-nfsroot-e5809dfe266f4ab66b20db540663298d909c7b8c-20160322-8447-s50ff4-5.yaml ARCH=x86_64 kconfig=x86_64-nfsroot branch=linux-devel/devel-catchup-201603221233 commit=e5809dfe266f4ab66b20db540663298d909c7b8c BOOT_IMAGE=/pkg/linux/x86_64-nfsroot/gcc-5/e5809dfe266f4ab66b20db540663298d909c7b8c/vmlinuz-4.5.0-rc2-00216-ge5809df max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-x86_64/yocto-minimal-x86_64.cgz/x86_64-nfsroot/gcc-5/e5809dfe266f4ab66b20db540663298d909c7b8c/5 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-x86_64-34::dhcp drbd.minor_count=8' -initrd /fs/sda1/initrd-vm-kbuild-yocto-x86_64-34 -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/sda1/disk0-vm-kbuild-yocto-x86_64-34,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-kbuild-yocto-x86_64-34 -serial file:/dev/shm/kboot/serial-vm-kbuild-yocto-x86_64-34 -daemonize -display none -monitor null
Thanks,
Xiaolong Ye
5 years, 8 months
[lkp] [sched, fair] dabbd61e79: No primary result change, -25.5% unixbench.time.involuntary_context_switches
by kernel test robot
FYI, we noticed that unixbench.time.involuntary_context_switches -25.5% change with your commit.
https://git.kernel.org/pub/scm/linux/kernel/git/peterz/queue.git sched/urgent
commit dabbd61e79c918f1d8a31598a678bc04e042faf8 ("sched,fair: Fix fairness issue on migrate")
=========================================================================================
compiler/cpufreq_governor/kconfig/nr_task/rootfs/tbox_group/test/testcase:
gcc-4.9/performance/x86_64-rhel/100%/debian-x86_64-2015-02-07.cgz/lkp-ivb-d01/shell1/unixbench
commit:
8ddfc624ef1cf17d19983350e3aa1c413eca98b2
dabbd61e79c918f1d8a31598a678bc04e042faf8
8ddfc624ef1cf17d dabbd61e79c918f1d8a31598a6
---------------- --------------------------
fail:runs %reproduction fail:runs
%stddev %change %stddev
\ | \
2657847 ± 0% -25.5% 1981056 ± 0% unixbench.time.involuntary_context_switches
5863552 ± 0% -9.9% 5283600 ± 0% unixbench.time.voluntary_context_switches
2657847 ± 0% -25.5% 1981056 ± 0% time.involuntary_context_switches
5863552 ± 0% -9.9% 5283600 ± 0% time.voluntary_context_switches
61338 ± 0% -12.6% 53619 ± 0% vmstat.system.cs
11328 ± 0% -4.1% 10864 ± 0% vmstat.system.in
2509602 ± 3% +14.4% 2870105 ± 1% cpuidle.C3-IVB.time
40796 ± 1% +8.3% 44163 ± 3% cpuidle.C3-IVB.usage
9140 ± 9% -42.7% 5234 ± 8% cpuidle.POLL.usage
0.31 ± 10% -20.0% 0.25 ± 0% sched_debug.cfs_rq:/.nr_spread_over.avg
34.51 ± 3% +8.7% 37.52 ± 1% sched_debug.cfs_rq:/.runnable_load_avg.avg
9627 ± 11% +25.2% 12056 ± 6% sched_debug.cpu.curr->pid.avg
11046 ± 6% +24.3% 13726 ± 4% sched_debug.cpu.curr->pid.max
696919 ± 0% -12.4% 610359 ± 0% sched_debug.cpu.nr_switches.avg
721494 ± 1% -13.1% 626954 ± 0% sched_debug.cpu.nr_switches.max
679371 ± 0% -11.7% 599806 ± 0% sched_debug.cpu.nr_switches.min
13857 ± 18% -29.8% 9733 ± 3% sched_debug.cpu.nr_switches.stddev
46.75 ± 79% -137.4% -17.50 ±-151% sched_debug.cpu.nr_uninterruptible.4
79.19 ± 27% -39.2% 48.12 ± 18% sched_debug.cpu.nr_uninterruptible.max
-76.06 ±-25% -31.9% -51.81 ±-15% sched_debug.cpu.nr_uninterruptible.min
49.98 ± 15% -30.5% 34.74 ± 18% sched_debug.cpu.nr_uninterruptible.stddev
701565 ± 0% -12.4% 614787 ± 0% sched_debug.cpu.sched_count.avg
749766 ± 0% -12.3% 657902 ± 0% sched_debug.cpu.sched_count.max
679732 ± 0% -11.7% 600230 ± 0% sched_debug.cpu.sched_count.min
22192 ± 7% -17.7% 18262 ± 5% sched_debug.cpu.sched_count.stddev
304372 ± 0% -13.1% 264622 ± 0% sched_debug.cpu.ttwu_count.avg
317048 ± 1% -13.8% 273189 ± 0% sched_debug.cpu.ttwu_count.max
295849 ± 0% -12.1% 260075 ± 0% sched_debug.cpu.ttwu_count.min
6882 ± 20% -38.3% 4248 ± 7% sched_debug.cpu.ttwu_count.stddev
220538 ± 0% -15.7% 185970 ± 0% sched_debug.cpu.ttwu_local.avg
229084 ± 1% -16.4% 191577 ± 1% sched_debug.cpu.ttwu_local.max
215432 ± 0% -14.9% 183288 ± 0% sched_debug.cpu.ttwu_local.min
4627 ± 28% -41.3% 2717 ± 18% sched_debug.cpu.ttwu_local.stddev
lkp-ivb-d01: Ivy Bridge
Memory: 16G
pigz.time.involuntary_context_switches
270000 ++-----------------------------------------------------------------+
260000 ++ .*.. |
*.. .*.. .*..*.. .*.*..*.*. .*..*.*.. *
250000 ++ *. .*.*..* *..*. .* .*. * *. ..|
240000 ++ *. *. * * |
| |
230000 ++ |
220000 ++ |
210000 ++ |
| |
200000 ++ |
190000 ++ O O O |
O O O O O O O O O O O O O O O O O |
180000 ++ O |
170000 ++-----------------------------------------------------------------+
time.involuntary_context_switches
270000 ++-----------------------------------------------------------------+
260000 ++ .*.. |
*.. .*.. .*..*.. .*.*..*.*. .*..*.*.. *
250000 ++ *. .*.*..* *..*. .* .*. * *. ..|
240000 ++ *. *. * * |
| |
230000 ++ |
220000 ++ |
210000 ++ |
| |
200000 ++ |
190000 ++ O O O |
O O O O O O O O O O O O O O O O O |
180000 ++ O |
170000 ++-----------------------------------------------------------------+
unixbench.time.voluntary_context_switches
5.9e+06 ++-----------------*---------------------**--------**---*---------+
*.**.*.**.*.*.**.* *.*.**.*.**.*.*.**.* *.**.* * + .*.**.*
5.8e+06 ++ ** |
| |
5.7e+06 ++ |
| |
5.6e+06 ++ |
| |
5.5e+06 ++ |
| |
5.4e+06 ++ |
| |
5.3e+06 O+ O OO O O OO OO O OO O O O |
| O O O OO O |
5.2e+06 ++----------------------------------------------------------------+
unixbench.time.involuntary_context_switches
2.7e+06 ++----------------------------------------------------------------+
*.**.*.**.*.*.**.*.**.*.**.*.**.*.*.**.*.**.*.**.*.**.*.*.**.*.**.*
2.6e+06 ++ |
| |
2.5e+06 ++ |
2.4e+06 ++ |
| |
2.3e+06 ++ |
| |
2.2e+06 ++ |
2.1e+06 ++ |
| |
2e+06 ++ O O O O O |
O OO O OO O OO O OO O O O O O |
1.9e+06 ++----------------------------------------------------------------+
time.voluntary_context_switches
5.9e+06 ++-----------------*---------------------**--------**---*---------+
*.**.*.**.*.*.**.* *.*.**.*.**.*.*.**.* *.**.* * + .*.**.*
5.8e+06 ++ ** |
| |
5.7e+06 ++ |
| |
5.6e+06 ++ |
| |
5.5e+06 ++ |
| |
5.4e+06 ++ |
| |
5.3e+06 O+ O OO O O OO OO O OO O O O |
| O O O OO O |
5.2e+06 ++----------------------------------------------------------------+
time.involuntary_context_switches
2.7e+06 ++----------------------------------------------------------------+
*.**.*.**.*.*.**.*.**.*.**.*.**.*.*.**.*.**.*.**.*.**.*.*.**.*.**.*
2.6e+06 ++ |
| |
2.5e+06 ++ |
2.4e+06 ++ |
| |
2.3e+06 ++ |
| |
2.2e+06 ++ |
2.1e+06 ++ |
| |
2e+06 ++ O O O O O |
O OO O OO O OO O OO O O O O O |
1.9e+06 ++----------------------------------------------------------------+
[*] 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.
5 years, 8 months
[lkp] [tty/serial/8250] 9e2a7d9c24: BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
by kernel test robot
FYI, we noticed the below changes on
https://github.com/0day-ci/linux yegorslists-googlemail-com/tty-serial-8250-add-MCTRL_GPIO-support/20160322-211617
commit 9e2a7d9c247ff3c90ff8a4086a165a6d141de16f ("tty/serial/8250: use mctrl_gpio helpers")
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000] NR_IRQS:4352 nr_irqs:440 16
[ 0.000000] BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
[ 0.000000] IP: [<ffffffff817064c5>] mctrl_gpio_set+0x15/0x60
[ 0.000000] PGD 0
[ 0.000000] Oops: 0000 [#1] SMP
[ 0.000000] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.5.0-next-20160322-00005-g9e2a7d9 #236
[ 0.000000] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 0.000000] task: ffffffff8301b540 ti: ffffffff83000000 task.ti: ffffffff83000000
[ 0.000000] RIP: 0010:[<ffffffff817064c5>] [<ffffffff817064c5>] mctrl_gpio_set+0x15/0x60
[ 0.000000] RSP: 0000:ffffffff83003d48 EFLAGS: 00010086
[ 0.000000] RAX: ffffffff826f8a48 RBX: 0000000000000000 RCX: 0000000000000000
[ 0.000000] RDX: 0000000000000008 RSI: 0000000000000002 RDI: 0000000000000000
[ 0.000000] RBP: ffffffff83003da8 R08: 000000000001c200 R09: 000000000000002a
[ 0.000000] R10: 0000000000000000 R11: 0000000000000053 R12: ffffffff8503e2e0
[ 0.000000] R13: 000000000001c200 R14: 0000000000000013 R15: 0000000000000001
[ 0.000000] FS: 0000000000000000(0000) GS:ffff880014c00000(0000) knlGS:0000000000000000
[ 0.000000] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 0.000000] CR2: 0000000000000008 CR3: 0000000003014000 CR4: 00000000000006b0
[ 0.000000] Stack:
[ 0.000000] 0000000000000086 ffffffff83003db0 ffffffff810d9e16 0000000000000000
[ 0.000000] ffffffff816f6e06 0000000000000000 0000000000000000 0000000000000001
[ 0.000000] 0000000000000000 ffffffff83003db0 ffffffff816f3627 ffffffff8503e2e0
[ 0.000000] Call Trace:
[ 0.000000] [<ffffffff810d9e16>] ? lock_acquire+0xa6/0xe0
[ 0.000000] [<ffffffff816f6e06>] ? serial8250_do_set_termios+0xf6/0x3f0
[ 0.000000] [<ffffffff816f3627>] ? default_serial_dl_write+0x27/0x30
[ 0.000000] [<ffffffff816f65d3>] serial8250_do_set_mctrl+0xa3/0xb0
[ 0.000000] [<ffffffff816f65f6>] serial8250_set_mctrl+0x16/0x20
[ 0.000000] [<ffffffff816f6fec>] serial8250_do_set_termios+0x2dc/0x3f0
[ 0.000000] [<ffffffff816f7116>] serial8250_set_termios+0x16/0x20
[ 0.000000] [<ffffffff816f1054>] uart_set_options+0xf4/0x150
[ 0.000000] [<ffffffff816f754f>] serial8250_console_setup+0x7f/0x130
[ 0.000000] [<ffffffff816f22c9>] univ8250_console_setup+0x39/0x50
[ 0.000000] [<ffffffff810e4075>] register_console+0x295/0x370
[ 0.000000] [<ffffffff832c4c52>] univ8250_console_init+0x1e/0x28
[ 0.000000] [<ffffffff832c4328>] console_init+0x1c/0x25
[ 0.000000] [<ffffffff83289dc2>] start_kernel+0x2cc/0x44c
[ 0.000000] [<ffffffff83289120>] ? early_idt_handler_array+0x120/0x120
[ 0.000000] [<ffffffff83289354>] x86_64_start_reservations+0x38/0x3a
[ 0.000000] [<ffffffff83289441>] x86_64_start_kernel+0xeb/0xf8
[ 0.000000] Code: ef e8 80 b5 d4 00 5b 41 5c 41 5d 5d c3 66 0f 1f 84 00 00 00 00 00 55 48 8d 57 08 48 c7 c0 48 8a 6f 82 31 ff 48 89 e5 48 83 ec 60 <48> 8b 0a 48 85 c9 74 1d 80 78 04 00 74 17 41 89 f8 4a 89 4c c5
[ 0.000000] RIP [<ffffffff817064c5>] mctrl_gpio_set+0x15/0x60
[ 0.000000] RSP <ffffffff83003d48>
[ 0.000000] CR2: 0000000000000008
[ 0.000000] ---[ end trace 6df90b3c20cfd0c4 ]---
[ 0.000000] Kernel panic - not syncing: Fatal exception
FYI, raw QEMU command line is:
qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap -kernel /pkg/linux/x86_64-randconfig-i0-201612/gcc-5/9e2a7d9c247ff3c90ff8a4086a165a6d141de16f/vmlinuz-4.5.0-next-20160322-00005-g9e2a7d9 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-wsx03-quantal-x86_64-2/bisect_boot-1-quantal-core-x86_64.cgz-x86_64-randconfig-i0-201612-9e2a7d9c247ff3c90ff8a4086a165a6d141de16f-20160322-6028-xx10d2-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-i0-201612 branch=linux-devel/devel-catchup-201603222125 commit=9e2a7d9c247ff3c90ff8a4086a165a6d141de16f BOOT_IMAGE=/pkg/linux/x86_64-randconfig-i0-201612/gcc-5/9e2a7d9c247ff3c90ff8a4086a165a6d141de16f/vmlinuz-4.5.0-next-20160322-00005-g9e2a7d9 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-quantal-x86_64/quantal-core-x86_64.cgz/x86_64-randconfig-i0-201612/gcc-5/9e2a7d9c247ff3c90ff8a4086a165a6d141de16f/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-quantal-x86_64-2::dhcp drbd.minor_count=8' -initrd /fs/sdc1/initrd-vm-lkp-wsx03-quantal-x86_64-2 -m 360 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -pidfile /dev/shm/kboot/pid-vm-lkp-wsx03-quantal-x86_64-2 -serial file:/dev/shm/kboot/serial-vm-lkp-wsx03-quantal-x86_64-2 -daemonize -display none -monitor null
Thanks,
Kernel Test Robot
5 years, 8 months
[lkp] [cpuidle] b67bb65b9d: No primary result change, -33.1% turbostat.%Busy
by kernel test robot
FYI, we noticed that turbostat.%Busy -33.1% change with your commit.
https://github.com/0day-ci/linux Rik-van-Riel/cpuidle-use-high-confidence-factors-only-when-considering-polling/20160317-001521
commit b67bb65b9de2d3c070073028aeb30cca6c6790a7 ("cpuidle: use high confidence factors only when considering polling")
=========================================================================================
compiler/cpufreq_governor/kconfig/rootfs/runtime/size/tbox_group/test/testcase:
gcc-4.9/performance/x86_64-rhel/debian-x86_64-2015-02-07.cgz/300s/1T/lkp-hsx04/msync-mt/vm-scalability
commit:
v4.5-rc7
b67bb65b9de2d3c070073028aeb30cca6c6790a7
v4.5-rc7 b67bb65b9de2d3c070073028ae
---------------- --------------------------
%stddev %change %stddev
\ | \
1383 ± 16% +30.2% 1801 ± 10% meminfo.Writeback
341.25 ± 17% +30.9% 446.75 ± 12% proc-vmstat.nr_writeback
1190 ± 14% +59.8% 1902 ± 31% numa-vmstat.node1.nr_anon_pages
79284 ± 17% -65.8% 27126 ± 56% numa-vmstat.node3.nr_inactive_anon
0.00 ± -1% +Inf% 20587 ±147% latency_stats.max.bt_get.blk_mq_get_tag.__blk_mq_alloc_request.blk_mq_map_request.blk_sq_make_request.generic_make_request.submit_bio.xfs_submit_ioend_bio.xfs_submit_ioend.xfs_vm_writepage.__writepage.write_cache_pages
0.00 ± -1% +Inf% 2597215 ±130% latency_stats.sum.bt_get.blk_mq_get_tag.__blk_mq_alloc_request.blk_mq_map_request.blk_sq_make_request.generic_make_request.submit_bio.xfs_submit_ioend_bio.xfs_submit_ioend.xfs_vm_writepage.__writepage.write_cache_pages
311599 ± 52% +3095.5% 9957231 ±167% latency_stats.sum.wait_on_page_bit.__filemap_fdatawait_range.filemap_fdatawait_range.filemap_write_and_wait_range.xfs_file_fsync.vfs_fsync_range.SyS_msync.entry_SYSCALL_64_fastpath
3622 ± 38% -84.8% 551.50 ± 74% numa-meminfo.node0.AnonHugePages
4754 ± 14% +60.2% 7615 ± 31% numa-meminfo.node1.AnonPages
317153 ± 17% -65.8% 108519 ± 56% numa-meminfo.node3.Inactive(anon)
4.011e+09 ± 2% +234.2% 1.341e+10 ± 0% cpuidle.C1-HSW.time
20612300 ± 3% +256.1% 73396067 ± 0% cpuidle.C1-HSW.usage
8.54e+09 ± 0% -98.9% 94559307 ± 67% cpuidle.POLL.time
27143032 ± 0% -98.5% 397406 ± 2% cpuidle.POLL.usage
19.34 ± 0% -33.1% 12.94 ± 0% turbostat.%Busy
559.50 ± 0% -33.1% 374.25 ± 0% turbostat.Avg_MHz
57.66 ± 0% +12.3% 64.75 ± 0% turbostat.CPU%c1
372.25 ± 0% -4.7% 354.77 ± 0% turbostat.PkgWatt
lkp-hsx04: Brickland Haswell-EX
Memory: 512G
turbostat.Avg_MHz
580 ++--------------------------------------------------------------------+
560 *+.*..*...*..*..*..*..*..*...*..*..*..*..*...*..*..*..*..*..*...*..*..*
| |
540 ++ |
520 ++ |
500 ++ |
480 ++ |
| |
460 ++ |
440 ++ |
420 ++ |
400 ++ |
| |
380 O+ O O O O O O O O O O O O O O O O O O O O |
360 ++--------------------------------------------------------------------+
turbostat._Busy
20 ++---------------------------------------------------------------------+
*..*..*...*..*..*..*...*..*..*..*...*..*..*..*..*...*..*..*..*...*..*..*
19 ++ |
18 ++ |
| |
17 ++ |
| |
16 ++ |
| |
15 ++ |
14 ++ |
| |
13 O+ O O O O O O O O O O O O O O O O O O O O |
| |
12 ++---------------------------------------------------------------------+
turbostat.CPU_c1
66 ++---------------------------------------------------------------------+
O O |
65 ++ O O O O O O O O O O O O O O O O O O O |
64 ++ |
| |
63 ++ |
62 ++ |
| |
61 ++ |
60 ++ |
| |
59 ++ |
58 ++ |
*..*..*...*..*..*..*...*..*..*..*...*..*..*..*..*...*..*..*..*...*..*..*
57 ++---------------------------------------------------------------------+
turbostat.PkgWatt
374 ++--------------------------------------------------------------------+
372 *+.*.. .*..*.. ..*..*..*.. .*..*...*.. .*
| *...*..*..*..*..*..*...*. *..*. *. *. |
370 ++ |
368 ++ |
| |
366 ++ |
364 ++ |
362 ++ |
| |
360 ++ |
358 ++ |
O |
356 ++ O O O O O O O O O O O O O O O |
354 ++------------------------------O--------O---------O--O---------O-----+
[*] 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 Ye
5 years, 8 months
[lkp] [drm/i915] 97f9010af0: No primary result change, -36.2% piglit.time.percent_of_cpu_this_job_got
by kernel test robot
FYI, we noticed that piglit.time.percent_of_cpu_this_job_got -36.2% change with your commit.
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit 97f9010af05c15e0b7e6b4ef6ff8cb0ebb7e7715 ("drm/i915: mdelay(10) considered harmful")
=========================================================================================
compiler/group/kconfig/rootfs/tbox_group/testcase:
gcc-4.9/igt-037/x86_64-rhel/debian-x86_64-2015-02-07.cgz/snb-drag/piglit
commit:
57a2af6bbc7a4f1b145cc216c34476402836f0b8
97f9010af05c15e0b7e6b4ef6ff8cb0ebb7e7715
57a2af6bbc7a4f1b 97f9010af05c15e0b7e6b4ef6f
---------------- --------------------------
fail:runs %reproduction fail:runs
%stddev %change %stddev
\ | \
69.00 ± 0% -36.2% 44.00 ± 0% piglit.time.percent_of_cpu_this_job_got
44.77 ± 0% -36.0% 28.66 ± 0% piglit.time.system_time
38337 ± 0% +4.1% 39904 ± 0% piglit.time.voluntary_context_switches
69.00 ± 0% -36.2% 44.00 ± 0% time.percent_of_cpu_this_job_got
44.77 ± 0% -36.0% 28.66 ± 0% time.system_time
snb-drag: Sandy Bridge
Memory: 6G
piglit.time.system_time
46 ++---------------------------------------------------------------------+
*..*..*..*..*..*..*..*..*..*..*..*..*.*..*..*..*..*..*..*..*..*..* |
44 ++ |
42 ++ |
| |
40 ++ |
38 ++ |
| |
36 ++ |
34 ++ |
| |
32 ++ |
30 ++ |
O O O O O O O O O O O O O O O O O O O O O O O O O
28 ++---------------------------------------------------------------------+
piglit.time.percent_of_cpu_this_job_got
70 *+----*--*--*--*--*--*--*--*--*--*--*-*--*--*--*--*--*--*--*--*--*-----+
| .. |
65 ++ * |
60 ++ |
| |
55 ++ |
50 ++ |
| |
45 ++ O O O O
40 ++ |
| O O O O O O O O O O |
35 ++ |
30 ++ |
| |
25 O+-O--O--O--O--O--O--O--O--O--O----------------------------------------+
piglit.time.voluntary_context_switches
46000 ++------------------------------------------------------------------+
O O O O O O O O O O O |
45000 ++ |
44000 ++ |
| |
43000 ++ |
| |
42000 ++ |
| |
41000 ++ O O O O O O O O O O |
40000 ++ |
| O O O O
39000 ++ |
*..*..*..*.*..*..*..*..*..*.*..*..*..*..*..*.*..*..*..*..*..*.* |
38000 ++------------------------------------------------------------------+
[*] 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 Ye
5 years, 8 months
[lkp] [rcutorture] 5b3e3964db: torture_init_begin: refusing rcu init: spin_lock running
by kernel test robot
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/paulmck/linux-rcu.git rcu/dev
commit 5b3e3964dba5f5a3210ca931d523c1e1f3119b31 ("rcutorture: Add RCU grace-period performance tests")
As below, the log "torture_init_begin: refusing rcu init: spin_lock running" showed with your commit.
[ 3.310757] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[ 3.310757] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[ 3.318722] spin_lock-torture: Creating torture_shuffle task
[ 3.318722] spin_lock-torture: Creating torture_shuffle task
[ 3.350213] spin_lock-torture: Creating torture_stutter task
[ 3.350213] spin_lock-torture: Creating torture_stutter task
[ 3.353000] spin_lock-torture: torture_shuffle task started
[ 3.353000] spin_lock-torture: torture_shuffle task started
[ 3.355562] spin_lock-torture: Creating lock_torture_writer task
[ 3.355562] spin_lock-torture: Creating lock_torture_writer task
[ 3.358373] spin_lock-torture: torture_stutter task started
[ 3.358373] spin_lock-torture: torture_stutter task started
[ 3.361060] spin_lock-torture: lock_torture_writer task started
[ 3.361060] spin_lock-torture: lock_torture_writer task started
[ 3.370011] spin_lock-torture: Creating lock_torture_writer task
[ 3.370011] spin_lock-torture: Creating lock_torture_writer task
[ 3.372856] spin_lock-torture: Creating lock_torture_writer task
[ 3.372856] spin_lock-torture: Creating lock_torture_writer task
[ 3.375817] spin_lock-torture: lock_torture_writer task started
[ 3.375817] spin_lock-torture: lock_torture_writer task started
[ 3.378697] spin_lock-torture: Creating lock_torture_writer task
[ 3.378697] spin_lock-torture: Creating lock_torture_writer task
[ 3.380049] spin_lock-torture: lock_torture_writer task started
[ 3.380049] spin_lock-torture: lock_torture_writer task started
[ 3.410169] spin_lock-torture: Creating lock_torture_stats task
[ 3.410169] spin_lock-torture: Creating lock_torture_stats task
[ 3.413129] spin_lock-torture: lock_torture_writer task started
[ 3.413129] spin_lock-torture: lock_torture_writer task started
[ 3.420137] torture_init_begin: refusing rcu init: spin_lock running
[ 3.420137] torture_init_begin: refusing rcu init: spin_lock running
[ 3.430064] spin_lock-torture: lock_torture_stats task started
[ 3.430064] spin_lock-torture: lock_torture_stats task started
[ 3.441101] futex hash table entries: 16 (order: -1, 2048 bytes)
[ 3.441101] futex hash table entries: 16 (order: -1, 2048 bytes)
[ 3.443791] audit: initializing netlink subsys (disabled)
[ 3.443791] audit: initializing netlink subsys (disabled)
[ 3.446329] audit: type=2000 audit(1458435960.381:1): initialized
[ 3.446329] audit: type=2000 audit(1458435960.381:1): initialized
[ 3.470185] zbud: loaded
[ 3.470185] zbud: loaded
FYI, raw QEMU command line is:
qemu-system-x86_64 -enable-kvm -cpu Nehalem -kernel /pkg/linux/x86_64-randconfig-i0-201612/gcc-5/5b3e3964dba5f5a3210ca931d523c1e1f3119b31/vmlinuz-4.5.0-rc1-00035-g5b3e396 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-intel12-yocto-x86_64-6/bisect_boot-1-yocto-minimal-x86_64.cgz-x86_64-randconfig-i0-201612-5b3e3964dba5f5a3210ca931d523c1e1f3119b31-20160320-8459-1gazcic-1.yaml ARCH=x86_64 kconfig=x86_64-randconfig-i0-201612 branch=linux-devel/devel-spot-201603200631 commit=5b3e3964dba5f5a3210ca931d523c1e1f3119b31 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-i0-201612/gcc-5/5b3e3964dba5f5a3210ca931d523c1e1f3119b31/vmlinuz-4.5.0-rc1-00035-g5b3e396 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-intel12-yocto-x86_64/yocto-minimal-x86_64.cgz/x86_64-randconfig-i0-201612/gcc-5/5b3e3964dba5f5a3210ca931d523c1e1f3119b31/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-yocto-x86_64-6::dhcp drbd.minor_count=8' -initrd /fs/KVM/initrd-vm-intel12-yocto-x86_64-6 -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/KVM/disk0-vm-intel12-yocto-x86_64-6,media=disk,if=virtio -drive file=/fs/KVM/disk1-vm-intel12-yocto-x86_64-6,media=disk,if=virtio -pidfile /dev/shm/kboot/pid-vm-intel12-yocto-x86_64-6 -serial file:/dev/shm/kboot/serial-vm-intel12-yocto-x86_64-6 -daemonize -display none -monitor null
Thanks,
Xiaolong Ye.
5 years, 8 months
[lkp] [cpuidle] 664ef5b861: No primary result change, +13.7% turbostat.PkgWatt
by kernel test robot
FYI, we noticed that turbostat.PkgWatt +13.7% change with your commit.
https://github.com/0day-ci/linux Rik-van-Riel/cpuidle-break-out-of-idle-polling-loop-after-HLT-threshold/20160319-053854
commit 664ef5b8615ff12b03b46988408b4c0a15eab07c ("cpuidle: use high confidence factors only when considering polling")
=========================================================================================
cluster/compiler/cpufreq_governor/ip/kconfig/nr_threads/rootfs/runtime/tbox_group/test/testcase:
cs-localhost/gcc-4.9/performance/ipv4/x86_64-rhel/1/debian-x86_64-2015-02-07.cgz/300s/lkp-hsw-d01/SCTP_RR/netperf
commit:
38497f04cd3604396327ba1810dde0ac239989f4
664ef5b8615ff12b03b46988408b4c0a15eab07c
38497f04cd360439 664ef5b8615ff12b03b4698840
---------------- --------------------------
%stddev %change %stddev
\ | \
67771 ± 1% +2.8% 69694 ± 1% netperf.Throughput_tps
77.00 ± 0% +1.3% 78.00 ± 0% netperf.time.percent_of_cpu_this_job_got
226.75 ± 0% +3.3% 234.16 ± 0% netperf.time.system_time
20330477 ± 1% +2.8% 20907309 ± 1% netperf.time.voluntary_context_switches
9.29 ± 10% -42.2% 5.38 ± 6% time.user_time
266114 ± 1% +2.8% 273497 ± 1% vmstat.system.cs
1929 ± 1% +374.1% 9148 ± 23% vmstat.system.in
1.622e+08 ± 6% -64.3% 57961470 ± 6% cpuidle.C1-HSW.time
33127115 ± 3% -96.7% 1109711 ± 50% cpuidle.C1-HSW.usage
5649502 ± 10% +16.0% 6551668 ± 2% cpuidle.C3-HSW.time
63535957 ± 10% +117.7% 1.383e+08 ± 1% cpuidle.POLL.time
7659494 ± 10% +1097.5% 91718696 ± 3% cpuidle.POLL.usage
21.06 ± 1% +16.3% 24.50 ± 0% turbostat.%Busy
794.00 ± 2% +19.7% 950.33 ± 0% turbostat.Avg_MHz
20.14 ± 12% -20.2% 16.06 ± 10% turbostat.CPU%c1
0.38 ± 5% +18.5% 0.45 ± 3% turbostat.CPU%c3
17.24 ± 0% +21.0% 20.85 ± 2% turbostat.CorWatt
25.77 ± 0% +13.7% 29.31 ± 1% turbostat.PkgWatt
0.51 ± 39% +164.7% 1.36 ± 36% perf-profile.cycles-pp._raw_spin_lock_bh.lock_sock_nested.sctp_skb_recv_datagram.sctp_recvmsg.sock_common_recvmsg
0.51 ± 34% +142.9% 1.23 ± 27% perf-profile.cycles-pp.cpuidle_select.cpu_startup_entry.start_secondary
1.34 ± 7% +11.8% 1.50 ± 5% perf-profile.cycles-pp.dequeue_entity.dequeue_task_fair.deactivate_task.__schedule.schedule
14.74 ± 14% -78.4% 3.18 ± 68% perf-profile.cycles-pp.intel_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry
1.32 ± 12% -28.5% 0.94 ± 18% perf-profile.cycles-pp.is_ftrace_trampoline.print_context_stack.dump_trace.save_stack_trace_tsk.__account_scheduler_latency
1.16 ± 17% -21.3% 0.91 ± 19% perf-profile.cycles-pp.kfree_skb.sctp_ulpevent_free.sctp_recvmsg.sock_common_recvmsg.sock_recvmsg
0.00 ± -1% +Inf% 17.25 ± 4% perf-profile.cycles-pp.ktime_get.poll_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle
0.68 ± 31% +126.6% 1.55 ± 33% perf-profile.cycles-pp.lock_sock_nested.sctp_skb_recv_datagram.sctp_recvmsg.sock_common_recvmsg.sock_recvmsg
0.38 ± 41% +178.9% 1.06 ± 28% perf-profile.cycles-pp.menu_select.cpuidle_select.cpu_startup_entry.start_secondary
0.30 ± 82% +304.4% 1.22 ± 42% perf-profile.cycles-pp.native_queued_spin_lock_slowpath._raw_spin_lock_bh.lock_sock_nested.sctp_skb_recv_datagram.sctp_recvmsg
9.13 ± 35% +165.1% 24.19 ± 3% perf-profile.cycles-pp.poll_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry
0.00 ± -1% +Inf% 10.46 ± 2% perf-profile.cycles-pp.read_tsc.ktime_get.poll_idle.cpuidle_enter_state.cpuidle_enter
1.14 ± 14% -16.2% 0.95 ± 8% perf-profile.cycles-pp.sctp_make_control.sctp_make_sack.sctp_packet_append_chunk.sctp_packet_transmit_chunk.sctp_outq_flush
1.71 ± 10% -16.3% 1.43 ± 5% perf-profile.cycles-pp.sctp_make_sack.sctp_packet_append_chunk.sctp_packet_transmit_chunk.sctp_outq_flush.sctp_outq_uncork
3.00 ± 8% -12.8% 2.62 ± 4% perf-profile.cycles-pp.sctp_packet_transmit_chunk.sctp_outq_flush.sctp_outq_uncork.sctp_cmd_interpreter.sctp_do_sm
1.40 ± 7% -23.9% 1.06 ± 11% perf-profile.cycles-pp.sctp_transport_reset_timers.sctp_outq_flush.sctp_outq_uncork.sctp_cmd_interpreter.sctp_do_sm
1.59 ± 20% -24.9% 1.19 ± 24% perf-profile.cycles-pp.sctp_ulpevent_free.sctp_recvmsg.sock_common_recvmsg.sock_recvmsg.___sys_recvmsg
lkp-hsw-d01: Haswell
Memory: 8G
turbostat.PkgWatt
35 ++---------------------------------------------------------------------+
| O |
30 OOO OO O OOO O O |
| O * * |
25 ** ******.*****.******.* ***.*** *.******.** **.******.*****.* ** *.***
|: : : : : : : : |
20 ++ : : : : : : : |
|: : : : : : : : |
15 ++ : : : : : : : |
| :: :: :: :: |
10 ++:: : : : |
| :: : : : |
5 ++: : : : |
| : : : : |
0 ++*------O----O----------*-------*-----------*-------------------------+
[*] 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 Ye.
5 years, 8 months
[lkp] [x86/tlb] ff9b625d26: stderr.Run:"Process_Creation":Fork_failed_at_iteration in unixbench test
by kernel test robot
FYI, we noticed stderr.Run:"Process_Creation":Fork_failed_at_iteration in unixbench test on
https://github.com/alexshi/power-scheduling.git x86-tlb
commit ff9b625d26ba7750745d235dc6f1792fb36fea48 ("x86/tlb: just do tlb flush on one of siblings of SMT")
2016-03-17 06:04:39 ./Run spawn -c 1
# # # # # # # ##### ###### # # #### # #
# # ## # # # # # # # ## # # # # #
# # # # # # ## ##### ##### # # # # ######
# # # # # # ## # # # # # # # # #
# # # ## # # # # # # # ## # # # #
#### # # # # # ##### ###### # # #### # #
Version 5.1.3 Based on the Byte Magazine Unix Benchmark
Multi-CPU version Version 5 revisions by Ian Smith,
Sunnyvale, CA, USA
January 13, 2011 johantheghost at yahoo period com
1 x Process Creation 1
=========================================================================================
compiler/cpufreq_governor/kconfig/nr_task/rootfs/tbox_group/test/testcase:
gcc-4.9/performance/x86_64-rhel/1/debian-x86_64-2015-02-07.cgz/lkp-ivb-d02/spawn/unixbench
commit:
v4.5
ff9b625d26ba7750745d235dc6f1792fb36fea48
v4.5 ff9b625d26ba7750745d235dc6
---------------- --------------------------
fail:runs %reproduction fail:runs
| | |
:4 100% 4:4 last_state.failed
:4 100% 4:4 last_state.is_incomplete_run
:4 100% 4:4 last_state.unixbench.exit_code.1
:4 100% 4:4 stderr.**********************************************
:4 50% 2:4 stderr.Reason:Success;aborting
:4 100% 4:4 stderr.Run:"Process_Creation":Fork_failed_at_iteration
:4 50% 2:4 stderr.Segmentation_fault;aborting
=========================================================================================
compiler/cpufreq_governor/kconfig/nr_task/rootfs/tbox_group/test/testcase:
gcc-4.9/performance/x86_64-rhel/1/debian-x86_64-2015-02-07.cgz/lkp-ivb-d04/spawn/unixbench
commit:
v4.5
ff9b625d26ba7750745d235dc6f1792fb36fea48
v4.5 ff9b625d26ba7750745d235dc6
---------------- --------------------------
fail:runs %reproduction fail:runs
| | |
:8 100% 8:8 last_state.failed
:8 100% 8:8 last_state.is_incomplete_run
:8 100% 8:8 last_state.unixbench.exit_code.1
:8 100% 8:8 stderr.**********************************************
:8 12% 1:8 stderr.Aborted;aborting
:8 62% 5:8 stderr.Reason:Success;aborting
:8 75% 6:8 stderr.Run:"Process_Creation":Fork_failed_at_iteration
:8 12% 1:8 stderr.Run:"Process_Creation":Segmentation_fault;aborting
:8 12% 1:8 stderr.Run:"Process_Creation":spawn:../nptl/sysdeps/unix/sysv/linux/x86_64/../fork.c:#:__libc_fork:Assertion`({__typeof(({struct_pthread*__self;asm("mov%%fs:%c1,%#":"=r"(__self):"i"(__builtin_offsetof(struct_pthread,header.self)));__self;})->tid)__value;if(sizeof(__value)==#)asm_volatile("movb%%fs:%P2,%b0":"=q"(__value):"#"(#),"i"(__builtin_offsetof(struct_pthread,tid)));else_if(sizeof(__value)==#)asm_volatile("movl%%fs:%P1,%#":"=r"(__value):"i"(__builtin_offsetof(struct_pthread,tid)));else{if(sizeof(__value)!=#)abort();asm_volatile("movq%%fs:%P1,%q0":"=r"(__value):"i"(__builtin_offsetof(struct_pthread,tid)));}__value;})==ppid'failed
:8 12% 1:8 stderr.Segmentation_fault;aborting
lkp-ivb-d02: Ivy Bridge
Memory: 8G
lkp-ivb-d04: Ivy Bridge
Memory: 4G
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 Ye
5 years, 8 months