• State TI Thinks Resolved
  • Locked Locked
  • Replies 5 replies
  • Answers 1 answer
  • Subscribers 101 subscribers
  • Views 992 views
  • Users 0 members are here
Support feedback
Options
Options
Related

This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

AM6546 : OSPI Flash write Error

Logan A
Prodigy 160 points

Other Parts Discussed in Thread: AM6546

Hi,

    We are using AM6546 custom board, SDK "ti-processor-sdk-linux-am65xx-evm-07_01_00_17", SR 2.0 version.

After multiple read write of OSPI flash the driver is not responding properly for write and read operations.

We can see the logs from driver.

[  619.673556] cadence-qspi 47040000.spi: Indirect write completion error (-110)
[  619.680721] spi-nor spi7.0: operation failed with -110

After this message we are unable to read/write to OSPI.  If we reboot then the drivers works properly. This issue is randomly reproduced.

Thanks,

Loganathan

  • 0
    TI__Expert 5970 points

    Hi Loganathan,

    Please share

    1. Are you using OSPI in DAC mode or INDAC mode?

    2. OSPI register configuration.

    Thanks & Regards,

    Sunita.

  • 0 in reply to Sunita Nadampalli
    Prodigy 160 points

    Hi Sunita,

    Please find below mentioned ospi configuration

    &ospi0 {
        pinctrl-names = "default";
        pinctrl-0 = <&mcu_fss0_ospi0_pins_default>;

        flash@0{
            compatible = "jedec,spi-nor";
            reg = <0x0>;
            spi-tx-bus-width = <8>;
            spi-rx-bus-width = <8>;
            spi-max-frequency = <166000000>;
            cdns,tshsl-ns = <60>;
            cdns,tsd2d-ns = <60>;
            cdns,tchsh-ns = <60>;
            cdns,tslch-ns = <60>;
            cdns,read-delay = <2>;
            cdns,phy-mode;
            #address-cells = <1>;
            #size-cells = <1>;
            partition@3fe0000 {
                label = "ospi.phypattern";
                reg = <0x3fe0000 0x20000>;
            };  
            
        };
    };

    I observed below mentioned 2 error from read/write test.

    test-1

    [18570.659944] cadence-qspi 47040000.spi: Indirect write timeout

    [18570.665737] spi-nor spi7.0: operation failed with -110


    test-2

    [  490.711981] cadence-qspi 47040000.spi: Indirect write completion error (-110)

    [  490.719254] spi-nor spi7.0: operation failed with -110

    We are using the Micron OSPI Flash Part number MT35XU512ABA1G12-0AAT. As per below link,

    https://software-dl.ti.com/processor-sdk-linux/esd/AM65X/latest/exports/docs/linux/Foundational_Components/Kernel/Kernel_Drivers/QSPI.html?highlight=ospi

    if i change read delay to 0, mtd partition not happening. For more details please find log.

    Fullscreen ospi_log.txt Download 
    U-Boot 2020.01-dirty (Mar 24 2021 - 00:55:15 +0530)

