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.

Linux/AM5726: Reset while booting kernel

Part Number: AM5726
Other Parts Discussed in Thread: PMP, AM5728,

Tool/software: Linux

Hi all,

I made an SD Card with BSP sdk-linux-am57xx-evm-04.00.00.04. During booting the kernel, board reboots after starting udev . When I remove /lib/modules/4.9.28-geed43d1050, board brings up to login but no modules installed at all. What may be the problem?

Below is the log before reset:

Welcome to Arago 2017.05!

[ 4.010547] systemd[1]: Set hostname to <am57xx-evm>.
[ 4.258978] systemd[1]: Listening on Network Service Netlink Socket.
[ OK ] Listening on Network Service Netlink Socket.
[ 4.317066] systemd[1]: Listening on Journal Socket.
[ OK ] Listening on Journal Socket.
[ 4.350040] systemd[1]: Listening on Journal Socket (/dev/log).
[ OK ] Listening on Journal Socket (/dev/log).
[ 4.379924] systemd[1]: Reached target Swap.
[ OK ] Reached target Swap.
[ 4.410068] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ OK ] Started Dispatch Password Requests to Console Directory Watch.
[ 4.451715] systemd[1]: Created slice System Slice.
[ OK ] Created slice System Slice.
[ 4.480497] systemd[1]: Created slice system-getty.slice.
[ OK ] Created slice system-getty.slice.
Starting Load Kernel Modules...
[ 4.526181] cryptodev: loading out-of-tree module taints kernel.
[ 4.533037] cryptodev: driver 1.8 loaded.
Starting Setup Virtual Console...
Starting Remount Root and Kernel File Systems...
[ 4.584802] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ OK ] Started Forward Password Requests to Wall Directory Watch.
[ OK ] Reached target Paths.
[ OK ] Listening on udev Kernel Socket.
[ OK ] Listening on udev Control Socket.
[ OK ] Listening on /dev/initctl Compatibility Named Pipe.
[ OK ] Reached target Remote File Systems.
Mounting Temporary Directory...
[ OK ] Created slice User and Session Slice.
[ OK ] Reached target Slices.
Mounting POSIX Message Queue File System...
Mounting Debug File System...
[ OK ] Created slice system-serial\x2dgetty.slice.
[ OK ] Listening on Syslog Socket.
Starting Journal Service...
Starting Create Static Device Nodes in /dev...
[ OK ] Mounted POSIX Message Queue File System.
[ OK ] Mounted Debug File System.
[ OK ] Mounted Temporary Directory.
[ OK ] Started Journal Service.
[ OK ] Started Load Kernel Modules.
[ OK ] Started Setup Virtual Console.
[ OK ] Started Remount Root and Kernel File Systems.
[ OK ] Started Create Static Device Nodes in /dev.
Starting udev Kernel Device Manager...
Starting Rebuild Hardware Database...
[ OK ] Reached target Local File Systems (Pre).
Mounting /media/ram...
Mounting /var/volatile...
Starting Apply Kernel Variables...
Mounting Configuration File System...
Starting Flush Journal to Persistent Storage...
[ OK ] Mounted Configuration File System.
[ OK ] Mounted /var/volatile.
[ OK ] Mounted /media/ram.
[ OK ] Started udev Kernel Device Manager.
[ OK ] Started Apply Kernel Variables.
Starting Load/Save Random Seed...
[ OK ] Reached target Local File Systems.
Starting Rebuild Dynamic Linker Cache...
Starting Rebuild Journal Catalog...
[ OK ] Started Load/Save Random Seed.
[ 5.871241] systemd-journald[127]: Received request to flush runtime journal from PID 1
[ OK ] Started Flush Journal to Persistent Storage.
Starting Create Volatile Files and Directories...
[ OK ] Started Rebuild Journal Catalog.
[ OK ] Started Create Volatile Files and Directories.
Starting Network Time Synchronization...
Starting Opkg first boot configure...
Starting Update UTMP about System Boot/Shutdown...
[ OK ] Started Update UTMP about System Boot/Shutdown.
[ OK ] Started Network Time Synchronization.
[ OK ] Started Rebuild Hardware Database.
Starting udev Coldplug all Devices...
Starting Synchronize System and HW clocks...
[ OK ] Reached target System Time Synchronized.
[FAILED] Failed to start Synchronize System and HW clocks.
See 'systemctl status sync-clocks.service' for details.
[ OK ] Started Opkg first boot configure.
[ 7.965246] omap-rproc 58820000.ipu: assigned reserved memory node ipu1_cma@9d000000
[ 7.990653] remoteproc remoteproc0: 58820000.ipu is available
[ 7.991018] omap-rproc 55020000.ipu: assigned reserved memory node ipu2_cma@95800000
[ 7.991096] remoteproc remoteproc1: 55020000.ipu is available
[ 7.991276] omap-rproc 40800000.dsp: assigned reserved memory node dsp1_cma@99000000
[ 7.991354] remoteproc remoteproc2: 40800000.dsp is available
[ 7.991640] omap-rproc 41000000.dsp: assigned reserved memory node dsp2_cma@9f000000
[ 7.991716] remoteproc remoteproc3: 41000000.dsp is available
[ 8.008553] remoteproc remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[ 8.008564] remoteproc remoteproc0: powering up 58820000.ipu
[ 8.008587] remoteproc remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[ 8.008592] remoteproc remoteproc0: request_firmware failed: -2
[ 8.008634] remoteproc remoteproc3: Direct firmware load for dra7-dsp2-fw.xe66 failed with error -2
[ 8.008638] remoteproc remoteproc3: powering up 41000000.dsp
[ 8.008657] remoteproc remoteproc3: Direct firmware load for dra7-dsp2-fw.xe66 failed with error -2
[ 8.008661] remoteproc remoteproc3: request_firmware failed: -2
[ 8.008695] remoteproc remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[ 8.008701] remoteproc remoteproc2: powering up 40800000.dsp
[ 8.008718] remoteproc remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[ 8.008722] remoteproc remoteproc2: request_firmware failed: -2
[ 8.008755] remoteproc remoteproc1: Direct firmware load for dra7-ipu2-fw.xem4 failed with error -2
[ 8.008760] remoteproc remoteproc1: powering up 55020000.ipu
[ 8.008777] remoteproc remoteproc1: Direct firmware load for dra7-ipu2-fw.xem4 failed with error -2
[ 8.008782] remoteproc remoteproc1: request_firmware failed: -2
[ 8.254378] omap-des 480a5000.des: OMAP DES hw accel rev: 2.2
[ 8.268957] omap-des 480a5000.des: will run requests pump with realtime priority
[ 8.272695] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659 as rtc1
[ 8.279034] mt9t11x 4-003c: input-clock-freq: 32000000
[ 8.279039] mt9t11x 4-003c: pixel-clock-freq: 96000000
[ 8.280267] rtc-ds1307: probe of 2-006f failed with error -5
[ 8.329936] mt9t11x 4-003c: Product ID error ffffff87
[ 8.387208] omap_rtc 48838000.rtc: rtc core: registered 48838000.rtc as rtc2
[ 8.456370] pixcir_ts 4-005c: pixcir_set_power_mode: can't read reg 0x33 : -121
[ 8.456374] pixcir_ts 4-005c: Failed to set IDLE mode
[ 8.456449] pixcir_ts: probe of 4-005c failed with error -121
[ 8.457484] vpe 489d0000.vpe: loading firmware vpdma-1b8.bin
[ 8.458729] vip 48990000.vip: loading firmware vpdma-1b8.bin
[ 8.489917] vip 48990000.vip: VPDMA firmware loaded
[ 8.494113] vpe 489d0000.vpe: Device registered as /dev/video0
[ 8.672213] SCSI subsystem initialized
[ OK ] Started udev Coldplug all Devices.
[ OK ] Started Rebuild Dynamic Linker Cache.
[ OK ] Found device /dev/ttyS2.
Starting Update is Completed...
[ 8.986608] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[ 8.998134] omap-sham 4b101000.sham: hw accel on OMAP rev 4.3
[ OK ] Started Update is Completed.
[ OK ] Reached target System Initialization.
[ 9.056163] ahci 4a140000.sata: SSS flag set, parallel bus scan disabled
[[ 9.071867] ahci 4a140000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
OK ] Listening on RPCbind Server Activation Socket.
[ 9.105098] ahci 4a140000.sata: flags: 64bit ncq sntf stag pm led clo only pmp pio slum part ccc apst
[ OK ] Started Daily Cleanup of Temporary Directorie[ 9.159633] omap-hdmi-audio omap-hdmi-audio.0.auto: snd-soc-dummy-dai <-> 58040000.encoder mapping ok
s.
[ OK ] Reached target Timers.
[ 9.197262] scsi host0: ahci
[ 9.200511] ata1: SATA max UDMA/133 mmio [mem 0x4a140000-0x4a1410ff] port 0x100 irq 346
[ OK ] Listening on D-Bus System Message Bus Socket.[ 9.223742] omap-aes 4b500000.aes: OMAP AES hw accel rev: 3.3

