AM5728: Remoteproc MMU error

Hi, 

I followed the step-by-step procedure to add IPC to UART_BasicExample_evmAM572x_m4ExampleProject. I used:

IPC: 3.50.3.05

BIOS: 6.75.2.00

PFK: 1.0.15

XDCtools: 3.51.1.18_core

Unfortunately, the firmware load fails with this MMU error message:

CPU : DRA752-GP ES2.0
Model: TI AM5728 BeagleBoard-X15 rev C
Board: BeagleBoard X15 REV C.00
DRAM: 2 GiB
MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1
Loading Environment from FAT... OK
Net:
Warning: ethernet@48484000 using MAC address from ROM
eth0: ethernet@48484000
Hit any key to stop autoboot: 0
switch to partitions #0, OK
mmc0 is current device
SD/MMC found on device 0
** Unable to read file boot.scr **
1490 bytes read in 2 ms (727.5 KiB/s)
Loaded env from uEnv.txt
Importing environment from mmc0 ...
Running uenvcmd ...
1 bytes read in 1 ms (1000 Bytes/s)
Already setup.
switch to partitions #0, OK
mmc0 is current device
SD/MMC found on device 0
4403712 bytes read in 200 ms (21 MiB/s)
90754 bytes read in 7 ms (12.4 MiB/s)
## Flattened Device Tree blob at 88000000
Booting using the fdt blob at 0x88000000
Loading Device Tree to 8ffe6000, end 8ffff281 ... OK

Starting kernel ...

