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.

PROCESSOR-SDK-TDAX: [TDA4] RTOS+Linux demo application hangs on appRemoteServiceRun read call

Part Number: PROCESSOR-SDK-TDAX
Other Parts Discussed in Thread: SYSBIOS

Hello,

After running the vx_single_cam demo application, it hangs on appRemoteServiceRun function call.
In vision_apps/utils/remote_service/src/app_remote_service_linux.c, ln 153
there is a call to read() where the application hangs.
The whole log is attached. There are warnings about firmware that cannot be loaded:

** File not found /lib/firmware/j7-main-r5f1_0-fw **

.....
[  OK  ] Started Job spooling tools.
[   12.145645] pci-endpoint-test 0002:00:00.0: of_irq_parse_pci: failed with rc=-22
[  OK  ] Started Daily Cleanup of Temporary Directori[   12.156326] PVR_K:  176: Read BVNC 22.104.208.318 from HW device registers
es.
[  OK  ] Reached target Timers.
[   12.181157] pci_bus 0002:00: 1-byte config write to 0002:00:00.0 offset 0x3c may corrupt adjacent RW1C bits
[   12.194228] PVR_K:  176: RGX Device initialised with BVNC 22.104.208.318
[  OK  ] Started TEE Supplicant.
[   12.209824] [drm] Initialized pvr 1.10.5187610 20170530 for 4e20000000.gpu on minor 1
[   12.277062] img_dec 4300000.video-decoder: decoder registered as /dev/video0
         Starting RPC Bind Service...
[   12.360735] k3_r5_rproc interconnect@100000:interconnect@28380000:r5fss@41000000: creating child devices for R5F cores
[   12.443051] platform 41000000.r5f: configured R5F for remoteproc mode
[   12.482877] platform 41000000.r5f: assigned reserved memory node r5f-dma-memory@a0000000
[   12.491078] remoteproc remoteproc3: 41000000.r5f is available
[   12.496968] remoteproc remoteproc3: Direct firmware load for j7-mcu-r5f0_0-fw failed with error -2
[   12.503213] k3_r5_rproc interconnect@100000:r5fss@5c00000: creating child devices for R5F cores
[   12.506772] remoteproc remoteproc3: powering up 41000000.r5f
[   12.520343] remoteproc remoteproc3: Direct firmware load for j7-mcu-r5f0_0-fw failed with error -2
[   12.524020] platform 5c00000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1)
[   12.531027] remoteproc remoteproc3: request_firmware failed: -2


There are no j7-mcu-r5f0_0-fw or j7-main-r5f1_0-fw firmware files on the target filesystem, are they needed and where can they be found?

Thanks,
Todor

8203.vx_single_cam.log
U-Boot SPL 2019.01-g6e54d1f7fa (Jul 17 2019 - 09:37:31 +0000)
SYSFW ABI: 2.6 (firmware rev 0x0013 '19.6.1-v2019.06a (Terrific Llam')
Trying to boot from MMC2
Loading Environment from MMC... *** Warning - No MMC card found, using default environment

Remoteproc 2 started successfully
** File not found /lib/firmware/j7-mcu-r5f0_0-fw **
Starting ATF on ARM64 core...

NOTICE:  BL31: v2.1(release):ti2019.02-rc3
NOTICE:  BL31: Built : 09:36:59, Jul 17 2019
I/TC:
I/TC: OP-TEE version: ti2019.02-rc1-dev #1 Wed Jul 17 09:23:14 UTC 2019 aarch64
I/TC: Initialized

U-Boot SPL 2019.01-g6e54d1f7fa (Jul 17 2019 - 09:37:36 +0000)
detected J7X-BASE-CPB
detected J7X-VSC8514-ETH
Trying to boot from MMC2


U-Boot 2019.01-g6e54d1f7fa (Jul 17 2019 - 09:37:36 +0000)

