From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1752222AbcBOQGa (ORCPT ); Mon, 15 Feb 2016 11:06:30 -0500 Received: from mail-pf0-f179.google.com ([209.85.192.179]:33688 "EHLO mail-pf0-f179.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751103AbcBOQG2 (ORCPT ); Mon, 15 Feb 2016 11:06:28 -0500 Date: Tue, 16 Feb 2016 01:04:34 +0900 From: Sergey Senozhatsky To: kernel test robot Cc: Sergey Senozhatsky , lkp@01.org, LKML , 0day robot , Sergey Senozhatsky Subject: Re: [lkp] [printk] af097cab1b: EIP is at vprintk_emit+0xab2/0xb5c Message-ID: <20160215160434.GA435@swordfish> References: <87vb5qd9yu.fsf@yhuang-dev.intel.com> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline In-Reply-To: <87vb5qd9yu.fsf@yhuang-dev.intel.com> User-Agent: Mutt/1.5.24 (2015-08-30) Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org On (02/15/16 09:43), kernel test robot wrote: > FYI, we noticed the below changes on > > https://github.com/0day-ci/linux Sergey-Senozhatsky/printk-move-can_use_console-out-of-console_trylock_for_printk/20160213-024210 > commit af097cab1b878d5be746be8bcaa9a79986716c41 ("printk: set may_schedule for some of console_trylock callers") > [ 37.263248] CPU: 0 PID: 1 Comm: swapper Not tainted 4.5.0-rc3-00002-gaf097ca #1 > [ 37.263248] CPU: 0 PID: 1 Comm: swapper Not tainted 4.5.0-rc3-00002-gaf097ca #1 the two patches you have, I assume printk-move-can_use_console-out-of-console_trylock_for_printk.patch printk-set-may_schedule-for-some-of-console_trylock-callers.patch does it happen all the time? is every single message duplicated, or just some of them (if so, then under what circumstances)? do you happen to have several console drivers from some point, so call_console_drivers() pushes the data to several consoles via con->write()? -ss > [ 37.263363] [] vprintk_default+0x20/0x30 > [ 37.263363] [] vprintk_default+0x20/0x30 > [ 37.263372] [] printk+0x1f/0x2f > [ 37.263372] [] printk+0x1f/0x2f > [ 37.263382] [] of_overlay_destroy+0x1b4/0x595 > [ 37.263382] [] of_overlay_destroy+0x1b4/0x595 > [ 37.263392] [] of_unittest+0x252c/0x26e5 > [ 37.263392] [] of_unittest+0x252c/0x26e5 > [ 37.263400] [] ? slob_free+0x98c/0x9a2 > [ 37.263400] [] ? slob_free+0x98c/0x9a2 > [ 37.263408] [] ? __phys_addr+0x146/0x188 > [ 37.263408] [] ? __phys_addr+0x146/0x188 > [ 37.263414] [] ? kfree+0x11f/0x1cc > [ 37.263414] [] ? kfree+0x11f/0x1cc > [ 37.263423] [] do_one_initcall+0x2ee/0x474 > [ 37.263423] [] do_one_initcall+0x2ee/0x474 > [ 37.263432] [] ? repair_env_string+0x36/0x140 > [ 37.263432] [] ? repair_env_string+0x36/0x140 > [ 37.263440] [] ? of_unittest_find_node_by_name+0x11f0/0x11f0 > [ 37.263440] [] ? of_unittest_find_node_by_name+0x11f0/0x11f0 > [ 37.263450] [] ? parse_args+0x828/0x9c2 > [ 37.263450] [] ? parse_args+0x828/0x9c2 > [ 37.263461] [] ? kernel_init_freeable+0x322/0x581 > [ 37.263461] [] ? kernel_init_freeable+0x322/0x581 > [ 37.263470] [] kernel_init_freeable+0x416/0x581 > [ 37.263470] [] kernel_init_freeable+0x416/0x581 > [ 37.263480] [] kernel_init+0x16/0x1e7 > [ 37.263480] [] kernel_init+0x16/0x1e7 > [ 37.263488] [] ret_from_kernel_thread+0x20/0x40 > [ 37.263488] [] ret_from_kernel_thread+0x20/0x40 > [ 37.263496] [] ? rest_init+0x2bb/0x2bb > [ 37.263496] [] ? rest_init+0x2bb/0x2bb > [ 37.263609] Code: 83 05 48 90 aa c2 01 b8 a0 65 f0 c1 83 15 4c 90 aa c2 00 e9 84 f6 ff ff 83 05 40 90 aa c2 01 8b 45 ec 83 15 44 90 aa c2 00 50 9d <8d> 74 26 00 83 05 50 90 aa c2 01 83 15 54 90 aa c2 00 80 7d eb > [ 37.263609] Code: 83 05 48 90 aa c2 01 b8 a0 65 f0 c1 83 15 4c 90 aa c2 00 e9 84 f6 ff ff 83 05 40 90 aa c2 01 8b 45 ec 83 15 44 90 aa c2 00 50 9d <8d> 74 26 00 83 05 50 90 aa c2 01 83 15 54 90 aa c2 00 80 7d eb > [ 37.263614] Kernel panic - not syncing: softlockup: hung tasks > [ 37.263614] Kernel panic - not syncing: softlockup: hung tasks