[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.19.59-g5f8c1c6121 (oe-user@oe-host) (gcc version 8.3.0 (GNU Toolchain for the A-profile Architecture 8.3-2019.03 (arm-rel-8.36))) #1 SMP PREEMPT Sat Oct 19 16:29:33 UTC 2019
[ 0.000000] CPU: ARMv7 Processor [412fc0f2] revision 2 (ARMv7), cr=30c5387d
[ 0.000000] CPU: div instructions available: patching division code
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[ 0.000000] OF: fdt: Machine model: TI AM5728 BeagleBoard-X15 rev C
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] efi: Getting EFI parameters from FDT:
[ 0.000000] efi: UEFI not found.
[ 0.000000] Reserved memory: created CMA memory pool at 0x0000000095800000, size 56 MiB
[ 0.000000] OF: reserved mem: initialized node ipu2-memory@95800000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x0000000099000000, size 64 MiB
[ 0.000000] OF: reserved mem: initialized node dsp1-memory@99000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x000000009d000000, size 32 MiB
[ 0.000000] OF: reserved mem: initialized node ipu1-memory@9d000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x000000009f000000, size 8 MiB
[ 0.000000] OF: reserved mem: initialized node dsp2-memory@9f000000, compatible id shared-dma-pool
[ 0.000000] cma: Reserved 24 MiB at 0x00000000fe400000
[ 0.000000] OMAP4: Map 0x00000000ffd00000 to (ptrval) for dram barrier
[ 0.000000] DRA752 ES2.0
[ 0.000000] random: get_random_bytes called from start_kernel+0xb4/0x470 with crng_init=0
[ 0.000000] percpu: Embedded 16 pages/cpu s36492 r8192 d20852 u65536
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 472640
[ 0.000000] Kernel command line: console=ttyS2,115200n8 root=PARTUUID=2306154f-02 rw rootfstype=ext4 rootwait
[ 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: 1673728K/1897472K available (10240K kernel code, 333K rwdata, 2772K rodata, 2048K init, 269K bss, 35328K reserved, 188416K cma-reserved, 1283072K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0xf0800000 - 0xff800000 ( 240 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xf0000000 ( 768 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0x(ptrval) - 0x(ptrval) (12256 kB)
[ 0.000000] .init : 0x(ptrval) - 0x(ptrval) (2048 kB)
[ 0.000000] .data : 0x(ptrval) - 0x(ptrval) ( 334 kB)
[ 0.000000] .bss : 0x(ptrval) - 0x(ptrval) ( 270 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] rcu: Preemptible hierarchical RCU implementation.
[ 0.000000] Tasks RCU enabled.
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] GIC: Using split EOI/Deactivate mode
[ 0.000000] OMAP clockevent source: timer1 at 32786 Hz
[ 0.000000] arch_timer: cp15 timer(s) running at 6.14MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x16af5adb9, max_idle_ns: 440795202250 ns
[ 0.000005] sched_clock: 56 bits at 6MHz, resolution 162ns, wraps every 4398046511023ns
[ 0.000018] Switching to timer-based delay loop, resolution 162ns
[ 0.000291] clocksource: 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns
[ 0.000301] OMAP clocksource: 32k_counter at 32768 Hz
[ 0.000744] Console: colour dummy device 80x30
[ 0.000786] Calibrating delay loop (skipped), value calculated using timer frequency.. 12.29 BogoMIPS (lpj=61475)
[ 0.000803] pid_max: default: 32768 minimum: 301
[ 0.000924] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000939] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001493] CPU: Testing write buffer coherency: ok
[ 0.001533] CPU0: Spectre v2: using ICIALLU workaround
[ 0.001746] /cpus/cpu@0 missing clock-frequency property
[ 0.001766] /cpus/cpu@1 missing clock-frequency property
[ 0.001779] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.059930] Setting up static identity map for 0x80200000 - 0x80200060
[ 0.079943] rcu: Hierarchical SRCU implementation.
[ 0.100138] EFI services will not be available.
[ 0.120007] smp: Bringing up secondary CPUs ...
[ 0.200394] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.200400] CPU1: Spectre v2: using ICIALLU workaround
[ 0.200523] smp: Brought up 1 node, 2 CPUs
[ 0.200535] SMP: Total of 2 processors activated (24.59 BogoMIPS).
[ 0.200543] CPU: All CPU(s) started in HYP mode.
[ 0.200551] CPU: Virtualization extensions available.
[ 0.201103] devtmpfs: initialized
[ 0.217573] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0
[ 0.217825] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.217843] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.220961] pinctrl core: initialized pinctrl subsystem
[ 0.221465] DMI not present or invalid.
[ 0.221740] NET: Registered protocol family 16
[ 0.222863] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.223762] omap_hwmod: l3_main_2 using broken dt data from ocp
[ 0.323408] wkupaon_cm:clk:0068:0: failed to disable
[ 0.422966] cpuidle: using governor ladder
[ 0.423001] cpuidle: using governor menu
[ 0.433119] OMAP GPIO hardware version 0.1
[ 0.456652] No ATAGs?
[ 0.456727] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.456741] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.457232] omap4_sram_init:Unable to allocate sram needed to handle errata I688
[ 0.457243] omap4_sram_init:Unable to get sram pool needed to handle errata I688
[ 0.457871] OMAP DMA hardware revision 0.0
[ 0.468866] edma 43300000.edma: memcpy is disabled
[ 0.472266] edma 43300000.edma: TI EDMA DMA engine driver
[ 0.479349] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver (LinkedList1/2/3 supported)
[ 0.480140] evm_5v0: supplied by main_12v0
[ 0.483435] omap-iommu 40d01000.mmu: 40d01000.mmu registered
[ 0.483609] omap-iommu 40d02000.mmu: 40d02000.mmu registered
[ 0.483906] omap-iommu 58882000.mmu: 58882000.mmu registered
[ 0.484152] omap-iommu 55082000.mmu: 55082000.mmu registered
[ 0.484516] omap-iommu 41501000.mmu: 41501000.mmu registered
[ 0.484684] omap-iommu 41502000.mmu: 41502000.mmu registered
[ 0.484958] iommu: Adding device 58820000.ipu to group 1
[ 0.485038] iommu: Adding device 55020000.ipu to group 2
[ 0.485164] iommu: Adding device 40800000.dsp to group 0
[ 0.485383] iommu: Adding device 41000000.dsp to group 3
[ 0.486598] SCSI subsystem initialized
[ 0.487635] palmas 0-0058: Irq flag is 0x00000008
[ 0.515349] palmas 0-0058: Muxing GPIO 2f, PWM 0, LED 0
[ 0.516926] SMPS12: supplied by regulator-dummy
[ 0.518588] SMPS3: supplied by regulator-dummy
[ 0.520238] SMPS45: supplied by regulator-dummy
[ 0.522033] SMPS6: supplied by regulator-dummy
[ 0.523441] SMPS7: supplied by regulator-dummy
[ 0.524830] SMPS8: supplied by regulator-dummy
[ 0.526085] SMPS9: supplied by regulator-dummy
[ 0.526766] LDO1: supplied by regulator-dummy
[ 0.534476] LDO2: supplied by regulator-dummy
[ 0.544213] random: fast init done
[ 0.544329] LDO3: supplied by regulator-dummy
[ 0.554351] LDO4: supplied by regulator-dummy
[ 0.564379] LDO5: supplied by regulator-dummy
[ 0.565063] LDO6: supplied by regulator-dummy
[ 0.565754] LDO7: supplied by regulator-dummy
[ 0.566444] LDO8: supplied by regulator-dummy
[ 0.567134] LDO9: supplied by regulator-dummy
[ 0.574401] LDOLN: supplied by regulator-dummy
[ 0.584417] LDOUSB: supplied by regulator-dummy
[ 0.596820] omap_i2c 48070000.i2c: bus 0 rev0.12 at 400 kHz
[ 0.597411] omap_i2c 48060000.i2c: bus 2 rev0.12 at 400 kHz
[ 0.597616] media: Linux media interface: v0.10
[ 0.597658] videodev: Linux video capture interface: v2.00
[ 0.597729] pps_core: LinuxPPS API ver. 1 registered
[ 0.597738] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[ 0.597759] PTP clock support registered
[ 0.597790] EDAC MC: Ver: 3.0.0
[ 0.598574] omap-mailbox 48840000.mailbox: omap mailbox rev 0x400
[ 0.598818] omap-mailbox 48842000.mailbox: omap mailbox rev 0x400
[ 0.599311] Advanced Linux Sound Architecture Driver Initialized.
[ 0.600068] clocksource: Switched to clocksource arch_sys_counter
[ 0.608166] NET: Registered protocol family 2
[ 0.608746] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
[ 0.608776] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.608840] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.608967] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.609040] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.609075] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.609204] NET: Registered protocol family 1
[ 0.629640] RPC: Registered named UNIX socket transport module.
[ 0.629651] RPC: Registered udp transport module.
[ 0.629660] RPC: Registered tcp transport module.
[ 0.629668] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.630718] hw perfevents: no interrupt-affinity property for /pmu, guessing.
[ 0.630925] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
[ 0.631885] Initialise system trusted keyrings
[ 0.632020] workingset: timestamp_bits=14 max_order=19 bucket_order=5
[ 0.636816] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.647305] NFS: Registering the id_resolver key type
[ 0.647326] Key type id_resolver registered
[ 0.647335] Key type id_legacy registered
[ 0.647376] ntfs: driver 2.1.32 [Flags: R/O].
[ 0.648944] Key type asymmetric registered
[ 0.648956] Asymmetric key parser 'x509' registered
[ 0.649004] bounce: pool size: 64 pages
[ 0.649038] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[ 0.649050] io scheduler noop registered
[ 0.649059] io scheduler deadline registered
[ 0.649158] io scheduler cfq registered (default)
[ 0.649169] io scheduler mq-deadline registered
[ 0.649179] io scheduler kyber registered
[ 0.654910] pinctrl-single 4a003400.pinmux: 282 pins, size 1128
[ 0.658477] dra7-pcie 51000000.pcie: Linked as a consumer to phy-4a094000.pciephy.1
[ 0.658738] dra7-pcie 51000000.pcie: WA for Errata i870 not applied
[ 0.658831] dra7-pcie 51000000.pcie: host bridge /ocp/axi@0/pcie@51000000 ranges:
[ 0.658871] dra7-pcie 51000000.pcie: IO 0x20003000..0x20012fff -> 0x00000000
[ 0.658900] dra7-pcie 51000000.pcie: MEM 0x20013000..0x2fffffff -> 0x20013000
[ 1.659184] dra7-pcie 51000000.pcie: Phy link never came up
[ 1.659322] dra7-pcie 51000000.pcie: PCI host bridge to bus 0000:00
[ 1.659337] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 1.659348] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
[ 1.659360] pci_bus 0000:00: root bus resource [mem 0x20013000-0x2fffffff]
[ 1.665156] PCI: bus0: Fast back to back transfers disabled
[ 1.670518] PCI: bus1: Fast back to back transfers enabled
[ 1.670562] pci 0000:00:00.0: BAR 0: assigned [mem 0x20100000-0x201fffff 64bit]
[ 1.670583] pci 0000:00:00.0: PCI bridge to [bus 01-ff]
[ 1.670896] pcieport 0000:00:00.0: Signaling PME with IRQ 170
[ 1.671031] pcieport 0000:00:00.0: AER enabled with IRQ 170
[ 1.674728] vdd_3v3: supplied by regen1
[ 1.674961] aic_dvdd_fixed: supplied by vdd_3v3
[ 1.675025] vtt_fixed: supplied by smps3
[ 1.718951] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
[ 1.722525] console [ttyS2] disabled
[ 1.722581] 48020000.serial: ttyS2 at MMIO 0x48020000 (irq = 45, base_baud = 3000000) is a 8250
[ 2.827150] console [ttyS2] enabled
[ 2.833013] omap_rng 48090000.rng: Random Number Generator ver. 20
[ 2.833321] random: crng init done
[ 2.840114] omapdss_dss 58000000.dss: Linked as a consumer to regulator.22
[ 2.849682] DSS: OMAP DSS rev 6.1
[ 2.855921] omapdss_hdmi5 58040000.encoder: Linked as a consumer to regulator.16
[ 2.863454] omapdss_hdmi5 58040000.encoder: Dropping the link to regulator.16
[ 2.883567] brd: module loaded
[ 2.892765] loop: module loaded
[ 2.899807] libphy: Fixed MDIO Bus: probed
[ 2.960095] davinci_mdio 48485000.mdio: davinci mdio revision 1.6, bus freq 1000000
[ 2.967790] libphy: 48485000.mdio: probed
[ 2.976935] davinci_mdio 48485000.mdio: phy[1]: device 48485000.mdio:01, driver Micrel KSZ9031 Gigabit PHY
[ 2.986658] davinci_mdio 48485000.mdio: phy[2]: device 48485000.mdio:02, driver Micrel KSZ9031 Gigabit PHY
[ 2.996917] cpsw 48484000.ethernet: Detected MACID = d4:36:39:29:27:54
[ 3.003539] cpsw 48484000.ethernet: initialized cpsw ale version 1.4
[ 3.009923] cpsw 48484000.ethernet: ALE Table size 1024
[ 3.015234] cpsw 48484000.ethernet: cpts: overflow check period 500 (jiffies)
[ 3.023215] cpsw 48484000.ethernet: cpsw: Detected MACID = d4:36:39:29:27:55
[ 3.031520] i2c /dev entries driver
[ 3.038158] gpio-fan gpio_fan: GPIO fan initialized
[ 3.044230] tmp102 0-0048: initialized
[ 3.051145] cpu cpu0: Linked as a consumer to regulator.6
[ 3.056641] cpu cpu0: Linked as a consumer to regulator.29
[ 3.063780] sdhci: Secure Digital Host Controller Interface driver
[ 3.069990] sdhci: Copyright(c) Pierre Ossman
[ 3.075754] sdhci-pltfm: SDHCI platform and OF driver helper
[ 3.082244] omap_gpio 4805d000.gpio: Could not set line 27 debounce to 200000 microseconds (-22)
[ 3.091105] sdhci-omap 4809c000.mmc: Got CD GPIO
[ 3.095905] sdhci-omap 4809c000.mmc: Linked as a consumer to regulator.28
[ 3.102941] sdhci-omap 4809c000.mmc: Linked as a consumer to regulator.13
[ 3.109807] sdhci-omap 4809c000.mmc: Dropping the link to regulator.13
[ 3.116451] sdhci-omap 4809c000.mmc: Linked as a consumer to regulator.3
[ 3.123403] sdhci-omap 4809c000.mmc: Linked as a consumer to regulator.13
[ 3.130378] sdhci-omap 4809c000.mmc: no pinctrl state for ddr_1_8v mode
[ 3.137020] sdhci-omap 4809c000.mmc: no pinctrl state for ddr_3_3v mode
[ 3.143695] sdhci-omap 4809c000.mmc: no pinctrl state for hs200_1_8v mode
[ 3.176934] mmc0: SDHCI controller on 4809c000.mmc [4809c000.mmc] using ADMA
[ 3.184745] sdhci-omap 480b4000.mmc: Linked as a consumer to regulator.3
[ 3.191562] sdhci-omap 480b4000.mmc: Dropping the link to regulator.3
[ 3.198120] sdhci-omap 480b4000.mmc: Linked as a consumer to regulator.3
[ 3.230615] mmc1: SDHCI controller on 480b4000.mmc [480b4000.mmc] using ADMA
[ 3.239089] ledtrig-cpu: registered to indicate activity on CPUs
[ 3.249924] mmc0: host does not support reading read-only switch, assuming write-enable
[ 3.251018] NET: Registered protocol family 10
[ 3.259604] ti-iodelay 4844a000.padconf: Set reg 0x620 Delay(a: 600 g: 400), Elements(C=1 F=10)0x2902a
[ 3.271884] ti-iodelay 4844a000.padconf: Set reg 0x628 Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.273200] Segment Routing with IPv6
[ 3.280880] ti-iodelay 4844a000.padconf: Set reg 0x62c Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.284554] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 3.293490] ti-iodelay 4844a000.padconf: Set reg 0x634 Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.299713] NET: Registered protocol family 17
[ 3.308271] ti-iodelay 4844a000.padconf: Set reg 0x638 Delay(a: 30 g: 0), Elements(C=0 F=0)0x29000
[ 3.312938] Key type dns_resolver registered
[ 3.321738] ti-iodelay 4844a000.padconf: Set reg 0x640 Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.321745] ti-iodelay 4844a000.padconf: Set reg 0x644 Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.326131] Registering SWP/SWPB emulation handler
[ 3.334949] ti-iodelay 4844a000.padconf: Set reg 0x64c Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.343877] omap_voltage_late_init: Voltage driver support not added
[ 3.348663] ti-iodelay 4844a000.padconf: Set reg 0x650 Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.348669] ti-iodelay 4844a000.padconf: Set reg 0x658 Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.357598] Power Management for TI OMAP4+ devices.
[ 3.363964] ti-iodelay 4844a000.padconf: Set reg 0x65c Delay(a: 0 g: 0), Elements(C=0 F=0)0x29000
[ 3.384016] mmc0: new ultra high speed SDR104 SDHC card at address 0001
[ 3.402589] Loading compiled-in X.509 certificates
[ 3.413000] mmcblk0: mmc0:0001 SD16G 29.2 GiB
[ 3.428777] mmcblk0: p1 p2
[ 3.432885] dmm 4e000000.dmm: workaround for errata i878 in use
[ 3.440232] dmm 4e000000.dmm: initialized all PAT entries
[ 3.446622] omapdss_hdmi5 58040000.encoder: Linked as a consumer to regulator.16
[ 3.454145] omapdss_hdmi5 58040000.encoder: Dropping the link to regulator.16
[ 3.461533] mmc1: new DDR MMC card at address 0001
[ 3.467141] mmcblk1: mmc1:0001 M62704 3.53 GiB
[ 3.472040] mmcblk1boot0: mmc1:0001 M62704 partition 1 2.00 MiB
[ 3.478328] mmcblk1boot1: mmc1:0001 M62704 partition 2 2.00 MiB
[ 3.484821] mmcblk1rpmb: mmc1:0001 M62704 partition 3 512 KiB, chardev (244:0)
[ 3.492111] omapdss_hdmi5 58040000.encoder: Linked as a consumer to regulator.16
[ 3.499864] omapdss_dss 58000000.dss: bound 58001000.dispc (ops dispc_component_ops)
[ 3.508221] omapdss_dss 58000000.dss: bound 58040000.encoder (ops hdmi5_component_ops)
[ 3.516220] mmcblk1: p1
[ 3.520769] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 3.527409] [drm] No driver support for vblank timestamp query.
[ 3.533390] [drm] Cannot find any crtc or sizes
[ 3.538607] [drm] Initialized omapdrm 1.0.0 20110917 for omapdrm.0 on minor 0
[ 3.546203] hctosys: unable to open rtc device (rtc0)
[ 3.551833] aic_dvdd_fixed: disabling
[ 3.555669] ldousb: disabling
[ 3.558905] ALSA device list:
[ 3.561906] No soundcards found.
[ 3.624821] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 3.633005] VFS: Mounted root (ext4 filesystem) on device 179:2.
[ 3.643464] devtmpfs: mounted
[ 3.647906] Freeing unused kernel memory: 2048K
[ 3.652570] Run /sbin/init as init process
[ 3.825892] systemd[1]: System time before build time, advancing clock.
[ 3.849358] systemd[1]: systemd 239 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN -PCRE2 default-hierarchy=hybrid)
[ 3.871253] systemd[1]: Detected architecture arm.

