linux-kernel - [interrupt] 998288b7e8: RIP:cpuidle_enter

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Date:   Sat, 8 Oct 2022 13:21:25 +0800
From:   kernel test robot <yujie.liu@...el.com>
To:     Zhang Xincheng <zhangxincheng@...ontech.com>
CC:     <lkp@...ts.01.org>, <lkp@...el.com>,
        <linux-kernel@...r.kernel.org>, <tglx@...utronix.de>,
        <maz@...nel.org>, <oleksandr@...alenko.name>,
        <hdegoede@...hat.com>, <bigeasy@...utronix.de>,
        <mark.rutland@....com>, <michael@...le.cc>,
        zhangxincheng <zhangxincheng@...ontech.com>
Subject: [interrupt] 998288b7e8: RIP:cpuidle_enter_state

Hi Xincheng,

We noticed that below patch introduced a new warning for frequent
interrupts, and this warning is triggered in our testing. Not sure if
this is an expected result or not, so we send this report FYI. Thanks.

Greeting,

FYI, we noticed the following commit (built with gcc-11):

commit: 998288b7e8ff62dafcef30933ee9a25ec4391d1e ("[PATCH] interrupt: discover and disable very frequent interrupts")
url: https://github.com/intel-lab-lkp/linux/commits/Zhang-Xincheng/interrupt-discover-and-disable-very-frequent-interrupts/20220930-145151
base: https://git.kernel.org/cgit/linux/kernel/git/tip/tip.git 94ec234a16cf3acdb319f05917b1efec9642222e
patch link: https://lore.kernel.org/lkml/20220930064042.14564-1-zhangxincheng@uniontech.com

in testcase: igt
version: igt-x86_64-e9244bfd-1_20221001
with following parameters:

	group: group-15

on test machine: 20 threads 1 sockets (Commet Lake) with 16G memory

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


