AM4376 with omap L3 error

Cindy Lin
Other Parts Discussed in Thread: AM4372
Hi:
  We are using AM4376 to do some developments.
  Now we confronted a problem that is the L3 error while interrupt handling occurs.
  Due to there is no related information for L3F_CFG in TRM, we could not debug for this issue.
  The following is the log : 
  Please give me some advise or hint, thanks.

[Tue Dec 08 09:39:52.978 2015] 
[Tue Dec 08 09:39:52.978 2015] U-Boot SPL 2014.07-gaa8e1f0 (Dec 08 2015 - 09:30:25)
[Tue Dec 08 09:39:53.001 2015] Could not probe the EEPROM at 0x50
[Tue Dec 08 09:39:53.001 2015] Could not get board ID.
[Tue Dec 08 09:39:53.208 2015] SPL: Please implement spl_start_uboot() for your board
[Tue Dec 08 09:39:53.208 2015] SPL: Direct Linux boot not active!
[Tue Dec 08 09:39:53.208 2015] reading u-boot.img
[Tue Dec 08 09:39:53.208 2015] reading u-boot.img
[Tue Dec 08 09:39:53.223 2015] 
[Tue Dec 08 09:39:53.223 2015] 
[Tue Dec 08 09:39:53.223 2015] U-Boot 2014.07-gaa8e1f0 (Dec 08 2015 - 09:30:25)
[Tue Dec 08 09:39:53.238 2015] 
[Tue Dec 08 09:39:53.238 2015] I2C:   ready
[Tue Dec 08 09:39:53.288 2015] DRAM:  512 MiB
[Tue Dec 08 09:39:53.336 2015] MMC:   OMAP SD/MMC: 0, OMAP SD/MMC: 1
[Tue Dec 08 09:39:53.360 2015] Card did not respond to voltage select!
[Tue Dec 08 09:39:53.361 2015] MMC init failed
[Tue Dec 08 09:39:53.361 2015] Using default environment
[Tue Dec 08 09:39:53.361 2015] 
[Tue Dec 08 09:39:53.426 2015] Could not probe the EEPROM at 0x50
[Tue Dec 08 09:39:53.426 2015] Could not get board ID.
[Tue Dec 08 09:39:53.426 2015] Net:   Net Initialization Skipped
[Tue Dec 08 09:39:53.426 2015] No ethernet found.
[Tue Dec 08 09:39:53.426 2015] Hit any key to stop autoboot:  1  0 
[Tue Dec 08 09:39:54.514 2015] switch to partitions #0, OK
[Tue Dec 08 09:39:54.514 2015] mmc0 is current device
[Tue Dec 08 09:39:54.591 2015] SD/MMC found on device 0
[Tue Dec 08 09:39:54.614 2015] reading uEnv.txt
[Tue Dec 08 09:39:54.614 2015] ** Unable to read file uEnv.txt **
[Tue Dec 08 09:39:54.870 2015] 4500584 bytes read in 263 ms (16.3 MiB/s)
[Tue Dec 08 09:39:54.918 2015] 45158 bytes read in 9 ms (4.8 MiB/s)
[Tue Dec 08 09:39:54.918 2015] Booting from mmc0 ...
[Tue Dec 08 09:39:54.918 2015] Kernel image @ 0x82000000 [ 0x000000 - 0x44ac68 ]
[Tue Dec 08 09:39:54.918 2015] ## Flattened Device Tree blob at 88000000
[Tue Dec 08 09:39:54.918 2015]    Booting using the fdt blob at 0x88000000
[Tue Dec 08 09:39:54.918 2015]    Loading Device Tree to 8fff1000, end 8ffff065 ... OK
[Tue Dec 08 09:39:54.918 2015] 
[Tue Dec 08 09:39:54.918 2015] Starting kernel ...
[Tue Dec 08 09:39:54.918 2015] 
[Tue Dec 08 09:39:55.747 2015] [    0.000000] Booting Linux on physical CPU 0x0
[Tue Dec 08 09:39:56.097 2015] [    0.000000] Linux version 3.14.43-rt42-g2d2fe37-dirty (cindylin@linuxserver-OptiPlex-9020 linuxserver) (gcc version 4.7.3 20130226 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.03-20130313 - Linaro GCC 2013.03) ) #3 PREEMPT RT Tue Dec 8 09:17:28 CST 2015
[Tue Dec 08 09:39:56.097 2015] [    0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c5387d
[Tue Dec 08 09:39:56.097 2015] [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[Tue Dec 08 09:39:56.097 2015] [    0.000000] Machine model: LITEON AM437x LP32cm EVT
[Tue Dec 08 09:39:56.097 2015] [    0.000000] cma: CMA: reserved 24 MiB at 9e400000
[Tue Dec 08 09:39:56.097 2015] [    0.000000] Memory policy: Data cache writeback
[Tue Dec 08 09:39:56.097 2015] [    0.000000] CPU: All CPU(s) started in SVC mode.
[Tue Dec 08 09:39:56.097 2015] [    0.000000] AM437x ES1.2 (neon )
[Tue Dec 08 09:39:56.097 2015] [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 129536
[Tue Dec 08 09:39:56.097 2015] [    0.000000] Kernel command line: console=ttyO0,115200n8 psplash=false root=/dev/mmcblk0p2 rw rootfstype=ext4 rootwait
[Tue Dec 08 09:39:56.097 2015] [    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[Tue Dec 08 09:39:56.097 2015] [    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[Tue Dec 08 09:39:56.103 2015] [    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[Tue Dec 08 09:39:56.103 2015] [    0.000000] Memory: 483760K/522240K available (6079K kernel code, 327K rwdata, 2200K rodata, 271K init, 259K bss, 38480K reserved, 0K highmem)
[Tue Dec 08 09:39:56.103 2015] [    0.000000] Virtual kernel memory layout:
[Tue Dec 08 09:39:56.103 2015] [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]     fixmap  : 0xfff00000 - 0xfffe0000   ( 896 kB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]     vmalloc : 0xe0800000 - 0xff000000   ( 488 MB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]       .text : 0xc0008000 - 0xc081e0c4   (8281 kB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]       .init : 0xc081f000 - 0xc0862ff4   ( 272 kB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]       .data : 0xc0864000 - 0xc08b5eb8   ( 328 kB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000]        .bss : 0xc08b5ec4 - 0xc08f6e78   ( 260 kB)
[Tue Dec 08 09:39:56.103 2015] [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[Tue Dec 08 09:39:56.109 2015] [    0.000000] Preemptible hierarchical RCU implementation.
[Tue Dec 08 09:39:56.109 2015] [    0.000000] NR_IRQS:16 nr_irqs:16 16
[Tue Dec 08 09:39:56.109 2015] [    0.000000] GIC CPU mask not found - kernel will fail to boot.
[Tue Dec 08 09:39:56.109 2015] [    0.000000] GIC CPU mask not found - kernel will fail to boot.
[Tue Dec 08 09:39:56.109 2015] [    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
[Tue Dec 08 09:39:56.109 2015] [    0.000024] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
[Tue Dec 08 09:39:56.109 2015] [    0.000042] OMAP clocksource: timer1 at 24000000 Hz
[Tue Dec 08 09:39:56.109 2015] [    0.000243] Console: colour dummy device 80x30
[Tue Dec 08 09:39:56.109 2015] [    0.000369] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
[Tue Dec 08 09:39:56.109 2015] [    0.000371] This ensures that you still see kernel messages. Please
[Tue Dec 08 09:39:56.109 2015] [    0.000373] update your kernel commandline.
[Tue Dec 08 09:39:56.109 2015] [    0.059088] Calibrating delay loop... 1993.93 BogoMIPS (lpj=9969664)
[Tue Dec 08 09:39:56.109 2015] [    0.059095] pid_max: default: 32768 minimum: 301
[Tue Dec 08 09:39:56.109 2015] [    0.059270] Security Framework initialized
[Tue Dec 08 09:39:56.109 2015] [    0.059349] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[Tue Dec 08 09:39:56.109 2015] [    0.059363] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[Tue Dec 08 09:39:56.113 2015] [    0.068063] CPU: Testing write buffer coherency: ok
[Tue Dec 08 09:39:56.113 2015] [    0.068475] Setting up static identity map for 0x805f57f0 - 0x805f5848
[Tue Dec 08 09:39:56.113 2015] [    0.068629] L310 cache controller enabled
[Tue Dec 08 09:39:56.113 2015] [    0.068653] l2x0: 16 ways, CACHE_ID 0x410000c9, AUX_CTRL 0x7e030000, Cache size: 256 kB
[Tue Dec 08 09:39:56.113 2015] [    0.070146] devtmpfs: initialized
[Tue Dec 08 09:39:56.113 2015] [    0.073221] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[Tue Dec 08 09:39:56.113 2015] [    0.093713] omap_hwmod: tptc0 using broken dt data from edma
[Tue Dec 08 09:39:56.113 2015] [    0.093875] omap_hwmod: tptc1 using broken dt data from edma
[Tue Dec 08 09:39:56.113 2015] [    0.094019] omap_hwmod: tptc2 using broken dt data from edma
[Tue Dec 08 09:39:56.113 2015] [    0.158144] omap_hwmod: dss_dispc: cannot be enabled for reset (3)
[Tue Dec 08 09:39:56.113 2015] [    0.161464] omap_hwmod: dss_rfbi: cannot be enabled for reset (3)
[Tue Dec 08 09:39:56.113 2015] [    0.170816] omap_hwmod: rtc: _wait_target_disable failed
[Tue Dec 08 09:39:56.113 2015] [    0.171557] pinctrl core: initialized pinctrl subsystem
[Tue Dec 08 09:39:56.113 2015] [    0.172727] regulator-dummy: no parameters
[Tue Dec 08 09:39:56.446 2015] [    0.174708] NET: Registered protocol family 16
[Tue Dec 08 09:39:56.446 2015] [    0.176543] DMA: preallocated 256 KiB pool for atomic coherent allocations
[Tue Dec 08 09:39:56.446 2015] [    0.179623] cpuidle: using governor ladder
[Tue Dec 08 09:39:56.446 2015] [    0.179637] cpuidle: using governor menu
[Tue Dec 08 09:39:56.446 2015] [    0.202507] syscon 44e10000.control_module: regmap [mem 0x44e10000-0x44e107f3] registered
[Tue Dec 08 09:39:56.446 2015] [    0.203598] omap_l3_noc 44000000.ocp: L3 debug error: target 8 mod:0 (unclearable)
[Tue Dec 08 09:39:56.446 2015] [    0.203627] omap_l3_noc 44000000.ocp: L3 debug error: target 13 mod:1 (unclearable)
[Tue Dec 08 09:39:56.446 2015] [    0.203780] omap_l3_noc 44000000.ocp: L3 application error: target 8 mod:0 (unclearable)
[Tue Dec 08 09:39:56.446 2015] [    0.203801] ------------[ cut here ]------------
[Tue Dec 08 09:39:56.446 2015] [    0.203834] WARNING: CPU: 0 PID: 51 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x234/0x35c()
[Tue Dec 08 09:39:56.446 2015] [    0.203846] 44000000.ocp:L3 Custom Error: MASTER M2 (64-bit) TARGET L4_WKUP (Read): Data Access in User mode during Functional access
[Tue Dec 08 09:39:56.446 2015] [    0.203853] Modules linked in:
[Tue Dec 08 09:39:56.446 2015] [    0.203870] CPU: 0 PID: 51 Comm: irq/42-l3-app-i Not tainted 3.14.43-rt42-g2d2fe37-dirty #3
[Tue Dec 08 09:39:56.455 2015] [    0.203880] Backtrace: 
[Tue Dec 08 09:39:56.455 2015] [    0.203911] [<c0011370>] (dump_backtrace) from [<c001150c>] (show_stack+0x18/0x1c)
[Tue Dec 08 09:39:56.455 2015] [    0.203919]  r6:00000093 r5:00000009 r4:ddd61e38 r3:00000000
[Tue Dec 08 09:39:56.455 2015] [    0.203948] [<c00114f4>] (show_stack) from [<c05ed5b0>] (dump_stack+0x20/0x28)
[Tue Dec 08 09:39:56.455 2015] [    0.203967] [<c05ed590>] (dump_stack) from [<c00386ec>] (warn_slowpath_common+0x6c/0x8c)
[Tue Dec 08 09:39:56.455 2015] [    0.203979] [<c0038680>] (warn_slowpath_common) from [<c00387b0>] (warn_slowpath_fmt+0x38/0x40)
[Tue Dec 08 09:39:56.455 2015] [    0.203986]  r8:c061b294 r7:c0785c1c r6:c0785828 r5:80080003 r4:ddcfa850
[Tue Dec 08 09:39:56.455 2015] [    0.204014] [<c003877c>] (warn_slowpath_fmt) from [<c02a31b8>] (l3_interrupt_handler+0x234/0x35c)
[Tue Dec 08 09:39:56.455 2015] [    0.204020]  r3:ddcf4d40 r2:c07858e8
[Tue Dec 08 09:39:56.455 2015] [    0.204048] [<c02a2f84>] (l3_interrupt_handler) from [<c006bb4c>] (irq_forced_thread_fn+0x28/0x5c)
[Tue Dec 08 09:39:56.455 2015] [    0.204055]  r10:ddc06000 r9:c006bb24 r8:00000001 r7:ddd60000 r6:ddce8100 r5:ddc06000
[Tue Dec 08 09:39:56.455 2015] [    0.204077]  r4:ddce8100
[Tue Dec 08 09:39:56.455 2015] [    0.204091] [<c006bb24>] (irq_forced_thread_fn) from [<c006b884>] (irq_thread+0xe0/0x138)
[Tue Dec 08 09:39:56.464 2015] [    0.204097]  r6:ddce8100 r5:00000000 r4:ddce8100 r3:ddd58a00
[Tue Dec 08 09:39:56.464 2015] [    0.204132] [<c006b7a4>] (irq_thread) from [<c00534b8>] (kthread+0xbc/0xd4)
[Tue Dec 08 09:39:56.464 2015] [    0.204139]  r10:00000000 r9:00000000 r8:00000000 r7:c006b7a4 r6:ddce8100 r5:ddce8000
[Tue Dec 08 09:39:56.464 2015] [    0.204160]  r4:00000000
[Tue Dec 08 09:39:56.464 2015] [    0.204175] [<c00533fc>] (kthread) from [<c000e918>] (ret_from_fork+0x14/0x3c)
[Tue Dec 08 09:39:56.464 2015] [    0.204182]  r7:00000000 r6:00000000 r5:c00533fc r4:ddce8000
[Tue Dec 08 09:39:56.464 2015] [    0.204200] ---[ end trace 0000000000000001 ]---
[Tue Dec 08 09:39:56.464 2015] [    0.204223] omap_l3_noc 44000000.ocp: L3 application error: target 13 mod:1 (unclearable)
[Tue Dec 08 09:39:56.464 2015] [    0.205256] platform 49000000.edma: alias fck already exists
[Tue Dec 08 09:39:56.464 2015] [    0.205279] platform 49000000.edma: alias fck already exists
[Tue Dec 08 09:39:56.464 2015] [    0.205292] platform 49000000.edma: alias fck already exists
[Tue Dec 08 09:39:56.464 2015] [    0.210147] OMAP GPIO hardware version 0.1
[Tue Dec 08 09:39:56.464 2015] [    0.230964] No ATAGs?
[Tue Dec 08 09:39:56.464 2015] [    0.230996] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[Tue Dec 08 09:39:56.464 2015] [    0.231008] hw-breakpoint: maximum watchpoint size is 4 bytes.
[Tue Dec 08 09:39:56.464 2015] [    0.269085] bio: create slab <bio-0> at 0
[Tue Dec 08 09:39:56.471 2015] [    0.290830] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
[Tue Dec 08 09:39:56.471 2015] [    0.292123] evm_v3_3d: 3300 mV 
[Tue Dec 08 09:39:56.471 2015] [    0.292739] vtt_fixed: 1500 mV 
[Tue Dec 08 09:39:56.471 2015] [    0.293355] vmmcwl_fixed: 1800 mV 
[Tue Dec 08 09:39:56.471 2015] [    0.297276] vgaarb: loaded
[Tue Dec 08 09:39:56.471 2015] [    0.297950] i2c-core: driver [palmas] using legacy suspend method
[Tue Dec 08 09:39:56.471 2015] [    0.297962] i2c-core: driver [palmas] using legacy resume method
[Tue Dec 08 09:39:56.471 2015] [    0.298813] SCSI subsystem initialized
[Tue Dec 08 09:39:56.471 2015] [    0.301508] usbcore: registered new interface driver usbfs
[Tue Dec 08 09:39:56.471 2015] [    0.301753] usbcore: registered new interface driver hub
[Tue Dec 08 09:39:56.471 2015] [    0.302016] usbcore: registered new device driver usb
[Tue Dec 08 09:39:56.471 2015] [    0.303307] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/i2c0_pins, deferring probe
[Tue Dec 08 09:39:56.471 2015] [    0.303338] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
[Tue Dec 08 09:39:56.471 2015] [    0.303369] omap_i2c 4802a000.i2c: could not find pctldev for node /pinmux@44e10800/i2c1_pins_default, deferring probe
[Tue Dec 08 09:39:56.471 2015] [    0.303385] platform 4802a000.i2c: Driver omap_i2c requests probe deferral
[Tue Dec 08 09:39:56.785 2015] [    0.303413] omap_i2c 4819c000.i2c: could not find pctldev for node /pinmux@44e10800/i2c2_pins, deferring probe
[Tue Dec 08 09:39:56.785 2015] [    0.303428] platform 4819c000.i2c: Driver omap_i2c requests probe deferral
[Tue Dec 08 09:39:56.785 2015] [    0.303934] pps_core: LinuxPPS API ver. 1 registered
[Tue Dec 08 09:39:56.785 2015] [    0.303947] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[Tue Dec 08 09:39:56.785 2015] [    0.304119] PTP clock support registered
[Tue Dec 08 09:39:56.785 2015] [    0.306886] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
[Tue Dec 08 09:39:56.785 2015] [    0.308387] Advanced Linux Sound Architecture Driver Initialized.
[Tue Dec 08 09:39:56.785 2015] [    0.311037] Switched to clocksource timer1
[Tue Dec 08 09:39:56.785 2015] [    0.335261] NET: Registered protocol family 2
[Tue Dec 08 09:39:56.785 2015] [    0.336011] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[Tue Dec 08 09:39:56.785 2015] [    0.336083] TCP bind hash table entries: 4096 (order: 4, 98304 bytes)
[Tue Dec 08 09:39:56.785 2015] [    0.336375] TCP: Hash tables configured (established 4096 bind 4096)
[Tue Dec 08 09:39:56.785 2015] [    0.336485] TCP: reno registered
[Tue Dec 08 09:39:56.785 2015] [    0.336505] UDP hash table entries: 256 (order: 2, 16384 bytes)
[Tue Dec 08 09:39:56.799 2015] [    0.336564] UDP-Lite hash table entries: 256 (order: 2, 16384 bytes)
[Tue Dec 08 09:39:56.799 2015] [    0.336926] NET: Registered protocol family 1
[Tue Dec 08 09:39:56.799 2015] [    0.337499] RPC: Registered named UNIX socket transport module.
[Tue Dec 08 09:39:56.799 2015] [    0.337514] RPC: Registered udp transport module.
[Tue Dec 08 09:39:56.799 2015] [    0.337522] RPC: Registered tcp transport module.
[Tue Dec 08 09:39:56.799 2015] [    0.337529] RPC: Registered tcp NFSv4.1 backchannel transport module.
[Tue Dec 08 09:39:56.799 2015] [    0.339346] omap_timer 48044000.timer: could not find pctldev for node /pinmux@44e10800/timer1_pins, deferring probe
[Tue Dec 08 09:39:56.799 2015] [    0.339376] platform 48044000.timer: Driver omap_timer requests probe deferral
[Tue Dec 08 09:39:56.799 2015] [    0.339409] omap_timer 48046000.timer: could not find pctldev for node /pinmux@44e10800/timer2_pins, deferring probe
[Tue Dec 08 09:39:56.799 2015] [    0.339424] platform 48046000.timer: Driver omap_timer requests probe deferral
[Tue Dec 08 09:39:56.799 2015] [    0.339453] omap_timer 48048000.timer: could not find pctldev for node /pinmux@44e10800/timer3_pins, deferring probe
[Tue Dec 08 09:39:56.799 2015] [    0.339468] platform 48048000.timer: Driver omap_timer requests probe deferral
[Tue Dec 08 09:39:56.799 2015] [    0.339495] omap_timer 4804a000.timer: could not find pctldev for node /pinmux@44e10800/timer4_pins, deferring probe
[Tue Dec 08 09:39:56.809 2015] [    0.339509] platform 4804a000.timer: Driver omap_timer requests probe deferral
[Tue Dec 08 09:39:56.809 2015] [    0.342564] futex hash table entries: 256 (order: 1, 8192 bytes)
[Tue Dec 08 09:39:56.809 2015] [    0.459196] VFS: Disk quotas dquot_6.5.2
[Tue Dec 08 09:39:56.809 2015] [    0.459583] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[Tue Dec 08 09:39:56.809 2015] [    0.465129] NFS: Registering the id_resolver key type
[Tue Dec 08 09:39:56.809 2015] [    0.465206] Key type id_resolver registered
[Tue Dec 08 09:39:56.809 2015] [    0.465216] Key type id_legacy registered
[Tue Dec 08 09:39:56.809 2015] [    0.465254] jffs2: version 2.2. (NAND) (SUMMARY)  c 2001-2006 Red Hat, Inc.
[Tue Dec 08 09:39:56.809 2015] [    0.466817] msgmni has been set to 992
[Tue Dec 08 09:39:56.809 2015] [    0.469027] NET: Registered protocol family 38
[Tue Dec 08 09:39:56.809 2015] [    0.469078] io scheduler noop registered
[Tue Dec 08 09:39:56.809 2015] [    0.469088] io scheduler deadline registered
[Tue Dec 08 09:39:56.809 2015] [    0.469527] io scheduler cfq registered (default)
[Tue Dec 08 09:39:56.809 2015] [    0.474808] pinctrl-single 44e10800.pinmux: 199 pins at pa f9e10800 size 796
[Tue Dec 08 09:39:56.809 2015] [    0.485244] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
[Tue Dec 08 09:39:56.814 2015] [    0.490497] omap8250 44e09000.serial: No clock speed specified: using default: 48000000
[Tue Dec 08 09:39:56.814 2015] [    0.491632] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 104, base_baud = 3000000) is a 8250
[Tue Dec 08 09:39:56.814 2015] [    1.471916] console [ttyS0] enabled
[Tue Dec 08 09:39:56.814 2015] [    1.476147] omap8250 481a6000.serial: No clock speed specified: using default: 48000000
[Tue Dec 08 09:39:56.814 2015] [    1.484860] 481a6000.serial: ttyS3 at MMIO 0x481a6000 (irq = 76, base_baud = 3000000) is a 8250
[Tue Dec 08 09:39:56.814 2015] [    1.496024] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
[Tue Dec 08 09:39:56.814 2015] [    1.503241] [drm] Initialized drm 1.1.0 20060810
[Tue Dec 08 09:39:56.814 2015] [    1.520303] brd: module loaded
[Tue Dec 08 09:39:57.012 2015] [    1.529953] loop: module loaded
[Tue Dec 08 09:39:57.012 2015] [    1.533810] (hci_tty): inside hci_tty_init
[Tue Dec 08 09:39:57.012 2015] [    1.538533] (hci_tty): allocated 249, 0
[Tue Dec 08 09:39:57.012 2015] [    1.548542] mtdoops: mtd device (mtddev=name/number) must be supplied
[Tue Dec 08 09:39:57.012 2015] [    1.557661] of_dma_request_slave_channel: dma-names property of node '/ocp/spi@48030000' missing or empty
[Tue Dec 08 09:39:57.012 2015] [    1.567487] spi spi1.0: not using DMA for McSPI
[Tue Dec 08 09:39:57.012 2015] [    1.573145] pinctrl-single 44e10800.pinmux: pin 44e109b8.0 already requested by 48030000.spi; cannot claim for 481a2000.spi
[Tue Dec 08 09:39:57.012 2015] [    1.584472] pinctrl-single 44e10800.pinmux: pin-110 (481a2000.spi) status -22
[Tue Dec 08 09:39:57.012 2015] [    1.591751] pinctrl-single 44e10800.pinmux: could not request pin 110 (44e109b8.0) from group spi2_pins  on device pinctrl-single
[Tue Dec 08 09:39:57.012 2015] [    1.603461] omap2_mcspi 481a2000.spi: Error applying setting, reverse things back
[Tue Dec 08 09:39:57.012 2015] [    1.616342] usbcore: registered new interface driver asix
[Tue Dec 08 09:39:57.012 2015] [    1.622124] usbcore: registered new interface driver ax88179_178a
[Tue Dec 08 09:39:57.012 2015] [    1.628486] usbcore: registered new interface driver cdc_ether
[Tue Dec 08 09:39:57.012 2015] [    1.634629] usbcore: registered new interface driver smsc95xx
[Tue Dec 08 09:39:57.022 2015] [    1.640627] usbcore: registered new interface driver net1080
[Tue Dec 08 09:39:57.022 2015] [    1.646664] usbcore: registered new interface driver cdc_subset
[Tue Dec 08 09:39:57.022 2015] [    1.652848] usbcore: registered new interface driver zaurus
[Tue Dec 08 09:39:57.022 2015] [    1.658709] usbcore: registered new interface driver cdc_ncm
[Tue Dec 08 09:39:57.022 2015] [    1.665200] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[Tue Dec 08 09:39:57.022 2015] [    1.671808] ehci-pci: EHCI PCI platform driver
[Tue Dec 08 09:39:57.022 2015] [    1.676535] ehci-omap: OMAP-EHCI Host Controller driver
[Tue Dec 08 09:39:57.022 2015] [    1.682549] usbcore: registered new interface driver cdc_wdm
[Tue Dec 08 09:39:57.022 2015] [    1.688515] usbcore: registered new interface driver usb-storage
[Tue Dec 08 09:39:57.022 2015] [    1.696098] mousedev: PS/2 mouse device common for all mice
[Tue Dec 08 09:39:57.022 2015] [    1.704386] i2c-core: driver [rtc-ds1307] using legacy suspend method
[Tue Dec 08 09:39:57.022 2015] [    1.710870] i2c-core: driver [rtc-ds1307] using legacy resume method
[Tue Dec 08 09:39:57.022 2015] [    1.718858] i2c /dev entries driver
[Tue Dec 08 09:39:57.022 2015] [    1.722670] Driver for 1-wire Dallas network protocol.
[Tue Dec 08 09:39:57.022 2015] [    1.730930] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[Tue Dec 08 09:39:57.421 2015] [    1.822507] omap-aes 53501000.aes: OMAP AES hw accel rev: 0.1
[Tue Dec 08 09:39:57.421 2015] [    1.829507] omap-des 53701000.des: OMAP DES hw accel rev: 0.33
[Tue Dec 08 09:39:57.421 2015] [    1.836941] omap-sham 53100000.sham: hw accel on OMAP rev 0.0
[Tue Dec 08 09:39:57.421 2015] [    1.845132] usbcore: registered new interface driver usbhid
[Tue Dec 08 09:39:57.421 2015] [    1.850743] usbhid: USB HID core driver
[Tue Dec 08 09:39:57.421 2015] [    1.855105] platform 44d00000.wkup_m3: Driver wkup_m3 requests probe deferral
[Tue Dec 08 09:39:57.421 2015] [    1.864888] mmc0: new high speed SDHC card at address aaaa
[Tue Dec 08 09:39:57.421 2015] [    1.871597] mmcblk0: mmc0:aaaa SU08G 7.40 GiB 
[Tue Dec 08 09:39:57.421 2015] [    1.878437]  mmcblk0: p1 p2
[Tue Dec 08 09:39:57.421 2015] [    1.882384] TCP: cubic registered
[Tue Dec 08 09:39:57.421 2015] [    1.885727] Initializing XFRM netlink socket
[Tue Dec 08 09:39:57.421 2015] [    1.890045] NET: Registered protocol family 17
[Tue Dec 08 09:39:57.421 2015] [    1.898281] NET: Registered protocol family 15
[Tue Dec 08 09:39:57.421 2015] [    1.905841] Key type dns_resolver registered
[Tue Dec 08 09:39:57.421 2015] [    1.910939] cpu cpu0: of_pm_voltdm_notifier_register: Failed to get cpu0 regulator/voltdm: -517
[Tue Dec 08 09:39:57.421 2015] [    1.919792] cpu cpu0: cpu0 clock notifier not ready, retry
[Tue Dec 08 09:39:57.421 2015] [    1.925439] platform cpufreq-cpu0.0: Driver cpufreq-cpu0 requests probe deferral
[Tue Dec 08 09:39:57.437 2015] [    1.933750] PM: no-rtc available, rtc-only mode disabled.
[Tue Dec 08 09:39:57.438 2015] [    1.935765] mmc1: BKOPS_EN bit is not set
[Tue Dec 08 09:39:57.438 2015] [    1.943310] ThumbEE CPU extension supported.
[Tue Dec 08 09:39:57.438 2015] [    1.945188] mmc1: new high speed MMC card at address 0001
[Tue Dec 08 09:39:57.438 2015] [    1.951523] mmcblk1: mmc1:0001 S10008 7.12 GiB 
[Tue Dec 08 09:39:57.438 2015] [    1.951711] mmcblk1boot0: mmc1:0001 S10008 partition 1 4.00 MiB
[Tue Dec 08 09:39:57.438 2015] [    1.961170] mmcblk1boot1: mmc1:0001 S10008 partition 2 4.00 MiB
[Tue Dec 08 09:39:57.438 2015] [    1.962408]  mmcblk1: unknown partition table
[Tue Dec 08 09:39:57.438 2015] [    1.974143]  mmcblk1boot1: unknown partition table
[Tue Dec 08 09:39:57.438 2015] [    1.983178] Registering SWP/SWPB emulation handler
[Tue Dec 08 09:39:57.438 2015] [    1.984162]  mmcblk1boot0: unknown partition table
[Tue Dec 08 09:39:57.438 2015] [    1.995580] vmmcwl_fixed: disabling
[Tue Dec 08 09:39:57.438 2015] [    1.999102] regulator-dummy: disabling
[Tue Dec 08 09:39:57.438 2015] [    2.003949] Error: Driver 'tfp410' is already registered, aborting...
[Tue Dec 08 09:39:57.438 2015] [    2.016086] prom_parse: Bad cell count for /ocp/i2c@44e0b000/tps65218@24
[Tue Dec 08 09:39:57.438 2015] [    2.025389] vdd_core: 920 <--> 1140 mV at 1100 mV 
[Tue Dec 08 09:39:57.438 2015] [    2.030841] prom_parse: Bad cell count for /ocp/i2c@44e0b000/tps65218@24
[Tue Dec 08 09:39:57.438 2015] [    2.039747] vdd_mpu: 920 <--> 1375 mV at 1330 mV 
[Tue Dec 08 09:39:57.445 2015] [    2.044702] prom_parse: Bad cell count for /ocp/i2c@44e0b000/tps65218@24
[Tue Dec 08 09:39:57.445 2015] [    2.054614] vdcdc3: 1500 mV 
[Tue Dec 08 09:39:57.445 2015] [    2.057677] prom_parse: Bad cell count for /ocp/i2c@44e0b000/tps65218@24
[Tue Dec 08 09:39:57.445 2015] [    2.067159] v1_0bat: 1000 mV 
[Tue Dec 08 09:39:57.445 2015] [    2.070289] prom_parse: Bad cell count for /ocp/i2c@44e0b000/tps65218@24
[Tue Dec 08 09:39:57.445 2015] [    2.079277] v1_8bat: 1800 mV 
[Tue Dec 08 09:39:57.445 2015] [    2.082474] prom_parse: Bad cell count for /ocp/i2c@44e0b000/tps65218@24
[Tue Dec 08 09:39:57.445 2015] [    2.091901] LDO1: 1800 mV 
[Tue Dec 08 09:39:57.445 2015] [    2.095242] omap_i2c 44e0b000.i2c: bus 0 rev0.12 at 100 kHz
[Tue Dec 08 09:39:57.445 2015] [    2.101304] pinctrl-single 44e10800.pinmux: pin 44e10a48.0 already requested by 44e10800.pinmux; cannot claim for 4802a000.i2c
[Tue Dec 08 09:39:57.445 2015] [    2.112759] pinctrl-single 44e10800.pinmux: pin-146 (4802a000.i2c) status -22
[Tue Dec 08 09:39:57.445 2015] [    2.119931] pinctrl-single 44e10800.pinmux: could not request pin 146 (44e10a48.0) from group i2c1_pins_default  on device pinctrl-single
[Tue Dec 08 09:39:57.445 2015] [    2.132337] omap_i2c 4802a000.i2c: Error applying setting, reverse things back
[Tue Dec 08 09:39:57.445 2015] [    2.140713] omap_i2c 4802a000.i2c: bus 1 rev0.12 at 100 kHz
[Tue Dec 08 09:39:57.503 2015] [    2.160997] omap_i2c 4819c000.i2c: bus 2 rev0.12 at 100 kHz
[Tue Dec 08 09:39:57.503 2015] [    2.167154] omap_timer 48044000.timer: [cindy]Timer Device Probed.
[Tue Dec 08 09:39:57.503 2015] [    2.173719] omap_timer 48046000.timer: [cindy]Timer Device Probed.
[Tue Dec 08 09:39:57.503 2015] [    2.180195] omap_timer 48048000.timer: [cindy]Timer Device Probed.
[Tue Dec 08 09:39:57.503 2015] [    2.186889] omap_timer 4804a000.timer: [cindy]Timer Device Probed.
[Tue Dec 08 09:39:57.503 2015] [    2.193817]  remoteproc0: wkup_m3 is available
[Tue Dec 08 09:39:57.503 2015] [    2.198291]  remoteproc0: Note: remoteproc is still under development and considered experimental.
[Tue Dec 08 09:39:57.503 2015] [    2.207391]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[Tue Dec 08 09:39:57.503 2015] [    2.217916]  remoteproc0: [Cindy] firmware: direct-loading firmware path name /lib/firmware/updates/3.14.43-rt42-g2d2fe37-dirty/am335x-pm-firmware.elf
[Tue Dec 08 09:39:57.503 2015] [    2.231410] cpu cpu0: of_pm_voltdm_notifier_register: Fail calculating voltage latency[950000<->1325000]:-22
[Tue Dec 08 09:39:57.643 2015] [    2.257868]  remoteproc0: [Cindy] firmware: direct-loading firmware path name /lib/firmware/updates/am335x-pm-firmware.elf
[Tue Dec 08 09:39:57.643 2015] [    2.269018]  remoteproc0: [Cindy] firmware: direct-loading firmware path name /lib/firmware/3.14.43-rt42-g2d2fe37-dirty/am335x-pm-firmware.elf
[Tue Dec 08 09:39:57.643 2015] [    2.281876]  remoteproc0: [Cindy] firmware: direct-loading firmware path name /lib/firmware/am335x-pm-firmware.elf
[Tue Dec 08 09:39:57.643 2015] [    2.292287]  remoteproc0: Direct firmware load failed with error -2
[Tue Dec 08 09:39:57.643 2015] [    2.298582]  remoteproc0: Falling back to user helper
[Tue Dec 08 09:39:57.643 2015] [    2.301081] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[Tue Dec 08 09:39:57.643 2015] [    2.301087] davinci_mdio 4a101000.mdio: detected phy mask fffdfffd
[Tue Dec 08 09:39:57.643 2015] [    2.317463] libphy: 4a101000.mdio: probed
[Tue Dec 08 09:39:57.643 2015] [    2.321536] davinci_mdio 4a101000.mdio: phy[1]: device 4a101000.mdio:01, driver unknown
[Tue Dec 08 09:39:57.643 2015] [    2.329581] davinci_mdio 4a101000.mdio: phy[17]: device 4a101000.mdio:11, driver unknown
[Tue Dec 08 09:39:57.643 2015] [    2.338760] cpsw 4a100000.ethernet: Random MACID = 8a:5c:5d:24:ac:2c
[Tue Dec 08 09:39:57.649 2015] [    2.347575] drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
[Tue Dec 08 09:39:57.649 2015] [    2.358955] ALSA device list:
[Tue Dec 08 09:39:57.649 2015] [    2.362028]   No soundcards found.
[Tue Dec 08 09:39:57.663 2015] [    2.404625] EXT4-fs (mmcblk0p2): recovery complete
[Tue Dec 08 09:39:57.708 2015] [    2.411717] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[Tue Dec 08 09:39:57.708 2015] [    2.419910] VFS: Mounted root (ext4 filesystem) on device 179:2.
[Tue Dec 08 09:39:57.708 2015] [    2.429927] devtmpfs: mounted
[Tue Dec 08 09:39:57.708 2015] [    2.433438] Freeing unused kernel memory: 268K (c081f000 - c0862000)
[Tue Dec 08 09:39:57.721 2015] [    2.468481] Unhandled fault: imprecise external abort (0x1406) at 0x4cb9f87c
[Tue Dec 08 09:39:57.749 2015] [    2.468864] Kernel panic - not syncing: Attempted to kill init! exitcode=0x00000007
[Tue Dec 08 09:39:57.749 2015] [    2.468864]
over 9 years ago
0 Yordan Kovachev over 9 years ago
TI__Guru**** 161600 points
Hi,

L3 Custom errors are logged in the linux kernel, when the module being accessed returns an error signal. In your case a process/kernel driver was trying to access some of the L4_WKUP targets, while it was "locked" for user mode accesses.

Unfortunately as you stated, sitara interconnect documentation is not publicly available and I cannot provide more information here. You can have a look at the sources: drivers/bus/omap_l3_noc.c. The driver has detailed comments that explain how errors in L3_noc are detected.

Best Regards,
Yordan
0 Wayne Kuo over 9 years ago
Intellectual 870 points
Hi Cindy,

I got a similar issue before, this issue might cause by the RTC.
There are 2 way to solve it:
S/W :
Take off all the RTC function from the Device Tree file. (e.g. am33xx.dtsi or am4372.dtsi)
Do not just set the status as "disable", it won't works.
note. I'm not sure this solution will affect the external RTC or not.
H/W:
Do not use the "RTC disable" mode, please use "RTC timer functionality but no RTC-only" mode.
The detail pin sets, please refer TRM.

If my solution works, please "Verify Answer". Thank you.

Best Regards,
Wayne Kuo
0 Mark Doyle over 9 years ago in reply to Wayne Kuo
Intellectual 295 points
Wayne,
Thanks so much for this answer. I've been having the same problem and was getting an "L3 custom error" and kernel panic. Removing the rtc from the am4372.dtsi file prevented both.
Now I need to see how to get the rtc functionality without the bugs. Anybody have any thoughts on this?
Regards,
Mark Doyle
0 Mark Doyle over 9 years ago in reply to Mark Doyle
Intellectual 295 points
Update: The kernel panic was due to the RTC being shorted and not functional on my board. Once the hardware was fixed, I added the RTC back into the device tree and it works fine. The interesting part of this is that a RTC hardware failure causes an L3 custom error and Linux to panic at boot up.
Processors

Processors forum

AM4376 with omap L3 error