Welcome to Arago 2019.07!

[ 3.910924] systemd[1]: Set hostname to <am57xx-evm>.
[ 4.032511] systemd[1]: File /lib/systemd/system/systemd-journald.service:36 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling.
[ 4.049721] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[ 4.258381] systemd[1]: Created slice system-serial\x2dgetty.slice.
[ OK ] Created slice system-serial\x2dgetty.slice.
[ 4.318813] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ OK ] Started Dispatch Password Requests to Console Directory Watch.
[ 4.360391] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ OK ] Started Forward Password Requests to Wall Directory Watch.
[ 4.415417] systemd[1]: Listening on Process Core Dump Socket.
[ OK ] Listening on Process Core Dump Socket.
[ 4.450492] systemd[1]: Listening on Network Service Netlink Socket.
[ OK ] Listening on Network Service Netlink Socket.
[ OK ] Listening on Journal Socket (/dev/log).
[ OK ] Reached target Remote File Systems.
[ OK ] Listening on initctl Compatibility Named Pipe.
[ 4.560140] [drm] Cannot find any crtc or sizes
[ OK ] Listening on udev Kernel Socket.
[ OK ] Created slice User and Session Slice.
[ OK ] Reached target Swap.
[ OK ] Reached target Slices.
[ OK ] Listening on Journal Socket.
Mounting Kernel Configuration File System...
Mounting Temporary Directory (/tmp)...
Mounting Kernel Debug File System...
Starting Apply Kernel Variables...
[ OK ] Started Hardware RNG Entropy Gatherer Daemon.
Starting Remount Root and Kernel File Systems...
[ 4.900668] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Starting Journal Service...
[ OK ] Listening on udev Control Socket.
Starting udev Coldplug all Devices...
[ OK ] Reached target Paths.
[ OK ] Created slice system-getty.slice.
Starting Create list of required st…ce nodes for the current kernel...
Mounting POSIX Message Queue File System...
[ OK ] Started Journal Service.
[ OK ] Mounted Kernel Configuration File System.
[ OK ] Mounted Temporary Directory (/tmp).
[ OK ] Mounted Kernel Debug File System.
[ OK ] Started Apply Kernel Variables.
[ OK ] Started Remount Root and Kernel File Systems.
[ OK ] Started Create list of required sta…vice nodes for the current kernel.
[ OK ] Mounted POSIX Message Queue File System.
Starting Create Static Device Nodes in /dev...
Starting Flush Journal to Persistent Storage...
[ OK ] Started Create Static Device Nodes in /dev.
[ 5.477707] systemd-journald[104]: Received request to flush runtime journal from PID 1
[ OK ] Reached target Local File Systems (Pre).
[ OK ] Reached target Containers.
Mounting /var/volatile...
Mounting /media/ram...
Starting udev Kernel Device Manager...
[ OK ] Started Flush Journal to Persistent Storage.
[ OK ] Started udev Kernel Device Manager.
[ OK ] Mounted /var/volatile.
[ OK ] Mounted /media/ram.
Starting Load/Save Random Seed...
[ OK ] Reached target Local File Systems.
Starting Create Volatile Files and Directories...
[ OK ] Started udev Coldplug all Devices.
[ OK ] Started Load/Save Random Seed.
[ 5.919411] omap-rproc 58820000.ipu: ignoring dependency for device, assuming no driver
[ OK ] Started Create Volatile Files and Directories[ 5.958458] omap-rproc 58820000.ipu: ignoring dependency for device, assuming no driver
.
[ 6.006912] omap-rproc 58820000.ipu: assigned reserved memory node ipu1-memory@9d000000
Starting Update UTMP about System Boot/Shutdown...
Starting Network Time Synchronization...
[ 6.071517] remoteproc remoteproc0: 58820000.ipu is available
Starting Network Service...
[ 6.093676] omap-rproc 55020000.ipu: ignoring dependency for device, assuming no driver
[ 6.106924] remoteproc remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[ 6.152396] remoteproc remoteproc0: powering up 58820000.ipu
[ 6.158133] remoteproc remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[ OK ] Started Update UTMP about System Boot/Shutdow[ 6.175107] omap-rproc 55020000.ipu: ignoring dependency for device, assuming no driver
n.
[ OK ] Found device /dev/ttyS2.
[ 6.227063] remoteproc remoteproc0: request_firmware failed: -2
[ 6.234519] omap-rproc 55020000.ipu: assigned reserved memory node ipu2-memory@95800000
[ 6.289109] Driver for 1-wire Dallas network protocol.
[ 6.333652] omap-des 480a5000.des: OMAP DES hw accel rev: 2.2
[ OK ] Started Network Service.
[ 6.346150] at24 0-0050: 4096 byte 24c32 EEPROM, writable, 1 bytes/write
[ 6.359253] tlv320aic3x-codec 0-0018: Linked as a consumer to regulator.3
Starting Wait for Network to be Configured...
[ 6.382956] omap-des 480a5000.des: will run requests pump with realtime priority
[ 6.405245] remoteproc remoteproc1: 55020000.ipu is available
Starting Network Name Resolution...
[ 6.412013] tlv320aic3x-codec 0-0018: Linked as a consumer to regulator.4
[ 6.433302] omap-rproc 40800000.dsp: ignoring dependency for device, assuming no driver
[ 6.443285] omap_hdq 480b2000.1w: OMAP HDQ Hardware Rev 0.:. Driver in Interrupt mode
[ 6.460343] omap-rproc 40800000.dsp: ignoring dependency for device, assuming no driver
[ 6.480035] rtc-ds1307 2-006f: registered as rtc0
[ 6.498090] omap-rproc 40800000.dsp: assigned reserved memory node dsp1-memory@99000000
[ 6.510442] remoteproc remoteproc1: powering up 55020000.ipu
[ 6.516585] remoteproc remoteproc1: Booting fw image dra7-ipu2-fw.xem4, size 5024900
[ 6.546001] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659038@58:tps659038_rtc as rtc1
[ 6.562578] remoteproc remoteproc2: 40800000.dsp is available
[ 6.582322] omap-iommu 55082000.mmu: 55082000.mmu: version 2.1
[ 6.638484] omap-rproc 41000000.dsp: ignoring dependency for device, assuming no driver
[ 6.691678] omap-rproc 41000000.dsp: ignoring dependency for device, assuming no driver
[ 6.704219] w1_master_driver w1_bus_master1: Attaching one wire slave 01.000000000000 crc 3d
[ 6.739636] omap-rproc 41000000.dsp: assigned reserved memory node dsp2-memory@9f000000
[ 6.751889] omap_rtc 48838000.rtc: registered as rtc2
[ OK ] Started Network Time Synchronization.
[ 6.764674] remoteproc remoteproc2: powering up 40800000.dsp
[ OK ] Reached target System Time Synchronized.
[ 6.781224] remoteproc remoteproc2: Booting fw image dra7-dsp1-fw.xe66, size 4298268
[ 6.790376] vpe 489d0000.vpe: loading firmware vpdma-1b8.bin
[ OK ] Reached target System Initialization.
[ 6.811721] omap-iommu 55082000.mmu: iommu fault: da 0x9f375740 flags 0x0
[ 6.822679] remoteproc remoteproc1: crash detected in 55020000.ipu: type mmufault
[ 6.830207] omap-iommu 55082000.mmu: 55082000.mmu: errs:0x00000002 da:0x9f375740 pgd:0xc472bca1 *pgd:px00000000
[ 6.840556] w1_master_driver w1_bus_master1: Family 1 for 01.000000000000.3d is not registered.
[ 6.844164] omap-iommu 40d01000.mmu: 40d01000.mmu: version 3.0
[ 6.855259] omap-iommu 40d02000.mmu: 40d02000.mmu: version 3.0
[ 6.888867] vpe 489d0000.vpe: Device registered as /dev/video0
[ OK ] Listening on RPCbind Server Activation Socket[ 6.895323] remoteproc remoteproc3: 41000000.dsp is available
.
[ OK ] Listening on Avahi mDNS/DNS-SD Stack Activati[ 6.915244] virtio_rpmsg_bus virtio0: rpmsg host is online
on Socket.
[ 6.923961] net eth1: initializing cpsw version 1.15 (0)
[ 6.939410] remoteproc remoteproc1: registered virtio0 (type 7)
[ OK ] Listening on D-Bus System Message Bus Socket.
[ 6.979947] remoteproc remoteproc1: remote processor 55020000.ipu is now up
[ OK ] Reached target Sockets.
[ 7.012785] remoteproc remoteproc1: handling crash #1 in 55020000.ipu
[ 7.014295] remoteproc remoteproc3: Direct firmware load for dra7-dsp2-fw.xe66 failed with error -2
[ 7.022544] remoteproc remoteproc1: recovering 55020000.ipu
[ OK ] Started Daily rotation of log files.
[ OK ] Started Daily Cleanup of Temporary Directories.
[ 7.082023] remoteproc remoteproc3: powering up 41000000.dsp
[ 7.082621] Micrel KSZ9031 Gigabit PHY 48485000.mdio:02: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=48485000.mdio:02, irq=POLL)
[ 7.087734] remoteproc remoteproc3: Direct firmware load for dra7-dsp2-fw.xe66 failed with error -2
[ OK ] Reached target Timers.
[ OK ] Reached target Basic System.
[ 7.154470] remoteproc remoteproc1: stopped remote processor 55020000.ipu
Starting RPC Bind Service...
[ 7.184554] IPv6: ADDRCONF(NETDEV_UP): eth1: link is not ready
[ OK ] Started Job spooling tools.
[ 7.209737] remoteproc remoteproc1: powering up 55020000.ipu
[ 7.225968] phy phy-4a084000.phy.3: Linked as a consumer to regulator.23
Starting telnetd.service...
[ 7.268411] phy phy-4a085000.phy.4: Linked as a consumer to regulator.23
Starting Print notice about GPLv3 packages...
[ 7.294786] remoteproc remoteproc3: request_firmware failed: -2
[ 7.297266] remoteproc remoteproc1: Booting fw image dra7-ipu2-fw.xem4, size 5024900
Starting Login Service...
[ 7.348845] ahci 4a140000.sata: controller can't do 64bit DMA, forcing 32bit
[ OK ] Started Periodic Command Scheduler.
[ OK ] Started D-Bus System Message Bus.
[ 7.392774] ahci 4a140000.sata: forcing port_map 0x0 -> 0x1
[ 7.415624] omap-iommu 55082000.mmu: 55082000.mmu: version 2.1
[ 7.424798] omap-sham 4b101000.sham: hw accel on OMAP rev 4.3
[ 7.431656] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[ 7.445344] omap-aes 4b500000.aes: OMAP AES hw accel rev: 3.3
[ 7.492300] ahci 4a140000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
[ 7.492308] ahci 4a140000.sata: flags: ncq sntf pm led clo only pmp pio slum part ccc apst
[ 7.502341] virtio_rpmsg_bus virtio1: rpmsg host is online
[ 7.502386] remoteproc remoteproc2: registered virtio1 (type 7)
[ 7.502392] remoteproc remoteproc2: remote processor 40800000.dsp is now up
[ 7.502620] virtio_rpmsg_bus virtio1: creating channel rpmsg-proto addr 0x3d
[ 7.503014] omap-aes 4b500000.aes: will run requests pump with realtime priority
[ 7.548254] scsi host0: ahci
[ 7.548583] ata1: SATA max UDMA/133 mmio [mem 0x4a140000-0x4a1410ff] port 0x100 irq 80
[ 7.570605] omap-aes 4b700000.aes: OMAP AES hw accel rev: 3.3
[ 7.583210] omap-aes 4b700000.aes: will run requests pump with realtime priority
[ 7.594398] net eth0: initializing cpsw version 1.15 (0)
[ 7.598979] alloc_contig_range: [98f00, 99000) PFNs busy
[ 7.598999] cma: cma_alloc: alloc failed, req-size: 256 pages, ret: -16
[ 7.599008] omap-rproc 55020000.ipu: failed to allocate dma memory: len 0x100000
[ 7.599015] remoteproc remoteproc1: Failed to process resources: -12
[ 7.680267] omap-hdmi-audio omap-hdmi-audio.0.auto: snd-soc-dummy-dai <-> 58040000.encoder mapping ok
[ 7.680276] omap-hdmi-audio omap-hdmi-audio.0.auto: ASoC: no DMI vendor name!
[ 7.710800] Micrel KSZ9031 Gigabit PHY 48485000.mdio:01: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=48485000.mdio:01, irq=POLL)
[ 7.712995] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 7.798137] asoc-simple-card sound0: tlv320aic3x-hifi <-> 48468000.mcasp mapping ok
[ 7.798175] asoc-simple-card sound0: ASoC: no DMI vendor name!
[ 7.895682] ata1: SATA link down (SStatus 0 SControl 300)
Starting TI IPC Daemon...
[ OK ] Started Network Name Resolution.
[ OK ] Started RPC Bind Service.
[ OK ] Started telnetd.service.
[ OK ] Started TI IPC Daemon.
[ 9.215522] dwc3 48890000.usb: Failed to get clk 'ref': -2
***************************************************************
***************************************************************
NOTICE: This file system contains the following GPLv3 packages:
bash
bc
cifs-utils
cpio
dosfstools
elfutils
gawk
gzip
libbfd
libdw1
libelf1
libreadline7
which