SoC:   AM65X SR2.0
Model: Texas Instruments AM654 Base Board
Reading on-board EEPROM at 0x50 failed -1
Board: AM6-COMPROCEVM rev E3
DRAM:  4 GiB
MMC:   sdhci@4f80000: 0, sdhci@4fa0000: 1
Loading Environment from MMC... OK
In:    serial
Out:   serial
Err:   serial
Reading on-board EEPROM at 0x50 failed -1
Net:   
Warning: ethernet@46000000 using MAC address from ROM
eth0: ethernet@46000000
Hit any key to stop autoboot:  0 
switch to partitions #0, OK
mmc1 is current device
SD/MMC found on device 1
1011 bytes read in 5 ms (197.3 KiB/s)
Loaded env from uEnv.txt
Importing environment from mmc1 ...
Running uenvcmd ...
16666632 bytes read in 672 ms (23.7 MiB/s)
70012 bytes read in 8 ms (8.3 MiB/s)
## Flattened Device Tree blob at 88000000
   Booting using the fdt blob at 0x88000000
   Loading Device Tree to 000000008feeb000, end 000000008fffffff ... OK

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 5.4.74-g9574bba32a (logan@logan-HP-Laptop-15-da0xxx) (gcc version 9.2.1 20191025 (GNU Toolchain for the A-profile Architecture 9.2-2019.12 (arm-9.10))) #2 SMP PREEMPT Tue Mar1
[    0.000000] Machine model: Texas Instruments AM654 Base Board
[    0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002810000 (options '')
[    0.000000] printk: bootconsole [ns16550a0] enabled
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a0000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@a0000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a0100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@a0100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a1000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@a1000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a1100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@a1100000, compatible id shared-dma-pool
[    0.000000] cma: Reserved 512 MiB at 0x00000000e0000000
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.1 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: Trusted OS migration not required
[    0.000000] psci: SMC Calling Convention v1.0
[    0.000000] percpu: Embedded 2 pages/cpu s48408 r8192 d74472 u131072
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] CPU features: detected: GIC system register CPU interface
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 55976
[    0.000000] Kernel command line: console=ttyS3,115200n8 earlycon=ns16550a,mmio32,0x02810000 mtdparts=47040000.spi.0:512k(ospi.tiboot3),2m(ospi.tispl),4m(ospi.u-boot),128k(ospi.env),128k(ospi.env.backut
[    0.000000] Dentry cache hash table entries: 524288 (order: 6, 4194304 bytes, linear)
[    0.000000] Inode-cache hash table entries: 262144 (order: 5, 2097152 bytes, linear)
[    0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.000000] software IO TLB: mapped [mem 0xbbff0000-0xbfff0000] (64MB)
[    0.000000] Memory: 3515712K/3586048K available (9598K kernel code, 788K rwdata, 3840K rodata, 1664K init, 683K bss, 18446744073709097664K reserved, 524288K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4.
[    0.000000]  Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: 960 SPIs implemented
[    0.000000] GICv3: 0 Extended SPIs implemented
[    0.000000] GICv3: Distributor has no Range Selector support
[    0.000000] GICv3: 16 PPIs implemented
[    0.000000] GICv3: no VLPI support, no direct LPI support
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001880000
[    0.000000] ITS [mem 0x01820000-0x0182ffff]
[    0.000000] GIC: enabling workaround for ITS: Socionext Synquacer pre-ITS
[    0.000000] ITS@0x0000000001820000: allocated 1048576 Devices @8c0800000 (flat, esz 8, psz 64K, shr 0)
[    0.000000] ITS: using cache flushing for cmd queue
[    0.000000] GICv3: using LPI property table @0x00000008c00d0000
[    0.000000] GIC: using cache flushing for LPI property table
[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000008c00e0000
[    0.000000] random: get_random_bytes called from start_kernel+0x2b8/0x43c with crng_init=0
[    0.000000] arch_timer: cp15 timer(s) running at 200.00MHz (phys).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x2e2049d3e8, max_idle_ns: 440795210634 ns
[    0.000005] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
[    0.008663] Console: colour dummy device 80x25
[    0.013272] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
[    0.023987] pid_max: default: 32768 minimum: 301
[    0.028838] LSM: Security Framework initializing
[    0.033655] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear)
[    0.041263] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear)
[    0.051705] ASID allocator initialised with 32768 entries
[    0.057428] rcu: Hierarchical SRCU implementation.
[    0.062730] Platform MSI: gic-its@1820000 domain created
[    0.068513] PCI/MSI: /bus@100000/interrupt-controller@1800000/gic-its@1820000 domain created
[    0.077757] smp: Bringing up secondary CPUs ...
[    0.083626] Detected VIPT I-cache on CPU1
[    0.083664] GICv3: CPU1: found redistributor 1 region 0:0x00000000018a0000
[    0.083678] GICv3: CPU1: using allocated LPI pending table @0x00000008c00f0000
[    0.083731] CPU1: Booted secondary processor 0x0000000001 [0x410fd034]
[    0.085147] Detected VIPT I-cache on CPU2
[    0.085191] GICv3: CPU2: found redistributor 100 region 0:0x00000000018c0000
[    0.085205] GICv3: CPU2: using allocated LPI pending table @0x00000008c0100000
[    0.085260] CPU2: Booted secondary processor 0x0000000100 [0x410fd034]
[    0.086578] Detected VIPT I-cache on CPU3
[    0.086612] GICv3: CPU3: found redistributor 101 region 0:0x00000000018e0000
[    0.086625] GICv3: CPU3: using allocated LPI pending table @0x00000008c0110000
[    0.086664] CPU3: Booted secondary processor 0x0000000101 [0x410fd034]
[    0.086817] smp: Brought up 1 node, 4 CPUs
[    0.167216] SMP: Total of 4 processors activated.
[    0.172056] CPU features: detected: 32-bit EL0 Support
[    0.177350] CPU features: detected: CRC32 instructions
[    0.194192] CPU: All CPU(s) started at EL2
[    0.198457] alternatives: patching kernel code
[    0.204713] devtmpfs: initialized
[    0.219387] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.229419] futex hash table entries: 1024 (order: 0, 65536 bytes, linear)
[    0.237939] pinctrl core: initialized pinctrl subsystem
[    0.244387] NET: Registered protocol family 16
[    0.256112] DMA: preallocated 256 KiB pool for atomic allocations
[    0.263345] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.293389] HugeTLB registered 16.0 GiB page size, pre-allocated 0 pages
[    0.300306] HugeTLB registered 512 MiB page size, pre-allocated 0 pages
[    0.307101] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.317057] cryptd: max_cpu_qlen set to 1000
[    0.328276] iommu: Default domain type: Translated 
[    0.333758] SCSI subsystem initialized
[    0.338375] mc: Linux media interface: v0.10
[    0.342796] videodev: Linux video capture interface: v2.00
[    0.348458] pps_core: LinuxPPS API ver. 1 registered
[    0.353556] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.362945] PTP clock support registered
[    0.366998] EDAC MC: Ver: 3.0.0
[    0.371480] FPGA manager framework
[    0.375114] Advanced Linux Sound Architecture Driver Initialized.
[    0.382428] clocksource: Switched to clocksource arch_sys_counter
[    0.388957] VFS: Disk quotas dquot_6.6.0
[    0.393092] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes)
[    0.407700] thermal_sys: Registered thermal governor 'step_wise'
[    0.407705] thermal_sys: Registered thermal governor 'power_allocator'
[    0.414462] NET: Registered protocol family 2
[    0.426463] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear)
[    0.435338] TCP established hash table entries: 32768 (order: 2, 262144 bytes, linear)
[    0.443837] TCP bind hash table entries: 32768 (order: 3, 524288 bytes, linear)
[    0.451967] TCP: Hash tables configured (established 32768 bind 32768)
[    0.458983] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear)
[    0.465986] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear)
[    0.473752] NET: Registered protocol family 1
[    0.479328] RPC: Registered named UNIX socket transport module.
[    0.485443] RPC: Registered udp transport module.
[    0.490273] RPC: Registered tcp transport module.
[    0.495103] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.501725] PCI: CLS 0 bytes, default 64
[    0.507020] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
[    0.521028] Initialise system trusted keyrings
[    0.525832] workingset: timestamp_bits=46 max_order=16 bucket_order=0
[    0.539353] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.546106] NFS: Registering the id_resolver key type
[    0.551335] Key type id_resolver registered
[    0.555634] Key type id_legacy registered
[    0.559761] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.566899] 9p: Installing v9fs 9p2000 file system support
[    0.592452] Key type asymmetric registered
[    0.596685] Asymmetric key parser 'x509' registered
[    0.601741] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)
[    0.609338] io scheduler mq-deadline registered
[    0.613989] io scheduler kyber registered
[    0.620716] pinctrl-single 4301c000.pinmux: 70 pins, size 280
[    0.627252] pinctrl-single 11c000.pinmux: 185 pins, size 740
[    0.633225] pinctrl-single 11c2e8.pinmux: 9 pins, size 36
[    0.645093] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
[    0.651473] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
[    0.662052] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
[    0.686317] brd: module loaded
[    0.698120] loop: module loaded
[    0.705463] libphy: Fixed MDIO Bus: probed
[    0.710288] tun: Universal TUN/TAP device driver, 1.6
[    0.716275] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k
[    0.724323] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    0.730458] sky2: driver version 1.30
[    0.735480] VFIO - User Level meta-driver version: 0.3
[    0.741698] i2c /dev entries driver
[    0.746596] sdhci: Secure Digital Host Controller Interface driver
[    0.752944] sdhci: Copyright(c) Pierre Ossman
[    0.757965] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.765199] ledtrig-cpu: registered to indicate activity on CPUs
[    0.771510] ti-sci bus@100000:bus@28380000:bus@42040000:dmsc: invalid resource
[    0.780416] optee: probing for conduit method from DT.
[    0.785736] optee: revision 3.8 (199fca17)
[    0.786557] optee: initialized driver
[    0.796374] NET: Registered protocol family 17
[    0.801141] 9pnet: Installing 9P2000 support
[    0.805606] Key type dns_resolver registered
[    0.810439] registered taskstats version 1
[    0.814659] Loading compiled-in X.509 certificates
[    0.829202] k3-ringacc 2b800000.ringacc: Failed to get MSI domain
[    0.835736] k3-ringacc 3c000000.ringacc: Failed to get MSI domain
[    0.848140] ti-sci bus@100000:bus@28380000:bus@42040000:dmsc: invalid resource
[    0.855793] ti-sci bus@100000:bus@28380000:bus@42040000:dmsc: ABI: 3.1 (firmware rev 0x0014 '20.8.5--v2020.08b (Terrific Lla')
[    0.917510] pca953x 0-0038: 0-0038 supply vcc not found, using dummy regulator
[    0.925045] pca953x 0-0038: using no AI
[    0.950663] random: fast init done
[    0.954739] omap_i2c 42120000.i2c: bus 0 rev0.12 at 400 kHz
[    0.961286] omap_i2c 40b00000.i2c: bus 1 rev0.12 at 100 kHz
[    0.967928] pca953x 2-0021: 2-0021 supply vcc not found, using dummy regulator
[    0.975451] pca953x 2-0021: using no AI
[    1.003348] omap_i2c 2000000.i2c: bus 2 rev0.12 at 400 kHz
[    1.009972] omap_i2c 2010000.i2c: bus 3 rev0.12 at 400 kHz
[    1.016382] omap_i2c 2020000.i2c: bus 4 rev0.12 at 400 kHz
[    1.023110] omap_i2c 2030000.i2c: bus 5 rev0.12 at 400 kHz
[    1.029772] ti-sci-intr bus@100000:bus@28380000:bus@42040000:interrupt-controller2: Interrupt Router 156 domain created
[    1.041072] ti-sci-intr bus@100000:interrupt-controller0: Interrupt Router 100 domain created
[    1.050026] ti-sci-intr bus@100000:navss@30800000:interrupt-controller1: Interrupt Router 182 domain created
[    1.060451] ti-sci-inta 33d00000.interrupt-controller: Interrupt Aggregator domain 179 created
[    1.077482] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,160] sci-dev-id:195
[    1.087509] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled
[    1.094305] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66348100, num_proxies:64
[    1.115988] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:818, gp-rings[304,464] sci-dev-id:187
[    1.126111] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled
[    1.132925] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66348100, num_proxies:64
[    1.141547] 42300000.serial: ttyS0 at MMIO 0x42300000 (irq = 7, base_baud = 6000000) is a 8250
[    1.151542] 40a00000.serial: ttyS1 at MMIO 0x40a00000 (irq = 9, base_baud = 6000000) is a 8250
[    1.161362] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 18, base_baud = 3000000) is a 8250
[    1.171051] 2810000.serial: ttyS3 at MMIO 0x2810000 (irq = 19, base_baud = 3000000) is a 8250
[    1.179856] printk: console [ttyS3] enabled
[    1.179856] printk: console [ttyS3] enabled
[    1.188323] printk: bootconsole [ns16550a0] disabled
[    1.188323] printk: bootconsole [ns16550a0] disabled
[    1.199234] 2820000.serial: ttyS4 at MMIO 0x2820000 (irq = 20, base_baud = 3000000) is a 8250
[    1.258452] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
[    1.266127] libphy: 46000f00.mdio: probed
[    1.271743] davinci_mdio 46000f00.mdio: phy[0]: device 46000f00.mdio:00, driver TI DP83867
[    1.280064] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00102, cpsw version 0x6BA80102 Ports: 2 quirks:00000000
[    1.292954] am65-cpsw-nuss 46000000.ethernet: Failed to request tx dma channel -517
[    1.303015] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010b, freq:200000000, add_val:4 pps:0
[    1.312806] mmc0: CQHCI version 5.10
[    1.357652] mmc0: SDHCI controller on 4f80000.sdhci [4f80000.sdhci] using ADMA 64-bit
[    1.380409] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100
[    1.387464] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100
[    1.397689] ti-udma 285c0000.dma-controller: Channels: 96 (tchan: 48, rchan: 48, gp-rflow: 48)
[    1.421187] ti-udma 31150000.dma-controller: Channels: 267 (tchan: 119, rchan: 148, gp-rflow: 150)
[    1.449778] spi-nor spi7.0: unrecognized JEDEC id bytes: 96 2d 8d 08 20 80
[    1.456753] spi-nor: probe of spi7.0 failed with error -2
[    1.465490] spi-nor spi8.0: cy15b104q (512 Kbytes)
[    1.477239] spi-nor spi9.0: unrecognized JEDEC id bytes: 00 00 00 00 00 00
[    1.484227] spi-nor: probe of spi9.0 failed with error -2
[    1.489829] mmc0: Command Queue Engine enabled
[    1.494298] mmc0: new HS400 MMC card at address 0001
[    1.501076] mmcblk0: mmc0:0001 S0J57X 29.6 GiB 
[    1.505911] mmcblk0boot0: mmc0:0001 S0J57X partition 1 31.5 MiB
[    1.512105] mmcblk0boot1: mmc0:0001 S0J57X partition 2 31.5 MiB
[    1.518272] mmcblk0rpmb: mmc0:0001 S0J57X partition 3 4.00 MiB, chardev (240:0)
[    1.527279]  mmcblk0: p1 p2
[    1.538450] davinci_mdio 46000f00.mdio: davinci mdio revision 9.7, bus freq 1000000
[    1.546139] libphy: 46000f00.mdio: probed
[    1.551683] davinci_mdio 46000f00.mdio: phy[0]: device 46000f00.mdio:00, driver TI DP83867
[    1.560010] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00102, cpsw version 0x6BA80102 Ports: 2 quirks:00000000
[    1.574234] am65-cpsw-nuss 46000000.ethernet: set new flow-id-base 48
[    1.581417] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 57.4
[    1.588741] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
[    1.595674] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010b, freq:200000000, add_val:4 pps:0
[    1.607105] mmc1: CQHCI version 5.10
[    2.383120] mmc1: SDHCI controller on 4fa0000.sdhci [4fa0000.sdhci] using ADMA 64-bit
[    2.392414] debugfs: Directory 'pd:121' with parent 'pm_genpd' already present!
[    2.399799] debugfs: Directory 'pd:120' with parent 'pm_genpd' already present!
[    2.409431] input: gpio-keys as /devices/platform/gpio-keys/input/input0
[    2.416469] hctosys: unable to open rtc device (rtc0)
[    2.437180] ALSA device list:
[    2.440166]   No soundcards found.
[    2.443973] Waiting 2 sec before mounting root device...
[    2.770521] mmc1: new ultra high speed DDR50 SDHC card at address 0001
[    2.777852] mmcblk1: mmc1:0001 0016G 15.2 GiB 
[    2.786485]  mmcblk1: p1 p2
[    4.884424] EXT4-fs (mmcblk1p2): recovery complete
[    4.894324] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null)
[    4.902523] VFS: Mounted root (ext4 filesystem) on device 179:98.
[    4.914966] devtmpfs: mounted
[    4.918798] Freeing unused kernel memory: 1664K
[    4.923400] Run /sbin/init as init process
[    5.366389] systemd[1]: System time before build time, advancing clock.
[    5.453676] NET: Registered protocol family 10
[    5.459265] Segment Routing with IPv6
[    5.498138] systemd[1]: systemd 244.3+ running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR -SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD )
[    5.520367] systemd[1]: Detected architecture arm64.

