From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1753403AbaCEFet (ORCPT ); Wed, 5 Mar 2014 00:34:49 -0500 Received: from e33.co.us.ibm.com ([32.97.110.151]:60561 "EHLO e33.co.us.ibm.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751880AbaCEFer (ORCPT ); Wed, 5 Mar 2014 00:34:47 -0500 Date: Tue, 4 Mar 2014 21:34:40 -0800 From: "Paul E. McKenney" To: Florian Fainelli Cc: Eric Dumazet , "linux-kernel@vger.kernel.org" , linux-mm , linux-nfs , "trond.myklebust" , netdev Subject: Re: RCU stalls when running out of memory on 3.14-rc4 w/ NFS and kernel threads priorities changed Message-ID: <20140305053440.GD3334@linux.vnet.ibm.com> Reply-To: paulmck@linux.vnet.ibm.com References: <1393980534.26794.147.camel@edumazet-glaptop2.roam.corp.google.com> <20140305014310.GC3334@linux.vnet.ibm.com> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline In-Reply-To: User-Agent: Mutt/1.5.21 (2010-09-15) X-TM-AS-MML: disable X-Content-Scanned: Fidelis XPS MAILER x-cbid: 14030505-0928-0000-0000-0000002497C8 Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org On Tue, Mar 04, 2014 at 07:55:03PM -0800, Florian Fainelli wrote: > 2014-03-04 17:43 GMT-08:00 Paul E. McKenney : > > On Tue, Mar 04, 2014 at 05:16:27PM -0800, Florian Fainelli wrote: > >> 2014-03-04 17:03 GMT-08:00 Florian Fainelli : > >> > 2014-03-04 16:48 GMT-08:00 Eric Dumazet : > >> >> On Tue, 2014-03-04 at 15:55 -0800, Florian Fainelli wrote: > >> >>> Hi all, > >> >>> > >> >>> I am seeing the following RCU stalls messages appearing on an ARMv7 > >> >>> 4xCPUs system running 3.14-rc4: > >> >>> > >> >>> [ 42.974327] INFO: rcu_sched detected stalls on CPUs/tasks: > >> >>> [ 42.979839] (detected by 0, t=2102 jiffies, g=4294967082, > >> >>> c=4294967081, q=516) > >> >>> [ 42.987169] INFO: Stall ended before state dump start > >> >>> > >> >>> this is happening under the following conditions: > >> >>> > >> >>> - the attached bumper.c binary alters various kernel thread priorities > >> >>> based on the contents of bumpup.cfg and > >> >>> - malloc_crazy is running from a NFS share > >> >>> - malloc_crazy.c is running in a loop allocating chunks of memory but > >> >>> never freeing it > >> >>> > >> >>> when the priorities are altered, instead of getting the OOM killer to > >> >>> be invoked, the RCU stalls are happening. Taking NFS out of the > >> >>> equation does not allow me to reproduce the problem even with the > >> >>> priorities altered. > >> >>> > >> >>> This "problem" seems to have been there for quite a while now since I > >> >>> was able to get 3.8.13 to trigger that bug as well, with a slightly > >> >>> more detailed RCU debugging trace which points the finger at kswapd0. > >> >>> > >> >>> You should be able to get that reproduced under QEMU with the > >> >>> Versatile Express platform emulating a Cortex A15 CPU and the attached > >> >>> files. > >> >>> > >> >>> Any help or suggestions would be greatly appreciated. Thanks! > >> >> > >> >> Do you have a more complete trace, including stack traces ? > >> > > >> > Attatched is what I get out of SysRq-t, which is the only thing I have > >> > (note that the kernel is built with CONFIG_RCU_CPU_STALL_INFO=y): > >> > >> QEMU for Versatile Express w/ 2 CPUs yields something slightly > >> different than the real HW platform this is happening with, but it > >> does produce the RCU stall anyway: > >> > >> [ 125.762946] BUG: soft lockup - CPU#1 stuck for 53s! [malloc_crazy:91] > > > > This soft-lockup condition can result in RCU CPU stall warnings. Fix > > the problem causing the soft lockup, and I bet that your RCU CPU stall > > warnings go away. > > I definitively agree, which is why I was asking for help, as I think > the kernel thread priority change is what is causing the soft lockup > to appear, but nothing obvious jumps to mind when looking at the > trace. Is your hardware able to make the malloc_crazy CPU periodically dump its stack, perhaps in response to an NMI? If not, another approach is to use ftrace -- though this will require a very high-priority task to turn tracing on and off reasonably quickly, unless you happen to have a very large amount of storage to hold the trace. What happens if you malloc() less intensively? Does that avoid this problem? The reason I ask is that you mentioned that avoiding NFS helped, and it is possible that NFS is increasing storage-access latencies and thus triggering another problem. It is quite possible that slowing down the malloc()s would also help, and might allow you to observe what is happening more easily than when the system is driven fully to the lockup condition. Finally, what are you trying to achieve with this workload? Does your production workload behave in this way? Or is this an experimental investigation of some sort? Thanx, Paul From mboxrd@z Thu Jan 1 00:00:00 1970 From: "Paul E. McKenney" Subject: Re: RCU stalls when running out of memory on 3.14-rc4 w/ NFS and kernel threads priorities changed Date: Tue, 4 Mar 2014 21:34:40 -0800 Message-ID: <20140305053440.GD3334@linux.vnet.ibm.com> References: <1393980534.26794.147.camel@edumazet-glaptop2.roam.corp.google.com> <20140305014310.GC3334@linux.vnet.ibm.com> Reply-To: paulmck@linux.vnet.ibm.com Mime-Version: 1.0 Content-Type: text/plain; charset=us-ascii Cc: Eric Dumazet , "linux-kernel@vger.kernel.org" , linux-mm , linux-nfs , "trond.myklebust" , netdev To: Florian Fainelli Return-path: Content-Disposition: inline In-Reply-To: Sender: owner-linux-mm@kvack.org List-Id: netdev.vger.kernel.org On Tue, Mar 04, 2014 at 07:55:03PM -0800, Florian Fainelli wrote: > 2014-03-04 17:43 GMT-08:00 Paul E. McKenney : > > On Tue, Mar 04, 2014 at 05:16:27PM -0800, Florian Fainelli wrote: > >> 2014-03-04 17:03 GMT-08:00 Florian Fainelli : > >> > 2014-03-04 16:48 GMT-08:00 Eric Dumazet : > >> >> On Tue, 2014-03-04 at 15:55 -0800, Florian Fainelli wrote: > >> >>> Hi all, > >> >>> > >> >>> I am seeing the following RCU stalls messages appearing on an ARMv7 > >> >>> 4xCPUs system running 3.14-rc4: > >> >>> > >> >>> [ 42.974327] INFO: rcu_sched detected stalls on CPUs/tasks: > >> >>> [ 42.979839] (detected by 0, t=2102 jiffies, g=4294967082, > >> >>> c=4294967081, q=516) > >> >>> [ 42.987169] INFO: Stall ended before state dump start > >> >>> > >> >>> this is happening under the following conditions: > >> >>> > >> >>> - the attached bumper.c binary alters various kernel thread priorities > >> >>> based on the contents of bumpup.cfg and > >> >>> - malloc_crazy is running from a NFS share > >> >>> - malloc_crazy.c is running in a loop allocating chunks of memory but > >> >>> never freeing it > >> >>> > >> >>> when the priorities are altered, instead of getting the OOM killer to > >> >>> be invoked, the RCU stalls are happening. Taking NFS out of the > >> >>> equation does not allow me to reproduce the problem even with the > >> >>> priorities altered. > >> >>> > >> >>> This "problem" seems to have been there for quite a while now since I > >> >>> was able to get 3.8.13 to trigger that bug as well, with a slightly > >> >>> more detailed RCU debugging trace which points the finger at kswapd0. > >> >>> > >> >>> You should be able to get that reproduced under QEMU with the > >> >>> Versatile Express platform emulating a Cortex A15 CPU and the attached > >> >>> files. > >> >>> > >> >>> Any help or suggestions would be greatly appreciated. Thanks! > >> >> > >> >> Do you have a more complete trace, including stack traces ? > >> > > >> > Attatched is what I get out of SysRq-t, which is the only thing I have > >> > (note that the kernel is built with CONFIG_RCU_CPU_STALL_INFO=y): > >> > >> QEMU for Versatile Express w/ 2 CPUs yields something slightly > >> different than the real HW platform this is happening with, but it > >> does produce the RCU stall anyway: > >> > >> [ 125.762946] BUG: soft lockup - CPU#1 stuck for 53s! [malloc_crazy:91] > > > > This soft-lockup condition can result in RCU CPU stall warnings. Fix > > the problem causing the soft lockup, and I bet that your RCU CPU stall > > warnings go away. > > I definitively agree, which is why I was asking for help, as I think > the kernel thread priority change is what is causing the soft lockup > to appear, but nothing obvious jumps to mind when looking at the > trace. Is your hardware able to make the malloc_crazy CPU periodically dump its stack, perhaps in response to an NMI? If not, another approach is to use ftrace -- though this will require a very high-priority task to turn tracing on and off reasonably quickly, unless you happen to have a very large amount of storage to hold the trace. What happens if you malloc() less intensively? Does that avoid this problem? The reason I ask is that you mentioned that avoiding NFS helped, and it is possible that NFS is increasing storage-access latencies and thus triggering another problem. It is quite possible that slowing down the malloc()s would also help, and might allow you to observe what is happening more easily than when the system is driven fully to the lockup condition. Finally, what are you trying to achieve with this workload? Does your production workload behave in this way? Or is this an experimental investigation of some sort? Thanx, Paul -- To unsubscribe, send a message with 'unsubscribe linux-mm' in the body to majordomo@kvack.org. For more info on Linux MM, see: http://www.linux-mm.org/ . Don't email: email@kvack.org