[ 9.265245] dwc3 488d0000.usb: Failed to get clk 'ref': -2ve

the above packages prior 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 t[ 9.301391] NET: Registered protocol family 45
he --force-removal-of-dependent-packages option to
also remove the dependent packages as well
***************************************************************
***************************************************************
[ 9.356992] remoteproc remoteproc4: 4b234000.pru is available
[ 9.386219] pru-rproc 4b234000.pru: PRU rproc node pru@4b234000 probed successfully
[ OK ] Started Print notice about GPLv3 packages.
[ 9.412585] remoteproc remoteproc5: 4b238000.pru is available
[ 9.418468] pru-rproc 4b238000.pru: PRU rproc node pru@4b238000 probed successfully
[ 9.427640] usbcore: registered new interface driver usbfs
[ 9.440730] usbcore: registered new interface driver hub
[ 9.450956] usbcore: registered new device driver usb
[ 9.452393] remoteproc remoteproc6: 4b2b4000.pru is available
[ 9.467934] pru-rproc 4b2b4000.pru: PRU rproc node pru@4b2b4000 probed successfully
[ 9.477124] remoteproc remoteproc7: 4b2b8000.pru is available
[ 9.483195] pru-rproc 4b2b8000.pru: PRU rproc node pru@4b2b8000 probed successfully
[ 9.504224] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[ 9.511043] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 1
[ 9.561641] xhci-hcd xhci-hcd.1.auto: hcc params 0x0220f04c hci version 0x100 quirks 0x0000000002010010
[ 9.573644] xhci-hcd xhci-hcd.1.auto: irq 181, io mem 0x48890000
[ 9.581728] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[ 9.590330] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.598855] usb usb1: Product: xHCI Host Controller
[ 9.604691] usb usb1: Manufacturer: Linux 4.19.59-g5f8c1c6121 xhci-hcd
[ 9.612741] usb usb1: SerialNumber: xhci-hcd.1.auto
[ 9.620685] hub 1-0:1.0: USB hub found
[ 9.626161] hub 1-0:1.0: 1 port detected
[ 9.641064] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[ 9.648349] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 2
[ 9.662727] xhci-hcd xhci-hcd.1.auto: Host supports USB 3.0 SuperSpeed
[ 9.670220] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[ 9.685316] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.19
[ 9.695547] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.703256] usb usb2: Product: xHCI Host Controller
[ 9.708455] usb usb2: Manufacturer: Linux 4.19.59-g5f8c1c6121 xhci-hcd
[ 9.717489] usb usb2: SerialNumber: xhci-hcd.1.auto
[ 9.727123] hub 2-0:1.0: USB hub found
[ 9.736146] hub 2-0:1.0: 1 port detected
[ 10.000106] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[ 10.180456] usb 1-1: New USB device found, idVendor=0451, idProduct=8142, bcdDevice= 1.00
[ 10.188677] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=1
[ 10.197575] usb 1-1: SerialNumber: 8A0B207927F9
[ 10.247413] hub 1-1:1.0: USB hub found
[ 10.252000] hub 1-1:1.0: 4 ports detected
[ 10.330139] usb 2-1: new SuperSpeed Gen 1 USB device number 2 using xhci-hcd
[ 10.361022] usb 2-1: New USB device found, idVendor=0451, idProduct=8140, bcdDevice= 1.00
[ 10.369239] usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 10.421546] hub 2-1:1.0: USB hub found
[ 10.426555] hub 2-1:1.0: 4 ports detected
[ 10.887826] cpsw 48484000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
[ 10.896735] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Starting Save/Restore Sound Card State...
[ OK ] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
[ OK ] Created slice system-systemd\x2dfsck.slice.
Starting File System Check on /dev/mmcblk1p1...
Starting File System Check on /dev/mmcblk0p1...
Starting thttpd.service...
[ OK ] Reached target Network.
Starting Permit User Sessions...
[ OK ] Reached target Host and Network Name Lookups.
[ OK ] Started NFS status monitor for NFSv2/3 locking..
Starting Avahi mDNS/DNS-SD Stack...
[ OK ] Started Save/Restore Sound Card State.
[ OK ] Started Permit User Sessions.
[ OK ] Started File System Check on /dev/mmcblk1p1.
[ OK ] Started thttpd.service.
Mounting /run/media/mmcblk1p1...
[ OK ] Started Serial Getty on ttyS2.
[ OK ] Started Getty on tty1.
[ OK ] Reached target Login Prompts.
Starting Synchronize System and HW clocks...
[ OK ] Reached target Sound Card.
[ OK ] Started Login Service.
[ OK ] Started Avahi mDNS/DNS-SD Stack.
[ OK ] Started Synchronize System and HW clocks.
[ 12.533424] EXT4-fs (mmcblk1p1): mounted filesystem with ordered data mode. Opts: (null)
[ OK ] Started File System Check on /dev/mmcblk0p1.
[ OK ] Mounted /run/media/mmcblk1p1.
Mounting /run/media/mmcblk0p1...
[ OK ] Mounted /run/media/mmcblk0p1.

Any ideas?

Regards, Filip