Model: Texas Instruments K3 J721E SoC
DRAM:  4 GiB
Flash: 64 MiB
MMC:   sdhci@4f80000: 0, sdhci@4fb0000: 1
Loading Environment from MMC... OK
In:    serial@2800000
Out:   serial@2800000
Err:   serial@2800000
detected J7X-BASE-CPB
detected J7X-VSC8514-ETH
Net:   eth0: ethernet@046000000
Hit any key to stop autoboot:  0
switch to partitions #0, OK
mmc1 is current device
SD/MMC found on device 1
** Unable to read file boot.scr **
110 bytes read in 0 ms
Loaded env from uEnv.txt
Importing environment from mmc1 ...
Running uenvcmd ...
## Error: "start_rprocs_mmc" not defined
9413284 bytes read in 1437 ms (6.2 MiB/s)
Load Remote Processor 3 with data@addr=0x80080000 9413284 bytes: Success!
** File not found /lib/firmware/j7-main-r5f1_0-fw **
7390424 bytes read in 1130 ms (6.2 MiB/s)
Load Remote Processor 6 with data@addr=0x80080000 7390424 bytes: Success!
7389416 bytes read in 1138 ms (6.2 MiB/s)
Load Remote Processor 7 with data@addr=0x80080000 7389416 bytes: Success!
12337604 bytes read in 1729 ms (6.8 MiB/s)
Load Remote Processor 8 with data@addr=0x80080000 12337604 bytes: Success!
12929032 bytes read in 543 ms (22.7 MiB/s)
80665 bytes read in 4 ms (19.2 MiB/s)
3653 bytes read in 0 ms
3537 bytes read in 4 ms (863.3 KiB/s)
## Flattened Device Tree blob at 82000000
   Booting using the fdt blob at 0x82000000
   Loading Device Tree to 00000000fddd3000, end 00000000fdee9fff ... OK

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x411fd080]
[    0.000000] Linux version 4.19.50-g79386bfefc (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 Tue Jul 23 07:12:52 UTC 2019
[    0.000000] Machine model: Texas Instruments K3 J721E SoC
[    0.000000] earlycon: ns16550a0 at MMIO32 0x0000000002800000 (options '')
[    0.000000] 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] Reserved memory: created DMA memory pool at 0x00000000a2000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@a2000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a2100000, size 31 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@a2100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a4000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@a3000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a4100000, size 63 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@a3100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a8000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@a4000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a8100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@a4100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a9000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node r5f-dma-memory@a5000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000a9100000, size 15 MiB
[    0.000000] OF: reserved mem: initialized node r5f-memory@a5100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000aa000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node c66-dma-memory@a6000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000aa100000, size 63 MiB
[    0.000000] OF: reserved mem: initialized node c66-memory@a6100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000ae000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node c66-dma-memory@a7000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000ae100000, size 31 MiB
[    0.000000] OF: reserved mem: initialized node c66-memory@a7100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000b0000000, size 1 MiB
[    0.000000] OF: reserved mem: initialized node c71-dma-memory@a8000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000b0100000, size 127 MiB
[    0.000000] OF: reserved mem: initialized node c71-memory@a8100000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000b8000000, size 32 MiB
[    0.000000] OF: reserved mem: initialized node vision_apps-dma-memory@b8000000, compatible id shared-dma-pool
[    0.000000] Reserved memory: created DMA memory pool at 0x00000000bc000000, size 576 MiB
[    0.000000] OF: reserved mem: initialized node cmem-memories@bc000000, compatible id shared-dma-pool
[    0.000000] cma: Failed to reserve 512 MiB
[    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.1
[    0.000000] random: get_random_bytes called from start_kernel+0x94/0x3e4 with crng_init=0
[    0.000000] percpu: Embedded 2 pages/cpu s48536 r8192 d74344 u131072
[    0.000000] Detected PIPT I-cache on CPU0
[    0.000000] CPU features: enabling workaround for EL2 vector hardening
[    0.000000] Speculative Store Bypass Disable mitigation not required
[    0.000000] Built 1 zonelists, mobility grouping off.  Total pages: 48720
[    0.000000] Kernel command line: console=ttyS2,115200n8 earlycon=ns16550a,mmio32,0x02800000 mtdparts=47040000.spi.0:512k(ospi.tiboot3),2m(ospi.tispl),4m(ospi.u-boot),128k(ospi.env),128k(ospi.env.backup),1m(ospi.sysfw),-@8m(ospi.rootfs);47034000.hyperbus:512k(hbmc.tiboot3),2m(hbmc.tispl),4m(hbmc.u-boot),256k(hbmc.env),1m(hbmc.sysfw),-@8m(hbmc.rootfs); root=PARTUUID=b2b88448-02 rw rootfstype=ext4 rootwait strict-devmem=n
[    0.000000] Dentry cache hash table entries: 524288 (order: 6, 4194304 bytes)
[    0.000000] Inode-cache hash table entries: 262144 (order: 5, 2097152 bytes)
[    0.000000] software IO TLB: mapped [mem 0xf9dd0000-0xfddd0000] (64MB)
[    0.000000] Memory: 3030016K/3121152K available (8254K kernel code, 722K rwdata, 3008K rodata, 576K init, 657K bss, 91136K reserved, 0K cma-reserved)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu:     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2.
[    0.000000]  Tasks RCU enabled.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
[    0.000000] GICv3: Distributor has no Range Selector support
[    0.000000] GICv3: no VLPI support, no direct LPI support
[    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] GIC: using LPI property table @0x00000008c00b0000
[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x0000000001900000
[    0.000000] CPU0: using LPI pending table @0x00000008c00c0000
[    0.000000] GIC: using cache flushing for LPI property table
[    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.000002] sched_clock: 56 bits at 200MHz, resolution 5ns, wraps every 4398046511102ns
[    0.008346] Console: colour dummy device 80x25
[    0.012907] Calibrating delay loop (skipped), value calculated using timer frequency.. 400.00 BogoMIPS (lpj=800000)
[    0.023576] pid_max: default: 32768 minimum: 301
[    0.028319] Security Framework initialized
[    0.032526] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes)
[    0.039383] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes)
[    0.070724] ASID allocator initialised with 32768 entries
[    0.084251] rcu: Hierarchical SRCU implementation.
[    0.097212] Platform MSI: gic-its@18200000 domain created
[    0.102884] PCI/MSI: /interconnect@100000/interrupt-controller@1800000/gic-its@18200000 domain created
[    0.120406] smp: Bringing up secondary CPUs ...
[    0.171206] Detected PIPT I-cache on CPU1
[    0.171230] GICv3: CPU1: found redistributor 1 region 0:0x0000000001920000
[    0.171258] CPU1: using LPI pending table @0x00000008c0350000
[    0.171284] CPU1: Booted secondary processor 0x0000000001 [0x411fd080]
[    0.171339] smp: Brought up 1 node, 2 CPUs
[    0.199177] SMP: Total of 2 processors activated.
[    0.203986] CPU features: detected: GIC system register CPU interface
[    0.210568] CPU features: detected: 32-bit EL0 Support
[    0.216079] CPU: All CPU(s) started at EL2
[    0.220267] alternatives: patching kernel code
[    0.225362] devtmpfs: initialized
[    0.232967] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.242933] futex hash table entries: 512 (order: -1, 32768 bytes)
[    0.249365] pinctrl core: initialized pinctrl subsystem
[    0.255095] NET: Registered protocol family 16
[    0.259992] vdso: 2 pages (1 code @ (____ptrval____), 1 data @ (____ptrval____))
[    0.267556] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.274640] DMA: preallocated 256 KiB pool for atomic allocations
[    0.287235] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.294089] HugeTLB registered 512 MiB page size, pre-allocated 0 pages
[    0.301572] cryptd: max_cpu_qlen set to 1000
[    0.306499] vsys_3v3: supplied by evm_12v0
[    0.310768] vsys_5v0: supplied by evm_12v0
[    0.315430] media: Linux media interface: v0.10
[    0.320068] videodev: Linux video capture interface: v2.00
[    0.325682] pps_core: LinuxPPS API ver. 1 registered
[    0.330752] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.340089] PTP clock support registered
[    0.344101] EDAC MC: Ver: 3.0.0
[    0.347943] Advanced Linux Sound Architecture Driver Initialized.
[    0.354587] clocksource: Switched to clocksource arch_sys_counter
[    0.360895] VFS: Disk quotas dquot_6.6.0
[    0.364937] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes)
[    0.374531] NET: Registered protocol family 2
[    0.379295] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes)
[    0.387350] TCP established hash table entries: 32768 (order: 2, 262144 bytes)
[    0.394833] TCP bind hash table entries: 32768 (order: 3, 524288 bytes)
[    0.401892] TCP: Hash tables configured (established 32768 bind 32768)
[    0.408622] UDP hash table entries: 2048 (order: 0, 65536 bytes)
[    0.414805] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes)
[    0.421483] NET: Registered protocol family 1
[    0.426183] RPC: Registered named UNIX socket transport module.
[    0.432237] RPC: Registered udp transport module.
[    0.437040] RPC: Registered tcp transport module.
[    0.441843] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.448750] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
[    0.458310] Initialise system trusted keyrings
[    0.462934] workingset: timestamp_bits=46 max_order=16 bucket_order=0
[    0.471055] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.477224] NFS: Registering the id_resolver key type
[    0.482401] Key type id_resolver registered
[    0.486672] Key type id_legacy registered
[    0.490770] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.497691] 9p: Installing v9fs 9p2000 file system support
[    0.504779] Key type asymmetric registered
[    0.508967] Asymmetric key parser 'x509' registered
[    0.513975] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[    0.521536] io scheduler noop registered
[    0.525543] io scheduler deadline registered
[    0.529950] io scheduler cfq registered (default)
[    0.534757] io scheduler mq-deadline registered
[    0.539383] io scheduler kyber registered
[    0.544267] pinctrl-single 4301c000.pinmux: 94 pins, size 376
[    0.550346] pinctrl-single 11c000.pinmux: 173 pins, size 692
[    0.556456] pinctrl-single a40000.timesync_router: 512 pins, size 2048
[    0.566439] Serial: 8250/16550 driver, 10 ports, IRQ sharing enabled
[    0.574292] arm-smmu-v3 36600000.smmu: IDR0.COHACC overridden by FW configuration (false)
[    0.582673] arm-smmu-v3 36600000.smmu: ias 48-bit, oas 48-bit (features 0x00001eaf)
[    0.591606] arm-smmu-v3 36600000.smmu: msi_domain absent - falling back to wired irqs
[    0.600056] panel-simple dummy-panel: dummy-panel supply power not found, using dummy regulator
[    0.608981] panel-simple dummy-panel: Linked as a consumer to regulator.0
[    0.619344] brd: module loaded
[    0.625191] loop: module loaded
[    0.629224] libphy: Fixed MDIO Bus: probed
[    0.633571] tun: Universal TUN/TAP device driver, 1.6
[    0.638960] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k
[    0.646966] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
[    0.653035] sky2: driver version 1.30
[    0.657375] VFIO - User Level meta-driver version: 0.3
[    0.662957] i2c /dev entries driver
[    0.666923] sdhci: Secure Digital Host Controller Interface driver
[    0.673240] sdhci: Copyright(c) Pierre Ossman
[    0.677864] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.684054] ledtrig-cpu: registered to indicate activity on CPUs
[    0.690961] optee: probing for conduit method from DT.
[    0.696229] optee: revision 3.5 (3a513cea)
[    0.696350] optee: initialized driver
[    0.704999] NET: Registered protocol family 17
[    0.709583] 9pnet: Installing 9P2000 support
[    0.713968] Key type dns_resolver registered
[    0.718556] registered taskstats version 1
[    0.722744] Loading compiled-in X.509 certificates
[    0.733292] ti-sci 44083000.dmsc: ABI: 2.6 (firmware rev 0x0013 '19.6.1-v2019.06a (Terrific Llam')
[    1.627002] random: fast init done
[    2.887268] davinci_gpio 42110000.gpio: IRQ not populated, err = -517
[    2.898284] davinci_gpio 600000.gpio: IRQ not populated, err = -517
[    2.910936] davinci_gpio 601000.gpio: IRQ not populated, err = -517
[    2.923780] omap_i2c 40b00000.i2c: bus 0 rev0.12 at 100 kHz
[    2.936376] omap_i2c 40b10000.i2c: bus 1 rev0.12 at 100 kHz
[    2.951501] palmas 2-0058: IRQ missing: skipping irq request
[    2.978844] palmas 2-0058: Muxing GPIO 5d, PWM 0, LED 0
[    2.984754] SMPS3: supplied by regulator-dummy
[    2.989995] SMPS4: supplied by regulator-dummy
[    2.995224] SMPS5: supplied by regulator-dummy
[    3.000454] SMPS12: supplied by regulator-dummy
[    3.005726] LDO1: supplied by vsys_3v3
[    3.009953] ldo1: Bringing 900000uV into 1800000-1800000uV
[    3.017761] LDO2: supplied by regulator-dummy
[    3.022615] ldo2: Bringing 900000uV into 3300000-3300000uV
[    3.031280] LDO3: supplied by regulator-dummy
[    3.036165] LDO4: supplied by regulator-dummy
[    3.041049] LDO5: supplied by regulator-dummy
[    3.046087] omap_i2c 42120000.i2c: bus 2 rev0.12 at 400 kHz
[    3.060232] pca953x 3-0020: 3-0020 supply vcc not found, using dummy regulator
[    3.067637] pca953x 3-0020: Linked as a consumer to regulator.0
[    3.095159] pca953x 3-0022: 3-0022 supply vcc not found, using dummy regulator
[    3.102560] pca953x 3-0022: Linked as a consumer to regulator.0
[    3.109435] GPIO line 481 (MCASP/TRACE_MUX_S0) hogged as output/low
[    3.116158] GPIO line 482 (MCASP/TRACE_MUX_S1) hogged as output/high
[    3.122715] omap_i2c 2000000.i2c: bus 3 rev0.12 at 400 kHz
[    3.136635] omap_i2c 2020000.i2c: bus 4 rev0.12 at 100 kHz
[    3.150595] pca953x 5-0020: 5-0020 supply vcc not found, using dummy regulator
[    3.157996] pca953x 5-0020: Linked as a consumer to regulator.0
[    3.187244] GPIO line 464 (CODEC_RSTz) hogged as output/high
[    3.193151] omap_i2c 2030000.i2c: bus 5 rev0.12 at 400 kHz
[    3.207059] omap_i2c 2040000.i2c: bus 6 rev0.12 at 100 kHz
[    3.220949] omap_i2c 2050000.i2c: bus 7 rev0.12 at 100 kHz
[    3.511941] wiz interconnect@100000:wiz@5030000: Failed to request typec-dir gpio: -517
[    3.532413] cdns-pcie-host d000000.pcie: missing "mem"
[    3.538007] cdns-pcie-host d000000.pcie: Linked as a consumer to phy-5000000.serdes.0
[    4.542610] cdns-pcie-host d000000.pcie: Phy link never came up
[    4.548664] cdns-pcie-host d000000.pcie: host bridge /interconnect@100000/pcie@2900000/pcie@d000000 ranges:
[    4.558632] cdns-pcie-host d000000.pcie:    IO 0x10001000..0x10010fff -> 0x10001000
[    4.566462] cdns-pcie-host d000000.pcie:   MEM 0x10011000..0x17ffffff -> 0x10011000
[    4.574347] cdns-pcie-host d000000.pcie: PCI host bridge to bus 0000:00
[    4.581109] pci_bus 0000:00: root bus resource [bus 00-0f]
[    4.586714] pci_bus 0000:00: root bus resource [io  0x0000-0xffff] (bus address [0x10001000-0x10010fff])
[    4.596404] pci_bus 0000:00: root bus resource [mem 0x10011000-0x17ffffff]
[    4.603457] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x4 may corrupt adjacent RW1C bits
[    4.613328] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x4 may corrupt adjacent RW1C bits
[    4.623221] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x92 may corrupt adjacent RW1C bits
[    4.633181] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0xb2 may corrupt adjacent RW1C bits
[    4.643169] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x84 may corrupt adjacent RW1C bits
[    4.654690] pci 0000:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    4.662871] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x3e may corrupt adjacent RW1C bits
[    4.672830] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x3e may corrupt adjacent RW1C bits
[    4.682792] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x3e may corrupt adjacent RW1C bits
[    4.692750] pci_bus 0000:00: 2-byte config write to 0000:00:00.0 offset 0x6 may corrupt adjacent RW1C bits
[    4.703987] pci_bus 0000:00: 1-byte config write to 0000:00:00.0 offset 0x1a may corrupt adjacent RW1C bits
[    4.713957] pci 0000:00:00.0: PCI bridge to [bus 01]
[    4.731221] cdns-pcie-host d800000.pcie: missing "mem"
[    4.736818] cdns-pcie-host d800000.pcie: Linked as a consumer to phy-5010000.serdes.1
[    5.746198] cdns-pcie-host d800000.pcie: Phy link never came up
[    5.752252] cdns-pcie-host d800000.pcie: host bridge /interconnect@100000/pcie@2910000/pcie@d800000 ranges:
[    5.762218] cdns-pcie-host d800000.pcie:    IO 0x18001000..0x18010fff -> 0x18001000
[    5.770048] cdns-pcie-host d800000.pcie:   MEM 0x18011000..0x1fffffff -> 0x18011000
[    5.777932] cdns-pcie-host d800000.pcie: PCI host bridge to bus 0001:00
[    5.784693] pci_bus 0001:00: root bus resource [bus 00-0f]
[    5.790298] pci_bus 0001:00: root bus resource [io  0x10000-0x1ffff] (bus address [0x18001000-0x18010fff])
[    5.800165] pci_bus 0001:00: root bus resource [mem 0x18011000-0x1fffffff]
[    5.808747] pci 0001:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    5.818307] pci 0001:00:00.0: PCI bridge to [bus 01]
[    5.835580] cdns-pcie-host e000000.pcie: missing "mem"
[    5.841178] cdns-pcie-host e000000.pcie: Linked as a consumer to phy-5020000.serdes.2
[    6.850554] cdns-pcie-host e000000.pcie: Phy link never came up
[    6.856606] cdns-pcie-host e000000.pcie: host bridge /interconnect@100000/pcie@2920000/pcie@e000000 ranges:
[    6.866572] cdns-pcie-host e000000.pcie:    IO 0x4400001000..0x4400010fff -> 0x00001000
[    6.874758] cdns-pcie-host e000000.pcie:   MEM 0x4400011000..0x4407ffffff -> 0x00011000
[    6.882993] cdns-pcie-host e000000.pcie: PCI host bridge to bus 0002:00
[    6.889754] pci_bus 0002:00: root bus resource [bus 00-0f]
[    6.895359] pci_bus 0002:00: root bus resource [io  0x20000-0x2ffff] (bus address [0x1000-0x10fff])
[    6.904605] pci_bus 0002:00: root bus resource [mem 0x4400011000-0x4407ffffff] (bus address [0x00011000-0x07ffffff])
[    6.916881] pci 0002:00:00.0: bridge configuration invalid ([bus 00-00]), reconfiguring
[    6.926441] pci 0002:00:00.0: PCI bridge to [bus 01]
[    6.936174] k3-ringacc 2b800000.ringacc: Ring Accelerator probed rings:286, gp-rings[96,20] sci-dev-id:235
[    6.946054] k3-ringacc 2b800000.ringacc: dma-ring-reset-quirk: disabled
[    6.952814] k3-ringacc 2b800000.ringacc: RA Proxy rev. 66346100, num_proxies:64
[    6.964705] k3-ringacc 3c000000.ringacc: Ring Accelerator probed rings:1024, gp-rings[440,150] sci-dev-id:211
[    6.974844] k3-ringacc 3c000000.ringacc: dma-ring-reset-quirk: disabled
[    6.981602] k3-ringacc 3c000000.ringacc: RA Proxy rev. 66346100, num_proxies:64
[    6.993468] omap8250 40a00000.serial: PM domain pd:149 will not be powered off
[    7.001015] 40a00000.serial: ttyS1 at MMIO 0x40a00000 (irq = 7, base_baud = 6000000) is a 8250
[    7.014389] 2800000.serial: ttyS2 at MMIO 0x2800000 (irq = 15, base_baud = 3000000) is a 8250
[    7.023128] console [ttyS2] enabled
[    7.023128] console [ttyS2] enabled
[    7.030162] bootconsole [ns16550a0] disabled
[    7.030162] bootconsole [ns16550a0] disabled
[    7.048064] 2810000.serial: ttyS3 at MMIO 0x2810000 (irq = 16, base_baud = 3000000) is a 8250
[    7.065852] 2820000.serial: ttyS4 at MMIO 0x2820000 (irq = 17, base_baud = 3000000) is a 8250
[    7.083646] 2840000.serial: ttyS6 at MMIO 0x2840000 (irq = 18, base_baud = 3000000) is a 8250
[    7.124425] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    7.131032] [drm] No driver support for vblank timestamp query.
[    7.213999] [drm] Initialized tidss 1.0.0 20180215 for 4a00000.dss on minor 0
[    7.328008] Console: switching to colour frame buffer device 240x67
[    7.350588] tidss 4a00000.dss: fb0: DRM emulated frame buffer device
[    7.370292] cadence-qspi 47050000.spi: unrecognized JEDEC id bytes: ff, ff, ff
[    7.377504] cadence-qspi 47050000.spi: Cadence QSPI NOR probe failed -2
[    7.403970] cadence-qspi: probe of 47050000.spi failed with error -2
[    7.424175] 47034000.hyperbus: Found 1 x16 devices at 0x0 in 16-bit bank. Manufacturer ID 0x000001 Chip ID 0x007000
[    7.434603] Amd/Fujitsu Extended Query Table at 0x0040
[    7.434627]   Amd/Fujitsu Extended Query version 1.5.
[    7.444772] 47034000.hyperbus: CFI contains unrecognised boot bank location (0). Assuming bottom.
[    7.453624] number of CFI chips: 1
[    7.457024] mtd: no mtd-id
[    7.470241] am65-cpsw-nuss 46000000.ethernet: rx-flow-id-base is not set -22
[    7.477300] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2
[    7.488697] UDMA has not been proped
[    7.492265] am65-cpsw-nuss 46000000.ethernet: Failed to request tx dma channel -517
[    7.524581] am65-cpts 310d0000.cpts: CPTS ver 0x4e8a010a, freq:200000000, add_val:4 pps:0
[    7.543020] mmc0: Unknown controller version (4). You may experience problems.
[    7.581007] mmc0: SDHCI controller on 4f80000.sdhci [4f80000.sdhci] using ADMA 64-bit
[    7.599107] sdhci-am654 4fb0000.sdhci: Linked as a consumer to regulator.8
[    7.616042] sdhci-am654 4fb0000.sdhci: Dropping the link to regulator.8
[    7.635701] mmc0: new HS400 MMC card at address 0001
[    7.641263] mmcblk0: mmc0:0001 S0J56X 14.8 GiB
[    7.646657] mmcblk0boot0: mmc0:0001 S0J56X partition 1 31.5 MiB
[    7.653159] mmcblk0boot1: mmc0:0001 S0J56X partition 2 31.5 MiB
[    7.659286] mmcblk0rpmb: mmc0:0001 S0J56X partition 3 4.00 MiB, chardev (242:0)
[    7.805478] vdd_mmc1: supplied by vsys_3v3
[    7.815235] omap-mailbox 31f80000.mailbox: omap mailbox rev 0x66fc7100
[    7.827168] omap-mailbox 31f81000.mailbox: omap mailbox rev 0x66fc7100
[    7.839094] omap-mailbox 31f82000.mailbox: omap mailbox rev 0x66fc7100
[    7.851035] omap-mailbox 31f83000.mailbox: omap mailbox rev 0x66fc7100
[    7.862938] omap-mailbox 31f84000.mailbox: omap mailbox rev 0x66fc7100
[    7.920618] ti-udma 285c0000.udmap: Channels: 24 (tchan: 48, echan: 0, rchan: 48, rflow: 96)
[    7.960370] ti-udma 31150000.udmap: Channels: 84 (tchan: 140, echan: 160, rchan: 140, rflow: 300)
[    7.980704] am65-cpsw-nuss 46000000.ethernet: rx-flow-id-base is not set -22
[    7.987768] am65-cpsw-nuss 46000000.ethernet: initializing am65 cpsw nuss version 0x6BA00101, cpsw version 0x6BA80100 Ports: 2
[    8.179244] am65-cpsw-nuss 46000000.ethernet: set new flow-id-base 48
[    8.297783] pps pps0: new PPS source ptp1
[    8.301884] am65-cpsw-nuss 46000000.ethernet: CPTS ver 0x4e8a010a, freq:500000000, add_val:1 pps:1
[    8.310828] am65-cpsw-nuss 46000000.ethernet: initialized cpsw ale version 0.4
[    8.318035] am65-cpsw-nuss 46000000.ethernet: ALE Table size 64
[    8.362593] am65-cpsw-nuss 46000000.ethernet: davinci mdio revision 9.7, bus freq 1000000
[    8.370754] libphy: 46000000.ethernet: probed
[    8.386353] sdhci-am654 4fb0000.sdhci: Linked as a consumer to regulator.16
[    8.393331] sdhci-am654 4fb0000.sdhci: Linked as a consumer to regulator.8
[    8.400232] mmc1: Unknown controller version (4). You may experience problems.
[    8.448975] mmc1: SDHCI controller on 4fb0000.sdhci [4fb0000.sdhci] using ADMA 64-bit
[    8.624894] hctosys: unable to open rtc device (rtc0)
[    9.697841] ALSA device list:
[    9.700805]   No soundcards found.
[    9.704456] Waiting for root device PARTUUID=b2b88448-02...
[    9.795180] mmc1: new high speed SDHC card at address aaaa
[    9.801293] mmcblk1: mmc1:aaaa SL16G 14.8 GiB
[    9.813394]  mmcblk1: p1 p2
[    9.830616] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null)
[    9.838720] VFS: Mounted root (ext4 filesystem) on device 179:98.
[    9.854724] devtmpfs: mounted
[    9.857821] Freeing unused kernel memory: 576K
[    9.862277] Run /sbin/init as init process
[   10.154926] systemd[1]: System time before build time, advancing clock.
[   10.240462] NET: Registered protocol family 10
[   10.245311] Segment Routing with IPv6
[   10.280250] 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)
[   10.301694] systemd[1]: Detected architecture arm64.