[  T505] 2022-10-08 04:08:57 build/tests/gem_exec_balancer --run-subtest nop
[   65.605852][  T505] 
[   65.633622][ T1444] [IGT] gem_exec_balancer: executing
[   65.641964][  T505] IGT-Version: 1.26-ge9244bfd (x86_64) (Linux: 6.0.0-rc6-00007-g998288b7e8ff x86_64)
[   65.641970][  T505] 
[   65.642081][ T1444] [IGT] gem_exec_balancer: starting subtest nop
[   65.660113][  T505] Starting subtest: nop
[   65.660118][  T505] 
[   66.201335][    C1] irq 158: triggered too frequently
[   66.206430][    C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 6.0.0-rc6-00007-g998288b7e8ff #1
[   66.215056][    C1] Call Trace:
[   66.218210][    C1]  <IRQ>
[   66.220930][    C1]  dump_stack_lvl+0x34/0x48
[   66.225318][    C1]  note_interrupt.cold+0x49/0x23d
[   66.230227][    C1]  handle_irq_event+0x171/0x1c0
[   66.234945][    C1]  handle_edge_irq+0x1f6/0xb80
[   66.239580][    C1]  __common_interrupt+0x6b/0x180
[   66.244390][    C1]  common_interrupt+0x3b/0xc0
[   66.248941][    C1]  asm_common_interrupt+0x22/0x40
[   66.253838][    C1] RIP: 0010:process_csb+0x470/0xe40 [i915]
[   66.259583][    C1] Code: f8 48 c1 e8 03 80 3c 18 00 0f 85 45 07 00 00 4d 8b 75 10 4c 89 f0 48 c1 e8 03 80 3c 18 00 0f 85 74 06 00 00 49 03 2e 8b 45 00 <4c> 89 d0 48 c1 e8 03 80 3c 18 00 0f 85 29 06 00 00 49 c7 85 18 04
[   66.279063][    C1] RSP: 0018:ffffc90000078dd8 EFLAGS: 00000286
[   66.284998][    C1] RAX: 0000000000000503 RBX: dffffc0000000000 RCX: ffffed102a01307f
[   66.292842][    C1] RDX: 0000000000000006 RSI: ffff888150098400 RDI: ffff888150098010
[   66.300688][    C1] RBP: ffffc900052023a0 R08: ffffed102a013000 R09: ffff888191296040
[   66.308538][    C1] R10: ffff888150098418 R11: 0000000000000000 R12: ffffc90000078e98
[   66.316382][    C1] R13: ffff888150098000 R14: ffff888114a687e0 R15: 0000000000000003
[   66.324225][    C1]  ? var_wake_function+0x280/0x280
[   66.329212][    C1]  execlists_submission_tasklet+0x9c/0x600 [i915]
[   66.335553][    C1]  ? execlists_dequeue+0x2840/0x2840 [i915]
[   66.341369][    C1]  ? var_wake_function+0x280/0x280
[   66.346352][    C1]  tasklet_action_common+0x225/0x2c0
[   66.352549][    C1]  __do_softirq+0x19f/0x5fb
[   66.356918][    C1]  __irq_exit_rcu+0x17a/0x200
[   66.361461][    C1]  common_interrupt+0x7d/0xc0
[   66.366003][    C1]  </IRQ>
[   66.368811][    C1]  <TASK>
[   66.371615][    C1]  asm_common_interrupt+0x22/0x40
[   66.376512][    C1] RIP: 0010:cpuidle_enter_state+0x1f9/0x1000
[   66.382368][    C1] Code: d0 7c 08 84 d2 0f 85 c9 08 00 00 44 8b 43 04 0f 1f 44 00 00 31 ff e8 56 1e 72 fe 80 7c 24 08 00 0f 85 e3 01 00 00 fb 45 85 ed <0f> 88 4b 04 00 00 49 63 ed 48 83 fd 09 0f 87 01 0a 00 00 48 8d 44
[   66.401844][    C1] RSP: 0018:ffffc900001b7d88 EFLAGS: 00000202
[   66.407785][    C1] RAX: dffffc0000000000 RBX: ffffe8ffff480000 RCX: 000000000000001f
[   66.415628][    C1] RDX: 1ffff110742d6e99 RSI: 0000000000000002 RDI: ffff8883a16b74c8
[   66.423475][    C1] RBP: 0000000000000001 R08: 0000000000000001 R09: ffff8883a16b31eb
[   66.431324][    C1] R10: ffffed10742d663d R11: 0000000000000001 R12: ffffffff84caaa00
[   66.439167][    C1] R13: 0000000000000001 R14: ffffe8ffff480004 R15: 0000000f69e82bfa
[   66.447013][    C1]  ? cpuidle_enter_state+0x1ea/0x1000
[   66.452252][    C1]  ? menu_reflect+0x80/0x100
[   66.456705][    C1]  cpuidle_enter+0x4a/0xc0
[   66.460990][    C1]  cpuidle_idle_call+0x271/0x400
[   66.465797][    C1]  ? arch_cpu_idle_exit+0xc0/0xc0
[   66.470691][    C1]  ? do_idle+0x7c/0x180
[   66.474720][    C1]  ? tsc_verify_tsc_adjust+0x5d/0x240
[   66.479961][    C1]  do_idle+0xcf/0x180
[   66.483813][    C1]  cpu_startup_entry+0x19/0x40
[   66.488443][    C1]  start_secondary+0x244/0x300
[   66.493080][    C1]  ? set_cpu_sibling_map+0x2640/0x2640
[   66.498405][    C1]  secondary_startup_64_no_verify+0xe0/0xeb
[   66.504172][    C1]  </TASK>
[   66.507069][    C1] handlers:
[   66.510053][    C1] [<00000000d93c4f99>] (%pf?)
...


If you fix the issue, kindly add following tag
| Reported-by: kernel test robot <yujie.liu@...el.com>
| Link: https://lore.kernel.org/r/202210081220.9da0a329-yujie.liu@intel.com


To reproduce:

        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        sudo bin/lkp install job.yaml           # job file is attached in this email
        bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
        sudo bin/lkp run generated-yaml-file

        # if come across any failure that blocks the test,
        # please remove ~/.lkp and /lkp dir to run from a clean state.


-- 
0-DAY CI Kernel Test Service
https://01.org/lkp

View attachment "config-6.0.0-rc6-00007-g998288b7e8ff" of type "text/plain" (168384 bytes)

View attachment "job-script" of type "text/plain" (5215 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (59796 bytes)

View attachment "igt" of type "text/plain" (248898 bytes)

View attachment "job.yaml" of type "text/plain" (4394 bytes)

View attachment "reproduce" of type "text/plain" (46278 bytes)