Hi Sebastien, Stack crashing into heap?
Have you upped the stack sizes across the board? David -----Original Message----- From: Sebastien Lorquet [mailto:sebast...@lorquet.fr] Sent: Wednesday, May 26, 2021 9:22 AM To: dev@nuttx.apache.org Subject: Re: Port of project from NuttX 7.30 to 10.1 RC1: Unexpected IRQ Hello, Thanks for the remarks. I am using the flat (monolithic build) and I see no place that define this flag, at all. I dont even see a place in the codebase that defines this flag. I see nothing related to mm, nor anything outdated in my Make.defs, which is from my old setup, yes, but still similar to a recent one. Sebastien Le 26/05/2021 à 18:08, raiden00pl a écrit : > If you use CONFIG_BUILD_FLAT=y, make sure that __KERNEL__ flag is set > here: > https://github.com/apache/incubator-nuttx/blob/master/include/nuttx/mm/mm.h#L85 > I remember that at some point I had a similar hardfault in mm which > doesn't > make sense and it was due to outdated board Make.defs. > > śr., 26 maj 2021 o 17:21 Sebastien Lorquet <sebast...@lorquet.fr> > napisał(a): > >> Update: stack dump and register analysis are in fact pointing to a crash >> in mm_alloc >> >> I have enabled memory management debug: >> >> mm_initialize: Heap: start=0x10000000 size=65536 >> mm_addregion: Region 1: base=0x10000154 size=65184 >> stm32_netinitialize: Enabling PHY power >> stm32_netinitialize: PHY reset... >> stm32_netinitialize: PHY reset done. >> stm32_netinitialize: Configuring PHY int >> F >> mm_free: Freeing 0x70fb460b >> irq_unexpected_isr: ERROR irq: 3 >> up_assert: Assertion failed at file:irq/irq_unexpectedisr.c line: 50 >> up_registerdump: R0: 00000001 2000737c c00000f2 08000101 00000000 >> 00000000 00000000 200073c8 >> up_registerdump: R8: 00000000 00000000 00000000 00000000 00000000 >> 200073c8 080126ad 080126f8 >> up_registerdump: xPSR: 21000000 PRIMASK: 00000000 CONTROL: 00000000 >> up_registerdump: EXC_RETURN: fffffff9 >> up_dumpstate: sp: 200072c8 >> up_dumpstate: stack base: 20007078 >> up_dumpstate: stack size: 00000400 >> >> The fact that mm_initialize only shows one region is weird... where is >> the heap for the main RAM at 0x20000000? >> >> the mm_free(0x70fb460b) is not what causes the hardfault (it comes >> later), but what the hell is is this invalid address! >> >> This is the first call to mm_free, here is the backtrace: >> >> Breakpoint 1, mm_free (heap=0x200060b4 <g_mmheap>, mem=0x70fb460b) at >> mm_heap/mm_free.c:85 >> 85 if (!mem) >> (gdb) bt >> #0 mm_free (heap=0x200060b4 <g_mmheap>, mem=0x70fb460b) at >> mm_heap/mm_free.c:85 >> #1 0x0801264a in mm_free_delaylist (heap=0x200060b4 <g_mmheap>) at >> mm_heap/mm_malloc.c:82 >> #2 0x08012672 in mm_malloc (heap=0x200060b4 <g_mmheap>, size=24) at >> mm_heap/mm_malloc.c:115 >> #3 0x08012a32 in mm_zalloc (heap=0x200060b4 <g_mmheap>, size=24) at >> mm_heap/mm_zalloc.c:45 >> #4 0x080123ac in zalloc (size=24) at umm_heap/umm_zalloc.c:68 >> #5 0x080399fa in inode_alloc (name=0x8059a78 "") at >> inode/fs_inodereserve.c:78 >> #6 0x08039a5c in inode_root_reserve () at inode/fs_inodereserve.c:129 >> #7 0x080398cc in inode_initialize () at inode/fs_inode.c:92 >> #8 0x08039284 in fs_initialize () at fs_initialize.c:47 >> #9 0x08007eb4 in nx_start () at init/nx_start.c:600 >> #10 0x0800421e in __start () at chip/stm32_start.c:338 >> >> As previously analyzed, this happens in fs_initialize through >> inode_root_reserve, so I was on the right track. >> >> Caller shows mm_free called with that weird address: >> >> (gdb) f 1 >> #1 0x0801264a in mm_free_delaylist (heap=0x200060b4 <g_mmheap>) at >> mm_heap/mm_malloc.c:82 >> 82 mm_free(heap, address); >> (gdb) list >> 77 >> 78 /* The address should always be non-NULL since that was >> checked in the >> 79 * 'while' condition above. >> 80 */ >> 81 >> 82 mm_free(heap, address); <-- address == 0x70fb460b >> 83 } >> 84 #endif >> 85 } >> 86 >> >> (gdb) print &g_mmheap >> $3 = (struct mm_heap_s *) 0x200060b4 <g_mmheap> >> (gdb) print g_mmheap >> $4 = {mm_impl = 0x0} >> >> this is not good! >> >> This is not a timing or IRQ related issue but a heap issue. >> >> R15 = 080126f8 translates to here: >> >> >> https://github.com/apache/incubator-nuttx/blob/master/mm/mm_heap/mm_malloc.c#L199 >> >> => this free() has corrupted a badly initialized heap, and the next >> malloc fails, giving a hardfault because that address is invalid. >> >> Horrific mess! >> >> ==> >> >> I think that my old board code does not initialize the board properly, I >> probably have to check for differences between my code and the >> stm32f429i-disco built-in board (on which I based my board). >> >> Sebastien >> >> Le 25/05/2021 à 21:26, Nathan Hartman a écrit : >>> On Tue, May 25, 2021 at 12:02 PM Sebastien Lorquet <sebast...@lorquet.fr >>> >>> wrote: >>> >>>> Back to the business >>>>>> After this we managed to recompile our project using the latest NuttX >>>>>> sources, but it fails when trying to init the PHY irq on our >>>>>> STM32F427 >>>>>> board: We get "unexpected IRQ". >>>>>> >>>>>> Yes I know that's pretty vague :-) >>>>>> >>>>>> Is there anything obvious I should have been careful with in this >>>>>> domain, before I dig the jtag probe to fix it (tomorrow) ? >>>>> I would first start by looking through the Release Notes between v7.30 >>>>> and v10.1. Many big improvements and bug fixes happened and some of >>>>> them are mentioned in Compatibility Concerns along with some changes >>>>> you might need to make to configuration etc. >>>>> >>>>> Also another thing you can try: Has this board and PHY worked >>>>> correctly with v7.30? If so, you can bisect and with very few tests >>>>> (I'm guessing fewer than 20) find the exact commit that broke it. >>>> Release notes are hard to read but I did not find anything special >>>> about >>>> phy interrupts. >>>> >>>> Note that it may not be the phy interrupt. Here is my log: >>>> >>>> stm32_netinitialize: Enabling PHY power >>>> stm32_netinitialize: PHY reset... >>>> stm32_netinitialize: PHY reset done. >>>> stm32_netinitialize: Configuring PHY int >>>> F >>>> irq_unexpected_isr: ERROR irq: 3 >>>> up_assert: Assertion failed at file:irq/irq_unexpectedisr.c line: 50 >>>> up_registerdump: R0: 00000001 2000737c c00000f2 08000101 00000000 >>>> 00000000 00000000 200073c8 >>>> up_registerdump: R8: 00000000 00000000 00000000 00000000 00000000 >>>> 200073c8 080126ad 080126f8 >>>> up_registerdump: xPSR: 21000000 PRIMASK: 00000000 CONTROL: 00000000 >>>> up_registerdump: EXC_RETURN: fffffff9 >>>> >>>> A lot of OS initialization things happen at the point, marked by the >>>> letter F. >>>> >>>> It seems that an unexpected IRQ happens in this interval, around the >>>> time the filesystem is initialized. The backtrace goes down to memory >>>> allocation routines through the initialization of the root inode. >>>> >>>> My guess is that AN external IRQ is triggered (possibly not the PHY >>>> IRQ) >>>> but the ISR handler for that one is not ready yet. I will add debug >>>> messages. >>>> >>>> >>>> I would expect that situation to be a simple NOP, but it seems that >>>> undefined handlers are set to this function "irq_unexpected_isr" >>>> >>>> Is that a new behaviour? a default config that I did not set properly >>>> when porting our old defconfig? >>>> >>>> Sebastien >>>> >>>>> Nathan >>> Did you try disabling the PHY (or networking) in Kconfig to see if >> removing >>> it from the build will eliminate the hardfault? >>> >>> Have you seen this about hardfault debugging: >>> >> https://cwiki.apache.org/confluence/plugins/servlet/mobile?contentId=139629445#content/view/139629445 >>> Nathan >>>