Welcome to Arago 2019.05!

[   10.330172] systemd[1]: Set hostname to <j7-evm>.
[   10.485574] 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.
[   10.502623] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[   10.623686] random: systemd: uninitialized urandom read (16 bytes read)
[   10.630335] systemd[1]: Reached target Swap.
[  OK  ] Reached target Swap.
[   10.646737] random: systemd: uninitialized urandom read (16 bytes read)
[   10.653511] systemd[1]: Listening on Network Service Netlink Socket.
[  OK  ] Listening on Network Service Netlink Socket.
[   10.670636] random: systemd: uninitialized urandom read (16 bytes read)
[   10.677324] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Started Forward Password Requests to Wall Directory Watch.
[   10.694733] systemd[1]: Listening on udev Kernel Socket.
[  OK  ] Listening on udev Kernel Socket.
[   10.711270] systemd[1]: Created slice User and Session Slice.
[  OK  ] Created slice User and Session Slice.
[  OK  ] Reached target Slices.
[  OK  ] Listening on initctl Compatibility Named Pipe.
[  OK  ] Started Dispatch Password Requests to Console Directory Watch.
[  OK  ] Reached target Paths.
[  OK  ] Listening on udev Control Socket.
[  OK  ] Listening on Journal Socket (/dev/log).
[  OK  ] Created slice system-serial\x2dgetty.slice.
[  OK  ] Listening on Journal Socket.
         Mounting Huge Pages File System...
         Mounting Kernel Debug File System...
         Starting Load Kernel Modules...
