From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: X-Spam-Checker-Version: SpamAssassin 3.4.0 (2014-02-07) on aws-us-west-2-korg-lkml-1.web.codeaurora.org X-Spam-Level: X-Spam-Status: No, score=-5.7 required=3.0 tests=BAYES_00,DKIM_SIGNED, DKIM_VALID,DKIM_VALID_AU,HEADER_FROM_DIFFERENT_DOMAINS,MAILING_LIST_MULTI, SPF_HELO_NONE,SPF_PASS,URIBL_BLOCKED autolearn=no autolearn_force=no version=3.4.0 Received: from mail.kernel.org (mail.kernel.org [198.145.29.99]) by smtp.lore.kernel.org (Postfix) with ESMTP id 7FE8EC4361A for ; Thu, 3 Dec 2020 23:34:11 +0000 (UTC) Received: from kanga.kvack.org (kanga.kvack.org [205.233.56.17]) by mail.kernel.org (Postfix) with ESMTP id BDE592223E for ; Thu, 3 Dec 2020 23:34:10 +0000 (UTC) DMARC-Filter: OpenDMARC Filter v1.3.2 mail.kernel.org BDE592223E Authentication-Results: mail.kernel.org; dmarc=fail (p=none dis=none) header.from=linutronix.de Authentication-Results: mail.kernel.org; spf=pass smtp.mailfrom=owner-linux-mm@kvack.org Received: by kanga.kvack.org (Postfix) id 139476B005C; Thu, 3 Dec 2020 18:34:10 -0500 (EST) Received: by kanga.kvack.org (Postfix, from userid 40) id 0C31E6B0068; Thu, 3 Dec 2020 18:34:10 -0500 (EST) X-Delivered-To: int-list-linux-mm@kvack.org Received: by kanga.kvack.org (Postfix, from userid 63042) id E7EEB6B006C; Thu, 3 Dec 2020 18:34:09 -0500 (EST) X-Delivered-To: linux-mm@kvack.org Received: from forelay.hostedemail.com (smtprelay0143.hostedemail.com [216.40.44.143]) by kanga.kvack.org (Postfix) with ESMTP id CEE736B005C for ; Thu, 3 Dec 2020 18:34:09 -0500 (EST) Received: from smtpin25.hostedemail.com (10.5.19.251.rfc1918.com [10.5.19.251]) by forelay03.hostedemail.com (Postfix) with ESMTP id 987068249980 for ; Thu, 3 Dec 2020 23:34:09 +0000 (UTC) X-FDA: 77553576618.25.drain50_5909ea8273bf Received: from filter.hostedemail.com (10.5.16.251.rfc1918.com [10.5.16.251]) by smtpin25.hostedemail.com (Postfix) with ESMTP id 761891804E3A1 for ; Thu, 3 Dec 2020 23:34:09 +0000 (UTC) X-HE-Tag: drain50_5909ea8273bf X-Filterd-Recvd-Size: 5253 Received: from galois.linutronix.de (Galois.linutronix.de [193.142.43.55]) by imf16.hostedemail.com (Postfix) with ESMTP for ; Thu, 3 Dec 2020 23:34:08 +0000 (UTC) From: Thomas Gleixner DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=linutronix.de; s=2020; t=1607038445; h=from:from:reply-to:subject:subject:date:date:message-id:message-id: to:to:cc:cc:mime-version:mime-version:content-type:content-type: in-reply-to:in-reply-to:references:references; bh=FVgoT08TG5YvAmWotKxqMBk0yHe89AS+W1UPWM1cCOU=; b=Mk7xKoKfyWCXtaFR+J6/WwO9YqNoUcAKE7Gf37tx2eOi9XndcwIib9aC8OI+iUU861Xh+w pnKoSApDWCirVMss6phNCwU4RP3p6SQwTjFSh5pkYl/YIr4bEi13YaYhi5u05Qx2r2+3hk eJze6siGQp7I594Xy8lZph0WpKnNNxGfefureAmF0jn2NrCgL83F0qjc7fm87DzCwBejgU DcKYRjbD/fU4txtsow+7HM+rycWgqp743Tilo3u92hs3PzEw+vWSIooMVb3RdoXj4iXYVX STtTAGp1ix5c2frRNHJTI6XB/QOvEt6SwuFw9D9hkar3a6OYSHz6SJetglsSYQ== DKIM-Signature: v=1; a=ed25519-sha256; c=relaxed/relaxed; d=linutronix.de; s=2020e; t=1607038445; h=from:from:reply-to:subject:subject:date:date:message-id:message-id: to:to:cc:cc:mime-version:mime-version:content-type:content-type: in-reply-to:in-reply-to:references:references; bh=FVgoT08TG5YvAmWotKxqMBk0yHe89AS+W1UPWM1cCOU=; b=Qcd9yBaZDFqngG0LovOd+mh+dCvYjY0RhGey/ZjUu4WH8jUPh+UcEx7LD+xvrATX1m22Fa pi2TKOE1zwPT3JDg== To: Corentin Labbe Cc: herbert@gondor.apana.org.au, mripard@kernel.org, wens@csie.org, linux-arm-kernel@lists.infradead.org, linux-crypto@vger.kernel.org, linux-kernel@vger.kernel.org,Jens Axboe ,linux-mm@kvack.org,Andrew Morton Subject: Re: crypto: sun4i-ss: error with kmap In-Reply-To: <20201203173846.GA16207@Red> References: <20201201130102.GA23461@Red> <87ft4phcyx.fsf@nanos.tec.linutronix.de> <20201201135252.GA9584@Red> <87y2ihfw6z.fsf@nanos.tec.linutronix.de> <20201201144529.GA6786@Red> <87v9dlfthf.fsf@nanos.tec.linutronix.de> <20201202195501.GA29296@Red> <877dpzexfr.fsf@nanos.tec.linutronix.de> <20201203173846.GA16207@Red> Date: Fri, 04 Dec 2020 00:34:05 +0100 Message-ID: <87r1o6bh1u.fsf@nanos.tec.linutronix.de> MIME-Version: 1.0 Content-Type: text/plain X-Bogosity: Ham, tests=bogofilter, spamicity=0.000000, version=1.2.4 Sender: owner-linux-mm@kvack.org Precedence: bulk X-Loop: owner-majordomo@kvack.org List-ID: On Thu, Dec 03 2020 at 18:38, Corentin Labbe wrote: > On Wed, Dec 02, 2020 at 09:59:36PM +0100, Thomas Gleixner wrote: >> On Wed, Dec 02 2020 at 20:55, Corentin Labbe wrote: >> > On Tue, Dec 01, 2020 at 04:15:08PM +0100, Thomas Gleixner wrote: >> > >> > The result could be seen at http://kernel.montjoie.ovh/129768.log >> > The log is 9Mb, but the ftrace dump seems not terminated, tell me if you need more. >> >> Correct, the interesting entries right before the crash are missing. Can >> you try to make the trace buffers smaller or wait longer before >> terminating the thing? >> >> 16k buffer size per CPU should be completely sufficient. That should >> give us roughly the last 100 entries per CPU. >> >> 'trace_buf_size=16k' >> >> is the command line option for that. > > I have set a longer timeout and now the job end with the crash: > http://kernel.montjoie.ovh/130094.log Ok. So here is the problem: [ 996.933980] cryptset-316 0d..3 73943313us : __kmap_local_pfn_prot: kmap_local_pfn: 0 ffefe000 [ 996.943030] cryptset-316 0d..4 73943317us : __kmap_local_pfn_prot: kmap_local_pfn: 1 ffefd000 [ 996.952080] cryptset-316 0d..4 73943419us : kunmap_local_indexed: kunmap_local: 1 ffefe000 There are two maps: 1) index 0 vaddr 0xffefe000 2) index 1 vaddr 0xffefd000 Now comes the unmap and unmaps 0xffefe000 which is the first map and not the second one. -> Fail [ 74.017103] [] (kunmap_local_indexed) from [] (sg_miter_stop+0xb4/0x164) [ 74.025535] [] (sg_miter_stop) from [] (sg_miter_next+0xc/0xe4) [ 74.033191] [] (sg_miter_next) from [] (sun4i_ss_opti_poll+0x278/0x40c) [ 74.041539] [] (sun4i_ss_opti_poll) from [] (sun4i_ss_cipher_poll+0x4f4/0x5e4) [ 74.050497] [] (sun4i_ss_cipher_poll) from [] (crypto_skcipher_encrypt+0x38/0x5c) [ 74.059713] [] (crypto_skcipher_encrypt) from [] (xts_encrypt+0x8c/0xd4) [ 74.068146] [] (xts_encrypt) from [] (crypto_skcipher_encrypt+0x38/0x5c) [ 74.076581] [] (crypto_skcipher_encrypt) from [] (skcipher_recvmsg+0x364/0x43c) [ 74.085625] [] (skcipher_recvmsg) from [] (sock_read_iter+0xa8/0xf8) [ 74.093713] [] (sock_read_iter) from [] (vfs_read+0x2b8/0x2d8) [ 74.101279] [] (vfs_read) from [] (ksys_read+0xb0/0xe4) [ 74.108237] [] (ksys_read) from [] (ret_fast_syscall+0x0/0x58) The unmap comes from sg_miter_stop() and looking at the previous map/unmap cycles there are never nested maps. [ 996.943030] cryptset-316 0d..4 73943317us : __kmap_local_pfn_prot: kmap_local_pfn: 1 ffefd000 is the first event which allocates a nested map. So something goes south either in sg_miter or in the crypto maze. Enabling CONFIG_DEBUG_KMAP_LOCAL and function tracing might give us more clue. Thanks, tglx