Linux/TDA2EXEVM: Failed to start Load Kernel Modules and start fail

Part Number: TDA2EXEVM

Tool/software: Linux

hi 

  I use the TDA2EG chip,tansfer linux 4.4 to our own board,the log as follow:

[11:16:46]Starting kernel ...
[11:16:46]
[11:16:46]-->>>697
[11:16:46][    0.000000] Booting Linux on physical CPU 0x0
[11:16:46][    0.000000] Initializing cgroup subsys cpuset
[11:16:46][    0.000000] Initializing cgroup subsys cpu
[11:16:46][    0.000000] Initializing cgroup subsys cpuacct
[11:16:46][    0.000000] Linux version 4.4.84+ (root@ubuntu) (gcc version 5.3.1 20160113 (Linaro GCC 5.3-2016.02) ) #51 SMP PREEMPT Tue Jan 30 11:11:15 CST 2018
[11:16:46][    0.000000] CPU: ARMv7 Processor [412fc0f2] revision 2 (ARMv7), cr=30c5387d
[11:16:46][    0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[11:16:46][    0.000000] Machine model: TI DRA722
[11:16:46][    0.000000] bootconsole [earlycon0] enabled
[11:16:46][    0.000000] Reserved memory: invalid reg property in 'app_cma@9F000000', skipping node.
[11:16:46][    0.000000] Reserved memory: created CMA memory pool at 0x0000000095800000, size 56 MiB
[11:16:46][    0.000000] Reserved memory: initialized node ipu2_cma@95800000, compatible id shared-dma-pool
[11:16:46][    0.000000] Reserved memory: created CMA memory pool at 0x0000000099000000, size 64 MiB
[11:16:46][    0.000000] Reserved memory: initialized node dsp1_cma@99000000, compatible id shared-dma-pool
[11:16:46][    0.000000] Reserved memory: created CMA memory pool at 0x000000009d000000, size 32 MiB
[11:16:46][    0.000000] Reserved memory: initialized node ipu1_cma@9d000000, compatible id shared-dma-pool
[11:16:46][    0.000000] cma: Reserved 64 MiB at 0x00000000bbc00000
[11:16:46][    0.000000] Forcing write-allocate cache policy for SMP
[11:16:46][    0.000000] Memory policy: Data cache writealloc
[11:16:46][    0.000000] OMAP4: Map 0x00000000bfd00000 to fe600000 for dram barrier
[11:16:46][    0.000000] DRA722 ES2.0
[11:16:46][    0.000000] PERCPU: Embedded 11 pages/cpu @ef648000 s14912 r8192 d21952 u45056
[11:16:46][    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 259648
[11:16:46][    0.000000] Kernel command line: console=ttyS0,115200n8 elevator=noop root=/dev/mmcblk0p2 ro rootwait earlyprintk fixrtc omapdrm.num_crtc=2 consoleblank=0 cma=64M rootfstype=ext4 snd.slots_reserved=1,1
[11:16:46][    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[11:16:46][    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[11:16:46][    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[11:16:46][    0.000000] Memory: 806588K/1045504K available (5106K kernel code, 230K rwdata, 980K rodata, 296K init, 260K bss, 17732K reserved, 221184K cma-reserved, 193536K highmem)
[11:16:46][    0.000000] Virtual kernel memory layout:
[11:16:46][    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[11:16:46][    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[11:16:46][    0.000000]     vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
[11:16:46][    0.000000]     lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
[11:16:46][    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[11:16:46][    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[11:16:46][    0.000000]       .text : 0xc0008000 - 0xc05f9f74   (6088 kB)
[11:16:46][    0.000000]       .init : 0xc05fa000 - 0xc0644000   ( 296 kB)
[11:16:46][    0.000000]       .data : 0xc0644000 - 0xc067d938   ( 231 kB)
[11:16:46][    0.000000]        .bss : 0xc067f000 - 0xc06c01b4   ( 261 kB)
[11:16:46][    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[11:16:46][    0.000000] Preemptible hierarchical RCU implementation.
[11:16:46][    0.000000]  Build-time adjustment of leaf fanout to 32.
[11:16:46][    0.000000]  RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1.
[11:16:46][    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=32, nr_cpu_ids=1
[11:16:46][    0.000000] NR_IRQS:16 nr_irqs:16 16
[11:16:46][    0.000000] OMAP clockevent source: timer1 at 32786 Hz
[11:16:46][    0.000000] Architected cp15 timer(s) running at 6.14MHz (virt).
[11:16:46][    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x16af5adb9, max_idle_ns: 440795202250 ns
[11:16:46][    0.000006] sched_clock: 56 bits at 6MHz, resolution 162ns, wraps every 4398046511023ns
[11:16:46][    0.008326] Switching to timer-based delay loop, resolution 162ns
[11:16:46][    0.015070] clocksource: 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns
[11:16:46][    0.025354] OMAP clocksource: 32k_counter at 32768 Hz
[11:16:46][    0.031139] Console: colour dummy device 80x30
[11:16:46][    0.035810] Calibrating delay loop (skipped), value calculated using timer frequency.. 12.29 BogoMIPS (lpj=61475)
[11:16:46][    0.046471] pid_max: default: 32768 minimum: 301
[11:16:46][    0.051415] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[11:16:46][    0.058317] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[11:16:46][    0.066305] Initializing cgroup subsys io
[11:16:46][    0.070544] Initializing cgroup subsys memory
[11:16:46][    0.075130] Initializing cgroup subsys devices
[11:16:46][    0.079789] Initializing cgroup subsys freezer
[11:16:46][    0.084461] Initializing cgroup subsys perf_event
[11:16:46][    0.089387] Initializing cgroup subsys pids
[11:16:46][    0.093798] CPU: Testing write buffer coherency: ok
[11:16:46][    0.099142] /cpus/cpu@0 missing clock-frequency property
[11:16:46][    0.104695] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[11:16:46][    0.110627] Setting up static identity map for 0x80008380 - 0x800083e0
[11:16:47][    0.160899] Brought up 1 CPUs
[11:16:47][    0.164039] SMP: Total of 1 processors activated (12.29 BogoMIPS).
[11:16:47][    0.170478] CPU: All CPU(s) started in SVC mode.
[11:16:47][    0.175700] devtmpfs: initialized
[11:16:47][    0.215551] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0
[11:16:47][    0.224383] omap_hwmod: l3_main_2 using broken dt data from ocp
[11:16:47][    0.339803] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[11:16:47][    0.350026] futex hash table entries: 256 (order: 2, 16384 bytes)
[11:16:47][    0.365032] pinctrl core: initialized pinctrl subsystem
[11:16:47][    0.371432] NET: Registered protocol family 16
[11:16:47][    0.377250] DMA: preallocated 256 KiB pool for atomic coherent allocations
[11:16:47][    0.414495] cpuidle: using governor ladder
[11:16:47][    0.444522] cpuidle: using governor menu
[11:16:47][    0.457322] platform 43300000.edma: Cannot lookup hwmod 'tpcc'
[11:16:47][    0.463750] platform 43400000.tptc: Cannot lookup hwmod 'tptc0'
[11:16:47][    0.470285] platform 43500000.tptc: Cannot lookup hwmod 'tptc1'
[11:16:47][    0.477765] OMAP GPIO hardware version 0.1
[11:16:47][    0.489828] irq: no irq domain found for /ocp/l4@4a000000/scm@2000/pinmux@1400 !
[11:16:47][    0.522735] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[11:16:47][    0.531085] hw-breakpoint: maximum watchpoint size is 8 bytes.
[11:16:47][    0.537712] omap4_sram_init:Unable to allocate sram needed to handle errata I688
[11:16:47][    0.545429] omap4_sram_init:Unable to get sram pool needed to handle errata I688
[11:16:47][    0.553408] OMAP DMA hardware revision 0.0
[11:16:47][    0.640754] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver (LinkedList1/2/3 supported)
[11:16:47][    0.651156] edma3-tptc 43400000.tptc: _od_fail_runtime_resume: FIXME: missing hwmod/omap_dev info
[11:16:47][    0.660418] edma3-tptc 43500000.tptc: _od_fail_runtime_resume: FIXME: missing hwmod/omap_dev info
[11:16:47][    0.669927] edma 43300000.edma: _od_fail_runtime_resume: FIXME: missing hwmod/omap_dev info
[11:16:47][    0.678607] edma 43300000.edma: pm_runtime_get_sync() failed
[11:16:47][    0.688754] omap-iommu 40d01000.mmu: 40d01000.mmu registered
[11:16:47][    0.694864] omap-iommu 40d02000.mmu: 40d02000.mmu registered
[11:16:47][    0.700913] omap-iommu 58882000.mmu: 58882000.mmu registered
[11:16:47][    0.706989] omap-iommu 55082000.mmu: 55082000.mmu registered
[11:16:47][    0.716208] palmas 0-0058: Irq flag is 0x00000000
[11:16:47][    0.753332] palmas 0-0058: Muxing GPIO 51, PWM 0, LED 2
[11:16:47][    0.863966] omap_i2c 48070000.i2c: bus 0 rev0.12 at 100 kHz
[11:16:47][    0.870463] omap_i2c 4807c000.i2c: bus 4 rev0.12 at 400 kHz
[11:16:47][    0.876498] media: Linux media interface: v0.10
[11:16:47][    0.881299] Linux video capture interface: v2.00
[11:16:47][    0.886179] EDAC MC: Ver: 3.0.0
[11:16:47][    0.900196] omap-mailbox 48840000.mailbox: omap mailbox rev 0x400
[11:16:47][    0.906783] omap-mailbox 48842000.mailbox: omap mailbox rev 0x400
[11:16:47][    0.914265] clocksource: Switched to clocksource arch_sys_counter
[11:16:47][    0.931317] NET: Registered protocol family 2
[11:16:47][    0.936526] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[11:16:47][    0.943930] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[11:16:47][    0.950811] TCP: Hash tables configured (established 8192 bind 8192)
[11:16:47][    0.957501] UDP hash table entries: 512 (order: 2, 16384 bytes)
[11:16:47][    0.963705] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[11:16:47][    0.970503] NET: Registered protocol family 1
[11:16:47][    0.976242] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
[11:16:47][    1.006520] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[11:16:47][    1.012610] ntfs: driver 2.1.32 [Flags: R/O].
[11:16:47][    1.018718] bounce: pool size: 64 pages
[11:16:47][    1.022922] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[11:16:47][    1.030699] io scheduler noop registered (default)
[11:16:47][    1.035761] io scheduler deadline registered
[11:16:47][    1.040267] io scheduler cfq registered
[11:16:47][    1.049009] pinctrl-single 4a003400.pinmux: 282 pins at pa fc003400 size 1128
[11:16:47][    1.056609] pinctrl-single 4a002e8c.pinmux: 1 pins at pa fc002e8c size 4
[11:16:47][    1.084690] fpd3_serdes 4-000d: Serializer fpd3_24b_ser ready
[11:16:48][    1.157294] Serial: 8250/16550 driver, 10 ports, IRQ sharing disabled
[11:16:48][    1.167266] omap8250 4806a000.serial: Can't verify DMA configuration (-19)
[11:16:48][    1.175047] console [ttyS0] disabled
[11:16:48][    1.178865] 4806a000.serial: ttyS0 at MMIO 0x4806a000 (irq = 301, base_baud = 3000000) is a 8250
[11:16:48][    1.188113] console [ttyS0] enabled
[11:16:48][    1.188113] console [ttyS0] enabled
[11:16:48][    1.195332] bootconsole [earlycon0] disabled
[11:16:48][    1.195332] bootconsole [earlycon0] disabled
[11:16:48][    1.204704] omap8250 48020000.serial: Can't verify DMA configuration (-19)
[11:16:48][    1.212182] 48020000.serial: ttyS2 at MMIO 0x48020000 (irq = 302, base_baud = 3000000) is a 8250
[11:16:48][    1.222376] [drm] Initialized drm 1.1.0 20060810
[11:16:48][    1.229912] OMAP DSS rev 6.1
[11:16:48][    1.233836] omapdss_dss 58000000.dss: bound 58001000.dispc (ops 0xc0541c54)
[11:16:48][    1.243951] vmemexp device MAJOR num = 248
[11:16:48][    1.248110] vmemexp class registered
[11:16:48][    1.251859] /dev/vmemexp device registered
[11:16:48][    1.255996] ioctl DBUFIOC_EXPORT_VIRTMEM = -1072899120
[11:16:48][    1.262856] i2c /dev entries driver
[11:16:48][    1.267714] vpe 489d0000.vpe: loading firmware vpdma-1b8.bin
[11:16:48][    1.274885] vip 48970000.vip: loading firmware vpdma-1b8.bin
[11:16:48][    1.283033] omap_hsmmc 4809c000.mmc: Got CD GPIO
[11:16:48][    1.287930] vpe 489d0000.vpe: Device registered as /dev/video0
[11:16:48][    1.294290] evm_3v3_sd: supplied by evm_3v3
[11:16:48][    1.314290] vip 48970000.vip: VPDMA firmware loaded
[11:16:48][    1.344795] omap_hsmmc 480b4000.mmc: no pinctrl state for sdr25 mode
[11:16:48][    1.351183] omap_hsmmc 480b4000.mmc: no pinctrl state for sdr12 mode
[11:16:48][    1.405037] ledtrig-cpu: registered to indicate activity on CPUs
[11:16:48][    1.412275] omap-rproc 58820000.ipu: assigned reserved memory node ipu1_cma@9d000000
[11:16:48][    1.434321]  remoteproc0: 58820000.ipu is available
[11:16:48][    1.439222]  remoteproc0: Note: remoteproc is still under development and considered experimental.
[11:16:48][    1.464266]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[11:16:48][    1.484359]  remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[11:16:48][    1.492574]  remoteproc0: Falling back to user helper
[11:16:48][    1.497839] omap-rproc 55020000.ipu: assigned reserved memory node ipu2_cma@95800000
[11:16:48][    1.514350]  remoteproc1: 55020000.ipu is available
[11:16:48][    1.519251]  remoteproc1: Note: remoteproc is still under development and considered experimental.
[11:16:48][    1.544269]  remoteproc1: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[11:16:48][    1.564342]  remoteproc1: Direct firmware load for dra7-ipu2-fw.xem4 failed with error -2
[11:16:48][    1.572557]  remoteproc1: Falling back to user helper
[11:16:48][    1.577853] omap-rproc 40800000.dsp: assigned reserved memory node dsp1_cma@99000000
[11:16:48][    1.594345]  remoteproc2: 40800000.dsp is available
[11:16:48][    1.599245]  remoteproc2: Note: remoteproc is still under development and considered experimental.
[11:16:48][    1.624268]  remoteproc2: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[11:16:48][    1.645745] NET: Registered protocol family 10
[11:16:48][    1.654543] sit: IPv6 over IPv4 tunneling driver
[11:16:48][    1.659847] NET: Registered protocol family 17
[11:16:48][    1.664444]  remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[11:16:48][    1.672659]  remoteproc2: Falling back to user helper
[11:16:48][    1.694303] NET: Registered protocol family 41
[11:16:48][    1.698908] omap_voltage_late_init: Voltage driver support not added
[11:16:48][    1.714924] Power Management for TI OMAP4+ devices.
[11:16:48][    1.720047] Registering SWP/SWPB emulation handler
[11:16:48][    1.736882] dmm 4e000000.dmm: initialized all PAT entries
[11:16:48][    1.772371] hctosys: unable to open rtc device (rtc0)
[11:16:48][    1.779043] omap8250 4806a000.serial: failed to request DMA
[11:16:48][    1.784912] Waiting for root device /dev/mmcblk0p2...
[11:16:48][    1.801420] mmc0: host does not support reading read-only switch, assuming write-enable
[11:16:48][    1.812114] mmc0: new high speed SDHC card at address aaaa
[11:16:48][    1.828203] mmcblk0: mmc0:aaaa SC32G 29.7 GiB
[11:16:48][    1.833682]  mmcblk0: p1 p2
[11:16:48][    1.919360] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[11:16:48][    1.927610] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[11:16:48][    1.942354] devtmpfs: mounted
[11:16:48][    1.945586] Freeing unused kernel memory: 296K
[11:16:48][    1.950050] This architecture does not have kernel memory protection.
[11:16:48][    1.969991] mmc1: MAN_BKOPS_EN bit is not set
[11:16:48][    1.991837] Kernel Entry time 49718 ticks
[11:16:48][    2.049717] mmc1: new HS200 MMC card at address 0001
[11:16:48][    2.065509] mmcblk1: mmc1:0001 MMC08G 7.25 GiB
[11:16:48][    2.080370] mmcblk1boot0: mmc1:0001 MMC08G partition 1 8.00 MiB
[11:16:48][    2.096869] mmcblk1boot1: mmc1:0001 MMC08G partition 2 8.00 MiB
[11:16:48][    2.105883]  mmcblk1: p1 p2 p3 p4 < p5 p6 p7 p8 p9 >
[11:16:49][    2.213040] systemd[1]: System time before build time, advancing clock.
[11:16:49][    2.238933] random: systemd: uninitialized urandom read (16 bytes read, 12 bits of entropy available)
[11:16:49][    2.251444] random: systemd: uninitialized urandom read (16 bytes read, 12 bits of entropy available)
[11:16:49][    2.263669] systemd[1]: systemd 229 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT +GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN)
[11:16:49][    2.282417] systemd[1]: Detected architecture arm.
[11:17:19][   32.285244] systemd[1]: Set hostname to <dra7xx-evm>.
[11:17:19][   32.338811] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 14 bits of entropy available)
[11:17:19][   32.355348] random: systemd-gpt-aut: uninitialized urandom read (16 bytes read, 14 bits of entropy available)
[11:17:19][   32.367143] random: systemd-gpt-aut: uninitialized urandom read (16 bytes read, 14 bits of entropy available)
[11:17:19][   32.379647] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 14 bits of entropy available)
[11:17:19][   32.400018] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 15 bits of entropy available)
[11:17:19][   32.486959] random: systemd: uninitialized urandom read (16 bytes read, 18 bits of entropy available)
[11:17:19][   32.496776] random: systemd: uninitialized urandom read (16 bytes read, 18 bits of entropy available)
[11:17:19][   32.507000] random: systemd: uninitialized urandom read (16 bytes read, 18 bits of entropy available)
[11:17:19][   32.692574] systemd[1]: sysinit.target: Found ordering cycle on sysinit.target/start
[11:17:19][   32.700509] systemd[1]: sysinit.target: Found dependency on alignment.service/start
[11:17:19][   32.708302] systemd[1]: sysinit.target: Found dependency on basic.target/start
[11:17:19][   32.715589] systemd[1]: sysinit.target: Found dependency on sockets.target/start
[11:17:19][   32.723026] systemd[1]: sysinit.target: Found dependency on dropbear.socket/stop
[11:17:19][   32.730482] systemd[1]: sysinit.target: Found dependency on sysinit.target/start
[11:17:19][   32.737938] systemd[1]: sysinit.target: Breaking ordering cycle by deleting job alignment.service/start
[11:17:19][   32.747401] systemd[1]: alignment.service: Job alignment.service/start deleted to break ordering cycle starting with sysinit.target/start
[11:17:48][   61.524405]  remoteproc0: failed to load dra7-ipu1-fw.xem4
[11:17:48][   61.604375]  remoteproc1: failed to load dra7-ipu2-fw.xem4
[11:17:48][   61.704374]  remoteproc2: failed to load dra7-dsp1-fw.xe66
[11:17:49][   62.757918] systemd[1]: Listening on udev Control Socket.
[11:18:19][   92.754806] systemd[1]: Listening on Network Service Netlink Socket.
[11:18:49][  122.754814] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[11:19:19][  152.754479] systemd[1]: Reached target Remote File Systems.
[11:19:49][  182.754618] systemd[1]: Listening on Journal Socket (/dev/log).
[11:20:19][  212.754636] systemd[1]: Listening on Journal Socket.
[11:20:49][  242.754571] systemd[1]: Listening on Syslog Socket.
[11:21:19][  272.770786] systemd[1]: Reached target Swap.
[11:21:49][  302.776365] systemd[1]: Created slice User and Session Slice.
[11:22:19][  332.774649] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[11:22:49][  362.774554] systemd[1]: Listening on udev Kernel Socket.
[11:23:19][  392.774693] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[11:23:49][  422.774455] systemd[1]: Reached target Paths.
[11:24:19][  452.775353] systemd[1]: Created slice System Slice.
[11:24:49][  482.774489] systemd[1]: Reached target Slices.
[11:25:19][  512.775391] systemd[1]: Created slice system-getty.slice.
[11:25:49][  542.778694] systemd[1]: Mounting Temporary Directory...
[11:26:19][  572.785841] systemd[1]: Created slice system-serial\x2dgetty.slice.
[11:26:49][  602.787281] systemd[1]: Starting File System Check on Root Device...
[11:27:19][  632.797825] systemd[1]: Starting Create Static Device Nodes in /dev...
[11:27:19][  632.856718] systemd[1]: Starting Setup Virtual Console...
[11:27:19][  632.890183] systemd[1]: Mounting POSIX Message Queue File System...
[11:27:19][  632.928174] systemd[1]: Starting Journal Service...
[11:27:19][  632.963021] systemd[1]: Starting Load Kernel Modules...
[11:27:19][  633.015072] systemd[1]: Mounted POSIX Message Queue File System.
[11:27:19][  633.021370] systemd[1]: Mounted Temporary Directory.
[11:27:19][  633.056874] systemd[1]: Started Create Static Device Nodes in /dev.
[11:27:19][  633.089059] systemd[1]: Started Setup Virtual Console.
[11:27:19][  633.109440] systemd[1]: systemd-modules-load.service: Main process exited, code=exited, status=1/FAILURE
[11:27:19][  633.140330] systemd[1]: Failed to start Load Kernel Modules.
[11:27:20][  633.160082] systemd[1]: systemd-modules-load.service: Unit entered failed state.
[11:27:20][  633.181881] systemd[1]: systemd-modules-load.service: Failed with result 'exit-code'.
[11:27:20][  633.200453] systemd[1]: Started Journal Service.
[11:28:51][  724.609768] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[11:33:24][  997.196820] EXT4-fs (mmcblk1p2): recovery complete
[11:33:24][  997.213590] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null)
[11:33:24][  997.279601] EXT4-fs (mmcblk1p6): recovery complete
[11:33:24][  997.299588] EXT4-fs (mmcblk1p3): recovery complete
[11:33:24][  997.331235] EXT4-fs (mmcblk1p6): mounted filesystem with ordered data mode. Opts: (null)
[11:33:24][  997.348357] EXT4-fs (mmcblk1p3): mounted filesystem with ordered data mode. Opts: (null)
[11:33:24][  997.387146] EXT4-fs (mmcblk1p5): recovery complete
[11:33:24][  997.391981] EXT4-fs (mmcblk1p5): mounted filesystem with ordered data mode. Opts: (null)
[11:33:24][  997.810889] EXT4-fs (mmcblk1p7): recovery complete
[11:33:24][  997.816397] EXT4-fs (mmcblk1p8): recovery complete
[11:33:24][  997.821226] EXT4-fs (mmcblk1p8): mounted filesystem with ordered data mode. Opts: (null)
[11:33:24][  997.864345] EXT4-fs (mmcblk1p7): mounted filesystem with ordered data mode. Opts: (null)
[11:33:25][  998.293305] EXT4-fs (mmcblk1p9): recovery complete
[11:33:25][  998.315357] EXT4-fs (mmcblk1p9): mounted filesystem with ordered data mode. Opts: (null)
[11:44:22][ 1655.715224] random: nonblocking pool is initialized

I have some question:

Q1: failed to load ....

[11:17:48][   61.524405]  remoteproc0: failed to load dra7-ipu1-fw.xem4
[11:17:48][   61.604375]  remoteproc1: failed to load dra7-ipu2-fw.xem4
[11:17:48][   61.704374]  remoteproc2: failed to load dra7-dsp1-fw.xe66

in the /lib/firware has load dra7-ipu1-fw.xem4、dra7-ipu2-fw.xem4、dra7-dsp1-fw.xe66 files。why don't load? 

Q2: Failed to start Load Kernel Modules.   why?

Q3: [11:28:51][  724.609768] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[11:33:24][  997.196820] EXT4-fs (mmcblk1p2): recovery complete
[11:33:24][  997.213590] EXT4-fs (mmcblk1p2): mounted filesystem

 why  remount cosume too much time? 5min,

Q4: [11:44:22][ 1655.715224] random: nonblocking pool is initialized

         dead when start ?