[   10.874148] cmemk: loading out-of-tree module taints kernel.
         Starting Create list of required st…ce nodes for the [   10.882161] CMEMK module: reference Linux version 4.19.50
current kernel...
[   10.891062] allocated heap buffer 0xbc000000 of size 0x24000000
[   10.898499] cmemk initialized
         Starting udev Coldplug all Devices...
[   10.917475] cryptodev: driver 1.9 loaded.
[  OK  ] Started Hardware RNG Entropy Gatherer Daemon.
         Starting Remount Root and Kernel File Systems...
[   10.963437] EXT4-fs (mmcblk1p2): re-mounted. Opts: (null)
         Mounting Temporary Directory (/tmp)...
         Mounting POSIX Message Queue File System...
[  OK  ] Reached target Remote File Systems.
[  OK  ] Created slice system-getty.slice.
[  OK  ] Listening on Process Core Dump Socket.
         Starting Journal Service...
[  OK  ] Mounted Huge Pages File System.
[  OK  ] Mounted Kernel Debug File System.
[  OK  ] Started Load Kernel Modules.
[  OK  ] Started Journal Service.
[  OK  ] Started Create list of required sta…vice nodes for the current kernel.
[  OK  ] Started Remount Root and Kernel File Systems.
[  OK  ] Mounted Temporary Directory (/tmp).
[  OK  ] Mounted POSIX Message Queue File System.
         Starting Create Static Device Nodes in /dev...
         Starting Flush Journal to Persistent Storage...
         Mounting Kernel Configuration File System...
         Starting Apply Kernel Variables...
[  OK  ] Started udev Coldplug all Devices.
[  OK  ] Started Create Static Device Nodes in /dev.
[  OK  ] Mounted Kernel Configuration File System.
[  OK  ] Started Apply Kernel Variables.
[  OK  ] Reached target Local File Systems (Pre).
         Mounting /media/ram...
         Mounting /var/volatile...
[  OK  ] Reached target Containers.
         Starting udev Kernel Device Manager...
[  OK  ] Mounted /media/ram.
[  OK  ] Mounted /var/volatile.
[   11.407190] systemd-journald[154]: Received request to flush runtime journal from PID 1
         Starting Load/Save Random Seed...
[  OK  ] Reached target Local File Systems.
[  OK  ] Started Flush Journal to Persistent Storage.
[  OK  ] Started udev Kernel Device Manager.
[  OK  ] Started Load/Save Random Seed.
         Starting Create Volatile Files and Directories...
[  OK  ] Started Create Volatile Files and Directories.
         Starting Update UTMP about System Boot/Shutdown...
         Starting Network Time Synchronization...
         Starting Network Service...
[  OK  ] Started Update UTMP about System Boot/Shutdown.
[  OK  ] Found device /dev/ttyS2.
[  OK  ] Started Network Service.
         Starting Network Name Resolution...
[  OK  ] Started Network Time Synchronization.
[  OK  ] Reached target System Time Synchronized.
[   11.733679] pcm3168a 5-0044: Linked as a consumer to regulator.2
[  OK  ] Reached target System Initialization.[   11.740851] pcm3168a 5-0044: Linked as a consumer to regulator.3

[  OK  ] Started Daily rotation of log files.
[  OK  ] Listening on RPCbind Server Activation Socket.
[   11.879832] k3-dsp-rproc 4d80800000.dsp: assigned reserved memory node c66-dma-memory@a7000000
[   11.896845] k3-dsp-rproc 4d80800000.dsp: configured DSP for IPC-only mode
[   11.917254] remoteproc remoteproc0: 4d80800000.dsp is available
[   11.930765] k3-dsp-rproc 4d81800000.dsp: assigned reserved memory node c66-dma-memory@a6000000
[  OK  ] Listening on D-Bus System Message Bus Socket.
[   11.953397] k3-dsp-rproc 4d81800000.dsp: configured DSP for IPC-only mode
[   11.960927] remoteproc remoteproc1: 4d81800000.dsp is available
[   11.974028] PVR_K:  176: HTBInit: HTBufferSizeInKB = 64
[   11.980505] iommu: Adding device 0000:00:00.0 to group 0
[   11.986549] pci-endpoint-test 0000:00:00.0: of_irq_parse_pci: failed with rc=-22
[   11.998018] pci_generic_config_write32: 29 callbacks suppressed
[   11.998024] pci_bus 0000:00: 1-byte config write to 0000:00:00.0 offset 0x3c may corrupt adjacent RW1C bits
[   12.015679] k3-dsp-rproc 64800000.dsp: assigned reserved memory node c71-dma-memory@a8000000
[   12.026102] iommu: Adding device 0001:00:00.0 to group 1
[   12.033460] k3-dsp-rproc 64800000.dsp: configured DSP for IPC-only mode
[   12.043147] pci-endpoint-test 0001:00:00.0: of_irq_parse_pci: failed with rc=-22
[   12.051947] pvrsrvkm 4e20000000.gpu: Linked as a consumer to genpd:0:4e20000000.gpu
[  OK  ] Listening on dropbear.socket.
[   12.063503] remoteproc remoteproc2: 64800000.dsp is available
[  OK  ] Reached target Sockets.
[   12.076668] pci_bus 0001:00: 1-byte config write to 0001:00:00.0 offset 0x3c may corrupt adjacent RW1C bits
[  OK  ] Reached target Basic System.
[   12.088984] pvrsrvkm 4e20000000.gpu: Linked as a consumer to genpd:1:4e20000000.gpu
         Starting Print notice about GPLv3 packages...
[  OK  ] Started irqbalance daemon.
         Starting Login Service...
[  OK  ] Started D-Bus System Message Bus.
         Starting rng-tools.service...
[  OK  ] Started strongSwan IPsec IKEv1/IKEv2 daemon using ipsec.conf.
         Starting Reboot and dump vmcore via [   12.136949] iommu: Adding device 0002:00:00.0 to group 2
