Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size of his blob but I suspect its the same issue and actually not to do with cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready DRAM: 256 MiB WARNING: Caches not enabled NAND: No NAND device found!!! 0 MiB MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1 *** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Peripheral mode controller at 47401000 using PIO, IRQ 0 musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Host mode controller at 47401800 using PIO, IRQ 0 Net: <ethaddr> not set. Validating first E-fuse MAC cpsw, usb_ether Hit any key to stop autoboot: 0 link up on port 0, speed 100, full duplex BOOTP broadcast 1 DHCP client bound to address 192.168.222.138 Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'zImage-bone'. Load address: 0x80200000 Loading: ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s done Bytes transferred = 4197392 (400c10 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'am335x-bone.dtb'. Load address: 0x80f80000 Loading: ## 489.3 KiB/s done Bytes transferred = 8518 (2146 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'bone.acpi'. Load address: 0x80f84000 Loading: # 416 KiB/s done Bytes transferred = 4266 (10aa hex) ## Flattened Device Tree blob at 80f80000 Booting using the fdt blob at 0x80f80000 * acpi: cmdline image address = 0x80f84000 * acpi: Length of blob 4258 * acpi: loading to 8f236000, end 8f2370aa Loading Device Tree to 8f230000, end 8f235145 ... OK using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] acpi: vaddress c0fb5000 [ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000 [ 0.000000] acpi: GOT HERE1 [ 0.000000] acpi: GOT HERE2 [ 0.000000] (I) entering acpi_tb_parse_root_table [ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] (I) acpi_table_init call completed [ 0.000000] (I) exit acpi_boot_table_init [ 0.000000] enter early_acpi_boot_init [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] AM335X ES1.0 (neon ) [ 0.000000] enter acpi_boot_init [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 255MB = 255MB total [ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB) [ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB) [ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB) [ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts [ 0.000000] Total of 128 interrupts on 1 active controller [ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz [ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms [ 0.000000] OMAP clocksource: timer1 at 24000000 Hz [ 0.000000] Console: colour dummy device 80x30 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3695 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624) [ 0.119238] pid_max: default: 32768 minimum: 301 [ 0.124655] Security Framework initialized [ 0.129183] Mount-cache hash table entries: 512 [ 0.146500] CPU: Testing write buffer coherency: ok [ 0.151830] ACPI: Core revision 20130328 [ 0.158096] ACPI: All ACPI Tables successfully acquired [ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0 [ 0.181338] Brought up 1 CPUs [ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS). [ 0.191125] CPU: All CPU(s) started in SVC mode. [ 0.199973] devtmpfs: initialized [ 0.283148] pinctrl core: initialized pinctrl subsystem [ 0.294438] regulator-dummy: no parameters [ 0.303478] NET: Registered protocol family 16 [ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.355305] OMAP GPIO hardware version 0.1 [ 0.387884] No ATAGs? [ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.486304] bio: create slab <bio-0> at 0 [ 0.494907] ACPI: Added _OSI(Module Device) [ 0.499533] ACPI: Added _OSI(Processor Device) [ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.509237] ACPI: Added _OSI(Processor Aggregator Device) [ 0.515927] ACPI: EC: EC description table is found, configuring boot EC [ 0.525136] ACPI: Interpreter enabled [ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568) [ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568) [ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568) [ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568) [ 0.568153] ACPI: (supports S0) [ 0.571482] ACPI: Using GIC for interrupt routing [ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67) [ 21.608358] INFO: Stall ended before state dump start
Hi,
I am going to have to admit defeat on this issue, I'm pretty sure its a lowlevel MMU/VM/RAM allocation/access thingy. But I know very little about the area.
Who can we call to give advice?
Graeme
On 22/06/13 01:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size of his blob but I suspect its the same issue and actually not to do with cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready DRAM: 256 MiB WARNING: Caches not enabled NAND: No NAND device found!!! 0 MiB MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1 *** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Peripheral mode controller at 47401000 using PIO, IRQ 0 musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Host mode controller at 47401800 using PIO, IRQ 0 Net: <ethaddr> not set. Validating first E-fuse MAC cpsw, usb_ether Hit any key to stop autoboot: 0 link up on port 0, speed 100, full duplex BOOTP broadcast 1 DHCP client bound to address 192.168.222.138 Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'zImage-bone'. Load address: 0x80200000 Loading: ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s done Bytes transferred = 4197392 (400c10 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'am335x-bone.dtb'. Load address: 0x80f80000 Loading: ## 489.3 KiB/s done Bytes transferred = 8518 (2146 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'bone.acpi'. Load address: 0x80f84000 Loading: # 416 KiB/s done Bytes transferred = 4266 (10aa hex) ## Flattened Device Tree blob at 80f80000 Booting using the fdt blob at 0x80f80000
- acpi: cmdline image address = 0x80f84000
- acpi: Length of blob 4258
- acpi: loading to 8f236000, end 8f2370aa Loading Device Tree to 8f230000, end 8f235145 ... OK
using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] acpi: vaddress c0fb5000 [ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000 [ 0.000000] acpi: GOT HERE1 [ 0.000000] acpi: GOT HERE2 [ 0.000000] (I) entering acpi_tb_parse_root_table [ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] (I) acpi_table_init call completed [ 0.000000] (I) exit acpi_boot_table_init [ 0.000000] enter early_acpi_boot_init [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] AM335X ES1.0 (neon ) [ 0.000000] enter acpi_boot_init [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 255MB = 255MB total [ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB) [ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB) [ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB) [ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts [ 0.000000] Total of 128 interrupts on 1 active controller [ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz [ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms [ 0.000000] OMAP clocksource: timer1 at 24000000 Hz [ 0.000000] Console: colour dummy device 80x30 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3695 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624) [ 0.119238] pid_max: default: 32768 minimum: 301 [ 0.124655] Security Framework initialized [ 0.129183] Mount-cache hash table entries: 512 [ 0.146500] CPU: Testing write buffer coherency: ok [ 0.151830] ACPI: Core revision 20130328 [ 0.158096] ACPI: All ACPI Tables successfully acquired [ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0 [ 0.181338] Brought up 1 CPUs [ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS). [ 0.191125] CPU: All CPU(s) started in SVC mode. [ 0.199973] devtmpfs: initialized [ 0.283148] pinctrl core: initialized pinctrl subsystem [ 0.294438] regulator-dummy: no parameters [ 0.303478] NET: Registered protocol family 16 [ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.355305] OMAP GPIO hardware version 0.1 [ 0.387884] No ATAGs? [ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.486304] bio: create slab <bio-0> at 0 [ 0.494907] ACPI: Added _OSI(Module Device) [ 0.499533] ACPI: Added _OSI(Processor Device) [ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.509237] ACPI: Added _OSI(Processor Aggregator Device) [ 0.515927] ACPI: EC: EC description table is found, configuring boot EC [ 0.525136] ACPI: Interpreter enabled [ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568) [ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568) [ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568) [ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568) [ 0.568153] ACPI: (supports S0) [ 0.571482] ACPI: Using GIC for interrupt routing [ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67) [ 21.608358] INFO: Stall ended before state dump start
Arnd, Grant, Nico,
I am fwd'ing the message here below to your attention, as you are the most skilled problem hunters at Linaro :-)
Any suggestion for Graeme?
Thanks a lot in advance for any idea!
Hi Graeme,
We'll start with the basics. Can you add this to the kernel command line and send the output? I want to make sure the ACPI region is getting properly protected by the kernel:
memblock=debug
g.
On Sun, Jun 23, 2013 at 11:07 AM, Andrea Gallo andrea.gallo@linaro.org wrote:
Arnd, Grant, Nico,
I am fwd'ing the message here below to your attention, as you are the most skilled problem hunters at Linaro :-)
Any suggestion for Graeme?
Thanks a lot in advance for any idea!
-- Andrea
Begin forwarded message:
From: Graeme Gregory graeme.gregory@linaro.org Date: 22 giugno 2013 14:28:35 CEST To: linaro-acpi@lists.linaro.org Subject: Re: [Linaro-acpi] ACPI Table Size Issue
Hi,
I am going to have to admit defeat on this issue, I'm pretty sure its a lowlevel MMU/VM/RAM allocation/access thingy. But I know very little about the area.
Who can we call to give advice?
Graeme
On 22/06/13 01:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which
has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall,
same place as I was seeing with Hanjun's patches. I did not check the size
of his blob but I suspect its the same issue and actually not to do with
cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready
DRAM: 256 MiB
WARNING: Caches not enabled
NAND: No NAND device found!!!
0 MiB
MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1
*** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn)
musb-hdrc: MHDRC RTL version 2.0
musb-hdrc: setup fifo_mode 4
musb-hdrc: 28/31 max ep, 16384/16384 memory
USB Peripheral mode controller at 47401000 using PIO, IRQ 0
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn)
musb-hdrc: MHDRC RTL version 2.0
musb-hdrc: setup fifo_mode 4
musb-hdrc: 28/31 max ep, 16384/16384 memory
USB Host mode controller at 47401800 using PIO, IRQ 0
Net: <ethaddr> not set. Validating first E-fuse MAC
cpsw, usb_ether
Hit any key to stop autoboot: 0
link up on port 0, speed 100, full duplex
BOOTP broadcast 1
DHCP client bound to address 192.168.222.138
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'zImage-bone'.
Load address: 0x80200000
Loading: #################################################################
################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s
done
Bytes transferred = 4197392 (400c10 hex)
link up on port 0, speed 100, full duplex
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'am335x-bone.dtb'.
Load address: 0x80f80000
Loading: ##
489.3 KiB/s
done
Bytes transferred = 8518 (2146 hex)
link up on port 0, speed 100, full duplex
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'bone.acpi'.
Load address: 0x80f84000
Loading: #
416 KiB/s
done
Bytes transferred = 4266 (10aa hex)
## Flattened Device Tree blob at 80f80000
Booting using the fdt blob at 0x80f80000
acpi: cmdline image address = 0x80f84000
acpi: Length of blob 4258
acpi: loading to 8f236000, end 8f2370aa
Loading Device Tree to 8f230000, end 8f235145 ... OK
using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013
[ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone
[ 0.000000] bootconsole [earlycon0] enabled
[ 0.000000] cma: CMA: reserved 16 MiB at 8e000000
[ 0.000000] Memory policy: ECC disabled, Data cache writeback
[ 0.000000] acpi: vaddress c0fb5000
[ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000
[ 0.000000] acpi: GOT HERE1
[ 0.000000] acpi: GOT HERE2
[ 0.000000] (I) entering acpi_tb_parse_root_table
[ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO)
[ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517)
[ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517)
[ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517)
[ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517)
[ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] (I) acpi_table_init call completed
[ 0.000000] (I) exit acpi_boot_table_init
[ 0.000000] enter early_acpi_boot_init
[ 0.000000] CPU: All CPU(s) started in SVC mode.
[ 0.000000] AM335X ES1.0 (neon )
[ 0.000000] enter acpi_boot_init
[ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768
[ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk
[ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.000000] Memory: 255MB = 255MB total
[ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
[ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB)
[ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB)
[ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB)
[ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB)
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[ 0.000000] Total of 128 interrupts on 1 active controller
[ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz
[ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms
[ 0.000000] OMAP clocksource: timer1 at 24000000 Hz
[ 0.000000] Console: colour dummy device 80x30
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768
[ 0.000000] ... CHAINHASH_SIZE: 16384
[ 0.000000] memory used by lock dependency info: 3695 kB
[ 0.000000] per task-struct memory footprint: 1152 bytes
[ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624)
[ 0.119238] pid_max: default: 32768 minimum: 301
[ 0.124655] Security Framework initialized
[ 0.129183] Mount-cache hash table entries: 512
[ 0.146500] CPU: Testing write buffer coherency: ok
[ 0.151830] ACPI: Core revision 20130328
[ 0.158096] ACPI: All ACPI Tables successfully acquired
[ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0
[ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0
[ 0.181338] Brought up 1 CPUs
[ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS).
[ 0.191125] CPU: All CPU(s) started in SVC mode.
[ 0.199973] devtmpfs: initialized
[ 0.283148] pinctrl core: initialized pinctrl subsystem
[ 0.294438] regulator-dummy: no parameters
[ 0.303478] NET: Registered protocol family 16
[ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.355305] OMAP GPIO hardware version 0.1
[ 0.387884] No ATAGs?
[ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported.
[ 0.486304] bio: create slab <bio-0> at 0
[ 0.494907] ACPI: Added _OSI(Module Device)
[ 0.499533] ACPI: Added _OSI(Processor Device)
[ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.509237] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.515927] ACPI: EC: EC description table is found, configuring boot EC
[ 0.525136] ACPI: Interpreter enabled
[ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568)
[ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568)
[ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568)
[ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568)
[ 0.568153] ACPI: (supports S0)
[ 0.571482] ACPI: Using GIC for interrupt routing
[ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67)
[ 21.608358] INFO: Stall ended before state dump start
Linaro-acpi mailing list Linaro-acpi@lists.linaro.org http://lists.linaro.org/mailman/listinfo/linaro-acpi
Hi Grant,
Here is the bootlog with that option.
Thanks
Graeme
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00159-gd175e0e-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #135 SMP Sat Jun 22 13:10:09 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] acpi: start info is 0x000010AA000010AA, 3229199264 bytes [ 0.000000] acpi: sig is "ACPI" [ 0.000000] acpi: info is 00 00 10 a2 [ 0.000000] acpi: first table is "RSD " [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] memblock_reserve: [0x00000080008280-0x00000080dbb8e8] arm_memblock_init+0x48/0x170 [ 0.000000] memblock_reserve: [0x00000080004000-0x00000080008000] arm_memblock_init+0xf4/0x170 [ 0.000000] memblock_reserve: [0x0000008f230000-0x0000008f235146] arm_dt_memblock_reserve+0x24/0x90 [ 0.000000] memblock_reserve: [0x0000008f236000-0x0000008f2370aa] arm_dt_memblock_reserve+0x84/0x90 [ 0.000000] memblock_reserve: [0x0000008ff00000-0x00000090000000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_free: [0x0000008ff00000-0x00000090000000] arm_memblock_steal+0x30/0x48 [ 0.000000] memblock_reserve: [0x0000008e000000-0x0000008f000000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] MEMBLOCK configuration: [ 0.000000] memory size = 0xff00000 reserved size = 0x1dbd858 [ 0.000000] memory.cnt = 0x1 [ 0.000000] memory[0x0] [0x00000080000000-0x0000008fefffff], 0xff00000 bytes [ 0.000000] reserved.cnt = 0x5 [ 0.000000] reserved[0x0] [0x00000080004000-0x00000080007fff], 0x4000 bytes [ 0.000000] reserved[0x1] [0x00000080008280-0x00000080dbb8e7], 0xdb3668 bytes [ 0.000000] reserved[0x2] [0x0000008e000000-0x0000008effffff], 0x1000000 bytes [ 0.000000] reserved[0x3] [0x0000008f230000-0x0000008f235145], 0x5146 bytes [ 0.000000] reserved[0x4] [0x0000008f236000-0x0000008f2370a9], 0x10aa bytes [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] memblock_reserve: [0x0000008fefffd8-0x0000008ff00000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefe000-0x0000008feff000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefd000-0x0000008fefe000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefc000-0x0000008fefd000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefb000-0x0000008fefc000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefa000-0x0000008fefb000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef9000-0x0000008fefa000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef8000-0x0000008fef9000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef7000-0x0000008fef8000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef6000-0x0000008fef7000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef5000-0x0000008fef6000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefff88-0x0000008fefffd8] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef4000-0x0000008fef5000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef3000-0x0000008fef4000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef1000-0x0000008fef3000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] ------------[ cut here ]------------ [ 0.000000] WARNING: at arch/arm/mm/ioremap.c:301 __arm_ioremap_pfn_caller+0x17c/0x1a8() [ 0.000000] Modules linked in: [ 0.000000] CPU: 0 PID: 0 Comm: swapper Not tainted 3.10.0-rc6-00159-gd175e0e-dirty #135 [ 0.000000] [<c001ac0c>] (unwind_backtrace+0x0/0xf0) from [<c00176bc>] (show_stack+0x10/0x14) [ 0.000000] [<c00176bc>] (show_stack+0x10/0x14) from [<c004154c>] (warn_slowpath_common+0x4c/0x6c) [ 0.000000] [<c004154c>] (warn_slowpath_common+0x4c/0x6c) from [<c0041588>] (warn_slowpath_null+0x1c/0x24) [ 0.000000] [<c0041588>] (warn_slowpath_null+0x1c/0x24) from [<c0020cb0>] (__arm_ioremap_pfn_caller+0x17c/0x1a8) [ 0.000000] [<c0020cb0>] (__arm_ioremap_pfn_caller+0x17c/0x1a8) from [<c0020d48>] (__arm_ioremap_caller+0x54/0x5c) [ 0.000000] [<c0020d48>] (__arm_ioremap_caller+0x54/0x5c) from [<c0020a20>] (__arm_ioremap+0x14/0x1c) [ 0.000000] [<c0020a20>] (__arm_ioremap+0x14/0x1c) from [<c0788e5c>] (acpi_arm_blob_relocate+0x48/0x40c) [ 0.000000] [<c0788e5c>] (acpi_arm_blob_relocate+0x48/0x40c) from [<c0789240>] (acpi_boot_table_init+0x20/0x78) [ 0.000000] [<c0789240>] (acpi_boot_table_init+0x20/0x78) from [<c0758fa8>] (setup_arch+0x5e4/0x7f0) [ 0.000000] [<c0758fa8>] (setup_arch+0x5e4/0x7f0) from [<c075558c>] (start_kernel+0x7c/0x31c) [ 0.000000] [<c075558c>] (start_kernel+0x7c/0x31c) from [<80008074>] (0x80008074) [ 0.000000] ---[ end trace 1b75b31a2719ed1c ]--- [ 0.000000] Unable to handle kernel NULL pointer dereference at virtual address 00000011 [ 0.000000] pgd = c0004000 [ 0.000000] [00000011] *pgd=00000000 [ 0.000000] Internal error: Oops: 5 [#1] SMP ARM [ 0.000000] Modules linked in: [ 0.000000] CPU: 0 PID: 0 Comm: swapper Tainted: G W 3.10.0-rc6-00159-gd175e0e-dirty #135 [ 0.000000] task: c07c9c50 ti: c07be000 task.ti: c07be000 [ 0.000000] PC is at acpi_arm_blob_relocate+0x48/0x40c [ 0.000000] LR is at warn_slowpath_null+0x1c/0x24 [ 0.000000] pc : [<c0788e5c>] lr : [<c0041588>] psr: 60000193 [ 0.000000] sp : c07bff68 ip : 00000000 fp : c0670728 [ 0.000000] r10: 80000200 r9 : c07cb348 r8 : c0820e08 [ 0.000000] r7 : c07cb348 r6 : 8f236008 r5 : c0fbe840 r4 : c0da6344 [ 0.000000] r3 : c0da6344 r2 : 00000200 r1 : c0858480 r0 : 00000000 [ 0.000000] Flags: nZCv IRQs off FIQs on Mode SVC_32 ISA ARM Segment kernel [ 0.000000] Control: 10c5387d Table: 80004019 DAC: 00000017 [ 0.000000] Process swapper (pid: 0, stack limit = 0xc07be240) [ 0.000000] Stack: (0xc07bff68 to 0xc07c0000) [ 0.000000] ff60: c0da6344 c0fbe840 c0d96534 c07cb348 c0820e08 c0789240 [ 0.000000] ff80: c0799540 c0758fa8 00000000 10c53c7d 413fc082 00000000 00000000 c05189cc [ 0.000000] ffa0: c066ecf8 00000001 00000000 c079b1b4 c07cb134 80004059 413fc082 00000000 [ 0.000000] ffc0: 00000000 c075558c 00000000 00000000 00000000 00000000 00000000 c079b1b8 [ 0.000000] ffe0: 00000000 10c53c7d c07c6910 c079b1b4 c07cb134 80008074 00000000 00000000 [ 0.000000] [<c0788e5c>] (acpi_arm_blob_relocate+0x48/0x40c) from [<c0789240>] (acpi_boot_table_init+0x20/0x78) [ 0.000000] [<c0789240>] (acpi_boot_table_init+0x20/0x78) from [<c0758fa8>] (setup_arch+0x5e4/0x7f0) [ 0.000000] [<c0758fa8>] (setup_arch+0x5e4/0x7f0) from [<c075558c>] (start_kernel+0x7c/0x31c) [ 0.000000] [<c075558c>] (start_kernel+0x7c/0x31c) from [<80008074>] (0x80008074) [ 0.000000] Code: e2411008 e3a02000 e1a00006 ebe25eeb (e5d0c011) [ 0.000000] ---[ end trace 1b75b31a2719ed1d ]--- [ 0.000000] Kernel panic - not syncing: Attempted to kill the idle task!
On 23/06/13 14:25, Grant Likely wrote:
Hi Graeme,
We'll start with the basics. Can you add this to the kernel command line and send the output? I want to make sure the ACPI region is getting properly protected by the kernel:
memblock=debug
g.
On Sun, Jun 23, 2013 at 11:07 AM, Andrea Gallo andrea.gallo@linaro.org wrote:
Arnd, Grant, Nico,
I am fwd'ing the message here below to your attention, as you are the most skilled problem hunters at Linaro :-)
Any suggestion for Graeme?
Thanks a lot in advance for any idea!
-- Andrea
Begin forwarded message:
From: Graeme Gregory graeme.gregory@linaro.org Date: 22 giugno 2013 14:28:35 CEST To: linaro-acpi@lists.linaro.org Subject: Re: [Linaro-acpi] ACPI Table Size Issue
Hi,
I am going to have to admit defeat on this issue, I'm pretty sure its a lowlevel MMU/VM/RAM allocation/access thingy. But I know very little about the area.
Who can we call to give advice?
Graeme
On 22/06/13 01:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which
has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall,
same place as I was seeing with Hanjun's patches. I did not check the size
of his blob but I suspect its the same issue and actually not to do with
cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready
DRAM: 256 MiB
WARNING: Caches not enabled
NAND: No NAND device found!!!
0 MiB
MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1
*** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn)
musb-hdrc: MHDRC RTL version 2.0
musb-hdrc: setup fifo_mode 4
musb-hdrc: 28/31 max ep, 16384/16384 memory
USB Peripheral mode controller at 47401000 using PIO, IRQ 0
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn)
musb-hdrc: MHDRC RTL version 2.0
musb-hdrc: setup fifo_mode 4
musb-hdrc: 28/31 max ep, 16384/16384 memory
USB Host mode controller at 47401800 using PIO, IRQ 0
Net: <ethaddr> not set. Validating first E-fuse MAC
cpsw, usb_ether
Hit any key to stop autoboot: 0
link up on port 0, speed 100, full duplex
BOOTP broadcast 1
DHCP client bound to address 192.168.222.138
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'zImage-bone'.
Load address: 0x80200000
Loading: #################################################################
################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s
done
Bytes transferred = 4197392 (400c10 hex)
link up on port 0, speed 100, full duplex
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'am335x-bone.dtb'.
Load address: 0x80f80000
Loading: ##
489.3 KiB/s
done
Bytes transferred = 8518 (2146 hex)
link up on port 0, speed 100, full duplex
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'bone.acpi'.
Load address: 0x80f84000
Loading: #
416 KiB/s
done
Bytes transferred = 4266 (10aa hex)
## Flattened Device Tree blob at 80f80000
Booting using the fdt blob at 0x80f80000
acpi: cmdline image address = 0x80f84000
acpi: Length of blob 4258
acpi: loading to 8f236000, end 8f2370aa
Loading Device Tree to 8f230000, end 8f235145 ... OK
using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013
[ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone
[ 0.000000] bootconsole [earlycon0] enabled
[ 0.000000] cma: CMA: reserved 16 MiB at 8e000000
[ 0.000000] Memory policy: ECC disabled, Data cache writeback
[ 0.000000] acpi: vaddress c0fb5000
[ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000
[ 0.000000] acpi: GOT HERE1
[ 0.000000] acpi: GOT HERE2
[ 0.000000] (I) entering acpi_tb_parse_root_table
[ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO)
[ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517)
[ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517)
[ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517)
[ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517)
[ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] (I) acpi_table_init call completed
[ 0.000000] (I) exit acpi_boot_table_init
[ 0.000000] enter early_acpi_boot_init
[ 0.000000] CPU: All CPU(s) started in SVC mode.
[ 0.000000] AM335X ES1.0 (neon )
[ 0.000000] enter acpi_boot_init
[ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768
[ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk
[ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.000000] Memory: 255MB = 255MB total
[ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
[ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB)
[ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB)
[ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB)
[ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB)
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[ 0.000000] Total of 128 interrupts on 1 active controller
[ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz
[ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms
[ 0.000000] OMAP clocksource: timer1 at 24000000 Hz
[ 0.000000] Console: colour dummy device 80x30
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768
[ 0.000000] ... CHAINHASH_SIZE: 16384
[ 0.000000] memory used by lock dependency info: 3695 kB
[ 0.000000] per task-struct memory footprint: 1152 bytes
[ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624)
[ 0.119238] pid_max: default: 32768 minimum: 301
[ 0.124655] Security Framework initialized
[ 0.129183] Mount-cache hash table entries: 512
[ 0.146500] CPU: Testing write buffer coherency: ok
[ 0.151830] ACPI: Core revision 20130328
[ 0.158096] ACPI: All ACPI Tables successfully acquired
[ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0
[ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0
[ 0.181338] Brought up 1 CPUs
[ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS).
[ 0.191125] CPU: All CPU(s) started in SVC mode.
[ 0.199973] devtmpfs: initialized
[ 0.283148] pinctrl core: initialized pinctrl subsystem
[ 0.294438] regulator-dummy: no parameters
[ 0.303478] NET: Registered protocol family 16
[ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.355305] OMAP GPIO hardware version 0.1
[ 0.387884] No ATAGs?
[ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported.
[ 0.486304] bio: create slab <bio-0> at 0
[ 0.494907] ACPI: Added _OSI(Module Device)
[ 0.499533] ACPI: Added _OSI(Processor Device)
[ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.509237] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.515927] ACPI: EC: EC description table is found, configuring boot EC
[ 0.525136] ACPI: Interpreter enabled
[ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568)
[ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568)
[ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568)
[ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568)
[ 0.568153] ACPI: (supports S0)
[ 0.571482] ACPI: Using GIC for interrupt routing
[ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67)
[ 21.608358] INFO: Stall ended before state dump start
Linaro-acpi mailing list Linaro-acpi@lists.linaro.org http://lists.linaro.org/mailman/listinfo/linaro-acpi
Hi Grant,
Sorry, that was the wrong kernel I booted, here is correct log.
Thanks
Graeme
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00159-gd175e0e-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #136 SMP Sun Jun 23 17:10:48 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] acpi: start info is 0x000010AA000010AA, 3229199256 bytes [ 0.000000] acpi: sig is "ACPI" [ 0.000000] acpi: info is 00 00 10 a2 [ 0.000000] acpi: first table is "RSD " [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] memblock_reserve: [0x00000080008280-0x00000080dbb8e8] arm_memblock_init+0x48/0x170 [ 0.000000] memblock_reserve: [0x00000080004000-0x00000080008000] arm_memblock_init+0xf4/0x170 [ 0.000000] memblock_reserve: [0x0000008f230000-0x0000008f235146] arm_dt_memblock_reserve+0x24/0x90 [ 0.000000] memblock_reserve: [0x0000008f236000-0x0000008f2370aa] arm_dt_memblock_reserve+0x84/0x90 [ 0.000000] memblock_reserve: [0x0000008ff00000-0x00000090000000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_free: [0x0000008ff00000-0x00000090000000] arm_memblock_steal+0x30/0x48 [ 0.000000] memblock_reserve: [0x0000008e000000-0x0000008f000000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] MEMBLOCK configuration: [ 0.000000] memory size = 0xff00000 reserved size = 0x1dbd858 [ 0.000000] memory.cnt = 0x1 [ 0.000000] memory[0x0] [0x00000080000000-0x0000008fefffff], 0xff00000 bytes [ 0.000000] reserved.cnt = 0x5 [ 0.000000] reserved[0x0] [0x00000080004000-0x00000080007fff], 0x4000 bytes [ 0.000000] reserved[0x1] [0x00000080008280-0x00000080dbb8e7], 0xdb3668 bytes [ 0.000000] reserved[0x2] [0x0000008e000000-0x0000008effffff], 0x1000000 bytes [ 0.000000] reserved[0x3] [0x0000008f230000-0x0000008f235145], 0x5146 bytes [ 0.000000] reserved[0x4] [0x0000008f236000-0x0000008f2370a9], 0x10aa bytes [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] memblock_reserve: [0x0000008fefffd8-0x0000008ff00000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefe000-0x0000008feff000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefd000-0x0000008fefe000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefc000-0x0000008fefd000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefb000-0x0000008fefc000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefa000-0x0000008fefb000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef9000-0x0000008fefa000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef8000-0x0000008fef9000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef7000-0x0000008fef8000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef6000-0x0000008fef7000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef5000-0x0000008fef6000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefff88-0x0000008fefffd8] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef4000-0x0000008fef5000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef3000-0x0000008fef4000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef1000-0x0000008fef3000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] (I) entering acpi_tb_parse_root_table [ 0.000000] ACPI: RSDP 8f236008 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 8f23602c 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 8f2360f0 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 8f2361fc 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 8f236464 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 8f2364f4 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 8f236539 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 8f23659d 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 8f2367cd 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 8f2368fd 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 8f236931 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 8f236967 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 8f2369e7 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 8f236a28 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 8f236be4 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 8f236c08 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 8f236cbe 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 8f236cfa 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 8f236df0 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 8f236fc4 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 8f237014 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 8f237056 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 8f237086 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] (I) acpi_table_init call completed [ 0.000000] (I) exit acpi_boot_table_init [ 0.000000] enter early_acpi_boot_init [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] AM335X ES1.0 (neon ) [ 0.000000] enter acpi_boot_init [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fc5000 s14656 r8192 d14016 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk memblock=debug [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 255MB = 255MB total [ 0.000000] Memory: 228284k/228284k available, 33860k reserved, 0K highmem [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc0754970 (7475 kB) [ 0.000000] .init : 0xc0755000 - 0xc07bc940 ( 415 kB) [ 0.000000] .data : 0xc07be000 - 0xc0856c88 ( 612 kB) [ 0.000000] .bss : 0xc0856c88 - 0xc0dbb8e8 (5524 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] Additional per-CPU info printed with stalls. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts [ 0.000000] Total of 128 interrupts on 1 active controller [ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz [ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms [ 0.000000] OMAP clocksource: timer1 at 24000000 Hz [ 0.000000] Console: colour dummy device 80x30 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3695 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.062526] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624) [ 0.119233] pid_max: default: 32768 minimum: 301 [ 0.124667] Security Framework initialized [ 0.129200] Mount-cache hash table entries: 512 [ 0.146507] CPU: Testing write buffer coherency: ok [ 0.151840] ACPI: Core revision 20130328 [ 0.158105] ACPI: All ACPI Tables successfully acquired [ 0.165249] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.170795] Setting up static identity map for 0xc05255d0 - 0xc0525640 [ 0.181420] Brought up 1 CPUs [ 0.184582] SMP: Total of 1 processors activated (363.72 BogoMIPS). [ 0.191211] CPU: All CPU(s) started in SVC mode. [ 0.200082] devtmpfs: initialized [ 0.283464] pinctrl core: initialized pinctrl subsystem [ 0.294786] regulator-dummy: no parameters [ 0.303842] NET: Registered protocol family 16 [ 0.318919] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.356223] OMAP GPIO hardware version 0.1 [ 0.388692] No ATAGs? [ 0.390872] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.487226] bio: create slab <bio-0> at 0 [ 0.495170] ACPI: Added _OSI(Module Device) [ 0.499806] ACPI: Added _OSI(Processor Device) [ 0.504482] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.509513] ACPI: Added _OSI(Processor Aggregator Device) [ 0.516216] ACPI: EC: EC description table is found, configuring boot EC [ 0.525433] ACPI: Interpreter enabled [ 0.529434] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568) [ 0.539144] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568) [ 0.548842] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568) [ 0.558629] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568) [ 0.568331] ACPI: (supports S0) [ 0.571661] ACPI: Using GIC for interrupt routing [ 21.596402] INFO: rcu_sched detected stalls on CPUs/tasks: [ 21.602166] (detected by 0, t=2102 jiffies, g=4294967021, c=4294967020, q=76) [ 21.609703] INFO: Stall ended before state dump start
On 23/06/13 17:05, Graeme Gregory wrote:
Hi Grant,
Here is the bootlog with that option.
Thanks
Graeme
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00159-gd175e0e-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #135 SMP Sat Jun 22 13:10:09 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] acpi: start info is 0x000010AA000010AA, 3229199264 bytes [ 0.000000] acpi: sig is "ACPI" [ 0.000000] acpi: info is 00 00 10 a2 [ 0.000000] acpi: first table is "RSD " [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] memblock_reserve: [0x00000080008280-0x00000080dbb8e8] arm_memblock_init+0x48/0x170 [ 0.000000] memblock_reserve: [0x00000080004000-0x00000080008000] arm_memblock_init+0xf4/0x170 [ 0.000000] memblock_reserve: [0x0000008f230000-0x0000008f235146] arm_dt_memblock_reserve+0x24/0x90 [ 0.000000] memblock_reserve: [0x0000008f236000-0x0000008f2370aa] arm_dt_memblock_reserve+0x84/0x90 [ 0.000000] memblock_reserve: [0x0000008ff00000-0x00000090000000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_free: [0x0000008ff00000-0x00000090000000] arm_memblock_steal+0x30/0x48 [ 0.000000] memblock_reserve: [0x0000008e000000-0x0000008f000000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] MEMBLOCK configuration: [ 0.000000] memory size = 0xff00000 reserved size = 0x1dbd858 [ 0.000000] memory.cnt = 0x1 [ 0.000000] memory[0x0] [0x00000080000000-0x0000008fefffff], 0xff00000 bytes [ 0.000000] reserved.cnt = 0x5 [ 0.000000] reserved[0x0] [0x00000080004000-0x00000080007fff], 0x4000 bytes [ 0.000000] reserved[0x1] [0x00000080008280-0x00000080dbb8e7], 0xdb3668 bytes [ 0.000000] reserved[0x2] [0x0000008e000000-0x0000008effffff], 0x1000000 bytes [ 0.000000] reserved[0x3] [0x0000008f230000-0x0000008f235145], 0x5146 bytes [ 0.000000] reserved[0x4] [0x0000008f236000-0x0000008f2370a9], 0x10aa bytes [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] memblock_reserve: [0x0000008fefffd8-0x0000008ff00000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefe000-0x0000008feff000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefd000-0x0000008fefe000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefc000-0x0000008fefd000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefb000-0x0000008fefc000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefa000-0x0000008fefb000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef9000-0x0000008fefa000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef8000-0x0000008fef9000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef7000-0x0000008fef8000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef6000-0x0000008fef7000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef5000-0x0000008fef6000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fefff88-0x0000008fefffd8] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef4000-0x0000008fef5000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef3000-0x0000008fef4000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] memblock_reserve: [0x0000008fef1000-0x0000008fef3000] memblock_alloc_base_nid+0x74/0x90 [ 0.000000] ------------[ cut here ]------------ [ 0.000000] WARNING: at arch/arm/mm/ioremap.c:301 __arm_ioremap_pfn_caller+0x17c/0x1a8() [ 0.000000] Modules linked in: [ 0.000000] CPU: 0 PID: 0 Comm: swapper Not tainted 3.10.0-rc6-00159-gd175e0e-dirty #135 [ 0.000000] [<c001ac0c>] (unwind_backtrace+0x0/0xf0) from [<c00176bc>] (show_stack+0x10/0x14) [ 0.000000] [<c00176bc>] (show_stack+0x10/0x14) from [<c004154c>] (warn_slowpath_common+0x4c/0x6c) [ 0.000000] [<c004154c>] (warn_slowpath_common+0x4c/0x6c) from [<c0041588>] (warn_slowpath_null+0x1c/0x24) [ 0.000000] [<c0041588>] (warn_slowpath_null+0x1c/0x24) from [<c0020cb0>] (__arm_ioremap_pfn_caller+0x17c/0x1a8) [ 0.000000] [<c0020cb0>] (__arm_ioremap_pfn_caller+0x17c/0x1a8) from [<c0020d48>] (__arm_ioremap_caller+0x54/0x5c) [ 0.000000] [<c0020d48>] (__arm_ioremap_caller+0x54/0x5c) from [<c0020a20>] (__arm_ioremap+0x14/0x1c) [ 0.000000] [<c0020a20>] (__arm_ioremap+0x14/0x1c) from [<c0788e5c>] (acpi_arm_blob_relocate+0x48/0x40c) [ 0.000000] [<c0788e5c>] (acpi_arm_blob_relocate+0x48/0x40c) from [<c0789240>] (acpi_boot_table_init+0x20/0x78) [ 0.000000] [<c0789240>] (acpi_boot_table_init+0x20/0x78) from [<c0758fa8>] (setup_arch+0x5e4/0x7f0) [ 0.000000] [<c0758fa8>] (setup_arch+0x5e4/0x7f0) from [<c075558c>] (start_kernel+0x7c/0x31c) [ 0.000000] [<c075558c>] (start_kernel+0x7c/0x31c) from [<80008074>] (0x80008074) [ 0.000000] ---[ end trace 1b75b31a2719ed1c ]--- [ 0.000000] Unable to handle kernel NULL pointer dereference at virtual address 00000011 [ 0.000000] pgd = c0004000 [ 0.000000] [00000011] *pgd=00000000 [ 0.000000] Internal error: Oops: 5 [#1] SMP ARM [ 0.000000] Modules linked in: [ 0.000000] CPU: 0 PID: 0 Comm: swapper Tainted: G W 3.10.0-rc6-00159-gd175e0e-dirty #135 [ 0.000000] task: c07c9c50 ti: c07be000 task.ti: c07be000 [ 0.000000] PC is at acpi_arm_blob_relocate+0x48/0x40c [ 0.000000] LR is at warn_slowpath_null+0x1c/0x24 [ 0.000000] pc : [<c0788e5c>] lr : [<c0041588>] psr: 60000193 [ 0.000000] sp : c07bff68 ip : 00000000 fp : c0670728 [ 0.000000] r10: 80000200 r9 : c07cb348 r8 : c0820e08 [ 0.000000] r7 : c07cb348 r6 : 8f236008 r5 : c0fbe840 r4 : c0da6344 [ 0.000000] r3 : c0da6344 r2 : 00000200 r1 : c0858480 r0 : 00000000 [ 0.000000] Flags: nZCv IRQs off FIQs on Mode SVC_32 ISA ARM Segment kernel [ 0.000000] Control: 10c5387d Table: 80004019 DAC: 00000017 [ 0.000000] Process swapper (pid: 0, stack limit = 0xc07be240) [ 0.000000] Stack: (0xc07bff68 to 0xc07c0000) [ 0.000000] ff60: c0da6344 c0fbe840 c0d96534 c07cb348 c0820e08 c0789240 [ 0.000000] ff80: c0799540 c0758fa8 00000000 10c53c7d 413fc082 00000000 00000000 c05189cc [ 0.000000] ffa0: c066ecf8 00000001 00000000 c079b1b4 c07cb134 80004059 413fc082 00000000 [ 0.000000] ffc0: 00000000 c075558c 00000000 00000000 00000000 00000000 00000000 c079b1b8 [ 0.000000] ffe0: 00000000 10c53c7d c07c6910 c079b1b4 c07cb134 80008074 00000000 00000000 [ 0.000000] [<c0788e5c>] (acpi_arm_blob_relocate+0x48/0x40c) from [<c0789240>] (acpi_boot_table_init+0x20/0x78) [ 0.000000] [<c0789240>] (acpi_boot_table_init+0x20/0x78) from [<c0758fa8>] (setup_arch+0x5e4/0x7f0) [ 0.000000] [<c0758fa8>] (setup_arch+0x5e4/0x7f0) from [<c075558c>] (start_kernel+0x7c/0x31c) [ 0.000000] [<c075558c>] (start_kernel+0x7c/0x31c) from [<80008074>] (0x80008074) [ 0.000000] Code: e2411008 e3a02000 e1a00006 ebe25eeb (e5d0c011) [ 0.000000] ---[ end trace 1b75b31a2719ed1d ]--- [ 0.000000] Kernel panic - not syncing: Attempted to kill the idle task!
On 23/06/13 14:25, Grant Likely wrote:
Hi Graeme,
We'll start with the basics. Can you add this to the kernel command line and send the output? I want to make sure the ACPI region is getting properly protected by the kernel:
memblock=debug
g.
On Sun, Jun 23, 2013 at 11:07 AM, Andrea Gallo andrea.gallo@linaro.org wrote:
Arnd, Grant, Nico,
I am fwd'ing the message here below to your attention, as you are the most skilled problem hunters at Linaro :-)
Any suggestion for Graeme?
Thanks a lot in advance for any idea!
-- Andrea
Begin forwarded message:
From: Graeme Gregory graeme.gregory@linaro.org Date: 22 giugno 2013 14:28:35 CEST To: linaro-acpi@lists.linaro.org Subject: Re: [Linaro-acpi] ACPI Table Size Issue
Hi,
I am going to have to admit defeat on this issue, I'm pretty sure its a lowlevel MMU/VM/RAM allocation/access thingy. But I know very little about the area.
Who can we call to give advice?
Graeme
On 22/06/13 01:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which
has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall,
same place as I was seeing with Hanjun's patches. I did not check the size
of his blob but I suspect its the same issue and actually not to do with
cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready
DRAM: 256 MiB
WARNING: Caches not enabled
NAND: No NAND device found!!!
0 MiB
MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1
*** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn)
musb-hdrc: MHDRC RTL version 2.0
musb-hdrc: setup fifo_mode 4
musb-hdrc: 28/31 max ep, 16384/16384 memory
USB Peripheral mode controller at 47401000 using PIO, IRQ 0
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn)
musb-hdrc: MHDRC RTL version 2.0
musb-hdrc: setup fifo_mode 4
musb-hdrc: 28/31 max ep, 16384/16384 memory
USB Host mode controller at 47401800 using PIO, IRQ 0
Net: <ethaddr> not set. Validating first E-fuse MAC
cpsw, usb_ether
Hit any key to stop autoboot: 0
link up on port 0, speed 100, full duplex
BOOTP broadcast 1
DHCP client bound to address 192.168.222.138
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'zImage-bone'.
Load address: 0x80200000
Loading: #################################################################
################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s
done
Bytes transferred = 4197392 (400c10 hex)
link up on port 0, speed 100, full duplex
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'am335x-bone.dtb'.
Load address: 0x80f80000
Loading: ##
489.3 KiB/s
done
Bytes transferred = 8518 (2146 hex)
link up on port 0, speed 100, full duplex
Using cpsw device
TFTP from server 192.168.222.11; our IP address is 192.168.222.138
Filename 'bone.acpi'.
Load address: 0x80f84000
Loading: #
416 KiB/s
done
Bytes transferred = 4266 (10aa hex)
## Flattened Device Tree blob at 80f80000
Booting using the fdt blob at 0x80f80000
acpi: cmdline image address = 0x80f84000
acpi: Length of blob 4258
acpi: loading to 8f236000, end 8f2370aa
Loading Device Tree to 8f230000, end 8f235145 ... OK
using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013
[ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone
[ 0.000000] bootconsole [earlycon0] enabled
[ 0.000000] cma: CMA: reserved 16 MiB at 8e000000
[ 0.000000] Memory policy: ECC disabled, Data cache writeback
[ 0.000000] acpi: vaddress c0fb5000
[ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000
[ 0.000000] acpi: GOT HERE1
[ 0.000000] acpi: GOT HERE2
[ 0.000000] (I) entering acpi_tb_parse_root_table
[ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO)
[ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517)
[ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517)
[ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517)
[ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517)
[ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517)
[ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517)
[ 0.000000] (I) acpi_table_init call completed
[ 0.000000] (I) exit acpi_boot_table_init
[ 0.000000] enter early_acpi_boot_init
[ 0.000000] CPU: All CPU(s) started in SVC mode.
[ 0.000000] AM335X ES1.0 (neon )
[ 0.000000] enter acpi_boot_init
[ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768
[ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk
[ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.000000] Memory: 255MB = 255MB total
[ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
[ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB)
[ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB)
[ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB)
[ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB)
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[ 0.000000] Total of 128 interrupts on 1 active controller
[ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz
[ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms
[ 0.000000] OMAP clocksource: timer1 at 24000000 Hz
[ 0.000000] Console: colour dummy device 80x30
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768
[ 0.000000] ... CHAINHASH_SIZE: 16384
[ 0.000000] memory used by lock dependency info: 3695 kB
[ 0.000000] per task-struct memory footprint: 1152 bytes
[ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624)
[ 0.119238] pid_max: default: 32768 minimum: 301
[ 0.124655] Security Framework initialized
[ 0.129183] Mount-cache hash table entries: 512
[ 0.146500] CPU: Testing write buffer coherency: ok
[ 0.151830] ACPI: Core revision 20130328
[ 0.158096] ACPI: All ACPI Tables successfully acquired
[ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0
[ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0
[ 0.181338] Brought up 1 CPUs
[ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS).
[ 0.191125] CPU: All CPU(s) started in SVC mode.
[ 0.199973] devtmpfs: initialized
[ 0.283148] pinctrl core: initialized pinctrl subsystem
[ 0.294438] regulator-dummy: no parameters
[ 0.303478] NET: Registered protocol family 16
[ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.355305] OMAP GPIO hardware version 0.1
[ 0.387884] No ATAGs?
[ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported.
[ 0.486304] bio: create slab <bio-0> at 0
[ 0.494907] ACPI: Added _OSI(Module Device)
[ 0.499533] ACPI: Added _OSI(Processor Device)
[ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.509237] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.515927] ACPI: EC: EC description table is found, configuring boot EC
[ 0.525136] ACPI: Interpreter enabled
[ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568)
[ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568)
[ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568)
[ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568)
[ 0.568153] ACPI: (supports S0)
[ 0.571482] ACPI: Using GIC for interrupt routing
[ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67)
[ 21.608358] INFO: Stall ended before state dump start
Linaro-acpi mailing list Linaro-acpi@lists.linaro.org http://lists.linaro.org/mailman/listinfo/linaro-acpi
On Sun, Jun 23, 2013 at 5:16 PM, Graeme Gregory graeme.gregory@linaro.org wrote:
Hi Grant,
Sorry, that was the wrong kernel I booted, here is correct log.
Thanks
Graeme
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00159-gd175e0e-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #136 SMP Sun Jun 23 17:10:48 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] acpi: start info is 0x000010AA000010AA, 3229199256 bytes [ 0.000000] acpi: sig is "ACPI" [ 0.000000] acpi: info is 00 00 10 a2 [ 0.000000] acpi: first table is "RSD " [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] memblock_reserve: [0x00000080008280-0x00000080dbb8e8] arm_memblock_init+0x48/0x170 [ 0.000000] memblock_reserve: [0x00000080004000-0x00000080008000] arm_memblock_init+0xf4/0x170 [ 0.000000] memblock_reserve: [0x0000008f230000-0x0000008f235146] arm_dt_memblock_reserve+0x24/0x90 [ 0.000000] memblock_reserve: [0x0000008f236000-0x0000008f2370aa] arm_dt_memblock_reserve+0x84/0x90
Okay, so it looks like the region is getting reserved correctly, assuming that the following log are the only places the ACPI code wants to look. Do you have a diff between a working and a non-working boot? Use loglevel=8 on the kernel command line to get as much output as possible, and turn off printk timings so the diff is easier.
[...]
[ 0.000000] ACPI: RSDP 8f236008 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 8f23602c 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 8f2360f0 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 8f2361fc 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 8f236464 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 8f2364f4 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 8f236539 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 8f23659d 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 8f2367cd 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 8f2368fd 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 8f236931 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 8f236967 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 8f2369e7 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 8f236a28 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 8f236be4 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 8f236c08 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 8f236cbe 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 8f236cfa 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 8f236df0 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 8f236fc4 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 8f237014 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 8f237056 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 8f237086 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517)
On 23/06/13 18:19, Grant Likely wrote:
Okay, so it looks like the region is getting reserved correctly, assuming that the following log are the only places the ACPI code wants to look. Do you have a diff between a working and a non-working boot? Use loglevel=8 on the kernel command line to get as much output as possible, and turn off printk timings so the diff is easier.
Hi Grant,
The logs are attached, as well as the diff, the only difference is the size of the ACPI blob. The oops as the end of log-passed is well known to us and is due to a bug in ACPI on single core CPUs (which omap3 is) so you can ignore it.
Thanks
Graeme
Hi Grant,
I have traced down the location of the lockup finally, it's caused by a possibly malfunctioning 64bit divide which always returns a quotient when it should not. This locked up a function trying to work out how many digits in a number.
Thanks for taking a poke at this, the memblock=debug I did not know about gave me better confidence in my u-boot patch.
Graeme
On 23/06/13 18:19, Grant Likely wrote:
On Sun, Jun 23, 2013 at 5:16 PM, Graeme Gregory graeme.gregory@linaro.org wrote:
Hi Grant,
Sorry, that was the wrong kernel I booted, here is correct log.
Thanks
Graeme
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00159-gd175e0e-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #136 SMP Sun Jun 23 17:10:48 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] acpi: start info is 0x000010AA000010AA, 3229199256 bytes [ 0.000000] acpi: sig is "ACPI" [ 0.000000] acpi: info is 00 00 10 a2 [ 0.000000] acpi: first table is "RSD " [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] memblock_reserve: [0x00000080008280-0x00000080dbb8e8] arm_memblock_init+0x48/0x170 [ 0.000000] memblock_reserve: [0x00000080004000-0x00000080008000] arm_memblock_init+0xf4/0x170 [ 0.000000] memblock_reserve: [0x0000008f230000-0x0000008f235146] arm_dt_memblock_reserve+0x24/0x90 [ 0.000000] memblock_reserve: [0x0000008f236000-0x0000008f2370aa] arm_dt_memblock_reserve+0x84/0x90
Okay, so it looks like the region is getting reserved correctly, assuming that the following log are the only places the ACPI code wants to look. Do you have a diff between a working and a non-working boot? Use loglevel=8 on the kernel command line to get as much output as possible, and turn off printk timings so the diff is easier.
[...]
[ 0.000000] ACPI: RSDP 8f236008 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 8f23602c 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 8f2360f0 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 8f2361fc 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 8f236464 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 8f2364f4 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 8f236539 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 8f23659d 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 8f2367cd 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 8f2368fd 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 8f236931 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 8f236967 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 8f2369e7 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 8f236a28 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 8f236be4 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 8f236c08 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 8f236cbe 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 8f236cfa 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 8f236df0 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 8f236fc4 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 8f237014 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 8f237056 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 8f237086 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517)
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
of his blob but I suspect its the same issue and actually not to do with cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready DRAM: 256 MiB WARNING: Caches not enabled NAND: No NAND device found!!! 0 MiB MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1 *** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Peripheral mode controller at 47401000 using PIO, IRQ 0 musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Host mode controller at 47401800 using PIO, IRQ 0 Net: <ethaddr> not set. Validating first E-fuse MAC cpsw, usb_ether Hit any key to stop autoboot: 0 link up on port 0, speed 100, full duplex BOOTP broadcast 1 DHCP client bound to address 192.168.222.138 Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'zImage-bone'. Load address: 0x80200000 Loading: ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s done Bytes transferred = 4197392 (400c10 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'am335x-bone.dtb'. Load address: 0x80f80000 Loading: ## 489.3 KiB/s done Bytes transferred = 8518 (2146 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'bone.acpi'. Load address: 0x80f84000 Loading: # 416 KiB/s done Bytes transferred = 4266 (10aa hex) ## Flattened Device Tree blob at 80f80000 Booting using the fdt blob at 0x80f80000
- acpi: cmdline image address = 0x80f84000
- acpi: Length of blob 4258
- acpi: loading to 8f236000, end 8f2370aa Loading Device Tree to 8f230000, end 8f235145 ... OK
using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] acpi: vaddress c0fb5000 [ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000 [ 0.000000] acpi: GOT HERE1 [ 0.000000] acpi: GOT HERE2 [ 0.000000] (I) entering acpi_tb_parse_root_table [ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] (I) acpi_table_init call completed [ 0.000000] (I) exit acpi_boot_table_init [ 0.000000] enter early_acpi_boot_init [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] AM335X ES1.0 (neon ) [ 0.000000] enter acpi_boot_init [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 255MB = 255MB total [ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB) [ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB) [ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB) [ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts [ 0.000000] Total of 128 interrupts on 1 active controller [ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz [ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms [ 0.000000] OMAP clocksource: timer1 at 24000000 Hz [ 0.000000] Console: colour dummy device 80x30 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3695 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624) [ 0.119238] pid_max: default: 32768 minimum: 301 [ 0.124655] Security Framework initialized [ 0.129183] Mount-cache hash table entries: 512 [ 0.146500] CPU: Testing write buffer coherency: ok [ 0.151830] ACPI: Core revision 20130328 [ 0.158096] ACPI: All ACPI Tables successfully acquired [ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0 [ 0.181338] Brought up 1 CPUs [ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS). [ 0.191125] CPU: All CPU(s) started in SVC mode. [ 0.199973] devtmpfs: initialized [ 0.283148] pinctrl core: initialized pinctrl subsystem [ 0.294438] regulator-dummy: no parameters [ 0.303478] NET: Registered protocol family 16 [ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.355305] OMAP GPIO hardware version 0.1 [ 0.387884] No ATAGs? [ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.486304] bio: create slab <bio-0> at 0 [ 0.494907] ACPI: Added _OSI(Module Device) [ 0.499533] ACPI: Added _OSI(Processor Device) [ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.509237] ACPI: Added _OSI(Processor Aggregator Device) [ 0.515927] ACPI: EC: EC description table is found, configuring boot EC [ 0.525136] ACPI: Interpreter enabled [ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568) [ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568) [ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568) [ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568) [ 0.568153] ACPI: (supports S0) [ 0.571482] ACPI: Using GIC for interrupt routing [ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67) [ 21.608358] INFO: Stall ended before state dump start
Linaro-acpi mailing list Linaro-acpi@lists.linaro.org http://lists.linaro.org/mailman/listinfo/linaro-acpi .
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
Thanks
Graeme
of his blob but I suspect its the same issue and actually not to do with cpu topology at all.
Anyway below is the log of the ACPI kernel booting on the beaglebone.
Thanks
Graeme
U-Boot 2013.04-00003-g8fc034b-dirty (Jun 22 2013 - 00:52:05)
I2C: ready DRAM: 256 MiB WARNING: Caches not enabled NAND: No NAND device found!!! 0 MiB MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1 *** Warning - readenv() failed, using default environment
musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Peripheral mode controller at 47401000 using PIO, IRQ 0 musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, HB-ISO Rx, HB-ISO Tx, SoftConn) musb-hdrc: MHDRC RTL version 2.0 musb-hdrc: setup fifo_mode 4 musb-hdrc: 28/31 max ep, 16384/16384 memory USB Host mode controller at 47401800 using PIO, IRQ 0 Net: <ethaddr> not set. Validating first E-fuse MAC cpsw, usb_ether Hit any key to stop autoboot: 0 link up on port 0, speed 100, full duplex BOOTP broadcast 1 DHCP client bound to address 192.168.222.138 Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'zImage-bone'. Load address: 0x80200000 Loading: ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ################################################################# ######################################## 625 KiB/s done Bytes transferred = 4197392 (400c10 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'am335x-bone.dtb'. Load address: 0x80f80000 Loading: ## 489.3 KiB/s done Bytes transferred = 8518 (2146 hex) link up on port 0, speed 100, full duplex Using cpsw device TFTP from server 192.168.222.11; our IP address is 192.168.222.138 Filename 'bone.acpi'. Load address: 0x80f84000 Loading: # 416 KiB/s done Bytes transferred = 4266 (10aa hex) ## Flattened Device Tree blob at 80f80000 Booting using the fdt blob at 0x80f80000
- acpi: cmdline image address = 0x80f84000
- acpi: Length of blob 4258
- acpi: loading to 8f236000, end 8f2370aa Loading Device Tree to 8f230000, end 8f235145 ... OK
using: ACPI
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 3.10.0-rc6-00024-g0eba3878-dirty (graeme@xora-build) (gcc version 4.7.3 20130328 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.04-20130415 - Linaro GCC 2013.04) ) #125 SMP Sat Jun 22 00:39:57 BST 2013 [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c53c7d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] Machine: Generic AM33XX (Flattened Device Tree), model: TI AM335x BeagleBone [ 0.000000] bootconsole [earlycon0] enabled [ 0.000000] cma: CMA: reserved 16 MiB at 8e000000 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] acpi: vaddress c0fb5000 [ 0.000000] acpi: Phys 80fb5000 Virt c0fb5000 [ 0.000000] acpi: GOT HERE1 [ 0.000000] acpi: GOT HERE2 [ 0.000000] (I) entering acpi_tb_parse_root_table [ 0.000000] ACPI: RSDP 80fb5000 00024 (v02 LINARO) [ 0.000000] ACPI: XSDT 80fb5024 000C4 (v01 LINARO ARNDALE 00000014 INTL 20130517) [ 0.000000] ACPI: FACP 80fb50e8 0010C (v05 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: DSDT 80fb51f4 00228 (v01 LINARO ARNDALE 00000002 INTL 20130517) [ 0.000000] ACPI: MSCT 80fb545c 00090 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCHI 80fb54ec 00045 (v01 LINARO ARNDALE 02000715 INTL 20130517) [ 0.000000] ACPI: FPDT 80fb5531 00064 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ERST 80fb5595 00230 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: EINJ 80fb57c5 00130 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: CPEP 80fb58f5 00034 (v01 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: UEFI 80fb5929 00036 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SRAT 80fb595f 00080 (v03 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SPMI 80fb59df 00041 (v04 LINARO ARNDALE 00000000 INTL 20130517) [ 0.000000] ACPI: SLIT 80fb5a20 001BC (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: OEM0 80fb5bdc 00024 (v01 LINARO ARNDALE 0000000A INTL 20130517) [ 0.000000] ACPI: MPST 80fb5c00 000B6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: MCFG 80fb5cb6 0003C (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: APIC 80fb5cf2 000F6 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: HEST 80fb5de8 001D4 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: GTDT 80fb5fbc 00050 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: ECDT 80fb600c 00042 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: BERT 80fb604e 00030 (v01 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] ACPI: SSDT 80fb607e 00024 (v02 LINARO ARNDALE 00000001 INTL 20130517) [ 0.000000] (I) acpi_table_init call completed [ 0.000000] (I) exit acpi_boot_table_init [ 0.000000] enter early_acpi_boot_init [ 0.000000] CPU: All CPU(s) started in SVC mode. [ 0.000000] AM335X ES1.0 (neon ) [ 0.000000] enter acpi_boot_init [ 0.000000] PERCPU: Embedded 9 pages/cpu @c0fbd000 s14592 r8192 d14080 u36864 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64768 [ 0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 rootwait earlyprintk [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 255MB = 255MB total [ 0.000000] Memory: 228316k/228316k available, 33828k reserved, 0K highmem [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc074a858 (7435 kB) [ 0.000000] .init : 0xc074b000 - 0xc07b2900 ( 415 kB) [ 0.000000] .data : 0xc07b4000 - 0xc084cc88 ( 612 kB) [ 0.000000] .bss : 0xc084cc88 - 0xc0db18e8 (5524 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts [ 0.000000] Total of 128 interrupts on 1 active controller [ 0.000000] OMAP clockevent source: timer2 at 24000000 Hz [ 0.000000] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms [ 0.000000] OMAP clocksource: timer1 at 24000000 Hz [ 0.000000] Console: colour dummy device 80x30 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 3695 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.062509] Calibrating delay loop... 363.72 BogoMIPS (lpj=1818624) [ 0.119238] pid_max: default: 32768 minimum: 301 [ 0.124655] Security Framework initialized [ 0.129183] Mount-cache hash table entries: 512 [ 0.146500] CPU: Testing write buffer coherency: ok [ 0.151830] ACPI: Core revision 20130328 [ 0.158096] ACPI: All ACPI Tables successfully acquired [ 0.165239] CPU0: thread -1, cpu 0, socket -1, mpidr 0 [ 0.170770] Setting up static identity map for 0xc0524750 - 0xc05247c0 [ 0.181338] Brought up 1 CPUs [ 0.184500] SMP: Total of 1 processors activated (363.72 BogoMIPS). [ 0.191125] CPU: All CPU(s) started in SVC mode. [ 0.199973] devtmpfs: initialized [ 0.283148] pinctrl core: initialized pinctrl subsystem [ 0.294438] regulator-dummy: no parameters [ 0.303478] NET: Registered protocol family 16 [ 0.318367] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.355305] OMAP GPIO hardware version 0.1 [ 0.387884] No ATAGs? [ 0.390062] hw-breakpoint: debug architecture 0x4 unsupported. [ 0.486304] bio: create slab <bio-0> at 0 [ 0.494907] ACPI: Added _OSI(Module Device) [ 0.499533] ACPI: Added _OSI(Processor Device) [ 0.504209] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.509237] ACPI: Added _OSI(Processor Aggregator Device) [ 0.515927] ACPI: EC: EC description table is found, configuring boot EC [ 0.525136] ACPI: Interpreter enabled [ 0.529128] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S1_] (20130328/hwxface-568) [ 0.538831] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S2_] (20130328/hwxface-568) [ 0.548527] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S3_] (20130328/hwxface-568) [ 0.558323] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [_S5_] (20130328/hwxface-568) [ 0.568153] ACPI: (supports S0) [ 0.571482] ACPI: Using GIC for interrupt routing [ 21.596404] INFO: rcu_sched detected stalls on CPUs/tasks: {} (detected by 0, t=2102 jiffies, g=4294967023, c=4294967022, q=67) [ 21.608358] INFO: Stall ended before state dump start
Linaro-acpi mailing list Linaro-acpi@lists.linaro.org http://lists.linaro.org/mailman/listinfo/linaro-acpi .
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
On 24/06/13 05:00, Hanjun Guo wrote:
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
Hi Hanjun,
Thanks for the info, I'm pretty sure you are seeing the same issue as me, when table is greater than approx 4k ACPI does not function.
This does not happen on 64bit, only on 32bit.
I have narrowed down the fault, it occurs somewhere in
acpi_bus_scan() from scan.c
Thanks
Graeme
On 24/06/13 12:33, Graeme Gregory wrote:
On 24/06/13 05:00, Hanjun Guo wrote:
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
Hi Hanjun,
Thanks for the info, I'm pretty sure you are seeing the same issue as me, when table is greater than approx 4k ACPI does not function.
This does not happen on 64bit, only on 32bit.
I have narrowed down the fault, it occurs somewhere in
acpi_bus_scan() from scan.c
This issue is now fixed and I have pushed the fix to the acpi-combined branch.
If others can confirm successful boot of this branch then I can look at moving this to our main development branch progressing us to 3.10 from current 3.9
Thanks
Graeme
On 06/24/2013 11:21 AM, Graeme Gregory wrote:
On 24/06/13 12:33, Graeme Gregory wrote:
On 24/06/13 05:00, Hanjun Guo wrote:
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
Hi Hanjun,
Thanks for the info, I'm pretty sure you are seeing the same issue as me, when table is greater than approx 4k ACPI does not function.
This does not happen on 64bit, only on 32bit.
I have narrowed down the fault, it occurs somewhere in
acpi_bus_scan() from scan.c
This issue is now fixed and I have pushed the fix to the acpi-combined branch.
If others can confirm successful boot of this branch then I can look at moving this to our main development branch progressing us to 3.10 from current 3.9
Hrm. I can boot and get well past ACPI initialization with this branch (huzzah!).
However, on Arndale, I get an oops. Not entirely sure what it's all about just yet but still looking....why there should be a problem in the mmc_rescan is a bit odd....
I'll try the same fix on the 3.9 branch for grins and giggles to check that the size issue goes away there, too.
------------[ cut here ]------------
kernel BUG at drivers/mmc/core/core.c:233!
Internal error: Oops - BUG: 0 [#1] PREEMPT SMP ARM
Modules linked in:
CPU: 0 PID: 6 Comm: kworker/u4:0 Not tainted 3.10.0-rc6-14781-ge4670fb #3 Workqueue: kmmcd mmc_rescan
task: ef084f00 ti: ef096000 task.ti: ef096000
PC is at mmc_start_request+0x168/0x258
LR is at mmc_wait_for_req+0x58/0x12c
pc : [<c0339f94>] lr : [<c033a280>] psr: 20000113
sp : ef097d00 ip : 00000000 fp : 00000000
r10: 00000200 r9 : ef097d9c r8 : 00000000
r7 : ef097d9c r6 : c0647410 r5 : ef312800 r4 : ef097dcc
r3 : ef097d9c r2 : 00000000 r1 : 00000200 r0 : 00000001
Flags: nzCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment kernel
Control: 30c5387d Table: 40003000 DAC: fffffffd
Process kworker/u4:0 (pid: 6, stack limit = 0xef096238)
Stack: (0xef097d00 to 0xef098000)
7d00: c05ebb00 c05ebb00 7fffffff 7fffffff eeb75e00 ef312800 ef097dcc ef097ddc 7d20: 00000000 c033a280 ef097da4 c01f7eb8 00000001 eeb75e00 ffffffff eeb75e00 7d40: ef312800 00000000 00000200 c033fb70 ef097de4 ef313000 ef097da4 c0c68ea2 7d60: 00000e00 00000200 00000000 00000008 00000000 00000000 00000000 00000000 7d80: 00000000 000000b5 00000000 00000000 00000000 00000000 ef097dcc 08f0d180 7da0: 000003e8 00000200 00000001 00000000 00000200 00000000 00000000 00000000 7dc0: 00000001 ef097d5c 00000000 00000000 ef097d6c ef097d9c 00000000 00000000 7de0: 00000000 dead4ead ffffffff ffffffff ef097df0 ef097df0 c0339e24 00000000 7e00: c0339e24 ef097e74 00000000 ef313000 00000100 eeb75e00 04326af0 000007db 7e20: ef313000 c033fc00 00000200 000007db ef313000 c033dfb4 ef312800 00000000 7e40: 00000034 00000100 00000000 c033ec60 ef312800 ef3129a0 ef312ac0 00061a80 7e60: 00000004 00000031 00000000 00000000 c0ff8080 00000000 1501004d 34473146 7e80: 41000432 6af0ce0f ef00a800 ef312800 00000000 ef312800 00061a80 c048292c 7ea0: 00000000 00000000 ef00a800 c033f904 00061a80 00ff8080 00000000 ef3129e4 7ec0: c0482920 c033cb84 ef080200 ef3129e4 ef00a800 ef096000 ef21c300 c0035468 7ee0: 00000001 c0033ad8 c05ebb00 c05ebb00 00000001 ef080200 ef00a820 ef080218 7f00: ef096000 ef096000 c0642008 00000001 ef00a800 c0035ab0 c0035978 ef096000 7f20: c05ebb00 ef096000 c0035978 ef083ddc 00000000 ef080200 c0035978 00000000 7f40: 00000000 00000000 00000000 c003b0a4 fffbefff 00000000 fffedded ef080200 7f60: 00000000 00000000 dead4ead ffffffff ffffffff ef097f74 ef097f74 00000000 7f80: 00000000 dead4ead ffffffff ffffffff ef097f90 ef097f90 ef097fac ef083ddc 7fa0: c003b000 00000000 00000000 c000ee18 00000000 00000000 00000000 00000000 7fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 7fe0: 00000000 00000000 00000000 00000000 00000013 00000000 ffefffff fffbffff Code: e5933000 ebfb2280 eaffffb4 e7f001f2 (e7f001f2)
---[ end trace 1d22ee08463484ed ]---
Unable to handle kernel paging request at virtual address ffffffe0
On 24/06/13 22:31, Al Stone wrote:
On 06/24/2013 11:21 AM, Graeme Gregory wrote:
On 24/06/13 12:33, Graeme Gregory wrote:
On 24/06/13 05:00, Hanjun Guo wrote:
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote: > Hi, > > I have managed to boot our ACPI enabled kernel on the beaglebone > device which > has working earlyprintk. > > You will see from the log below there is a very familiar looking > RCU stall, > same place as I was seeing with Hanjun's patches. I did not > check the size Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
Hi Hanjun,
Thanks for the info, I'm pretty sure you are seeing the same issue as me, when table is greater than approx 4k ACPI does not function.
This does not happen on 64bit, only on 32bit.
I have narrowed down the fault, it occurs somewhere in
acpi_bus_scan() from scan.c
This issue is now fixed and I have pushed the fix to the acpi-combined branch.
If others can confirm successful boot of this branch then I can look at moving this to our main development branch progressing us to 3.10 from current 3.9
Hrm. I can boot and get well past ACPI initialization with this branch (huzzah!).
However, on Arndale, I get an oops. Not entirely sure what it's all about just yet but still looking....why there should be a problem in the mmc_rescan is a bit odd....
Leif reported an issue with MMC driver and LPAE, are you hitting that issue?
Graeme
I'll try the same fix on the 3.9 branch for grins and giggles to check that the size issue goes away there, too.
------------[ cut here ]------------ kernel BUG at drivers/mmc/core/core.c:233! Internal error: Oops - BUG: 0 [#1] PREEMPT SMP ARM Modules linked in: CPU: 0 PID: 6 Comm: kworker/u4:0 Not tainted 3.10.0-rc6-14781-ge4670fb #3 Workqueue: kmmcd mmc_rescan task: ef084f00 ti: ef096000 task.ti: ef096000 PC is at mmc_start_request+0x168/0x258 LR is at mmc_wait_for_req+0x58/0x12c pc : [<c0339f94>] lr : [<c033a280>] psr: 20000113 sp : ef097d00 ip : 00000000 fp : 00000000 r10: 00000200 r9 : ef097d9c r8 : 00000000 r7 : ef097d9c r6 : c0647410 r5 : ef312800 r4 : ef097dcc r3 : ef097d9c r2 : 00000000 r1 : 00000200 r0 : 00000001 Flags: nzCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment kernel Control: 30c5387d Table: 40003000 DAC: fffffffd Process kworker/u4:0 (pid: 6, stack limit = 0xef096238) Stack: (0xef097d00 to 0xef098000) 7d00: c05ebb00 c05ebb00 7fffffff 7fffffff eeb75e00 ef312800 ef097dcc ef097ddc 7d20: 00000000 c033a280 ef097da4 c01f7eb8 00000001 eeb75e00 ffffffff eeb75e00 7d40: ef312800 00000000 00000200 c033fb70 ef097de4 ef313000 ef097da4 c0c68ea2 7d60: 00000e00 00000200 00000000 00000008 00000000 00000000 00000000 00000000 7d80: 00000000 000000b5 00000000 00000000 00000000 00000000 ef097dcc 08f0d180 7da0: 000003e8 00000200 00000001 00000000 00000200 00000000 00000000 00000000 7dc0: 00000001 ef097d5c 00000000 00000000 ef097d6c ef097d9c 00000000 00000000 7de0: 00000000 dead4ead ffffffff ffffffff ef097df0 ef097df0 c0339e24 00000000 7e00: c0339e24 ef097e74 00000000 ef313000 00000100 eeb75e00 04326af0 000007db 7e20: ef313000 c033fc00 00000200 000007db ef313000 c033dfb4 ef312800 00000000 7e40: 00000034 00000100 00000000 c033ec60 ef312800 ef3129a0 ef312ac0 00061a80 7e60: 00000004 00000031 00000000 00000000 c0ff8080 00000000 1501004d 34473146 7e80: 41000432 6af0ce0f ef00a800 ef312800 00000000 ef312800 00061a80 c048292c 7ea0: 00000000 00000000 ef00a800 c033f904 00061a80 00ff8080 00000000 ef3129e4 7ec0: c0482920 c033cb84 ef080200 ef3129e4 ef00a800 ef096000 ef21c300 c0035468 7ee0: 00000001 c0033ad8 c05ebb00 c05ebb00 00000001 ef080200 ef00a820 ef080218 7f00: ef096000 ef096000 c0642008 00000001 ef00a800 c0035ab0 c0035978 ef096000 7f20: c05ebb00 ef096000 c0035978 ef083ddc 00000000 ef080200 c0035978 00000000 7f40: 00000000 00000000 00000000 c003b0a4 fffbefff 00000000 fffedded ef080200 7f60: 00000000 00000000 dead4ead ffffffff ffffffff ef097f74 ef097f74 00000000 7f80: 00000000 dead4ead ffffffff ffffffff ef097f90 ef097f90 ef097fac ef083ddc 7fa0: c003b000 00000000 00000000 c000ee18 00000000 00000000 00000000 00000000 7fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 7fe0: 00000000 00000000 00000000 00000000 00000013 00000000 ffefffff fffbffff Code: e5933000 ebfb2280 eaffffb4 e7f001f2 (e7f001f2) ---[ end trace 1d22ee08463484ed ]--- Unable to handle kernel paging request at virtual address ffffffe0
On 06/25/2013 01:51 AM, Graeme Gregory wrote:
On 24/06/13 22:31, Al Stone wrote:
On 06/24/2013 11:21 AM, Graeme Gregory wrote:
On 24/06/13 12:33, Graeme Gregory wrote:
On 24/06/13 05:00, Hanjun Guo wrote:
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote: > On 2013-6-22 8:01, Graeme Gregory wrote: >> Hi, >> >> I have managed to boot our ACPI enabled kernel on the beaglebone >> device which >> has working earlyprintk. >> >> You will see from the log below there is a very familiar looking >> RCU stall, >> same place as I was seeing with Hanjun's patches. I did not >> check the size > Yes, I'm sure the RCU stall happened in the same place. > Graeme, do you want me to check the size of the DSDT table? Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
Hi Hanjun,
Thanks for the info, I'm pretty sure you are seeing the same issue as me, when table is greater than approx 4k ACPI does not function.
This does not happen on 64bit, only on 32bit.
I have narrowed down the fault, it occurs somewhere in
acpi_bus_scan() from scan.c
This issue is now fixed and I have pushed the fix to the acpi-combined branch.
If others can confirm successful boot of this branch then I can look at moving this to our main development branch progressing us to 3.10 from current 3.9
Hrm. I can boot and get well past ACPI initialization with this branch (huzzah!).
However, on Arndale, I get an oops. Not entirely sure what it's all about just yet but still looking....why there should be a problem in the mmc_rescan is a bit odd....
Leif reported an issue with MMC driver and LPAE, are you hitting that issue?
Don't know but I'll ping Leif...
BTW, this fix does not seem to help 3.9; I put in the memblock reserve if the driver/of code and the replacement for the division routine, but I'm still not mapping in blobs > 4K in size. OTOH, I'm not sure I care if I can get 3.10 to actually run w/out panic'ing....
On 2013-6-25 1:21, Graeme Gregory wrote:
On 24/06/13 12:33, Graeme Gregory wrote:
On 24/06/13 05:00, Hanjun Guo wrote:
On 2013-6-23 17:04, Graeme Gregory wrote:
On 23/06/13 06:52, Hanjun Guo wrote:
On 2013-6-22 8:01, Graeme Gregory wrote:
Hi,
I have managed to boot our ACPI enabled kernel on the beaglebone device which has working earlyprintk.
You will see from the log below there is a very familiar looking RCU stall, same place as I was seeing with Hanjun's patches. I did not check the size
Yes, I'm sure the RCU stall happened in the same place. Graeme, do you want me to check the size of the DSDT table?
Yes please, if its over approx 4000 bytes then I think its the same issue and not an issue with CPU topology.
I rebuilt the ACPI tables with I2C device and processor device in DSDT table which you send me before, and reboot the armv8 foundation model, it shows in the log:
CPU: AArch64 Processor [410fd000] revision 0 Machine: Foundation-v8A acpi: start info is 0x0000000088100000, 4300 bytes // so the size is 4300 bytes // and it is more than 4KB. acpi: sig is "ACPI" acpi: info is 00 00 10 c4 acpi: first table is "RSD " (I) entering acpi_tb_parse_root_table ACPI: RSDP 0000000088100008 00024 (v02 LINARO) ACPI: XSDT 000000008810002c 000C4 (v01 LINARO FOUNDATI 00000014 INTL 20130214) ACPI: FACP 00000000881000f0 0010C (v05 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: DSDT 00000000881001fc 0024A (v01 REDHAT ARNDALE 00000002 INTL 20130214) ACPI: MSCT 0000000088100486 00090 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCHI 0000000088100516 00045 (v01 LINARO FOUNDATI 02000715 INTL 20130214) ACPI: FPDT 000000008810055b 00064 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ERST 00000000881005bf 00230 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: EINJ 00000000881007ef 00130 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: CPEP 000000008810091f 00034 (v01 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: UEFI 0000000088100953 00036 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SRAT 0000000088100989 00080 (v03 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SPMI 0000000088100a09 00041 (v04 LINARO FOUNDATI 00000000 INTL 20130214) ACPI: SLIT 0000000088100a4a 001BC (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: OEM0 0000000088100c06 00024 (v01 LINARO FOUNDATI 0000000A INTL 20130214) ACPI: MPST 0000000088100c2a 000B6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: MCFG 0000000088100ce0 0003C (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: APIC 0000000088100d1c 000F6 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: HEST 0000000088100e12 001D4 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: GTDT 0000000088100fe6 00050 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: ECDT 0000000088101036 00042 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: BERT 0000000088101078 00030 (v01 LINARO FOUNDATI 00000001 INTL 20130214) ACPI: SSDT 00000000881010a8 00024 (v02 LINARO FOUNDATI 00000001 INTL 20130214) (I) acpi_table_init call completed (I) exit acpi_boot_table_init enter early_acpi_boot_init [...]
But it boots ok on armv8 foundation model, so does this happened only on armv7?
Thanks Hanjun
Hi Hanjun,
Thanks for the info, I'm pretty sure you are seeing the same issue as me, when table is greater than approx 4k ACPI does not function.
This does not happen on 64bit, only on 32bit.
I have narrowed down the fault, it occurs somewhere in
acpi_bus_scan() from scan.c
This issue is now fixed and I have pushed the fix to the acpi-combined branch.
Great! problem hunter! :)
If others can confirm successful boot of this branch then I can look at moving this to our main development branch progressing us to 3.10 from current 3.9
Thanks
Graeme