启动失败的问题

beying

自己写了arm和2个dsp程序，前几次load-firmware.sh都没问题，多次load-firmware.sh之后，发现串口打印不停，截取部分打印信息如下：
** 8969 printk messages dropped ** [   13.280074] [<c022d9a4>] (__warn) from [<c022dae8>] (warn_slowpath_fmt+0x40/0x48)
** 6999 printk messages dropped ** [   13.313016] Modules linked in: pru_rproc pruss_intc pruss snd_soc_simple_card snd_soc_simple_card_utils snd_soc_omap_hdmi_audio pvrsrvkm(O) m25p80 pruss_soc_bus c_can_platform c_can can_dev omap_wdt ahci_platform libahci_platform libahci libata ti_vpe ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)
** 10500 printk messages dropped ** [   13.362226] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 2712 printk messages dropped ** [   13.374846] WARNING: CPU: 0 PID: 27 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x25c/0x36c
** 4813 printk messages dropped ** [   13.398074] ---[ end trace 0000000000009736 ]---
** 1651 printk messages dropped ** [   13.405874] ---[ end trace 0000000000009771 ]---
** 1653 printk messages dropped ** [   13.413571] WARNING: CPU: 0 PID: 27 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x25c/0x36c
** 2634 printk messages dropped ** [   13.425849] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 2707 printk messages dropped ** [   13.438433]  r4:00000000
** 1200 printk messages dropped ** [   13.444026]  r7:00000001 r6:00000000 r5:d064c000 r4:d063f424
** 1871 printk messages dropped ** [   13.452742] [<c0503ac0>] (l3_interrupt_handler) from [<c02827b8>] (irq_forced_thread_fn+0x28/0x7c)
** 7322 printk messages dropped ** [   13.486797] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 2703 printk messages dropped ** [   13.499440] [<c0282790>] (irq_forced_thread_fn) from [<c0282b1c>] (irq_thread+0x124/0x1f8)
** 2438 printk messages dropped ** [   13.510816]  r10:00000000 r9:00000000 r8:c02829f8 r7:d063f400 r6:d064c000 r5:d063f440
** 2339 printk messages dropped ** [   13.521694]  r7:00000009 r6:c0bd28c8 r5:00000000 r4:d064de20
** 2746 printk messages dropped ** [   13.534480] [<c022daac>] (warn_slowpath_fmt) from [<c0503d1c>] (l3_interrupt_handler+0x25c/0x36c)
** 2593 printk messages dropped ** [   13.546622] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 2710 printk messages dropped ** [   13.559162] ---[ end trace 0000000000009c09 ]---
** 1651 printk messages dropped ** [   13.566832] ---[ end trace 0000000000009c44 ]---
** 1653 printk messages dropped ** [   13.574528] WARNING: CPU: 0 PID: 27 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x25c/0x36c
** 2642 printk messages dropped ** [   13.586813] [<c022d9a4>] (__warn) from [<c022dae8>] (warn_slowpath_fmt+0x40/0x48)
** 2268 printk messages dropped ** [   13.597372]  r9:0000001b r8:d063f090 r7:c0bd2bf8 r6:00000002 r5:c0bd27f4 r4:c0bd2898
** 4050 printk messages dropped ** [   13.616296] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 2712 printk messages dropped ** [   13.628957] WARNING: CPU: 0 PID: 27 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x25c/0x36c
** 2671 printk messages dropped ** [   13.641368]  r9:0000001b r8:d063f090 r7:c0bd2bf8 r6:00000002 r5:c0bd27f4 r4:c0bd2898
** 2341 printk messages dropped ** [   13.652238] Modules linked in: pru_rproc pruss_intc pruss snd_soc_simple_card snd_soc_simple_card_utils snd_soc_omap_hdmi_audio pvrsrvkm(O) m25p80 pruss_soc_bus c_can_platform c_can can_dev omap_wdt ahci_platform libahci_platform libahci libata ti_vpe ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)