Welcome to Arago 2020.09!

[    5.579400] systemd[1]: Set hostname to <am65xx-evm>.
[    5.976622] systemd[1]: /lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit .
[    6.117339] random: systemd: uninitialized urandom read (16 bytes read)
[    6.124308] systemd[1]: system-getty.slice: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling.
[    6.136668] systemd[1]: (This warning is only shown for the first unit using IP firewalling.)
[    6.149147] systemd[1]: Created slice system-getty.slice.
[  OK  ] Created slice system-getty.slice.
[    6.170729] random: systemd: uninitialized urandom read (16 bytes read)
[    6.179222] systemd[1]: Created slice system-serial\x2dgetty.slice.
[  OK  ] Created slice system-serial\x2dgetty.slice.
[    6.198607] random: systemd: uninitialized urandom read (16 bytes read)
[    6.206884] systemd[1]: Created slice User and Session Slice.
[  OK  ] Created slice User and Session Slice.
[    6.226911] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[  OK  ] Started Dispatch Password …ts to Console Directory Watch.
[    6.250728] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Started Forward Password R…uests to Wall Directory Watch.
[    6.274768] systemd[1]: Reached target Paths.
[  OK  ] Reached target Paths.
[    6.290596] systemd[1]: Reached target Remote File Systems.
[  OK  ] Reached target Remote File Systems.
[    6.306566] systemd[1]: Reached target Slices.
[  OK  ] Reached target Slices.
[    6.322576] systemd[1]: Reached target Swap.
[  OK  ] Reached target Swap.
[    6.340989] systemd[1]: Listening on RPCbind Server Activation Socket.
[  OK  ] Listening on RPCbind Server Activation Socket.
[    6.358654] systemd[1]: Reached target RPC Port Mapper.
[  OK  ] Reached target RPC Port Mapper.
[    6.380943] systemd[1]: Listening on Process Core Dump Socket.
[  OK  ] Listening on Process Core Dump Socket.
[    6.398874] systemd[1]: Listening on initctl Compatibility Named Pipe.
[  OK  ] Listening on initctl Compatibility Named Pipe.
[    6.432992] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
[    6.441896] systemd[1]: Listening on Journal Socket (/dev/log).
[  OK  ] Listening on Journal Socket (/dev/log).
[    6.463148] systemd[1]: Listening on Journal Socket.
[  OK  ] Listening on Journal Socket.
[    6.479267] systemd[1]: Listening on Network Service Netlink Socket.
[  OK  ] Listening on Network Service Netlink Socket.
[    6.498993] systemd[1]: Listening on udev Control Socket.
[  OK  ] Listening on udev Control Socket.
[    6.514883] systemd[1]: Listening on udev Kernel Socket.
[  OK  ] Listening on udev Kernel Socket.
[    6.537101] systemd[1]: Mounting Huge Pages File System...
         Mounting Huge Pages File System...
