Hi experts,
I'm working on a DRA71XEVM (JACINTO 6 ENTRY/RSP EVM) and using VISION_SDK (PROCESSOR_SDK_VISION_03_08_00_00)
Due to product demand of H/Lamp, boot time need to be reduced to 1s and now is about 3s.0
I find that it takes a long time (about 700ms) for GRPXSRC to create. My question is how to optimize it or is there any reference design?
[IPU1-0] 1.997773 s: GRPXSRC: Create in progress !!!
[IPU1-0] 2.657658 s: GRPXSRC: Create Done !!!
Are there any additional ways to shorten the boot time ?
thanks.
teraterm_SBL_210429.log
TDA2Ex SBL Boot DPLL Configuration Completed Clock Domain Configuration Completed Module Enable Configuration Completed TI EVM PAD Config Completed DDR Config Completed App Image Download Begins Manufacturer ID - 0x1 Device ID - 0x18 MPU CPU0 Image Load Completed IPU1 CPU0 Image Load Completed IPU1 CPU1 Image Load Completed DSP1 Image Load Completed App Image Download Completed ***************************************************************** PMCCNTR counts once every 64 clock cycles, multiple by 64 to get actual CPU cycles SBL Initial Config Cycles - 1690362 (135.22 ms) SOC Init Cycles - 212921 (17.3 ms) DDR Config Clock Cycles - 49050 (3.92 ms) App Image Load Cycles - 3151887 (252.15 ms) Slave Core Bootup Cycles - 16327 (1.30 ms) SBL Boot-up Cycles - 5128600 (410.28 ms) Time at which SBL started IPU1_0 - 15872 (1.26 ms) ***************************************************************** Jumping to MPU CPU0 App [IPU1-0] 0.489660 s: ***** IPU1_0 Firmware build time 12:43:03 Apr 29 2021 [IPU1-0] 0.489843 s: *** SYSTEM: CPU Frequency <ORG = 212800000 Hz>, <NEW = 212800000 Hz> [IPU1-0] 0.551790 s: SYSTEM: Notify register to [IPU1-1] line 0, event 15... [IPU1-0] 0.551942 s: SYSTEM: Notify register to [DSP1] line 0, event 15... [IPU1-0] 0.552095 s: SYSTEM: Notify register to [HOST] line 0, event 15... [IPU1-0] 0.553894 s: *** UTILS: CPU MHz = 20 Mhz *** [IPU1-0] 0.554047 s: SYSTEM: System Common Init in progress !!! [IPU1-0] 0.563777 s: UTILS: CIO: Init Done !!! [IPU1-0] 0.563868 s: SYSTEM: IPC init in progress !!! [IPU1-0] 0.563929 s: SYSTEM: Notify init done !!! [IPU1-0] 0.565698 s: SYSTEM: MsgQ init done !!! [IPU1-0] 0.565790 s: SYSTEM: IPC init DONE !!! [IPU1-0] 0.569602 s: SYSTEM: System Common Init Done !!! [IPU1-0] 0.569694 s: SYSTEM: System Init in progress !!! [IPU1-0] 0.569755 s: SYSTEM: BSP Common Init in progress !!! [IPU1-0] 0.569816 s: SYSTEM: BSP Common Init Done !!! [IPU1-0] 0.569877 s: SYSTEM: BSP Platform Init in progress !!! [IPU1-0] 0.570029 s: SYSTEM: BSP Platform Init Done !!! [IPU1-0] 0.570121 s: SYSTEM: FVID2 Init in progress !!! [IPU1-0] 0.570243 s: SYSTEM: FVID2 Init Done !!! [IPU1-0] 0.570334 s: SYSTEM: VPS Init in progress !!! [IPU1-0] 0.570456 s: SYSTEM: VPDMA Descriptor Memory Address translation ENABLED [0xa0000000 -> 0x80000000] [IPU1-0] 0.573232 s: *** VPDMA Firmware Loading... *** [IPU1-0] 0.573354 s: VPDMA Firmware Address = 0x9fd197c0 [IPU1-0] 0.573476 s: VPDMA Load Address = 0x4897d004 [IPU1-0] 0.573598 s: VPDMA Firmware Version = 0x4d0001b8 [IPU1-0] 0.573689 s: VPDMA List Busy Status = 0x00000000 [IPU1-0] 0.573750 s: *** VPDMA Firmware Load Success *** [IPU1-0] 0.574086 s: *** VPDMA Firmware Loading... *** [IPU1-0] 0.574178 s: VPDMA Firmware Address = 0x9fd197c0 [IPU1-0] 0.574269 s: VPDMA Load Address = 0x489dd004 [IPU1-0] 0.574361 s: VPDMA Firmware Version = 0x4d0001b8 [IPU1-0] 0.574513 s: VPDMA List Busy Status = 0x00000000 [IPU1-0] 0.574605 s: *** VPDMA Firmware Load Success *** [IPU1-0] 0.607759 s: SYSTEM: VPS Init Done !!! [IPU1-0] 0.608613 s: UTILS: DMA: HWI Create for INT34 !!! [IPU1-0] 0.608796 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1024 [IPU1-0] 0.608887 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 262144 B (256 KB), Free size = 258104 B (252 KB) [IPU1-0] 0.609040 s: SYSTEM: Heap = SR_OCMC @ 0x00000000, Total size = 0 B (0 KB), Free size = 0 B (0 KB) [IPU1-0] 0.609192 s: SYSTEM: Heap = SR_DDR_CACHED @ 0x85083000, Total size = 368037888 B (350 MB), Free size = 368037888 B (350 MB) [IPU1-0] 0.609406 s: SYSTEM: Heap = SR_DDR_NON_CACHED @ 0xbfc00000, Total size = 129408 B (0 MB), Free size = 124800 B (0 MB) [IPU1-0] 0.609619 s: SYSTEM: Initializing Links !!! [IPU1-0] 0.779814 s: SYSTEM: Initializing Links ... DONE !!! [IPU1-0] 0.788415 s: BOARD: Board Init in progress !!! [IPU1-0] 0.788812 s: BOARD: Board Init Done !!! [IPU1-0] 0.798755 s: [IPU1-0] 0.798816 s: Vision SDK Version : [REL_VISION_SDK_03_08_00_00] [IPU1-0] 0.798908 s: FVID2 Version : [FVID_02_01_00_01] [IPU1-0] 0.798969 s: BSP Version : [PDK_01_10_04__xx] [IPU1-0] 0.799030 s: Platform : [EVM] [IPU1-0] 0.799091 s: SOC : [TDA2EX] [IPU1-0] 0.799152 s: SOC Revision : [ES2.1] [IPU1-0] 0.799213 s: Board Detected : [Vision] [IPU1-0] 0.806655 s: EEPROM Base Board Name: [DRA79x,DRA71x] [IPU1-0] 0.806746 s: EEPROM Base Board EMIF1 Size: 2048 MB [IPU1-0] 0.806838 s: EEPROM Base Board EMIF2 Size: 0 MB [IPU1-0] 0.806899 s: Base Board Revision : [REV C] [IPU1-0] 0.808210 s: Daughter Card Revision: [REV D] [IPU1-0] 0.808271 s: [IPU1-0] 0.811901 s: SYSTEM: UART: INTERRUPT Mode is Selected [IPU1-1] 0.500152 s: ***** IPU1_1 Firmware build time 12:40:02 Apr 29 2021 [IPU1-1] 0.500335 s: *** SYSTEM: CPU Frequency <ORG = 212800000 Hz>, <NEW = 212800000 Hz> [IPU1-1] 0.552186 s: SYSTEM: Notify register to [IPU1-0] line 0, event 15... [IPU1-1] 0.552369 s: SYSTEM: Notify register to [DSP1] line 0, event 15... [IPU1-1] 0.552491 s: SYSTEM: Notify register to [HOST] line 0, event 15... [IPU1-1] 0.554413 s: SYSTEM: System Common Init in progress !!! [IPU1-1] 0.555450 s: UTILS: CIO: Init Done !!! [IPU1-1] 0.555572 s: SYSTEM: IPC init in progress !!! [IPU1-1] 0.555633 s: SYSTEM: Notify init done !!! [IPU1-1] 0.557311 s: SYSTEM: MsgQ init done !!! [IPU1-1] 0.557402 s: SYSTEM: IPC init DONE !!! [IPU1-1] 0.560940 s: SYSTEM: System Common Init Done !!! [IPU1-1] 0.561062 s: SYSTEM: System IPU1_1 Init in progress !!! [IPU1-1] 0.561855 s: UTILS: DMA: HWI Create for INT25 !!! [IPU1-1] 0.562038 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1024 [IPU1-1] 0.562160 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 262144 B (256 KB), Free size = 258232 B (252 KB) [IPU1-1] 0.562282 s: SYSTEM: Initializing Links !!! [IPU1-1] 0.663819 s: UTILS: PRF: ##### Cannot allocate Object for SYNC1 #### [IPU1-1] 0.666564 s: UTILS: PRF: ##### Cannot allocate Object for SYNC2 #### [IPU1-1] 0.669340 s: UTILS: PRF: ##### Cannot allocate Object for SYNC3 #### [IPU1-1] 0.672512 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM0 #### [IPU1-1] 0.675593 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM1 #### [IPU1-1] 0.678551 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM2 #### [IPU1-1] 0.681540 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM3 #### [IPU1-1] 0.684895 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM4 #### [IPU1-1] 0.688464 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM5 #### [IPU1-1] 0.691972 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM6 #### [IPU1-1] 0.695632 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM7 #### [IPU1-1] 0.695784 s: SYSTEM: Initializing Links ... DONE !!! [IPU1-1] 0.695845 s: SYSTEM: System IPU1_1 Init Done !!! [HOST ] 0.550417 s: ***** A15_0 Firmware build time 12:41:49 Apr 29 2021 [HOST ] 0.550448 s: *** SYSTEM: CPU Frequency <ORG = 588000000 Hz>, <NEW = 800000000 Hz> [HOST ] 0.551851 s: SYSTEM: Notify register to [IPU1-0] line 0, event 15... [HOST ] 0.551881 s: SYSTEM: Notify register to [IPU1-1] line 0, event 15... [HOST ] 0.551881 s: SYSTEM: Notify register to [DSP1] line 0, event 15... [HOST ] 0.551942 s: SYSTEM: System Common Init in progress !!! [HOST ] 0.551973 s: SYSTEM: IPC init in progress !!! [HOST ] 0.551973 s: SYSTEM: Notify init done !!! [HOST ] 0.552003 s: SYSTEM: MsgQ init done !!! [HOST ] 0.552003 s: SYSTEM: IPC init DONE !!! [HOST ] 0.552552 s: SYSTEM: System Common Init Done !!! [HOST ] 0.552552 s: SYSTEM: System A15 Init in progress !!! [HOST ] 0.552583 s: UTILS: DMA: HWI Create for INT66 !!! [HOST ] 0.552613 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1024 [HOST ] 0.552613 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 6291456 B (6144 KB), Free size = 6286416 B (6139 KB) [HOST ] 0.552644 s: SYSTEM: Initializing Links !!! [HOST ] 0.554809 s: UTILS: PRF: ##### Cannot allocate Object for SYNC1 #### [HOST ] 0.554870 s: UTILS: PRF: ##### Cannot allocate Object for SYNC2 #### [HOST ] 0.554931 s: UTILS: PRF: ##### Cannot allocate Object for SYNC3 #### [HOST ] 0.554992 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM0 #### [HOST ] 0.555084 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM1 #### [HOST ] 0.555145 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM2 #### [HOST ] 0.555206 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM3 #### [HOST ] 0.555267 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM4 #### [HOST ] 0.555358 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM5 #### [HOST ] 0.555419 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM6 #### [HOST ] 0.555480 s: UTILS: PRF: ##### Cannot allocate Object for ALGORITHM7 #### [HOST ] 0.555480 s: SYSTEM: Initializing Links ... DONE !!! [HOST ] 0.555511 s: SYSTEM: System A15 Init Done !!! [DSP1 ] 0.552186 s: SYSTEM: Notify register to [IPU1-0] line 0, event 15... [DSP1 ] 0.552247 s: SYSTEM: Notify register to [IPU1-1] line 0, event 15... [DSP1 ] 0.552278 s: SYSTEM: Notify register to [HOST] line 0, event 15... [DSP1 ] 0.552400 s: *** UTILS: CPU MHz = 20 Mhz *** [DSP1 ] 0.552430 s: SYSTEM: System Common Init in progress !!! [DSP1 ] 0.552613 s: UTILS: CIO: Init Done !!! [DSP1 ] 0.552644 s: SYSTEM: IPC init in progress !!! [DSP1 ] 0.552644 s: SYSTEM: Notify init done !!! [DSP1 ] 0.552796 s: SYSTEM: MsgQ init done !!! [DSP1 ] 0.552796 s: SYSTEM: IPC init DONE !!! [DSP1 ] 0.553467 s: SYSTEM: System Common Init Done !!! [DSP1 ] 0.553498 s: SYSTEM: System DSP Init in progress !!! [DSP1 ] 0.553681 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1024 [DSP1 ] 0.553711 s: SYSTEM: Heap = LOCAL_L2 @ 0x00800000, Total size = 227264 B (221 KB), Free size = 227264 B (221 KB) [DSP1 ] 0.553772 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 524288 B (512 KB), Free size = 520400 B (508 KB) [DSP1 ] 0.553803 s: SYSTEM: Initializing Links !!! [DSP1 ] 0.561367 s: SYSTEM: Initializing Links ... DONE !!! [DSP1 ] 0.561398 s: SYSTEM: System DSP Init Done !!! [DSP1 ] 0.788415 s: SYSTEM: CACHE: L1P = 32 KB, L1D = 32 KB, L2 = 32 KB ... after boot !!! [DSP1 ] 0.788446 s: SYSTEM: CACHE: L1P = 32 KB, L1D = 32 KB, L2 = 32 KB ... after update by APP !!! [IPU1-0] 1.815409 s: QSPI Init Started [IPU1-0] 1.815714 s: MID - 1 [IPU1-0] 1.815775 s: DID - 18 [IPU1-0] 1.815836 s: QSPI Init Completed Sucessfully [IPU1-0] 1.986671 s: IPC_OUT_1 : Create in progress !!! [IPU1-0] 1.987006 s: IPC_OUT_1 : Create Done !!! [IPU1-0] 1.992130 s: IPC_IN_1 : Create in progress !!! [IPU1-0] 1.993076 s: IPC_IN_1 : Create Done !!! [IPU1-0] 1.993259 s: IPC_OUT_0 : Create in progress !!! [IPU1-0] 1.993594 s: IPC_OUT_0 : Create Done !!! [IPU1-0] 1.995241 s: IPC_IN_0 : Create in progress !!! [IPU1-0] 1.996156 s: IPC_IN_0 : Create Done !!! [IPU1-0] 1.997010 s: DISPLAY: Create in progress !!! [IPU1-0] 1.997620 s: DISPLAY: Create Done !!! [IPU1-0] 1.997773 s: GRPXSRC: Create in progress !!! [IPU1-0] 2.657658 s: GRPXSRC: Create Done !!! [IPU1-0] 2.658055 s: DISPLAY: Create in progress !!! [IPU1-0] 2.658543 s: DISPLAY: Create Done !!! [IPU1-0] 2.659702 s: UTILS_MCSPI: McSPI is configured in interrupt mode!! [IPU1-0] 2.663514 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1022 [IPU1-0] 2.663636 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 262144 B (256 KB), Free size = 254088 B (248 KB) [IPU1-0] 2.663789 s: SYSTEM: Heap = SR_OCMC @ 0x00000000, Total size = 0 B (0 KB), Free size = 0 B (0 KB) [IPU1-0] 2.663941 s: SYSTEM: Heap = SR_DDR_CACHED @ 0x85083000, Total size = 368037888 B (350 MB), Free size = 356978688 B (340 MB) [IPU1-0] 2.664124 s: SYSTEM: Heap = SR_DDR_NON_CACHED @ 0xbfc00000, Total size = 129408 B (0 MB), Free size = 124800 B (0 MB) [IPU1-0] 2.664307 s: MCSPI: Communication Task Start... [IPU1-0] 2.664582 s: MCSPI: Communication Task Start... [IPU1-0] 2.666687 s: *** UTILS: CPU KHz = 20000 Khz *** [IPU1-0] 2.767919 s: DISPLAY: Start in progress !!! [IPU1-0] 2.768010 s: DISPLAY: Start Done !!! [IPU1-0] 2.768681 s: DISPLAY: Start in progress !!! [IPU1-0] 2.768742 s: DISPLAY: Start Done !!! [IPU1-0] 2.769596 s: [IPU1-0] [IPU1-0] ==================== [IPU1-0] Chains Run-time Menu [IPU1-0] ==================== [IPU1-0] [IPU1-0] 0: Stop Chain [IPU1-0] [IPU1-0] p: Print Performance Statistics [IPU1-0] [IPU1-0] Enter Choice: [IPU1-0] [IPU1-1] 2.665100 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1023 [IPU1-1] 2.665253 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 262144 B (256 KB), Free size = 255912 B (249 KB) [HOST ] 1.993747 s: IPC_IN_0 : Create in progress !!! [HOST ] 1.994052 s: IPC_IN_0 : Create Done !!! [HOST ] 1.994113 s: ALGORITHM: Create in progress (algId = 15) !!! [HOST ] 1.995028 s: ALGORITHM: Create Done (algId = 15) !!! [HOST ] 1.995119 s: IPC_OUT_0 : Create in progress !!! [HOST ] 1.995150 s: IPC_OUT_0 : Create Done !!! [HOST ] 2.665649 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1023 [HOST ] 2.665680 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 6291456 B (6144 KB), Free size = 6264640 B (6117 KB) [DSP1 ] 1.987189 s: IPC_IN_0 : Create in progress !!! [DSP1 ] 1.987616 s: IPC_IN_0 : Create Done !!! [DSP1 ] 1.987769 s: ALGORITHM: Create in progress (algId = 44) !!! [DSP1 ] 1.987860 s: ALG_SlampDsp: DMA: Allocated CH (TCC) = 0 (0) [DSP1 ] 1.991825 s: ALGORITHM: Create Done (algId = 44) !!! [DSP1 ] 1.991978 s: IPC_OUT_0 : Create in progress !!! [DSP1 ] 1.992039 s: IPC_OUT_0 : Create Done !!! [DSP1 ] 2.665893 s: SYSTEM: SW Message Box Msg Pool, Free Msg Count = 1023 [DSP1 ] 2.665924 s: SYSTEM: Heap = LOCAL_L2 @ 0x00800000, Total size = 227264 B (221 KB), Free size = 227264 B (221 KB) [DSP1 ] 2.665954 s: SYSTEM: Heap = LOCAL_DDR @ 0x00000000, Total size = 524288 B (512 KB), Free size = 505464 B (493 KB)