第一次重启板子，从串口观察，卡在下面的地方：
[    8.616026] hub 3-0:1.0: USB hub found
[    8.620373] hub 3-0:1.0: 1 port detected
[  OK  ] Started System Logging Service.
[    8.637550] xhci-hcd xhci-hcd.2.auto: xHCI Host Controller
[    8.643198] xhci-hcd xhci-hcd.2.auto: new USB bus registered, assigned bus number 4
[    8.654371] spi2.0 supply vcc not found, using dummy regulator
[    8.661804] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
[    8.670094] remoteproc remoteproc3: powering up 41000000.dsp
[    8.670101] remoteproc remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 4520256
[    8.676900] omap-iommu 41501000.mmu: 41501000.mmu: version 3.0
[    8.676937] omap-iommu 41502000.mmu: 41502000.mmu: version 3.0

再次重启板子，又循环不停的打印，截取部分打印信息如下：
[    8.616026] hub 3-0:1.0: USB hub found
[    8.620373] hub 3-0:1.0: 1 port detected
[  OK  ] Started System Logging Service.
[    8.637550] xhci-hcd xhci-hcd.2.auto: xHCI Host Controller
[    8.643198] xhci-hcd xhci-hcd.2.auto: new USB bus registered, assigned bus number 4
[    8.654371] spi2.0 supply vcc not found, using dummy regulator
[    8.661804] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
[    8.670094] remoteproc remoteproc3: powering up 41000000.dsp
[    8.670101] remoteproc remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 4520256
[    8.676900] omap-iommu 41501000.mmu: 41501000.mmu: version 3.0
[    8.676937] omap-iommu 41502000.mmu: 41502000.mmu: version 3.0

现在板子起不来了，请问：
1、多load-firmware.sh几次，系统就出现这种问题，这是bug吗？要怎么定位为什么会出现这种问题，arm程序和server_dsp1.xe66、server_dsp2.xe66我都保留了，需要的话，我可以提供给你们。
2、现在板子起不来了（一直从TF卡启动），要重做TF卡吗？（就从TF卡启动，emmc搞坏了估计更麻烦）。

beying

再次重启我的截取有误，更正如下：
[  OK  ] Started udev Coldplug all Devices.
[    7.611167] omap-rproc 58820000.ipu: assigned reserved memory node ipu1_cma@9d000000
[    7.619024] remoteproc remoteproc0: 58820000.ipu is available
[    7.644224] omap-rproc 55020000.ipu: assigned reserved memory node ipu2_cma@95800000
[    7.651115] remoteproc remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[    7.651122] remoteproc remoteproc0: powering up 58820000.ipu
[    7.651146] remoteproc remoteproc0: Direct firmware load for dra7-ipu1-fw.xem4 failed with error -2
[    7.651151] remoteproc remoteproc0: request_firmware failed: -2
[  OK  ] Started Load/Save Random Seed.
[    7.697324] remoteproc remoteproc1: 55020000.ipu is available
[    7.704821] remoteproc remoteproc1: Direct firmware load for dra7-ipu2-fw.xem4 failed with error -2
[    7.713965] remoteproc remoteproc1: powering up 55020000.ipu
[    7.719695] remoteproc remoteproc1: Direct firmware load for dra7-ipu2-fw.xem4 failed with error -2
[    7.728802] remoteproc remoteproc1: request_firmware failed: -2
[    7.735307] omap-rproc 40800000.dsp: assigned reserved memory node dsp1_cma@99000000
[    7.747865] remoteproc remoteproc2: 40800000.dsp is available
[    7.755424] omap-rproc 41000000.dsp: assigned reserved memory node dsp2_cma@9f000000
[    7.767410] remoteproc remoteproc3: 41000000.dsp is available
[    7.774681] remoteproc remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[    7.783970] remoteproc remoteproc2: powering up 40800000.dsp
[    7.789726] remoteproc remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[    7.798827] remoteproc remoteproc2: request_firmware failed: -2
[  OK  ] Started Create Volatile Files and Directories.
         Starting Network Time Synchronization...
         Starting Update UTMP about System Boot/Shutdown...