kexec...
[  OK  ] Started Job spooling tools.
[   12.145645] pci-endpoint-test 0002:00:00.0: of_irq_parse_pci: failed with rc=-22
[  OK  ] Started Daily Cleanup of Temporary Directori[   12.156326] PVR_K:  176: Read BVNC 22.104.208.318 from HW device registers
es.
[  OK  ] Reached target Timers.
[   12.181157] pci_bus 0002:00: 1-byte config write to 0002:00:00.0 offset 0x3c may corrupt adjacent RW1C bits
[   12.194228] PVR_K:  176: RGX Device initialised with BVNC 22.104.208.318
[  OK  ] Started TEE Supplicant.
[   12.209824] [drm] Initialized pvr 1.10.5187610 20170530 for 4e20000000.gpu on minor 1
[   12.277062] img_dec 4300000.video-decoder: decoder registered as /dev/video0
         Starting RPC Bind Service...
[   12.360735] k3_r5_rproc interconnect@100000:interconnect@28380000:r5fss@41000000: creating child devices for R5F cores
[   12.443051] platform 41000000.r5f: configured R5F for remoteproc mode
[   12.482877] platform 41000000.r5f: assigned reserved memory node r5f-dma-memory@a0000000
[   12.491078] remoteproc remoteproc3: 41000000.r5f is available
[   12.496968] remoteproc remoteproc3: Direct firmware load for j7-mcu-r5f0_0-fw failed with error -2
[   12.503213] k3_r5_rproc interconnect@100000:r5fss@5c00000: creating child devices for R5F cores
[   12.506772] remoteproc remoteproc3: powering up 41000000.r5f
[   12.520343] remoteproc remoteproc3: Direct firmware load for j7-mcu-r5f0_0-fw failed with error -2
[   12.524020] platform 5c00000.r5f: R5F core may have been powered on by a different host, programmed state (0) != actual state (1)
[   12.531027] remoteproc remoteproc3: request_firmware failed: -2
[   12.549193] platform 5c00000.r5f: configured R5F for IPC-only mode
[   12.556067] platform 5c00000.r5f: assigned reserved memory node r5f-dma-memory@a2000000
[   12.564267] remoteproc remoteproc4: 5c00000.r5f is available
[   12.578629] platform 5d00000.r5f: configured R5F for IPC-only mode
[   12.584856] platform 5d00000.r5f: assigned reserved memory node r5f-dma-memory@a3000000
[   12.593122] remoteproc remoteproc5: 5d00000.r5f is available
[   12.604255] k3_r5_rproc interconnect@100000:r5fss@5e00000: creating child devices for R5F cores
[   12.624974] platform 5e00000.r5f: configured R5F for remoteproc mode
[   12.640636] platform 5e00000.r5f: assigned reserved memory node r5f-dma-memory@a4000000
[   12.649971] remoteproc remoteproc6: 5e00000.r5f is available
[   12.655722] remoteproc remoteproc6: Direct firmware load for j7-main-r5f1_0-fw failed with error -2
[   12.667190] remoteproc remoteproc6: powering up 5e00000.r5f
[   12.676727] remoteproc remoteproc6: Direct firmware load for j7-main-r5f1_0-fw failed with error -2
[   12.685787] remoteproc remoteproc6: request_firmware failed: -2
[  OK  ] Started Periodic Command Scheduler.
[  OK  ] Started Network Name Resolution.
[  OK  ] Reached target Host and Network Name Lookups.
[  OK  ] Reached target Network.
         Starting Lightning Fast Webserver With Light System Requirements...
         Starting Permit User Sessions...
[   12.991724] asoc-simple-card sound@0: pcm3168a-dac <-> 2ba0000.mcasp mapping ok
[   13.055971] asoc-simple-card sound@0: pcm3168a-adc <-> 2ba0000.mcasp mapping ok
[   13.109916] remoteproc remoteproc0: powering up 4d80800000.dsp
[   13.115770] remoteproc remoteproc0: Booting fw image j7-c66_0-fw, size 7390424
[   13.123091] k3-dsp-rproc 4d80800000.dsp: DSP initialized in IPC-only mode
[   13.130298] virtio_rpmsg_bus virtio0: rpmsg host is online
[   13.135821] remoteproc remoteproc0: registered virtio0 (type 7)
[   13.142096] remoteproc remoteproc0: remote processor 4d80800000.dsp is now up
[   13.164090] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0xd
[   13.228114] remoteproc remoteproc4: powering up 5c00000.r5f
[   13.233715] remoteproc remoteproc4: Booting fw image j7-main-r5f0_0-fw, size 1918996
[   13.291296] remoteproc remoteproc1: powering up 4d81800000.dsp
[   13.297151] remoteproc remoteproc1: Booting fw image j7-c66_1-fw, size 7389416
[   13.304460] k3-dsp-rproc 4d81800000.dsp: DSP initialized in IPC-only mode
[   13.311675] virtio_rpmsg_bus virtio1: rpmsg host is online
[   13.317210] remoteproc remoteproc1: registered virtio1 (type 7)
[   13.323488] remoteproc remoteproc1: remote processor 4d81800000.dsp is now up
[   13.345506] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0xd
[   13.768768] remoteproc remoteproc2: powering up 64800000.dsp
[   13.774439] remoteproc remoteproc2: Booting fw image j7-c71_0-fw, size 12337604
[   13.781863] k3-dsp-rproc 64800000.dsp: DSP initialized in IPC-only mode
[   13.788926] virtio_rpmsg_bus virtio2: rpmsg host is online
[   13.794457] remoteproc remoteproc2: registered virtio2 (type 7)
[   13.800711] remoteproc remoteproc2: remote processor 64800000.dsp is now up
[   13.819304] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0xd
[   13.840952] TI DP83867 k3-cpsw-mdio:00: attached PHY driver [TI DP83867] (mii_bus:phy_addr=k3-cpsw-mdio:00, irq=POLL)
[   13.852263] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   13.977088] remoteproc remoteproc5: powering up 5d00000.r5f
[   13.982700] remoteproc remoteproc5: Booting fw image j7-main-r5f0_1-fw, size 9413284
[   13.990607] platform 5d00000.r5f: R5F core initialized in IPC-only mode
[   13.997777] virtio_rpmsg_bus virtio3: rpmsg host is online
[   14.003310] remoteproc remoteproc5: registered virtio3 (type 7)
[   14.009250] remoteproc remoteproc5: remote processor 5d00000.r5f is now up
[   14.023230] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0xd
[   14.031173] virtio_rpmsg_bus virtio3: creating channel rpmsg_chrdev addr 0x15
[   14.038396] virtio_rpmsg_bus virtio0: creating channel rpmsg_chrdev addr 0x15
[   14.045764] virtio_rpmsg_bus virtio0: creating channel ti.ipc4.ping-pong addr 0xe
[   14.053336] virtio_rpmsg_bus virtio1: creating channel rpmsg_chrdev addr 0x15
[   14.066786] virtio_rpmsg_bus virtio1: creating channel ti.ipc4.ping-pong addr 0xe
[   14.078802] virtio_rpmsg_bus virtio2: creating channel rpmsg_chrdev addr 0x15
[   14.090001] virtio_rpmsg_bus virtio2: creating channel ti.ipc4.ping-pong addr 0xe
[  OK  ] Started Login Service.
[  OK  ] Started rng-tools.service.
[  OK  ] Started Reboot and dump vmcore via kexec.
[  OK  ] Started RPC Bind Service.
[  OK  ] Started Lightning Fast Webserver With Light System Requirements.
[  OK  ] Started Permit User Sessions.
[   14.223235] NET: Registered protocol family 15
[  OK  ] Started Serial Getty on ttyS2.
[  OK  ] Started Getty on tty1.
[  OK  ] Reached target Login Prompts.
         Starting Synchronize System and HW clocks...
[  OK  ] Started NFS status monitor for NFSv2/3 locking..
         Starting rc.pvr.service...
[   14.319870] Initializing XFRM netlink socket
[FAILED] Failed to start Synchronize System and HW clocks.
See 'systemctl status sync-clocks.service' for details.
[   14.614513] cdns-usb3 6000000.usb: DRD version v1 (ID: 0004024e, rev: 00000200)
[  OK  ] Started rc.pvr.service.
         Starting weston.service...
[   14.683050] cdns-usb3 6400000.usb: DRD version v1 (ID: 0004024e, rev: 00000200)
         Starting Save/Restore Sound Card State...
[   14.819097] usbcore: registered new interface driver usbfs
[   14.824684] usbcore: registered new interface driver hub
[   14.830103] usbcore: registered new device driver usb
[   14.867981] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[   14.873514] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 1
[   14.882268] xhci-hcd xhci-hcd.1.auto: hcc params 0x200073c9 hci version 0x100 quirks 0x0000000000010010
[   14.891732] am65-cpsw-nuss 46000000.ethernet eth0: Link is Down
[   14.892196] xhci-hcd xhci-hcd.1.auto: irq 315, io mem 0x06410000
[   14.904202] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[   14.912738] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   14.920201] usb usb1: Product: xHCI Host Controller
[   14.925139] usb usb1: Manufacturer: Linux 4.19.50-g79386bfefc xhci-hcd
[   14.931873] usb usb1: SerialNumber: xhci-hcd.1.auto
[   14.937078] hub 1-0:1.0: USB hub found
[   14.940952] hub 1-0:1.0: 1 port detected
[   14.945089] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[   14.950638] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 2
[   14.958340] xhci-hcd xhci-hcd.1.auto: Host supports USB 3.0  SuperSpeed
[   14.965033] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[   14.973197] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.19
[   14.981496] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   14.988744] usb usb2: Product: xHCI Host Controller
[   14.993653] usb usb2: Manufacturer: Linux 4.19.50-g79386bfefc xhci-hcd
[   15.000217] usb usb2: SerialNumber: xhci-hcd.1.auto
[   15.005335] hub 2-0:1.0: USB hub found
[   15.009168] hub 2-0:1.0: 1 port detected
[   15.278611] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[  OK  ] Created slice system-systemd\x2dfsck.slice.
[   15.430905] usb 1-1: New USB device found, idVendor=0451, idProduct=8142, bcdDevice= 1.00
[   15.439110] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=1
[   15.446246] usb 1-1: SerialNumber: 7E060879E165
[   15.451744] hub 1-1:1.0: USB hub found
[   15.455536] hub 1-1:1.0: 4 ports detected
[  OK  ] Started Save/Restore Sound Card State.
[  OK  ] Reached target Sound Card.
[  OK  ] Found device /dev/mmcblk1p1.
         Starting File System Check on /dev/mmcblk1p1...