[    6.560646] systemd[1]: Mounting POSIX Message Queue File System...
         Mounting POSIX Message Queue File System...
[    6.588931] systemd[1]: Mounting Kernel Debug File System...
         Mounting Kernel Debug File System...
[    6.614043] systemd[1]: Mounting Temporary Directory (/tmp)...
         Mounting Temporary Directory (/tmp)...
[    6.637713] systemd[1]: Starting Create list of static device nodes for the current kernel...
         Starting Create list of st…odes for the current kernel...
[    6.669039] systemd[1]: Starting Start psplash boot splash screen...
         Starting Start psplash boot splash screen...
[    6.704335] systemd[1]: Started Hardware RNG Entropy Gatherer Daemon.
[  OK  ] Started Hardware RNG Entropy Gatherer Daemon.
[    6.729498] systemd[1]: Starting RPC Bind...
         Starting RPC Bind...
[    6.742889] systemd[1]: Condition check resulted in File System Check on Root Device being skipped.
[    6.759918] systemd[1]: Starting Journal Service...
         Starting Journal Service...
[    6.784085] systemd[1]: Starting Load Kernel Modules...
         Starting Load Kernel Modules...
[    6.812758] systemd[1]: Starting Remount Root and Kernel File Systems...
[    6.815174] cryptodev: loading out-of-tree module taints kernel.
         Starting Remount Root and Kernel File Systems...
[    6.838940] cryptodev: driver 1.10 loaded.
[    6.840985] EXT4-fs (mmcblk1p2): re-mounted. Opts: (null)
[    6.849226] systemd[1]: Starting udev Coldplug all Devices...
         Starting udev Coldplug all Devices...
[    6.877898] systemd[1]: Started RPC Bind.
[  OK  ] Started RPC Bind.
[    6.897542] systemd[1]: Mounted Huge Pages File System.
[  OK  ] Mounted Huge Pages File System.
[    6.919637] systemd[1]: Mounted POSIX Message Queue File System.
[  OK  ] Mounted POSIX Message Queue File System.
[    6.939335] systemd[1]: Mounted Kernel Debug File System.
[  OK  ] Mounted Kernel Debug File System.
[    6.959212] systemd[1]: Started Journal Service.
[  OK  ] Started Journal Service.
[  OK  ] Mounted Temporary Directory (/tmp).
[  OK  ] Started Create list of sta… nodes for the current kernel.
[FAILED] Failed to start Start psplash boot splash screen.
See 'systemctl status psplash-start.service' for details.
[DEPEND] Dependency failed for Star…progress communication helper.
[  OK  ] Started Load Kernel Modules.
[  OK  ] Started Remount Root and Kernel File Systems.
         Mounting Kernel Configuration File System...
         Starting Flush Journal to Persistent Storage...
         Starting Apply Kernel Variables...