[  OK  ] Found device /dev/ttyS2.
[    8.300309] omap_rtc 48838000.rtc: rtc core: registered 48838000.rtc as rtc2
[    8.312562] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659 as rtc1
[    8.383443] xhci-hcd xhci-hcd.2.auto: xHCI Host Controller
[    8.388982] xhci-hcd xhci-hcd.2.auto: new USB bus registered, assigned bus number 3
[    8.424281] xhci-hcd xhci-hcd.2.auto: hcc params 0x0220f04c hci version 0x100 quirks 0x02010010
[    8.435914] xhci-hcd xhci-hcd.2.auto: irq 483, io mem 0x488d0000
[    8.442155] remoteproc remoteproc3: powering up 41000000.dsp
[    8.442164] remoteproc remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 4520256
[    8.449322] omap-iommu 41501000.mmu: 41501000.mmu: version 3.0
[    8.449358] omap-iommu 41502000.mmu: 41502000.mmu: version 3.0
** 1384 printk messages dropped ** [    8.528918] Hardware name: Generic DRA74X (Flattened Device Tree)
** 2210 printk messages dropped ** [    8.538082] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 3049 printk messages dropped ** [    8.550722] 44000000.ocp3 Custom Error: MASTER DSP2_DMA TARGET L4_PER3_P3 (Read): Data Access in User mode during Functional access
** 3669 printk messages dropped ** [    8.565822] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 3051 printk messages dropped ** [    8.578365] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 3046 printk messages dropped ** [    8.590927] ---[ end trace 000000000000024b ]---
** 1861 printk messages dropped ** [    8.598615]  r9:0000001b r8:d063f090 r7:c0bd2bf8 r6:00000002 r5:c0bd27f4 r4:c0bd2898
** 2623 printk messages dropped ** [    8.609425] Hardware name: Generic DRA74X (Flattened Device Tree)
** 2220 printk messages dropped ** [    8.618590] [<c022daac>] (warn_slowpath_fmt) from [<c0503d1c>] (l3_interrupt_handler+0x25c/0x36c)
** 2901 printk messages dropped ** [    8.630557] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 3050 printk messages dropped ** [    8.643140] Modules linked in: ti_vpe(+) ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)
** 12880 printk messages dropped ** [    8.696136] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 7849 printk messages dropped ** [    8.727530] [<c022daac>] (warn_slowpath_fmt) from [<c0503d1c>] (l3_interrupt_handler+0x25c/0x36c)
** 15893 printk messages dropped ** [    8.793638] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 13408 printk messages dropped ** [    8.848598] WARNING: CPU: 0 PID: 27 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x25c/0x36c
** 13145 printk messages dropped ** [    8.903030]  r3:d0619ec0 r2:c0bd2898
** 11722 printk messages dropped ** [    8.952099] Hardware name: Generic DRA74X (Flattened Device Tree)
** 4981 printk messages dropped ** [    8.973385] Modules linked in: ahci_platform(+) libahci_platform libahci libata ti_vpe(+) ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)
** 20358 printk messages dropped ** [    9.060290] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 7579 printk messages dropped ** [    9.093767]  r4:d063f400
** 7519 printk messages dropped ** [    9.127229] Backtrace:
** 1244 printk messages dropped ** [    9.132580]  r4:d063f400
** 7488 printk messages dropped ** [    9.165735] Modules linked in: m25p80(+) pruss_soc_bus(+) c_can_platform(+) c_can can_dev omap_wdt(+) ahci_platform(+) libahci_platform libahci libata ti_vpe(+) ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)
** 17891 printk messages dropped ** [    9.243893] ------------[ cut here ]------------
** 4875 printk messages dropped ** [    9.265474] Modules linked in: m25p80(+) pruss_soc_bus(+) c_can_platform(+) c_can can_dev omap_wdt(+) ahci_platform(+) libahci_platform libahci libata ti_vpe(+) ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)
** 22990 printk messages dropped ** [    9.367278] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 7197 printk messages dropped ** [    9.398800] Backtrace:
** 3924 printk messages dropped ** [    9.416397]  r7:00000009 r6:c0bd28c8 r5:00000000 r4:d064de20
** 9980 printk messages dropped ** [    9.461623]  r4:00000000
** 5571 printk messages dropped ** [    9.487301] [<c02829f8>] (irq_thread) from [<c024b004>] (kthread+0x100/0x118)
** 6617 printk messages dropped ** [    9.517796] CPU: 0 PID: 27 Comm: irq/23-l3-app-i Tainted: G        W  O    4.9.65-rt23-06396-ga1cf405 #2
** 10733 printk messages dropped ** [    9.566536] [<c022daac>] (warn_slowpath_fmt) from [<c0503d1c>] (l3_interrupt_handler+0x25c/0x36c)
** 9823 printk messages dropped ** [    9.610583] [<c04d3d30>] (dump_stack) from [<c022da90>] (__warn+0xec/0x104)
** 5674 printk messages dropped ** [    9.636958] WARNING: CPU: 0 PID: 27 at drivers/bus/omap_l3_noc.c:147 l3_interrupt_handler+0x25c/0x36c
** 4680 printk messages dropped ** [    9.657502] Backtrace:
** 1219 printk messages dropped ** [    9.663018] [<c02829f8>] (irq_thread) from [<c024b004>] (kthread+0x100/0x118)
** 6855 printk messages dropped ** [    9.693294] [<c0503ac0>] (l3_interrupt_handler) from [<c02827b8>] (irq_forced_thread_fn+0x28/0x7c)
** 6568 printk messages dropped ** [    9.722478] Backtrace:
** 5008 printk messages dropped ** [    9.745453] Modules linked in: snd_soc_omap_hdmi_audio(+) pvrsrvkm(O+) m25p80 pruss_soc_bus(+) c_can_platform(+) c_can can_dev omap_wdt(+) ahci_platform(+) libahci_platform libahci libata ti_vpe(+) ti_sc ti_csc ads7846 ti_vpdma extcon_palmas rtc_palmas rtc_omap snd_soc_tlv320aic3x omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel cryptodev(O) cmemk(O)
** 21595 printk messages dropped ** [    9.843316] [<c04d3d30>] (dump_stack) from [<c022da90>] (__warn+0xec/0x104)
** 11123 printk messages dropped ** [    9.893203]  r10:c0282790 r9:d063f400 r8:d0465e00 r7:00000001 r6:00000000 r5:d0465e00
** 4255 printk messages dropped ** [    9.913370] [<c0503ac0>] (l3_interrupt_handler) from [<c02827b8>] (irq_forced_thread_fn+0x28/0x7c)