[  OK  ] Started File System Check on /dev/mmcblk1p1.
         Mounting /run/media/mmcblk1p1...
[  OK  ] Mounted /run/media/mmcblk1p1.
***************************************************************
***************************************************************
NOTICE: This file system contains the following GPLv3 packages:
        autoconf
        bash-dev
        bash
        bc
        binutils
        cifs-utils
        cpio
        cpp-symlinks
        cpp
        dosfstools
        elfutils
        g++-symlinks
        g++
        gawk
        gcc-symlinks
        gcc
        gdb
        gdbserver
        gettext
        glmark2
        gstreamer1.0-libav
        gzip
        libbfd
        libdw1
        libelf1
        libgdbm-compat4
        libgdbm-dev
        libgdbm6
        libgettextlib
        libgettextsrc
        libgmp10
        libidn2-0
        libmpc3
        libmpfr6
        libreadline-dev
        libreadline7
        libunistring2
        m4
        make
        nettle
        parted
        which

If you do not wish to distribute GPLv3 components please remove
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 the --force-removal-of-dependent-packages option to
      also remove the dependent packages as well
***************************************************************
***************************************************************
[  OK  ] Started Print notice about GPLv3 packages.
[  OK  ] Started weston.service.
         Starting telnetd.service...
         Starting Matrix GUI...
[  OK  ] Started telnetd.service.
         Starting thttpd.service...
[  OK  ] Started Matrix GUI.
[  OK  ] Started thttpd.service.
         Starting thermal-zone-init.service...
[  OK  ] Started thermal-zone-init.service.
[  OK  ] Reached target Multi-User System.
         Starting Update UTMP about System Runlevel Changes...
[  OK  ] Started Update UTMP about System Runlevel Changes.

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

Arago Project http://arago-project.org j7-evm ttyS2

Arago 2019.05 j7-evm ttyS2

j7-evm login: [  110.138842] random: crng init done
[  110.142237] random: 7 urandom warning(s) missed due to ratelimiting

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

Arago Project http://arago-project.org j7-evm ttyS2

Arago 2019.05 j7-evm ttyS2