[ OK ] Reached target Sockets.
[ 9.244960] omap-aes 4b500000.aes: will run requests pump with realtime priority
[ 9.262990] omap-aes 4b700000.aes: OMAP AES hw accel rev: 3.3
[ 9.264818] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[ OK ] Reached target Basic System.
[ 9.306504] omap-aes 4b700000.aes: will run requests pump with realtime priority
[ 9.318129] asoc-simple-card sound0: tlv320aic3x-hifi <-> 48468000.mcasp mapping ok
Starting Print notice about GPLv3 packages...
Starting telnetd.service...


Regards

  • The software team have been notified. They will respond here.
  • Hi,

    Another important information is that EVM is successfully booting with this SD but our boar is not. What may be the reason for this reset?

    Regards
  • Hi Ferhat,

    Could you make a SD card with the last Processor SDK 4.02.00.09
    software-dl.ti.com/.../index_FDS.html
    and try to boot the board.
    If the issue still exists could you describe the differences in the hardware between your board and AM57x EVM?

    BR
    Tsvetolin Shulev
  • Hi Tsvetolin ,

    I tried with SDK 4.02.00.09 and the problem changes ; now kernel hangs (not resets) with the below log:

    *
    *
    *
    [ OK ] Started Rebuild Hardware Database.
    Starting udev Coldplug all Devices...
    [ OK ] Reached target System Time Synchronized.
    [ OK ] Started udev Coldplug all Devices.
    [ 9.971057] omap-rproc 58820000.ipu: assigned reserved memory node ipu1_cma@9d000000
    [ 9.994145] remoteproc remoteproc0: 58820000.ipu is available
    [ 10.037405] omap-rproc 55020000.ipu: assigned reserved memory node ipu2_cma@95800000
    [ 10.084029] remoteproc remoteproc1: 55020000.ipu is available
    [ 10.108608] omap-rproc 40800000.dsp: assigned reserved memory node dsp1_cma@99000000
    [ 10.156884] remoteproc remoteproc2: 40800000.dsp is available
    [ 10.160544] omap-rproc 41000000.dsp: assigned reserved memory node dsp2_cma@9f000000
    [ 10.160661] remoteproc remoteproc3: 41000000.dsp is available
    [ 10.279929] rtc-ds1307: probe of 2-006f failed with error -5
    [ 10.342865] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659 as rtc1
    [ 10.388304] omap-des 480a5000.des: OMAP DES hw accel rev: 2.2
    [ 10.415373] omap-des 480a5000.des: will run requests pump with realtime priority
    [ 10.475174] systemd[1]: Found device /dev/ttyS2.
    [ OK ] Found device /dev/ttyS2.
    [ OK ] Started Opkg first boot configure.
    [ 10.633963] remoteproc remoteproc0: powering up 58820000.ipu
    [ 10.640051] remoteproc remoteproc0: Booting fw image dra7-ipu1-fw.xem4, size 4687356
    [ 10.648659] omap-iommu 58882000.mmu: 58882000.mmu: version 2.1
    [ 10.656264] remoteproc remoteproc1: powering up 55020000.ipu
    [ 10.662005] remoteproc remoteproc1: Booting fw image dra7-ipu2-fw.xem4, size 3738980
    [ 10.673731] omap-iommu 55082000.mmu: 55082000.mmu: version 2.1


    the main difference with the EVM is that we use AM5726 not AM5728.
    What may be the problem ? Is it because of powering up ipu?

    Thanks and best regards
    Ferhat