beying

看样子每次启动现象都不同，这次又卡在这里：
[    8.002256] remoteproc remoteproc1: powering up 55020000.ipu
[    8.017462] remoteproc remoteproc1: Direct firmware load for dra7-ipu2-fw.xem4 failed with error -2
[    8.030580] remoteproc remoteproc1: request_firmware failed: -2
[    8.044365] remoteproc remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[    8.054616] remoteproc remoteproc2: powering up 40800000.dsp
[    8.060429] remoteproc remoteproc2: Direct firmware load for dra7-dsp1-fw.xe66 failed with error -2
[    8.069612] remoteproc remoteproc2: request_firmware failed: -2
[  OK  ] Started Network Time Synchronization.
[  OK  ] Found device /dev/ttyS2.
[  OK  ] Started Update UTMP about System Boot/Shutdown.
[  OK  ] Reached target System Time Synchronized.
[  OK  ] Started udev Coldplug all Devices.
[  OK  ] Reached target System Initialization.
[  OK  ] Listening on RPCbind Server Activation Socket.
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Reached target Timers.
[    8.475464] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659 as rtc1
[    8.538982] xhci-hcd xhci-hcd.2.auto: xHCI Host Controller
[    8.548162] xhci-hcd xhci-hcd.2.auto: new USB bus registered, assigned bus number 3
[    8.561723] spi2.0 supply vcc not found, using dummy regulator
[    8.572779] ads7846 spi2.0: touchscreen, irq 129
[    8.573163] input: ADS7846 Touchscreen as /devices/platform/44000000.ocp/480b8000.spi/spi_master/spi2/spi2.0/input/input1
[    8.618456] remoteproc remoteproc3: powering up 41000000.dsp
[    8.618465] remoteproc remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 4520256
[    8.


我现在急于恢复，请问是重做TF卡，还是怎么弄？谢谢。

梁淑怡-Tronlong

您好，
1.排查建议：试下改一下加载脚本，将bind跟ubind的时间拉长，15s左右  让DSP核状态唤醒切换慢一下，看情况有没有改善；
2.板子起不来，建议直接重新制作SD启动卡测试