[    7.161260] systemd-journald[177]: Received client request to flush runtime journal.
         Starting Create Static Device Nodes in /dev...
[  OK  ] Mounted Kernel Configuration File System.
[  OK  ] Started Flush Journal to Persistent Storage.
[  OK  ] Started Apply Kernel Variables.
[  OK  ] Started Create Static Device Nodes in /dev.
[  OK  ] Reached target Local File Systems (Pre).
         Mounting /media/ram...
         Mounting /var/volatile...
         Starting udev Kernel Device Manager...
[  OK  ] Mounted /media/ram.
[  OK  ] Mounted /var/volatile.
         Starting Load/Save Random Seed...
[  OK  ] Reached target Local File Systems.
         Starting Create Volatile Files and Directories...
[  OK  ] Started Create Volatile Files and Directories.
         Starting Network Time Synchronization...
         Starting Update UTMP about System Boot/Shutdown...
[  OK  ] Started udev Kernel Device Manager.
[  OK  ] Started Update UTMP about System Boot/Shutdown.
[  OK  ] Started Network Time Synchronization.
[  OK  ] Reached target System Time Set.
[  OK  ] Reached target System Time Synchronized.
[  OK  ] Started udev Coldplug all Devices.
[  OK  ] Reached target System Initialization.
[  OK  ] Started Daily rotation of log files.
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Reached target Timers.
[  OK  ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
[  OK  ] Listening on D-Bus System Message Bus Socket.
         Starting Docker Socket for the API.
[  OK  ] Listening on dropbear.socket.
         Starting Reboot and dump vmcore via kexec...
[  OK  ] Listening on Docker Socket for the API.
[  OK  ] Reached target Sockets.
[  OK  ] Reached target Basic System.
[  OK  ] Started Job spooling tools.
[  OK  ] Started Periodic Command Scheduler.
[  OK  ] Started D-Bus System Message Bus.
         Starting Print notice about GPLv3 packages...
         Starting IPv6 Packet Filtering Framework...
         Starting IPv4 Packet Filtering Framework...
[  OK  ] Started irqbalance daemon.
         Starting rc.pvr.service...
         Starting Login Service...
[  OK  ] Started Reboot and dump vmcore via kexec.
[  OK  ] Started IPv6 Packet Filtering Framework.
[  OK  ] Started IPv4 Packet Filtering Framework.
[  OK  ] Reached target Network (Pre).
         Starting Network Service...
[    8.482562] [drm] Initialized pvr 1.17.4948957 20110701 for 7000000.gpu on minor 0
[    8.601783] PVR_K: UM DDK-(4948957) and KM DDK-(4948957) match. [ OK ]
[  OK  ] Started rc.pvr.service.
         Starting weston.service...
[  OK  ] Started weston.service.
         Starting Matrix GUI...
         Starting telnetd.service...
[  OK  ] Started Network Service.
         Starting Wait for Network to be Configured...
         Starting Network Name Resolution...
[  OK  ] Started Matrix GUI.
[  OK  ] Started Login Service.
[  OK  ] Started telnetd.service.
[  OK  ] Started Network Name Resolution.
[  OK  ] Reached target Network.
[  OK  ] Reached target Host and Network Name Lookups.
         Starting Avahi mDNS/DNS-SD Stack...
[  OK  ] Started NFS status monitor for NFSv2/3 locking..
         Starting Simple Network Ma…ent Protocol (SNMP) Daemon....
         Starting Permit User Sessions...
[  OK  ] Started Permit User Sessions.
[  OK  ] Started Getty on tty1.
[    9.385154] ov5640 3-003c: 3-003c supply DOVDD not found, using dummy regulator
[  OK  ] Started Serial Getty on ttyS1.
[  OK  ] Started Serial Getty on ttyS2.
[  OK  ] Started Serial Getty on ttyS3.
[  OK  ] Reached target Login Prompts.
         Starting Synchronize System and HW clocks...
[  OK  ] Started Avahi mDNS/DNS-SD Stack.
[FAILED] Failed to start Synchronize System and HW clocks.
See 'systemctl status sync-clocks.service' for details.
[    9.475727] ov5640 3-003c: 3-003c supply AVDD not found, using dummy regulator
[    9.607654] ov5640 3-003c: 3-003c supply DVDD not found, using dummy regulator
[    9.643357] at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[    9.670503] random: crng init done
[    9.673932] random: 7 urandom warning(s) missed due to ratelimiting
[    9.734642] ov5640 3-003c: ov5640_read_reg: error: reg=300a
[    9.740383] ov5640 3-003c: ov5640_check_chip_id: failed to read chip identifier
[    9.760151] ov5640: probe of 3-003c failed with error -121
[    9.774626] davinci_mdio b132400.mdio: davinci mdio revision 1.7, bus freq 1000000
[    9.787178] libphy: b132400.mdio: probed
[  OK  ] Started Load/Save Random Seed.
[    9.901463] davinci_mdio b132400.mdio: phy[0]: device b132400.mdio:00, driver TI DP83867
[   10.023105] davinci_mdio b132400.mdio: phy[1]: device b132400.mdio:01, driver TI DP83867
[   10.401630] davinci_mdio b232400.mdio: davinci mdio revision 1.7, bus freq 1000000
[   10.456222] libphy: b232400.mdio: probed
[   10.627474] davinci_mdio b232400.mdio: phy[0]: device b232400.mdio:00, driver TI DP83867
[   10.649595] davinci_mdio b232400.mdio: phy[1]: device b232400.mdio:01, driver TI DP83867
[   10.846536] platform 41000000.r5f: configured R5F for remoteproc mode
[   10.887076] platform 41000000.r5f: assigned reserved memory node r5f-dma-memory@a0000000
[   10.898710] remoteproc remoteproc0: 41000000.r5f is available
[   10.925147] TI DP83867 46000f00.mdio:00: attached PHY driver [TI DP83867] (mii_bus:phy_addr=46000f00.mdio:00, irq=POLL)
[   10.944279] am65-cpsw-nuss 46000000.ethernet eth0: Link is Down
[   10.964449] remoteproc remoteproc0: powering up 41000000.r5f
[   10.970524] remoteproc remoteproc0: Booting fw image am65x-mcu-r5f0_0-fw, size 85036
[  OK  ] Started Simple Network Man…ement P[   10.983963] platform 41000000.r5f: booting R5F core using boot addr = 0x0
rotocol (SNMP) Daemon..
[   10.998805]  remoteproc0#vdev0buffer: assigned reserved memory node r5f-dma-memory@a0000000
[   11.008421] virtio_rpmsg_bus virtio0: rpmsg host is online
[   11.014113]  remoteproc0#vdev0buffer: registered virtio0 (type 7)
[   11.014543] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xd
[   11.020279] remoteproc remoteproc0: remote processor 41000000.r5f is now up
[   11.030750] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xe
[  OK  ] Created slice system-systemd\x2dcoredump.slice.
[  OK  ] Started Process Core Dump (PID 508/UID 0).
[   12.209449] remoteproc remoteproc1: b034000.pru is available
[   12.323736] pru-rproc b034000.pru: PRU rproc node /bus@100000/icssg@b000000/pru@34000 probed successfully
[   12.395323] remoteproc remoteproc2: b004000.rtu is available
[   12.418602] pru-rproc b004000.rtu: PRU rproc node /bus@100000/icssg@b000000/rtu@4000 probed successfully
[   12.492432] pru-rproc b00a000.txpru: IRQ vring not found
[   12.524025] pru-rproc b00a000.txpru: IRQ kick not found
[   12.555492] remoteproc remoteproc3: b00a000.txpru is available
[   12.562769] pru-rproc b00a000.txpru: PRU rproc node /bus@100000/icssg@b000000/txpru@a000 probed successfully
[   12.630797] remoteproc remoteproc4: b038000.pru is available
[   12.665722] pru-rproc b038000.pru: PRU rproc node /bus@100000/icssg@b000000/pru@38000 probed successfully
[   12.846317] remoteproc remoteproc5: b006000.rtu is available
[   13.027321] pru-rproc b006000.rtu: PRU rproc node /bus@100000/icssg@b000000/rtu@6000 probed successfully
[   13.243601] pru-rproc b00c000.txpru: IRQ vring not found
[   13.270593] pru-rproc b00c000.txpru: IRQ kick not found
[   13.326774] remoteproc remoteproc6: b00c000.txpru is available
[   13.419836] pru-rproc b00c000.txpru: PRU rproc node /bus@100000/icssg@b000000/txpru@c000 probed successfully
[   13.530179] remoteproc remoteproc7: b134000.pru is available
[   13.709142] pru-rproc b134000.pru: PRU rproc node /bus@100000/icssg@b100000/pru@34000 probed successfully
[   13.944093] remoteproc remoteproc8: b104000.rtu is available
[  OK  ] Created slice system-systemd\x2dfsck.slice.
[   14.143396] pru-rproc b104000.rtu: PRU rproc node /bus@100000/icssg@b100000/rtu@4000 probed successfully
[   14.331846] pru-rproc b10a000.txpru: IRQ vring not found
[   14.515897] pru-rproc b10a000.txpru: IRQ kick not found
[   14.562340] remoteproc remoteproc9: b10a000.txpru is available
[   14.612336] pru-rproc b10a000.txpru: PRU rproc node /bus@100000/icssg@b100000/txpru@a000 probed successfully
***************************************************************
***************************************************************
NOTICE: This file system contains the following GPLv3 packages:
        autoconf
        bash-dev
        bash
        bc
        binutils
        cifs-utils
        coreutils-stdbuf
        coreutils
        cpio
        cpp-symlinks
        cpp
        dosfstools
        elfutils
        g++-symlinks
        g++
        gawk
        gcc-symlinks
        gcc
        gdb
        gdbserver
        gettext
        glmark2
        gstreamer1.0-libav
        gzip
        less
        libasm1
        libbfd
        libdw1
        libelf1
        libgdbm-compat4
        libgdbm-dev
        libgdbm6
        libgettextlib
        libgettextsrc
        libgmp10
        libidn2-0
        libmpc3
        libmpfr6
        libreadline-dev
        libreadline8
        libunistring2
        m4-dev
        m4
        make
        nettle
        parted
        pdm-anomaly-detection
        tar
        which

If you do not wish to distribute GPLv3 components please remove
the above packages prior[   14.723017] remoteproc remoteproc10: b138000.pru is available
 to distribution.  This can be done using
the opkg remove command.  i.e.:
    opkg remove <package>
Where <package> is the name printed in the list above

NOTE: If the package is a dependency of another package you
      will be notified of the dependent packages.  You should
      use the --force-removal-of-dependent-packages option to
      also remove the dependent packages as well
***************************************************************
***************************************************************
[   14.888753] pru-rproc b138000.pru: PRU rproc node /bus@100000/icssg@b100000/pru@38000 probed successfully
[   14.940503] remoteproc remoteproc11: b106000.rtu is available
[   14.984598] pru-rproc b106000.rtu: PRU rproc node /bus@100000/icssg@b100000/rtu@6000 probed successfully
[   15.131629] pru-rproc b10c000.txpru: IRQ vring not found
[   15.176575] pru-rproc b10c000.txpru: IRQ kick not found
[   15.251308] remoteproc remoteproc12: b10c000.txpru is available
[   15.282701] pru-rproc b10c000.txpru: PRU rproc node /bus@100000/icssg@b100000/txpru@c000 probed successfully
[   15.409865] dwc3 4030000.usb: Failed to get clk 'ref': -2
[   15.411154] remoteproc remoteproc13: b234000.pru is available

 _____                    _____           _         _   
|  _  |___ ___ ___ ___   |  _  |___ ___  |_|___ ___| |_ 
|     |  _| .'| . | . |  |   __|  _| . | | | -_|  _|  _|
|__|__|_| |__,|_  |___|  |__|  |_| |___|_| |___|___|_|  
              |___|                    |___|            

Arago Project http://arago-project.org am65xx-evm ttyS3

Arago 2020.09 am65xx-evm ttyS3

am65xx-evm login: [   15.495879] pru-rproc b234000.pru: PRU rproc node /bus@100000/icssg@b200000/pru@34000 probed successfully
[   15.755885] remoteproc remoteproc14: b204000.rtu is available
[   15.774560] pru-rproc b204000.rtu: PRU rproc node /bus@100000/icssg@b200000/rtu@4000 probed successfully
[   15.811738] pru-rproc b20a000.txpru: IRQ vring not found
[   15.838281] pru-rproc b20a000.txpru: IRQ kick not found
[   15.853062] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[   15.877157] remoteproc remoteproc15: b20a000.txpru is available
[   15.938673] pru-rproc b20a000.txpru: PRU rproc node /bus@100000/icssg@b200000/txpru@a000 probed successfully
[   16.149011] remoteproc remoteproc16: b238000.pru is available
[   16.157987] pru-rproc b238000.pru: PRU rproc node /bus@100000/icssg@b200000/pru@38000 probed successfully
[   16.174068] remoteproc remoteproc17: b206000.rtu is available
[   16.185508] pru-rproc b206000.rtu: PRU rproc node /bus@100000/icssg@b200000/rtu@6000 probed successfully
[   16.213410] pru-rproc b20c000.txpru: IRQ vring not found
[   16.231360] pru-rproc b20c000.txpru: IRQ kick not found
[   16.236868] remoteproc remoteproc18: b20c000.txpru is available
[   16.322235] pru-rproc b20c000.txpru: PRU rproc node /bus@100000/icssg@b200000/txpru@c000 probed successfully
[   16.474752] b128000.serial: ttyS5 at MMIO 0xb128000 (irq = 1336, base_baud = 12000000) is a 16550A
[   16.612333] icssg-prueth pruss1_eth: TI PRU ethernet driver initialized: dual EMAC mode
[   16.838503] icssg-prueth pruss2_eth: TI PRU ethernet driver initialized: dual EMAC mode
[   17.257799] remoteproc remoteproc10: powering up b138000.pru
[   17.268129] remoteproc remoteproc10: Booting fw image ti-pruss/am65x-sr2-pru1-prueth-fw.elf, size 35824
[   17.297928] pru-rproc b138000.pru: configured system_events[159-0] = 00000000,00000000,00000000,00000000,02000000
[   17.308280] pru-rproc b138000.pru: configured intr_channels = 0x00000002 host_intr = 0x00000008
[   17.324441] remoteproc remoteproc10: remote processor b138000.pru is now up
[   17.331562] remoteproc remoteproc11: powering up b106000.rtu
[   17.344231] remoteproc remoteproc11: Booting fw image ti-pruss/am65x-sr2-rtu1-prueth-fw.elf, size 27900
[   17.353755] remoteproc remoteproc11: remote processor b106000.rtu is now up
[   17.374513] remoteproc remoteproc12: powering up b10c000.txpru
[   17.382392] remoteproc remoteproc12: Booting fw image ti-pruss/am65x-sr2-txpru1-prueth-fw.elf, size 30264
[   17.394479] remoteproc remoteproc12: remote processor b10c000.txpru is now up
[   17.403772] TI DP83867 b132400.mdio:01: attached PHY driver [TI DP83867] (mii_bus:phy_addr=b132400.mdio:01, irq=POLL)
[   17.418485] net eth2: started
[   17.462648] remoteproc remoteproc7: powering up b134000.pru
[   17.470334] remoteproc remoteproc7: Booting fw image ti-pruss/am65x-sr2-pru0-prueth-fw.elf, size 35548
[   17.482724] pru-rproc b134000.pru: configured system_events[159-0] = 00000000,00000000,00000000,00000000,01000000
[   17.493065] pru-rproc b134000.pru: configured intr_channels = 0x00000001 host_intr = 0x00000004
[   17.506457] remoteproc remoteproc7: remote processor b134000.pru is now up
[   17.513410] remoteproc remoteproc8: powering up b104000.rtu
[   17.520784] remoteproc remoteproc8: Booting fw image ti-pruss/am65x-sr2-rtu0-prueth-fw.elf, size 28664
[   17.531154] remoteproc remoteproc8: remote processor b104000.rtu is now up
[   17.539093] remoteproc remoteproc9: powering up b10a000.txpru
[   17.550823] remoteproc remoteproc9: Booting fw image ti-pruss/am65x-sr2-txpru0-prueth-fw.elf, size 31620
[   17.560412] remoteproc remoteproc9: remote processor b10a000.txpru is now up
[   17.579712] TI DP83867 b132400.mdio:00: attached PHY driver [TI DP83867] (mii_bus:phy_addr=b132400.mdio:00, irq=POLL)
[   17.594729] net eth1: started
[   17.616913] remoteproc remoteproc16: powering up b238000.pru
[   17.622883] remoteproc remoteproc16: Booting fw image ti-pruss/am65x-sr2-pru1-prueth-fw.elf, size 35824
[   17.638632] pru-rproc b238000.pru: configured system_events[159-0] = 00000000,00000000,00000000,00000000,02000000
[   17.649082] pru-rproc b238000.pru: configured intr_channels = 0x00000002 host_intr = 0x00000008
[   17.657894] remoteproc remoteproc16: remote processor b238000.pru is now up
[   17.670484] remoteproc remoteproc17: powering up b206000.rtu
[   17.676404] remoteproc remoteproc17: Booting fw image ti-pruss/am65x-sr2-rtu1-prueth-fw.elf, size 27900
[   17.685867] remoteproc remoteproc17: remote processor b206000.rtu is now up
[   17.698471] remoteproc remoteproc18: powering up b20c000.txpru
[   17.704532] remoteproc remoteproc18: Booting fw image ti-pruss/am65x-sr2-txpru1-prueth-fw.elf, size 30264
[   17.714166] remoteproc remoteproc18: remote processor b20c000.txpru is now up
[   17.727730] TI DP83867 b232400.mdio:01: attached PHY driver [TI DP83867] (mii_bus:phy_addr=b232400.mdio:01, irq=POLL)
[   17.742489] net eth4: started
[   17.757556] remoteproc remoteproc13: powering up b234000.pru
[   17.763514] remoteproc remoteproc13: Booting fw image ti-pruss/am65x-sr2-pru0-prueth-fw.elf, size 35548
[   17.773143] pru-rproc b234000.pru: configured system_events[159-0] = 00000000,00000000,00000000,00000000,01000000
[   17.790468] pru-rproc b234000.pru: configured intr_channels = 0x00000001 host_intr = 0x00000004
[   17.799222] remoteproc remoteproc13: remote processor b234000.pru is now up
[   17.810479] remoteproc remoteproc14: powering up b204000.rtu
[   17.816426] remoteproc remoteproc14: Booting fw image ti-pruss/am65x-sr2-rtu0-prueth-fw.elf, size 28664
[   17.825946] remoteproc remoteproc14: remote processor b204000.rtu is now up
[   17.838481] remoteproc remoteproc15: powering up b20a000.txpru
[   17.844578] remoteproc remoteproc15: Booting fw image ti-pruss/am65x-sr2-txpru0-prueth-fw.elf, size 31620
[   17.854242] remoteproc remoteproc15: remote processor b20a000.txpru is now up
[   17.871785] TI DP83867 b232400.mdio:00: attached PHY driver [TI DP83867] (mii_bus:phy_addr=b232400.mdio:00, irq=POLL)
[   17.886706] net eth3: started

am65xx-evm login: root
Last login: Wed Nov 25 15:19:31 UTC 2020
root@am65xx-evm:~# cat /proc/mtd
dev:    size   erasesize  name
mtd0: 00080000 00000200 "47050000.spi.0"
root@am65xx-evm:~#

    Please guide me to solve this issue.

    Thanks & Regards,

    logan

  • 0 in reply to Logan A
    TI__Guru** 113810 points

    Hi Logan,

    I have to re-establish some basic questions, please bear with me on this:

    1. You are trying this on the custom hardware with AM65 device. 
    2. Your software is adapted from the SDK 7.01 - the customization does not involve any changes to OSPI driver etc.
    3. I am going to check internally if anyone has seen this issue and has any debug pointers with just this error message that you have highlighted above.
    4. To help debug the problem, it would be firstly useful to have a reproducible test case. The read/write to the OSPI is being done from the Linux user space? Would you be able to share the test case with TI so that I can run the same on the TI EVM to determine the next steps?
    5. Can you please also comment on the reproducibility of the issue?

    Regards

    Karthik

  • 0 in reply to Karthik Ramanan
    Prodigy 160 points

    Hi,

    1. We are working in AM6546 custom board

    2. We are using the Micron OSPI Flash Part number MT35XU512ABA1G12-0AAT.

    Customer required spi-max-frequency = 166MHz, so we configured as per previous post.

    3. Please find the attached ospi_test file & Debug_log. while running randomly facing kernel crash issue.

    Fullscreen 1016.ospi_test.txt Download 
    #!/bin/sh
echo "Script to Write and Read from ospi multiple times."

usleep 500000;

while true
do

	echo "WELCOME" > /dev/mtdblock0

        usleep 1000000;
	
        read=`head -n 1 /dev/mtdblock0`

        if [ $read == "WELCOME" ]
        then
   		echo "OSPI Test Passed."
        else
		echo "OSPI Test Failed."
        fi

        usleep 1000000;
done

    If i configure ospi as per previous post, we are facing ospi timeout issue and it can producible.

    Fullscreen 8270.Debug_log.txt Download 
    OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
[49132.003651] cadence-qspi 47040000.spi: Indirect write completion error (-110)
[49132.010877] spi-nor spi7.0: operation failed with -110
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
OSPI Test Passed.
[82357.566878] Unable to handle kernel NULL pointer dereference at virtual address 0000000000000000
[82357.575663] Mem abort info:
[82357.578448]   ESR = 0x86000007
[82357.581494]   EC = 0x21: IABT (current EL), IL = 32 bits
[82357.586791]   SET = 0, FnV = 0
[82357.589836]   EA = 0, S1PTW = 0
[82357.592971] user pgtable: 64k pages, 48-bit VAs, pgdp=00000008c7090200
[82357.599484] [0000000000000000] pgd=00000008c50b0003, pud=00000008c50b0003, pmd=00000008c5080003, pte=0000000000000000
[82357.610078] Internal error: Oops: 86000007 [#1] PREEMPT SMP
[82357.615638] Modules linked in: xt_conntrack xt_MASQUERADE xt_addrtype iptable_filter iptable_nat nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 libcrc32c ip_tables x_tables br_netfilter bridge stp llc xfrm_user xfrm_algo sha512_generic sha512_arm64 md5 des_generic libdes cbc rpmsg_char 8250_pruss icssg_prueth dwc3 ti_am335x_adc udc_core kfifo_buf usb_common icss_iep crct10dif_ce pru_rproc irq_pruss_intc ti_k3_r5_remoteproc virtio_rpmsg_bus ti_am335x_tscadc pruss ti_cal phy_omap_usb2 dwc3_keystone ov5640 v4l2_fwnode at24 pvrsrvkm(O) sch_fq_codel jailhouse(O) cryptodev(O) ipv6
[82357.666812] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G           O      5.4.74-g9574bba32a #9
[82357.675145] Hardware name: Texas Instruments AM654 Base Board (DT)
[82357.681314] pstate: 40000085 (nZcv daIf -PAN -UAO)
[82357.686097] pc : 0x0
[82357.688276] lr : 0x0
[82357.690454] sp : ffff80001000ff60
[82357.693758] x29: 0000000000000000 x28: ffff800010e8a430 
[82357.699059] x27: ffff00087fa48430 x26: ffff800010010000 
[82357.704360] x25: ffff800010000000 x24: ffff800010fdb700 
[82357.709661] x23: 0000000000000001 x22: 0000000000000003 
[82357.714962] x21: ffff000840022180 x20: ffff800011005cb8 
[82357.720264] x19: ffff000840041800 x18: 0000000000000000 
[82357.725565] x17: 0000000000000000 x16: 0000000000000000 
[82357.730865] x15: 0000000000000000 x14: 0000000000000000 
[82357.736165] x13: 0000000000000001 x12: 0000000000000632 
[82357.741466] x11: 0000000000000115 x10: 000000000018d97d 
[82357.746767] x9 : 0000000000000632 x8 : 00004ae755f4b000 
[82357.752067] x7 : 7fffffffffffffff x6 : 00000efb52cd2440 
[82357.757368] x5 : 00ffffffffffffff x4 : 001efe9200000000 
[82357.762669] x3 : 0000000033333333 x2 : ffff8000107dfd98 
[82357.767969] x1 : 0000000000000007 x0 : 0000000000000001 
[82357.773270] Call trace:
[82357.775719] Code: bad PC value
[82357.778775] ---[ end trace 2131ad08806e5dd6 ]---
[82357.783383] Kernel panic - not syncing: Fatal exception in interrupt
[82357.789723] SMP: stopping secondary CPUs
[82357.793640] Kernel Offset: disabled
[82357.797120] CPU features: 0x0002,2000200c
[82357.801118] Memory Limit: none
[82357.804169] ---[ end Kernel panic - not syncing: Fatal exception in interrupt ]---

    Thanks & Regards,

    Logan

  • 0 in reply to Logan A
    TI__Guru**** 169240 points

    Logan,

    https://e2e.ti.com/support/processors/f/processors-forum/985694/am6546-kernel-crash

    I believe the above is similar. I am closing this & working on the above. Please feel free to reply on this if you believe both are separate
    issues.

    - Keerthy