Hi,
I am working on debugging our customized AM5728 board. I am able to start to boot the kernel. However the kernel crashed during the usb initialization. The booting log is shown as following. Could anyone give me some insight for debugging this problem? Our board is designed based on the AM5728 EVM. I am thinking about this issue is related to interrupt.
U-Boot SPL 2015.07-00258-g77eb520-dirty (Apr 12 2016 - 16:16:34)
DRA752-GP ES1.1
ti_i2c_eeprom_init failed 1
U-Boot 2015.07-00258-g77eb520-dirty (Apr 12 2016 - 16:16:34 -0400)
CPU : DRA752-GP ES1.1
Board: AM572x EVM REV 1.1
I2C: ready
DRAM: 2 GiB
MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1
** Unable to use mmc 0:1 for loading the env **
Using default environment
SATA link 0 timeout.
AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl SATA mode
flags: 64bit ncq stag pm led clo only pmp pio slum part ccc apst
SCSI: SATA link 0 timeout.
AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl SATA mode
flags: 64bit ncq stag pm led clo only pmp pio slum part ccc apst
scanning bus for devices…
Found 0 device(s).
Net: not set. Validating first E-fuse MAC
cpsw
Hit any key to stop autoboot: 0
usb_boot is currently disabled
scsi_boot is currently disabled
switch to partitions #0, OK
mmc0 is current device
Scanning mmc device 0
Checking for: /uEnv.txt …
Checking for: /boot/uEnv.txt …
272 bytes read in 33 ms (7.8 KiB/s)
Loaded environment from /boot/uEnv.txt
Checking if uname_r is set in /boot/uEnv.txt …
debug: [uname_r=4.1.18-ti-r56] …
loading /boot/vmlinuz-4.1.18-ti-r56 …
7693688 bytes read in 413 ms (17.8 MiB/s)
loading /boot/dtbs/4.1.18-ti-r56/am57xx-evm.dtb …
163688 bytes read in 53 ms (2.9 MiB/s)
loading /boot/initrd.img-4.1.18-ti-r56 …
4456140 bytes read in 253 ms (16.8 MiB/s)
debug: [console=ttyO2,115200n8 root=/dev/mmcblk0p1 ro rootfstype=ext4 rootwait coherent_pool=1M debug earlyprintk] …
debug: [bootz 0x82000000 0x88080000:43fecc 0x88000000] …
Kernel image @ 0x82000000 [ 0x000000 - 0x756578 ]
Flattened Device Tree blob at 88000000
Booting using the fdt blob at 0x88000000
Loading Ramdisk to 8fbc0000, end 8ffffecc … OK
Loading Device Tree to 8fb95000, end 8fbbff67 … OK
Starting kernel …
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.1.18-ti-r56 (root@b1-omap5-uevm-2gb) (gcc version 4.9.2 (Debian 4.9.2-10) ) #1 SMP Thu Mar 31 00:22:03 UTC 2016
[ 0.000000] CPU: ARMv7 Processor [412fc0f2] revision 2 (ARMv7), cr=50c5387d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[ 0.000000] Machine model: TI AM572x EVM
[ 0.000000] Reserved memory: created CMA memory pool at 0x95800000, size 56 MiB
[ 0.000000] Reserved memory: initialized node ipu2_cma@95800000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x99000000, size 64 MiB
[ 0.000000] Reserved memory: initialized node dsp1_cma@99000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x9d000000, size 32 MiB
[ 0.000000] Reserved memory: initialized node ipu1_cma@9d000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x9f000000, size 16 MiB
[ 0.000000] Reserved memory: initialized node dsp2_cma@9f000000, compatible id shared-dma-pool
[ 0.000000] cma: Reserved 24 MiB at 0xfe000000
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] OMAP4: Map 0xffd00000 to fe600000 for dram barrier
[ 0.000000] On node 0 totalpages: 482815
[ 0.000000] free_area_init_node: node 0, pgdat c0bedd80, node_mem_map ee5a4000
[ 0.000000] Normal zone: 1710 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 153600 pages, LIFO batch:31
[ 0.000000] HighMem zone: 329215 pages, LIFO batch:31
[ 0.000000] DRA752 ES1.1
[ 0.000000] PERCPU: Embedded 13 pages/cpu @ee508000 s23168 r8192 d21888 u53248
[ 0.000000] pcpu-alloc: s23168 r8192 d21888 u53248 alloc=13*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 481105
[ 0.000000] Kernel command line: console=ttyO2,115200n8 root=/dev/mmcblk0p1 ro rootfstype=ext4 rootwait coherent_pool=1M debug earlyprintk
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 1698128K/1931260K available (7046K kernel code, 938K rwdata, 3732K rodata, 596K init, 902K bss, 36524K reserved, 196608K cma-reserved, 1292284K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0xf0000000 - 0xff000000 ( 240 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xef800000 ( 760 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf800000 - 0xbfe00000 ( 6 MB)
[ 0.000000] .text : 0xc0008000 - 0xc0a8eb78 (10779 kB)
[ 0.000000] .init : 0xc0a8f000 - 0xc0b24000 ( 596 kB)
[ 0.000000] .data : 0xc0b24000 - 0xc0c0ebe8 ( 939 kB)
[ 0.000000] .bss : 0xc0c11000 - 0xc0cf2808 ( 903 kB)
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU dyntick-idle grace-period acceleration is enabled.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] OMAP clockevent source: timer1 at 32768 Hz
[ 0.000000] clocksource 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns
[ 0.000000] sched_clock: 32 bits at 32kHz, resolution 30517ns, wraps every 65535999984741ns
[ 0.000000] OMAP clocksource: 32k_counter at 32768 Hz
[ 0.000640] Architected cp15 timer(s) running at 6.14MHz (virt).
[ 0.000640] clocksource arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x16af5adb9, max_idle_ns: 440795202250 ns
[ 0.000645] sched_clock: 56 bits at 6MHz, resolution 162ns, wraps every 4398046511023ns
[ 0.000655] Switching to timer-based delay loop, resolution 162ns
[ 0.002326] Console: colour dummy device 80x30
[ 0.002341] WARNING: Your ‘console=ttyO2’ has been replaced by ‘ttyS2’
[ 0.002346] This ensures that you still see kernel messages. Please
[ 0.002352] update your kernel commandline.
[ 0.002365] Calibrating delay loop (skipped), value calculated using timer frequency… 12.29 BogoMIPS (lpj=61475)
[ 0.002376] pid_max: default: 32768 minimum: 301
[ 0.002484] Security Framework initialized
[ 0.002510] AppArmor: AppArmor disabled by boot time parameter
[ 0.002516] Yama: becoming mindful.
[ 0.002655] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.002664] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.003221] Initializing cgroup subsys blkio
[ 0.003234] Initializing cgroup subsys memory
[ 0.003263] Initializing cgroup subsys devices
[ 0.003276] Initializing cgroup subsys freezer
[ 0.003292] Initializing cgroup subsys net_cls
[ 0.003303] Initializing cgroup subsys perf_event
[ 0.003315] Initializing cgroup subsys net_prio
[ 0.003349] CPU: Testing write buffer coherency: ok
[ 0.003378] ftrace: allocating 35088 entries in 69 pages
[ 0.035822] /cpus/cpu@0 missing clock-frequency property
[ 0.035873] /cpus/cpu@1 missing clock-frequency property
[ 0.035883] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.035937] Setting up static identity map for 0x80008240 - 0x8000828c
[ 0.039533] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.039604] Brought up 2 CPUs
[ 0.039614] SMP: Total of 2 processors activated (24.59 BogoMIPS).
[ 0.039620] CPU: All CPU(s) started in SVC mode.
[ 0.040012] devtmpfs: initialized
[ 0.072998] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0
[ 0.073886] omap_hwmod: l3_main_2 using broken dt data from ocp
[ 0.267079] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.273302] xor: measuring software checksum speed
[ 0.365769] arm4regs : 2051.200 MB/sec
[ 0.465819] 8regs : 1666.400 MB/sec
[ 0.565871] 32regs : 1662.800 MB/sec
[ 0.665917] neon : 3076.800 MB/sec
[ 0.665923] xor: using function: neon (3076.800 MB/sec)
[ 0.666002] pinctrl core: initialized pinctrl subsystem
[ 0.667414] NET: Registered protocol family 16
[ 0.669888] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[ 0.705995] cpuidle: using governor ladder
[ 0.746023] cpuidle: using governor menu
[ 0.753712] OMAP GPIO hardware version 0.1
[ 0.759366] irq: no irq domain found for /ocp/l4@4a000000/scm@2000/pinmux@1400 !
[ 0.781195] No ATAGs?
[ 0.781220] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.781227] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.781754] omap4_sram_init:Unable to allocate sram needed to handle errata I688
[ 0.781761] omap4_sram_init:Unable to get sram pool needed to handle errata I688
[ 0.782179] OMAP DMA hardware revision 0.0
[ 0.996343] raid6: int32x1 gen() 225 MB/s
[ 1.166409] raid6: int32x1 xor() 230 MB/s
[ 1.336650] raid6: int32x2 gen() 351 MB/s
[ 1.506768] raid6: int32x2 xor() 280 MB/s
[ 1.676938] raid6: int32x4 gen() 481 MB/s
[ 1.847038] raid6: int32x4 xor() 307 MB/s
[ 2.017117] raid6: int32x8 gen() 559 MB/s
[ 2.187295] raid6: int32x8 xor() 318 MB/s
[ 2.357421] raid6: neonx1 gen() 898 MB/s
[ 2.527541] raid6: neonx2 gen() 1491 MB/s
[ 2.697684] raid6: neonx4 gen() 1824 MB/s
[ 2.867830] raid6: neonx8 gen() 1678 MB/s
[ 2.867836] raid6: using algorithm neonx4 gen() 1824 MB/s
[ 2.867841] raid6: using intx1 recovery algorithm
[ 2.872204] edma 43300000.edma: memcpy is disabled
[ 2.877223] edma 43300000.edma: TI EDMA DMA engine driver
[ 2.880107] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver
[ 2.884794] omap-iommu 40d01000.mmu: 40d01000.mmu registered
[ 2.884927] omap-iommu 40d02000.mmu: 40d02000.mmu registered
[ 2.885058] omap-iommu 58882000.mmu: 58882000.mmu registered
[ 2.885178] omap-iommu 55082000.mmu: 55082000.mmu registered
[ 2.885396] omap-iommu 41501000.mmu: 41501000.mmu registered
[ 2.885539] omap-iommu 41502000.mmu: 41502000.mmu registered
[ 2.885738] vgaarb: loaded
[ 2.886163] SCSI subsystem initialized
[ 2.886287] libata version 3.00 loaded.
[ 2.886494] usbcore: registered new interface driver usbfs
[ 2.886542] usbcore: registered new interface driver hub
[ 2.886583] usbcore: registered new device driver usb
[ 2.887648] palmas 0-0058: Irq flag is 0x00000008
[ 2.917220] palmas 0-0058: Muxing GPIO fd, PWM 0, LED 0
[ 3.028026] omap_i2c 48070000.i2c: bus 0 rev0.12 at 100 kHz
[ 3.028368] omap_i2c 48060000.i2c: bus 2 rev0.12 at 400 kHz
[ 3.028678] omap_i2c 4807c000.i2c: bus 4 rev0.12 at 400 kHz
[ 3.028864] pps_core: LinuxPPS API ver. 1 registered