j7-evm login: root
root@j7-evm:~# cd /opt/vision_apps/
root@j7-evm:/opt/vision_apps# ./vision_apps_init.sh
root@j7-evm:/opt/vision_apps# APP_LOG: Mapping 0xb8000000 ...
APP_LOG: Mapped 0xb8000000 -> 0xffffba2f0000 of size 262144 bytes
[MCU2_1]      0.000758 s: CIO: Init ... Done !!!
[MCU2_1]      0.000833 s: ### CPU Frequency <ORG = 1000000000 Hz>, <NEW = 1000000000 Hz>
[MCU2_1]      0.000874 s: APP: Init ... !!!
[MCU2_1]      0.000892 s: SCICLIENT: Init ... !!!
[MCU2_1]      0.002417 s: SCICLIENT: DMSC FW version [19.6.1-v2019.06a (Terrific Llam]
[MCU2_1]      0.002465 s: SCICLIENT: DMSC FW revision 0x13
[MCU2_1]      0.002490 s: SCICLIENT: DMSC FW ABI revision 2.6
[MCU2_1]      0.002514 s: SCICLIENT: Init ... Done !!!
[MCU2_1]      0.002535 s: UDMA: Init ... !!!
[MCU2_1]      0.002756 s: UDMA: Init ... Done !!!
[MCU2_1]      0.002793 s: MEM: Init ... !!!
[MCU2_1]      0.002824 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ a4101000 of size 50331648 bytes !!!
[MCU2_1]      0.002905 s: MEM: Init ... Done !!!
[MCU2_1]      0.002929 s: IPC: Init ... !!!
[MCU2_1]      0.002955 s: IPC: 5 CPUs participating in IPC !!!
[MCU2_1]      0.002985 s: IPC: Waiting for HLOS to be ready ... !!!
[MCU2_1]     19.473162 s: IPC: HLOS is ready !!!
[MCU2_1]     19.494070 s: IPC: Init ... Done !!!
[MCU2_1]     19.494147 s: APP: Syncing with 4 CPUs ... !!!
[MCU2_1]     19.494192 s: APP: Syncing with 4 CPUs ... Done !!!
[MCU2_1]     19.494232 s: REMOTE_SERVICE: Init ... !!!
[MCU2_1]     19.494939 s: REMOTE_SERVICE: Init ... Done !!!
[MCU2_1]     19.495013 s: MEM PROXY: Init ... !!!
[MCU2_1]     19.495056 s: MEM PROXY: Init ... Done !!!
[MCU2_1]     19.495089 s: FVID2: Init ... !!!
[MCU2_1]     19.495162 s: FVID2: Init ... Done !!!
[MCU2_1]     19.495198 s: DSS: Init ... !!!
[MCU2_1]     19.495229 s: DSS: Display type is eDP !!!
[MCU2_1]     19.495261 s: DSS: SoC init ... !!!
[MCU2_1]     19.495287 s: SCICLIENT: Sciclient_pmSetModuleState module=297 state=2
[MCU2_1]     19.551287 s: SCICLIENT: Sciclient_pmSetModuleState success
[MCU2_1]     19.551342 s: SCICLIENT: Sciclient_pmSetModuleState module=151 state=2
[MCU2_1]     19.562373 s: SCICLIENT: Sciclient_pmSetModuleState success
[MCU2_1]     19.562413 s: SCICLIENT: Sciclient_pmSetModuleClkParent module=152 clk=4 parent=6
[MCU2_1]     19.567728 s: SCICLIENT: Sciclient_pmSetModuleClkParent success
[MCU2_1]     19.567764 s: SCICLIENT: Sciclient_pmSetModuleState module=152 state=2
[MCU2_1]     19.572148 s: SCICLIENT: Sciclient_pmSetModuleState success
[MCU2_1]     19.572180 s: SCICLIENT: Sciclient_pmModuleClkRequest module=152 clk=0 state=2 flag=0
[MCU2_1]     19.576568 s: SCICLIENT: Sciclient_pmModuleClkRequest success
[MCU2_1]     19.576603 s: SCICLIENT: Sciclient_pmSetModuleClkFreq module=152 clk=4 freq=148500000
[MCU2_1]     19.588485 s: SCICLIENT: Sciclient_pmSetModuleClkFreq success
[MCU2_1]     19.588523 s: SCICLIENT: Sciclient_pmModuleClkRequest module=152 clk=6 state=2 flag=0
[MCU2_1]     19.592864 s: SCICLIENT: Sciclient_pmModuleClkRequest success
[MCU2_1]     19.592901 s: SCICLIENT: Sciclient_pmModuleClkRequest module=152 clk=4 state=2 flag=0
[MCU2_1]     19.597284 s: SCICLIENT: Sciclient_pmModuleClkRequest success
[MCU2_1]     19.597317 s: DSS: SoC init ... Done !!!
[MCU2_1]     19.597341 s: DSS: Board init ... !!!
[MCU2_1]     19.597361 s: DSS: Board init ... Done !!!
[MCU2_1]     21.220665 s: src/trace.c @ Line 448:
[MCU2_1]     21.220720 s:  Assertion @ Line: 1937 in src/drv/dctrl/dss_dctrlApi.c: (FVID2_SOK == retVal) : failed !!!
[C6x_1 ]      0.005745 s: CIO: Init ... Done !!!
[C6x_1 ]      0.005783 s: ### CPU Frequency <ORG = 1350000000 Hz>, <NEW = 1350000000 Hz>
[C6x_1 ]      0.005798 s: APP: Init ... !!!
[C6x_1 ]      0.005804 s: SCICLIENT: Init ... !!!
[C6x_1 ]      0.007283 s: SCICLIENT: DMSC FW version [19.6.1-v2019.06a (Terrific Llam]
[C6x_1 ]      0.007297 s: SCICLIENT: DMSC FW revision 0x13
[C6x_1 ]      0.007305 s: SCICLIENT: DMSC FW ABI revision 2.6
[C6x_1 ]      0.007314 s: SCICLIENT: Init ... Done !!!
[C6x_1 ]      0.007322 s: UDMA: Init ... !!!
[C6x_1 ]      0.007446 s: UDMA: Init ... Done !!!
[C6x_1 ]      0.007461 s: MEM: Init ... !!!
[C6x_1 ]      0.007472 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ ac201000 of size 8388608 bytes !!!
[C6x_1 ]      0.007491 s: MEM: Created heap (DDR_SCRATCH_MEM, id=4, flags=0x00000001) @ aa201000 of size 33554432 bytes !!!
[C6x_1 ]      0.007506 s: MEM: Init ... Done !!!
[C6x_1 ]      0.007513 s: IPC: Init ... !!!
[C6x_1 ]      0.007523 s: IPC: 5 CPUs participating in IPC !!!
[C6x_1 ]      0.007537 s: IPC: Waiting for HLOS to be ready ... !!!
[C6x_1 ]     17.429797 s: IPC: HLOS is ready !!!
[C6x_1 ]     17.463647 s: IPC: Init ... Done !!!
[C6x_1 ]     17.463678 s: APP: Syncing with 4 CPUs ... !!!
[C6x_1 ]     18.318306 s: APP: Syncing with 4 CPUs ... Done !!!
[C6x_1 ]     18.318337 s: REMOTE_SERVICE: Init ... !!!
[C6x_1 ]     18.318553 s: REMOTE_SERVICE: Init ... Done !!!
[C6x_1 ]     18.318605 s:  VX_ZONE_INIT:Enabled
[C6x_1 ]     18.318618 s:  VX_ZONE_ERROR:Enabled
[C6x_1 ]     18.318627 s:  VX_ZONE_WARNING:Enabled
[C6x_1 ]     18.319343 s:  VX_ZONE_INIT:[tivxInit:64] Initialization Done !!!
[C6x_1 ]     18.319365 s: APP: OpenVX Target kernel init ... !!!
[C6x_1 ]     18.319488 s: APP: OpenVX Target kernel init ... Done !!!
[C6x_1 ]     18.319512 s: APP: Init ... Done !!!
[C6x_1 ]     18.319521 s: APP: Run ... !!!
[C6x_1 ]     18.319529 s: IPC: Starting echo test ...
[C6x_1 ]     18.320276 s: APP: Run ... Done !!!
[C6x_1 ]     18.320878 s: IPC: Echo status: mpu1_0[x] mcu2_1[x] C66X_1[s] C66X_2[P] C7X_1[x]
[C6x_1 ]     18.327991 s: IPC: Echo status: mpu1_0[x] mcu2_1[x] C66X_1[s] C66X_2[P] C7X_1[P]
[C6x_2 ]      0.005747 s: CIO: Init ... Done !!!
[C6x_2 ]      0.005784 s: ### CPU Frequency <ORG = 1350000000 Hz>, <NEW = 1350000000 Hz>
[C6x_2 ]      0.005798 s: APP: Init ... !!!
[C6x_2 ]      0.005805 s: SCICLIENT: Init ... !!!
[C6x_2 ]      0.007282 s: SCICLIENT: DMSC FW version [19.6.1-v2019.06a (Terrific Llam]
[C6x_2 ]      0.007297 s: SCICLIENT: DMSC FW revision 0x13
[C6x_2 ]      0.007305 s: SCICLIENT: DMSC FW ABI revision 2.6
[C6x_2 ]      0.007314 s: SCICLIENT: Init ... Done !!!
[C6x_2 ]      0.007322 s: UDMA: Init ... !!!
[C6x_2 ]      0.007444 s: UDMA: Init ... Done !!!
[C6x_2 ]      0.007459 s: MEM: Init ... !!!
[C6x_2 ]      0.007471 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ ae201000 of size 8388608 bytes !!!
[C6x_2 ]      0.007489 s: MEM: Init ... Done !!!
[C6x_2 ]      0.007496 s: IPC: Init ... !!!
[C6x_2 ]      0.007507 s: IPC: 5 CPUs participating in IPC !!!
[C6x_2 ]      0.007520 s: IPC: Waiting for HLOS to be ready ... !!!
[C6x_2 ]     16.448493 s: IPC: HLOS is ready !!!
[C6x_2 ]     16.482375 s: IPC: Init ... Done !!!
[C6x_2 ]     16.482408 s: APP: Syncing with 4 CPUs ... !!!
[C6x_2 ]     17.155626 s: APP: Syncing with 4 CPUs ... Done !!!
[C6x_2 ]     17.155655 s: REMOTE_SERVICE: Init ... !!!
[C6x_2 ]     17.155910 s: REMOTE_SERVICE: Init ... Done !!!
[C6x_2 ]     17.155963 s:  VX_ZONE_INIT:Enabled
[C6x_2 ]     17.155975 s:  VX_ZONE_ERROR:Enabled
[C6x_2 ]     17.155986 s:  VX_ZONE_WARNING:Enabled
[C6x_2 ]     17.156709 s:  VX_ZONE_INIT:[tivxInit:64] Initialization Done !!!
[C6x_2 ]     17.156734 s: APP: OpenVX Target kernel init ... !!!
[C6x_2 ]     17.156850 s: APP: OpenVX Target kernel init ... Done !!!
[C6x_2 ]     17.156876 s: APP: Init ... Done !!!
[C6x_2 ]     17.156885 s: APP: Run ... !!!
[C6x_2 ]     17.156893 s: IPC: Starting echo test ...
[C6x_2 ]     17.157645 s: APP: Run ... Done !!!
[C6x_2 ]     17.158171 s: IPC: Echo status: mpu1_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[x]
[C6x_2 ]     17.165374 s: IPC: Echo status: mpu1_0[x] mcu2_1[x] C66X_1[P] C66X_2[s] C7X_1[P]
[C7x_1 ]      0.043068 s: CIO: Init ... Done !!!
[C7x_1 ]      0.043237 s: ### CPU Frequency <ORG = 1000000000 Hz>, <NEW = 1000000000 Hz>
[C7x_1 ]      0.043500 s: APP: Init ... !!!
[C7x_1 ]      0.043629 s: SCICLIENT: Init ... !!!
[C7x_1 ]      0.045261 s: SCICLIENT: DMSC FW version [19.6.1-v2019.06a (Terrific Llam]
[C7x_1 ]      0.045495 s: SCICLIENT: DMSC FW revision 0x13
[C7x_1 ]      0.045675 s: SCICLIENT: DMSC FW ABI revision 2.6
[C7x_1 ]      0.045868 s: SCICLIENT: Init ... Done !!!
[C7x_1 ]      0.046024 s: UDMA: Init ... !!!
[C7x_1 ]      0.046303 s: UDMA: Init ... Done !!!
[C7x_1 ]      0.046446 s: MEM: Init ... !!!
[C7x_1 ]      0.046585 s: MEM: Created heap (DDR_SHARED_MEM, id=0, flags=0x00000004) @ b0404000 of size 83886080 bytes !!!
[C7x_1 ]      0.046950 s: MEM: Created heap (L3_MEM, id=1, flags=0x00000001) @ 70020000 of size 8159232 bytes !!!
[C7x_1 ]      0.047316 s: MEM: Created heap (L2_MEM, id=2, flags=0x00000001) @ 64800000 of size 458752 bytes !!!
[C7x_1 ]      0.047656 s: MEM: Created heap (L1_MEM, id=3, flags=0x00000001) @ 64e00000 of size 16384 bytes !!!
[C7x_1 ]      0.047993 s: MEM: Created heap (DDR_SCRATCH_MEM, id=4, flags=0x00000001) @ b5404000 of size 16777216 bytes !!!
[C7x_1 ]      0.048380 s: MEM: Init ... Done !!!
[C7x_1 ]      0.048521 s: IPC: Init ... !!!
[C7x_1 ]      0.048653 s: IPC: 5 CPUs participating in IPC !!!
[C7x_1 ]      0.048849 s: IPC: Waiting for HLOS to be ready ... !!!
[C7x_1 ]     15.184033 s: IPC: HLOS is ready !!!
[C7x_1 ]     15.214320 s: IPC: Init ... Done !!!
[C7x_1 ]     15.214486 s: APP: Syncing with 4 CPUs ... !!!
[C7x_1 ]     15.413912 s: APP: Syncing with 4 CPUs ... Done !!!
[C7x_1 ]     15.414646 s: REMOTE_SERVICE: Init ... !!!
[C7x_1 ]     15.415694 s: REMOTE_SERVICE: Init ... Done !!!
[C7x_1 ]     15.415968 s:  VX_ZONE_INIT:Enabled
[C7x_1 ]     15.416439 s:  VX_ZONE_ERROR:Enabled
[C7x_1 ]     15.416677 s:  VX_ZONE_WARNING:Enabled
[C7x_1 ]     15.418171 s:  VX_ZONE_INIT:[tivxInit:64] Initialization Done !!!
[C7x_1 ]     15.418457 s: APP: OpenVX Target kernel init ... !!!
[C7x_1 ]     15.418796 s: APP: OpenVX Target kernel init ... Done !!!
[C7x_1 ]     15.419013 s: APP: Init ... Done !!!
[C7x_1 ]     15.419187 s: APP: Run ... !!!
[C7x_1 ]     15.419354 s: IPC: Starting echo test ...
[C7x_1 ]     15.421811 s: APP: Run ... Done !!!
[C7x_1 ]     15.424124 s: IPC: Echo status: mpu1_0[x] mcu2_1[x] C66X_1[P] C66X_2[.] C7X_1[s]
[C7x_1 ]     15.424687 s: IPC: Echo status: mpu1_0[x] mcu2_1[x] C66X_1[P] C66X_2[P] C7X_1[s]

root@j7-evm:/opt/vision_apps# ./vx_app_single_cam.out
APP: Init ... !!!
APP_LOG: Mapping 0xb8000000 ...
APP_LOG: Mapped 0xb8000000 -> 0xffffb1430000 of size 262144 bytes
MEM: Init ... !!!
MEM: Init ... Done !!!
IPC: Init ... !!!
APP_LOG: Mapping 0xb8040000 ...
APP_LOG: Mapped 0xb8040000 -> 0xffff8b470000 of size 33292288 bytes
APP_LOG: Mapping 0x30e00000 ...
APP_LOG: Mapped 0x30e00000 -> 0xffffb1900000 of size 3072 bytes
IPC: Init ... Done !!!
REMOTE_SERVICE: Init ... !!!
REMOTE_SERVICE: Init ... Done !!!
APP: Init ... Done !!!
     0.000000 s:  VX_ZONE_INIT:Enabled
     0.000023 s:  VX_ZONE_ERROR:Enabled
     0.000027 s:  VX_ZONE_WARNING:Enabled
     0.000204 s:  VX_ZONE_INIT:[tivxInit:64] Initialization Done !!!
     0.000353 s:  VX_ZONE_INIT:[tivxHostInit:35] Initialization Done for HOST !!!
>>>>0
>>>IN_SINGLE_CAM_MAIN
>>>APP_INIT
>>>LOAD_HWA_KERNELS_START
>>>LOAD_HWA_KERNELS_END
>>>LOAD_IMAGING_KERNELS_END
     0.001099 s: ISS: Enumerating sensors ... !!!
REMOTE_SERVICE: TX: mpu1_0 -> mcu2_1 (port 21) cmd = 0x00000000, prm_size = 256 bytes ...
>>>STATUS : 336>>>>READ
^C
root@j7-evm:/opt/vision_apps#

  • Have you followed the steps provided in vision_apps/docs/user_guide/RUN_INSTRUCTIONS.html?

    I think you would have missed Step 2 "make linux_fs_install_sd"

  • Hello, Sivaraj,

    I have followed the provided steps. The missing firmware files from the log are not being built. Perhaps there are some additional build flags that have to be set?

    Thank you,
    Todor

  • Can you share the build log and also any changes made on top of the release package?

  • I have attached the sdk clean build log.

    The only change is in /imaging/sensor_drv/src/imx390/imx390_serdes_config.h configuration to match our hardware.

    diff --git a/imaging/sensor_drv/src/imx390/imx390_serdes_config.h b/imaging/sensor_drv/src/imx390/imx390_serdes_config.h
    --- a/imaging/sensor_drv/src/imx390/imx390_serdes_config.h
    +++ b/imaging/sensor_drv/src/imx390/imx390_serdes_config.h
    @@ -16,11 +16,11 @@ SoC will communicate with the devices using alias adresses
     #define SER_2_I2C_ALIAS       (0x78U)
     #define SER_3_I2C_ALIAS       (0x7AU)
     
    -//#define CAM_MODULE_VER 0 //D3_IMX390_CM
    -#define CAM_MODULE_VER 1 //D3_IMX390_RCM
    +#define CAM_MODULE_VER 0 //D3_IMX390_CM^M
    +//#define CAM_MODULE_VER 1 //D3_IMX390_RCM^M
     
    -//#define FUSION_BOARD_VER 0 //RevB and older
    -#define FUSION_BOARD_VER 1 //RevC
    +#define FUSION_BOARD_VER 0 //RevB and older^M
    +//#define FUSION_BOARD_VER 1 //RevC^M
     
     #if (CAM_MODULE_VER == 0)
     #define IMX390_I2C_ADDR 0x42

    No other changes were made, except uncommenting two debug defines and adding some debug prints.

    Thanks,
    Todor
    5670.output.log

  • I suspect what is happening is A72 is asking R5F to init the sensor and the sensor init is hanging.

    You can confirm this by enabling logs in below file

    vision_apps/utils/remote_service/src/app_remote_service_sysbios.c

    Uncomment, #define APP_REMOTE_SERVICE_DEBUG and see the logs.

    You should a message before the command is executed and one after after.

    If the message after does not appear then sensor config is stuck maybe because you don't have right HW.

    regards
    Kedar

  • Can you please revert your changes and try again? Camera output will not work if you don't have the right HW, but it should fail at a later stage. Let's reach that state and debug from there.

  • Hello Kedar,

    I tried with the changes you suggested and this is the result.

    APP: Init ... !!!
    APP_LOG: Mapping 0xb8000000 ...
    APP_LOG: Mapped 0xb8000000 -> 0xffffa34b0000 of size 262144 bytes
    MEM: Init ... !!!
    MEM: Init ... Done !!!
    IPC: Init ... !!!
    APP_LOG: Mapping 0xb8040000 ...
    APP_LOG: Mapped 0xb8040000 -> 0xffff7d4f0000 of size 33292288 bytes
    APP_LOG: Mapping 0x30e00000 ...
    APP_LOG: Mapped 0x30e00000 -> 0xffffa3980000 of size 3072 bytes
    IPC: Init ... Done !!!
    REMOTE_SERVICE: Init ... !!!
    REMOTE_SERVICE: Init ... Done !!!
    APP: Init ... Done !!!
         0.000000 s:  VX_ZONE_INIT:Enabled
         0.000022 s:  VX_ZONE_ERROR:Enabled
         0.000027 s:  VX_ZONE_WARNING:Enabled
         0.000176 s:  VX_ZONE_INIT:[tivxInit:64] Initialization Done !!!
         0.000317 s:  VX_ZONE_INIT:[tivxHostInit:35] Initialization Done for HOST !!!
    >>>>0
    >>>IN_SINGLE_CAM_MAIN
    >>>APP_INIT
    >>>LOAD_HWA_KERNELS_START
    >>>LOAD_HWA_KERNELS_END
    >>>LOAD_IMAGING_KERNELS_END
         0.000873 s: ISS: Enumerating sensors ... !!!
    REMOTE_SERVICE: TX: mpu1_0 -> mcu2_1 (port 21) cmd = 0x00000000, prm_size = 256 bytes ...
    >>>STATUS : 336>>>>READ
    [MCU2_1]    283.669888 s: REMOTE_SERVICE: RX: mpu1_0 (port 21) -> mcu2_1 (port 21) cmd = 0x00000000, prm_size = 256 bytes ... !!!
    [MCU2_1]    283.669965 s: >> service: com.ti.image_sensor, cmd: 0

    It was observed that the hang occurs in vision_apps/utils/remote_service/src/app_remote_service_sysbios.c file
    at appRemoteServiceRxTaskMain() function right after the appRemoteServiceRunHandler() call.

    I put a break at imaging/sensor_drv/src/iss_sensors.c on ImageSensor_RemoteServiceHandler function and it did not break,
    which leads me to the conclusion that the IPC call could not reach R5F.

    Regards,
    Todor

  • Update:

    After further inspection, the cause of the hang was a semaphore that was not released.
    There is an assertion when calling the ./vision_apps_init.sh script that we missed.
    [MCU2_1]     19.206297 s: src/trace.c @ Line 448:
    [MCU2_1]     19.206355 s:  Assertion @ Line: 1937 in src/drv/dctrl/dss_dctrlApi.c: (FVID2_SOK == retVal) : failed !!!

    and after the assertion, the semaphore is not being released, so when the application is executed, it hangs.
    What does this assertion mean?

    Thank you for the support,
    Todor


  • Hi Todor,

    Can you check if it is asserting on below line?

    regionId = Dss_dctrlGetVpSafetyRegionId(currEvent);
    GT_assert(DssTrace, (CSL_DSS_VP_SAFETY_REGION_INVALID != regionId));

    Rgds,

    Brijesh

  • Hi Brijesh,

    No, it is asserting here:

    #if defined (SOC_J721E)
        if(DSS_DCTRL_NODE_EDP_DPI0 == outNode)
        {
            retVal = Dss_dctrlDrvProgDP();
            GT_assert(DssTrace, (FVID2_SOK == retVal));
        }
    #endif

    After unplugging the Display Port - there is no assertion, but the application still hangs - probably waiting for Display Port to connect?

    Regards,
    Todor

  • Hi Todor,

    I think DP init is somehow failing. Is it possible to use HDMI output?

    Rgds,

    Brijesh

  • Hi Todor,

    There is a known issue eDP drivers which will be fixed in next release coming out in 2 weeks. Till then I suggest disabling eDP. Please follow the instructions below:

    Edit vision_apps/apps/basic_demos/app_tirtos/common/app_cfg*.h for additional build time configuration,

     Comment ENABLE_DSS_EDP to enable HDMI display via Infotainment daughter card

    This will make the DSS output from HDMI. You don't have HDMI boards so will not be able to see the live video. However, you can start the usecase and capture RAW/YUV snapshots for viewing.

  • Hi Mayank,

    After applying the suggested change in apps/basic_demos/app_tirtos/common/app_cfg_mcu2_1.h file and performing a clean build, the device is unable to boot properly.
    This is the only change.

    diff --git a/vision_apps/apps/basic_demos/app_tirtos/common/app_cfg_mcu2_1.h b/vision_apps/apps/basic_demos/app_tirtos/common/app_cfg_mcu2_1.h
    index 99996e61..af3a72ae 100755
    --- a/vision_apps/apps/basic_demos/app_tirtos/common/app_cfg_mcu2_1.h
    +++ b/vision_apps/apps/basic_demos/app_tirtos/common/app_cfg_mcu2_1.h
    @@ -71,7 +71,7 @@
     
     #define ENABLE_DSS
     /* uncomment below to use eDP display, else DPI/HDMI display is used */
    -#define ENABLE_DSS_EDP
    +/*#define ENABLE_DSS_EDP*/

    I have attached the device output log and the build log.7028.build_output.log
    0638.device_output.log
    Regards,
    Todor

  • Update:

    The device output issue has been resolved - it was due to improper serial port wiring.

    Regards,
    Todor

  • The initial issue has been resolved after disabling Display Port. The application no longer hangs.

    Thank you for the support,
    Todor