TX2i vs TX2 boot up time

Compare with TX2i and TX2 boot up time, we found TX2i cost 17 seconds and TX2 cost 3 seconds before entering into uboot phase.

  • TX2i boot up log:
[17.180859 0.001131] [0017.264] E> tegrabl_display_clear: display is not initialized
[17.182044 0.001185] [0017.270] W> Boot logo display failed...
[17.208265 0.026221] 
[17.208348 0.000083] 
[17.208378 0.000030] U-Boot 2016.07-00002-gfc6b608-dirty (Mar 04 2019 - 16:46:53 +0800)
  • TX2 boot up log:
[3.388511 0.014520] [0003.108] I> tegrabl_load_kernel_and_dtb: Done
[3.390808 0.002297] [0003.112] E> tegrabl_display_clear: display is not initialized
[3.393820 0.003012] [0003.118] W> Boot logo display failed...
[3.413588 0.019768] 
[3.413792 0.000204] 
[3.413875 0.000083] U-Boot 2016.07-dirty (Dec 05 2018 - 15:50:07 +0800)

After comparing with TX2i and TX2, we found two hot point below.

  1. Hot point 1:

9 seconds cost from C> to I>.

[0.000001 0.000001] [0000.086] C> I2C command failed
[0.003314 0.003313] [0000.089] C> block index = (4) and rail_id = (1)
[0.006004 0.002690] [0000.094] C> Addr: Reg = [0xe8:0x07]: 336166925
[0.011984 0.005980] [0000.098] C> I2C command failed
[0.013878 0.001894] [0000.101] C> block index = (5) and rail_id = (1)
[0.016327 0.002449] [0000.106] C> Addr: Reg = [0xe8:0x07]: 336166925
[9.367296 9.350969] [0009.453] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)
[9.372689 0.005393] [0009.461] I> Default Heap @ [0xd486400 - 0xd488400]
  1. Hot Point2:

DRAM Scrub cost 5 seconds.

[10.309183 0.001407] [0010.395] initializing platform
[10.310146 0.000963] [0010.398] I> Boot-device: eMMC
[10.311025 0.000879] [0010.402] I> Dram Scrub in progress
[15.588805 5.277780] [0015.675] I> DRAM Scrub Successfull
[15.590573 0.001768] [0015.679] I> sdmmc bdev is already initialized

Can you point me out which reason cause those two hot points?

We didn’t have such problem here. Could you share the full log for us to compare?

Also, are you using custom carrier board or devkit?

@WayneWWW Your suspect is correct. We use our own carrier board.

TX2i over EMV log file:

[0.000001 0.000001] [0009.432] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)
[0.007642 0.007641] [0009.441] I> Default Heap @ [0xd486400 - 0xd488400]
[0.012394 0.004752] [0009.446] I> DMA Heap @ [0x85200000 - 0x86200000]
[0.017033 0.004639] [0009.450] I> bit @ 0xd480000
[0.019847 0.002814] [0009.453] I> BR-BCT relocated to 0xd7020000
[0.023387 0.003540] [0009.457] I> Boot-device: eMMC
[0.027276 0.003889] [0009.461] I> sdmmc bdev is already initialized
[0.032360 0.005084] [0009.466] I> pmic: reset reason (nverc)	: 0x4
[0.035918 0.003558] [0009.470] I> Reading GPT from 512 for device 00000003
[0.042935 0.007017] [0009.476] I> Reading GPT from 16776704 for device 00000003
[0.050123 0.007188] [0009.483] I> Found 13 partitions in 00000003 device
[0.053925 0.003802] [0009.488] I> Reading GPT from 512 for device 00010003
[0.061639 0.007714] [0009.495] I> Found 29 partitions in 00010003 device
[0.066238 0.004599] [0009.500] I> OEM carveouts init scrub in progress...
[0.148475 0.082237] [0009.581] I> Mb2 SDRAM scrub successful
[0.151808 0.003333] [0009.585] W> No valid slot number is found in scratch register
[0.157242 0.005434] [0009.591] W> Return default slot: _a
[0.160699 0.003457] [0009.594] I> A/B: bin_type (16) slot 0
[0.163884 0.003185] [0009.598] I> Loading partition bpmp-fw at 0xd7800000
[0.169050 0.005166] [0009.603] I> Reading two headers - addr:0xd7800000 blocks:1
[0.174754 0.005704] [0009.608] I> Addr: 0xd7800000, start-block: 58761217, num_blocks: 1
[0.189809 0.015055] [0009.623] I> Binary(16) of size 529040 is loaded @ 0xd7800000
[0.195805 0.005996] [0009.629] W> No valid slot number is found in scratch register
[0.201435 0.005630] [0009.634] W> Return default slot: _a
[0.204556 0.003121] [0009.638] I> A/B: bin_type (17) slot 0
[0.207826 0.003270] [0009.641] I> Loading partition bpmp-fw-dtb at 0xd79f0000
[0.213255 0.005429] [0009.647] I> Reading two headers - addr:0xd79f0000 blocks:1
[0.218536 0.005281] [0009.652] I> Addr: 0xd79f0000, start-block: 58763633, num_blocks: 1
[0.228105 0.009569] [0009.661] I> Binary(17) of size 75472 is loaded @ 0xd79ed600
[0.262737 0.034632] [0009.695] I> BPMP-FW load address = 0xd7800000
[0.266283 0.003546] [0009.700] I> BPMP-FW DTB load address = 0x501ed600
[0.271614 0.005331] [0009.705] I> Loading SCE-FW ...
[0.274515 0.002901] [0009.708] W> No valid slot number is found in scratch register
[0.280120 0.005605] [0009.713] W> Return default slot: _a
[0.283302 0.003182] [0009.717] I> A/B: bin_type (12) slot 0
[0.286548 0.003246] [0009.720] I> Loading partition sce-fw at 0xd7300000
[0.291385 0.004837] [0009.725] I> Reading two headers - addr:0xd7300000 blocks:1
[0.297370 0.005985] [0009.731] I> Addr: 0xd7300000, start-block: 58765633, num_blocks: 1
[0.306581 0.009211] [0009.739] I> Binary(12) of size 76592 is loaded @ 0xd7300000
[0.310734 0.004153] [0009.745] I> Init SCE
[0.313485 0.002751] [0009.747] I> Copy BTCM section
[0.316343 0.002858] [0009.750] W> No valid slot number is found in scratch register
[0.321940 0.005597] [0009.756] W> Return default slot: _a
[0.326266 0.004326] [0009.759] I> A/B: bin_type (13) slot 0
[0.329711 0.003445] [0009.763] I> Loading partition cpu-bootloader at 0x96000000
[0.334927 0.005216] [0009.768] I> Reading two headers - addr:0x96000000 blocks:1
[0.340889 0.005962] [0009.774] I> Addr: 0x96000000, start-block: 58740737, num_blocks: 1
[0.352430 0.011541] [0009.785] I> Binary(13) of size 282736 is loaded @ 0x96000000
[0.357866 0.005436] [0009.791] W> No valid slot number is found in scratch register
[0.363528 0.005662] [0009.796] W> Return default slot: _a
[0.366766 0.003238] [0009.800] I> A/B: bin_type (20) slot 0
[0.369984 0.003218] [0009.804] I> Loading partition bootloader-dtb at 0x8520f400
[0.375585 0.005601] [0009.809] I> Reading two headers - addr:0x8520f400 blocks:1
[0.381159 0.005574] [0009.814] I> Addr: 0x8520f400, start-block: 58742785, num_blocks: 1
[0.393102 0.011943] [0009.826] I> Binary(20) of size 276016 is loaded @ 0x8520f400
[0.398581 0.005479] [0009.831] I> MB2-params(VA) @ 0xd7000000
[0.402001 0.003420] [0009.835] I> CPUBL-params(VA) @ 0xd7000000
[0.405435 0.003434] [0009.839] I> CPUBL-params(PA) @ 0x237000000
[0.410402 0.004967] [0009.843] I> CPU-BL loaded @ PA 0x96000000
[0.413683 0.003281] [0009.847] I> Loading TOS ...
[0.416485 0.002802] [0009.850] W> No valid slot number is found in scratch register
[0.422105 0.005620] [0009.856] W> Return default slot: _a
[0.425185 0.003080] [0009.859] I> A/B: bin_type (14) slot 0
[0.429950 0.004765] [0009.863] I> Loading partition secure-os at 0x8530f600
[0.433772 0.003822] [0009.868] I> Reading two headers - addr:0x8530f600 blocks:1
[0.439462 0.005690] [0009.873] I> Addr: 0x8530f600, start-block: 58744833, num_blocks: 1
[0.449154 0.009692] [0009.882] I> Binary(14) of size 62576 is loaded @ 0x8530f600
[0.453407 0.004253] [0009.888] I> Copying Monitor (length: 0xf270) from 0x8530f800 to 0x40000000
[0.460932 0.007525] [0009.895] I> Erasing Monitor @ 0x8530f800
[0.465211 0.004279] [0009.899] I> Unhalting SCE
[0.467927 0.002716] [0009.902] I> Primary Memory Start:80000000 Size:70000000
[0.473288 0.005361] [0009.907] I> Extended Memory Start:f0110000 Size:145ef0000
[0.480245 0.006957] [0009.914] I> Waypoint2-ACK: 0x52012714
[0.483369 0.003124] [0009.917] I> MB2(TBoot-BPMP) done
[0.488212 0.004843] 
[0.501690 0.013478] NOTICE:  BL31: v1.2(release):e1e4477
[0.505121 0.003431] NOTICE:  BL31: Built : 00:08:30, May 17 2018
[0.509193 0.004072] NOTICE:  Trusty image missing.
[0.512052 0.002859] ERROR:   Error initializing runtime service trusty_fast
[0.689471 0.177419] [0010.122] I> Welcome to Cboot
[0.691760 0.002289] [0010.125] I> Cboot Version: 00.00.2014.50-t186-0c600f85
[0.696297 0.004537] [0010.130] I> CPU-BL Params @ 0x237000000
[0.700711 0.004414] [0010.134] I>  0) Base:0x00000000 Size:0x00000000
[0.704504 0.003793] [0010.138] I>  1) Base:0x237f00000 Size:0x00100000
[0.709418 0.004914] [0010.143] I>  2) Base:0x237e00000 Size:0x00100000
[0.714143 0.004725] [0010.147] I>  3) Base:0x237d00000 Size:0x00100000
[0.718186 0.004043] [0010.152] I>  4) Base:0x237c00000 Size:0x00100000
[0.723010 0.004824] [0010.156] I>  5) Base:0x237b00000 Size:0x00100000
[0.726756 0.003746] [0010.161] I>  6) Base:0x237800000 Size:0x00200000
[0.731739 0.004983] [0010.165] I>  7) Base:0x237400000 Size:0x00400000
[0.736758 0.005019] [0010.170] I>  8) Base:0x237a00000 Size:0x00100000
[0.740424 0.003666] [0010.174] I>  9) Base:0x237300000 Size:0x00100000
[0.745143 0.004719] [0010.179] I> 10) Base:0x236800000 Size:0x00800000
[0.750038 0.004895] [0010.183] I> 11) Base:0x30000000 Size:0x00040000
[0.754178 0.004140] [0010.188] I> 12) Base:0xf0000000 Size:0x00100000
[0.759089 0.004911] [0010.192] I> 13) Base:0x30040000 Size:0x00001000
[0.762432 0.003343] [0010.197] I> 14) Base:0x30048000 Size:0x00001000
[0.767668 0.005236] [0010.201] I> 15) Base:0x30049000 Size:0x00001000
[0.771357 0.003689] [0010.205] I> 16) Base:0x3004a000 Size:0x00001000
[0.776002 0.004645] [0010.210] I> 17) Base:0x3004b000 Size:0x00001000
[0.781276 0.005274] [0010.214] I> 18) Base:0x3004c000 Size:0x00001000
[0.784715 0.003439] [0010.219] I> 19) Base:0x3004d000 Size:0x00001000
[0.789576 0.004861] [0010.223] I> 20) Base:0x3004e000 Size:0x00001000
[0.793333 0.003757] [0010.228] I> 21) Base:0x3004f000 Size:0x00001000
[0.798018 0.004685] [0010.232] I> 22) Base:0x00000000 Size:0x00000000
[0.803072 0.005054] [0010.236] I> 23) Base:0xf0100000 Size:0x00010000
[0.806948 0.003876] [0010.241] I> 24) Base:0x00000000 Size:0x00000000
[0.811992 0.005044] [0010.245] I> 25) Base:0x00000000 Size:0x00000000
[0.815555 0.003563] [0010.250] I> 26) Base:0x00000000 Size:0x00000000
[0.820561 0.005006] [0010.254] I> 27) Base:0x00000000 Size:0x00000000
[0.825580 0.005019] [0010.259] I> 28) Base:0x84400000 Size:0x00400000
[0.829098 0.003518] [0010.263] I> 29) Base:0x30000000 Size:0x00010000
[0.834166 0.005068] [0010.267] I> 30) Base:0x238000000 Size:0x08000000
[0.838553 0.004387] [0010.272] I> 31) Base:0x00000000 Size:0x00000000
[0.842892 0.004339] [0010.276] I> 32) Base:0x236000000 Size:0x00600000
[0.847456 0.004564] [0010.281] I> 33) Base:0x80000000 Size:0x70000000
[0.851061 0.003605] [0010.285] I> 34) Base:0xf0110000 Size:0x145ef0000
[0.856475 0.005414] [0010.290] I> 35) Base:0x00000000 Size:0x00000000
[0.859683 0.003208] [0010.294] I> 36) Base:0x00000000 Size:0x00000000
[0.864612 0.004929] [0010.299] I> 37) Base:0x2372e0000 Size:0x00020000
[0.869893 0.005281] [0010.303] I> 38) Base:0x84000000 Size:0x00400000
[0.873315 0.003422] [0010.308] I> 39) Base:0x96000000 Size:0x02400000
[0.878829 0.005514] [0010.312] I> 40) Base:0x85000000 Size:0x01200000
[0.882139 0.003310] [0010.316] I> 41) Base:0x237000000 Size:0x00280000
[0.887375 0.005236] [0010.321] I> 42) Base:0x00000000 Size:0x00000000
[0.892348 0.004973] [0010.325] I> 43) Base:0x00000000 Size:0x00000000
[0.895876 0.003528] [0010.330] GIC-SPI Target CPU: 4
[0.899097 0.003221] [0010.333] Interrupts Init done
[0.901746 0.002649] [0010.336] calling constructors
[0.905123 0.003377] [0010.339] initializing heap
[0.907911 0.002788] [0010.342] initializing threads
[0.911020 0.003109] [0010.345] initializing timers
[0.915446 0.004426] [0010.348] creating bootstrap completion thread
[0.919520 0.004074] [0010.353] top of bootstrap2()
[0.922475 0.002955] [0010.356] CPU: ARM Cortex A57
[0.925485 0.003010] [0010.359] CPU: MIDR: 0x411FD073, MPIDR: 0x80000100
[0.931085 0.005600] [0010.364] initializing platform
[0.934007 0.002922] [0010.367] I> Boot-device: eMMC
[0.937544 0.003537] [0010.371] I> Dram Scrub in progress
[6.211556 5.274012] [0015.644] I> DRAM Scrub Successfull
[6.214363 0.002807] [0015.648] I> sdmmc bdev is already initialized
[6.217942 0.003579] [0015.652] I> Reading GPT from 512 for device 00000003
[6.224692 0.006750] [0015.658] I> Reading GPT from 16776704 for device 00000003
[6.230425 0.005733] [0015.664] I> Found 13 partitions in 00000003 device
[6.235663 0.005238] [0015.669] I> Reading GPT from 512 for device 00010003
[6.239873 0.004210] [0015.675] I> Found 29 partitions in 00010003 device
[6.245480 0.005607] [0015.680] W> opt-in fuse is not set, skip fuse_burning
[6.251018 0.005538] [0015.685] I> Bl_dtb @0x8520f400
[6.253535 0.002517] [0015.688] I> gpio framework initialized
[6.256490 0.002955] [0015.691] I> tegrabl_gpio_driver_register: register 'tegra_gpio_main_driver' driver
[6.264895 0.008405] [0015.699] I> tegrabl_gpio_driver_register: register 'tegra_gpio_aon_driver' driver
[6.272830 0.007935] [0015.706] I> tegrabl_tca9539_init: i2c bus: 0, slave addr: 0xee
[6.282001 0.009171] [0015.715] I> tegrabl_gpio_driver_register: register 'tca9539_gpio_driver' driver
[6.288306 0.006305] [0015.722] I> tegrabl_tca9539_init: i2c bus: 0, slave addr: 0xe8
[6.297298 0.008992] [0015.730] I> tegrabl_gpio_driver_register: register 'tca9539_gpio_driver' driver
[6.303355 0.006057] [0015.738] I> tegrabl_tca9539_init: i2c bus: 0, slave addr: 0xec
[6.309795 0.006440] [0015.744] E> i2c dev write failed
[6.312650 0.002855] [0015.747] E> tca9539_device_init: failed to write polar reg
[6.318088 0.005438] [0015.752] E> tegrabl_tca9539_init: failed to init device!
[6.323552 0.005464] [0015.758] E> GPIO TCA9539 driver init failed
[6.441194 0.117642] [0015.874] I> decompressor handler not found
[6.448102 0.006908] [0015.881] I> fixed regulator driver initialized
[6.484072 0.035970] [0015.917] I> register 'maxim' power off handle
[6.489637 0.005565] [0015.923] I> virtual i2c enabled
[6.491764 0.002127] [0015.926] I> registered 'maxim,max77620' pmic
[6.497235 0.005471] [0015.930] I> tegrabl_gpio_driver_register: register 'max77620-gpio' driver
[6.508164 0.010929] [0015.941] I> Find /i2c@c250000's alias i2c7
[6.511470 0.003306] [0015.945] I> Reading eeprom i2c=7 address=0x50
[6.541932 0.030462] [0015.975] I> Device at /i2c@c250000:0x50
[6.545914 0.003982] [0015.979] I> Reading eeprom i2c=7 address=0x57
[6.575215 0.029301] [0016.009] I> Device at /i2c@c250000:0x57
[6.579431 0.004216] [0016.013] I> Find /i2c@c240000's alias i2c1
[6.582820 0.003389] [0016.017] I> Reading eeprom i2c=1 address=0x51
[6.588847 0.006027] [0016.023] E> i2c dev read failed
[6.591690 0.002843] [0016.026] E> eeprom: Retry to read I2C slave device.
[6.597637 0.005947] [0016.031] E> i2c dev read failed
[6.600508 0.002871] [0016.034] E> eeprom: Failed to read I2C slave device
[6.603786 0.003278] [0016.039] I> Eeprom read failed 0x1a89800d
[6.609722 0.005936] [0016.043] I> Find /i2c@3160000's alias i2c0
[6.612905 0.003183] [0016.047] I> Reading eeprom i2c=0 address=0x50
[6.618520 0.005615] [0016.052] E> i2c dev read failed
[6.621164 0.002644] [0016.055] E> eeprom: Failed to read I2C slave device
[6.626086 0.004922] [0016.060] I> Eeprom read failed 0x1a89800d
[6.630578 0.004492] [0016.064] I> Find /i2c@3180000's alias i2c2
[6.633959 0.003381] [0016.068] I> Reading eeprom i2c=2 address=0x54
[6.638988 0.005029] [0016.073] I> Enabling gpio chip_id = 2, gpio pin = 9
[6.645941 0.006953] [0016.079] E> i2c dev read failed
[6.649301 0.003360] [0016.082] E> eeprom: Failed to read I2C slave device
[6.652908 0.003607] [0016.087] I> Disabling gpio chip_id = 2, gpio pin = 9
[6.658635 0.005727] [0016.092] I> Eeprom read failed 0x00000000
[6.661850 0.003215] [0016.096] I> create_pm_ids: id: 3489-0000-300-K, len: 15
[6.667274 0.005424] [0016.101] I> config: mem-type:00,power-config:00,misc-config:00,modem-config:00,touch-config:00,display-config:00,, len: 93
[6.678205 0.010931] [0016.112] I> create_pm_ids: id: 2597-0000-302-D, len: 15
[6.683569 0.005364] [0016.117] I> config: mem-type:00,power-config:00,misc-config:00,modem-config:00,touch-config:00,display-config:00,, len: 93
[6.699118 0.015549] [0016.132] I> found one nvdisp nodes at offset = 103932
[6.702649 0.003531] [0016.137] I> found one nvdisp nodes at offset = 104848
[6.714434 0.011785] [0016.147] I> enabling 'vdd-hdmi' regulator
[6.729081 0.014647] [0016.162] I> regulator 'vdd-hdmi' already enabled
[6.732596 0.003515] [0016.167] E> tegrabl_display_init_regulator: hdmi cable is not connected
[6.738634 0.006038] [0016.173] I> found one nvdisp nodes at offset = 105652
[6.743921 0.005287] [0016.178] I> no valid display unit config found in dtb
[6.749187 0.005266] [0016.183] W> display init failed
[6.752183 0.002996] [0016.186] initializing target
[6.755256 0.003073] [0016.189] calling apps_init()
[6.758279 0.003023] [0016.192] starting app android_boot_app
[6.763170 0.004891] [0016.196] I> Gpio keyboard init success
[6.766421 0.003251] [0016.200] I> Kernel type = Normal
[6.769295 0.002874] [0016.203] I> Loading kernel/boot.img from storage ...
[6.774580 0.005285] [0016.208] W> No valid slot number is found in scratch register
[6.780129 0.005549] [0016.214] W> Return default slot: _a
[6.783271 0.003142] [0016.217] I> A/B: bin_type (0) slot 0
[6.786283 0.003012] [0016.220] I> Loading partition kernel at 0xa8000000
[7.548046 0.761763] [0016.981] I> tegrabl_auth_payload: partition kernel (bin_type 0)
[7.555008 0.006962] [0016.988] W> No valid slot number is found in scratch register
[7.560416 0.005408] [0016.994] W> Return default slot: _a
[7.563503 0.003087] [0016.997] I> A/B: bin_type (1) slot 0
[7.566576 0.003073] [0017.000] I> Loading partition kernel-dtb at 0x92000000
[7.578847 0.012271] [0017.012] I> tegrabl_auth_payload: partition kernel-dtb (bin_type 1)
[7.585662 0.006815] [0017.019] I> Kernel DTB @ 0x92000000
[7.588581 0.002919] [0017.022] I> Checking boot.img header magic ... [0017.027] I> [OK]
[7.594451 0.005870] [0017.028] I> Valid boot.img @ 0xa8000000
[7.597644 0.003193] [0017.032] I> decompressor handler not found
[7.602492 0.004848] [0017.036] I> Copying kernel image (488466 bytes) from 0xa8000800 to 0x80080000 ... [0017.043] I> Done
[7.610989 0.008497] [0017.045] I> Move ramdisk (len: 0) from 0xa8078000 to 0x9d000000
[7.618242 0.007253] [0017.052] I> Updated bpmp info to DTB
[7.624723 0.006481] [0017.058] I> Ramdisk: Base: 0x9d000000; Size: 0x0
[7.628238 0.003515] [0017.062] I> Updated initrd info to DTB
[7.631408 0.003170] [0017.066] E> tegrabl_linuxboot_add_disp_param, du 0 failed to get display params
[7.639445 0.008037] [0017.073] E> tegrabl_linuxboot_add_disp_param, du 0 failed to get display params
[7.646914 0.007469] [0017.080] E> tegrabl_linuxboot_add_disp_param, du 0 failed to get display params
[7.653229 0.006315] [0017.088] I> disabled_core_mask: 0xffffff0c
[7.658448 0.005219] [0017.092] W> No valid slot number is found in scratch register
[7.664020 0.005572] [0017.097] W> Return default slot: _a
[7.667090 0.003070] [0017.101] I> Active slot suffix: 
[7.669995 0.002905] [0017.104] I> add_boot_slot_suffix: slot_suffix = 
[7.675117 0.005122] [0017.108] I> add_serialno: Serial Num = 0320218172294
[7.678843 0.003726] [0017.113] I> Linux Cmdline: root=/dev/mmcblk0p1 rw rootwait console=ttyS0,115200n8 console=tty0 OS=l4t fbcon=map:0 net.ifnames=0 memtype=0 video=tegrafb no_console_suspend=1 earlycon=uart8250,mmio32,0x03100000 nvdumper_reserved=0x2372e0000 gpt tegraid=18.1.2.0.0 tegra_keep_boot_clocks maxcpus=6 boot.slot_suffix= boot.ratchetvalues=0.2.1 androidboot.serialno=0320218172294 bl_prof_dataptr=0x10000@0x237040000 sdhci_tegra.en_boot_part_access=1 
[7.717343 0.038500] [0017.152] I> Updated bootarg info to DTB
[7.722044 0.004701] [0017.156] E> "plugin-manager" doesn't exist, creating
[7.725741 0.003697] [0017.161] E> "odm-data" doesn't exist, creating
[7.732654 0.006913] [0017.167] I> eeprom_get_mac_addr: MAC (type: 0): 00:ff:ff:ff:ff:ff
[7.738250 0.005596] [0017.173] I> eeprom_get_mac_addr: MAC (type: 1): 00:ff:ff:ff:ff:ff
[7.744523 0.006273] [0017.179] I> eeprom_get_mac_addr: MAC (type: 2): 00:04:4b:ab:f9:cb
[7.751762 0.007239] [0017.185] E> "ids" doesn't exist, creating
[7.755230 0.003468] [0017.189] E> "connection" doesn't exist, creating
[7.760306 0.005076] [0017.193] E> "configs" doesn't exist, creating
[7.763798 0.003492] [0017.198] I> create_pm_ids: id: 3489-0000-300-K, len: 15
[7.769136 0.005338] [0017.203] I> config: mem-type:00,power-config:00,misc-config:00,modem-config:00,touch-config:00,display-config:00,, len: 93
[7.780260 0.011124] [0017.214] I> create_pm_ids: id: 2597-0000-302-D, len: 15
[7.785566 0.005306] [0017.219] I> config: mem-type:00,power-config:00,misc-config:00,modem-config:00,touch-config:00,display-config:00,, len: 93
[7.796241 0.010675] [0017.230] I> Adding plugin-manager/ids/3489-0000-300=/i2c@c250000:module@0x50
[7.802554 0.006313] [0017.237] E> "i2c@c250000" doesn't exist, creating
[7.807680 0.005126] [0017.242] E> "module@0x50" doesn't exist, creating
[7.811854 0.004174] [0017.246] I> Adding plugin-manager/ids/2597-0000-302=/i2c@c250000:module@0x57
[7.819210 0.007356] [0017.253] E> "module@0x57" doesn't exist, creating
[7.826967 0.007757] [0017.260] I> Adding plugin-manager/ids/3489-0000-300-K
[7.833936 0.006969] [0017.267] I> Adding plugin-manager/configs/3489-mem-type 00
[7.838114 0.004178] [0017.273] I> Adding plugin-manager/configs/3489-power-config 00
[7.845194 0.007080] [0017.278] I> Adding plugin-manager/configs/3489-misc-config 00
[7.851065 0.005871] [0017.284] I> Adding plugin-manager/configs/3489-modem-config 00
[7.856782 0.005717] [0017.290] I> Adding plugin-manager/configs/3489-touch-config 00
[7.862170 0.005388] [0017.296] I> Adding plugin-manager/configs/3489-display-config 00
[7.868017 0.005847] [0017.302] E> "chip-id" doesn't exist, creating
[7.871499 0.003482] [0017.306] I> Adding plugin-manager/chip-id/A02P
[7.879116 0.007617] [0017.313] I> added [base:0x80000000, size:0x70000000] to /memory
[7.884858 0.005742] [0017.318] I> added [base:0xf0200000, size:0x145e00000] to /memory
[7.890676 0.005818] [0017.324] I> added [base:0x236600000, size:0x200000] to /memory
[7.896440 0.005764] [0017.330] E> WARNING: Failed to pass NS DRAM ranges to TOS
[7.901619 0.005179] [0017.335] I> Updated memory info to DTB
[7.907669 0.006050] [0017.341] E> "reset" doesn't exist, creating
[7.911316 0.003647] [0017.345] E> "pmc-reset-reason" doesn't exist, creating
[7.916957 0.005641] [0017.350] E> "pmic-reset-reason" doesn't exist, creating
[7.922692 0.005735] [0017.356] I> disabled_core_mask: 0xffffff0c
[7.934134 0.011442] [0017.367] I> Add serial number as DT property
[7.938671 0.004537] [0017.372] I> tegrabl_load_kernel_and_dtb: Done
[7.943226 0.004555] [0017.377] E> tegrabl_display_clear: display is not initialized
[7.949027 0.005801] [0017.382] W> Boot logo display failed...
[7.972333 0.023306] 
[7.972542 0.000209] 
[7.972630 0.000088] U-Boot 2016.07-g9c3b9a4 (May 17 2018 - 00:08:48 -0700)

TX2i over our own carrier board log :

[0.000001 0.000001] [0000.086] C> I2C command failed
[0.003314 0.003313] [0000.089] C> block index = (4) and rail_id = (1)
[0.006004 0.002690] [0000.094] C> Addr: Reg = [0xe8:0x07]: 336166925
[0.011984 0.005980] [0000.098] C> I2C command failed
[0.013878 0.001894] [0000.101] C> block index = (5) and rail_id = (1)
[0.016327 0.002449] [0000.106] C> Addr: Reg = [0xe8:0x07]: 336166925
[9.367296 9.350969] [0009.453] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)
[9.372689 0.005393] [0009.461] I> Default Heap @ [0xd486400 - 0xd488400]
[9.376996 0.004307] [0009.466] I> DMA Heap @ [0x85200000 - 0x86200000]
[9.379702 0.002706] [0009.471] I> bit @ 0xd480000
[9.383963 0.004261] [0009.474] I> BR-BCT relocated to 0xd7020000
[9.386667 0.002704] [0009.478] I> Boot-device: eMMC
[9.391677 0.005010] [0009.482] I> sdmmc bdev is already initialized
[9.396668 0.004991] [0009.486] I> pmic: reset reason (nverc)	: 0x40
[9.401235 0.004567] [0009.491] I> Reading GPT from 512 for device 00000003
[9.407691 0.006456] [0009.497] I> Reading GPT from 16776704 for device 00000003
[9.414767 0.007076] [0009.504] I> Found 13 partitions in 00000003 device
[9.419363 0.004596] [0009.509] I> Reading GPT from 512 for device 00010003
[9.426300 0.006937] [0009.515] I> Found 29 partitions in 00010003 device
[9.431123 0.004823] [0009.521] I> OEM carveouts init scrub in progress...
[9.511777 0.080654] [0009.602] I> Mb2 SDRAM scrub successful
[9.524398 0.012621] [0009.606] W> No valid slot number is found in scratch register
[9.528153 0.003755] [0009.611] W> Return default slot: _a
[9.530166 0.002013] [0009.615] I> A/B: bin_type (16) slot 0
[9.532231 0.002065] [0009.618] I> Loading partition bpmp-fw at 0xd7800000
[9.534998 0.002767] [0009.623] I> Reading two headers - addr:0xd7800000 blocks:1
[9.540575 0.005577] [0009.629] I> Addr: 0xd7800000, start-block: 18915329, num_blocks: 1
[9.561083 0.020508] [0009.644] I> Binary(16) of size 529040 is loaded @ 0xd7800000
[9.564055 0.002972] [0009.649] W> No valid slot number is found in scratch register
[9.566859 0.002804] [0009.655] W> Return default slot: _a
[9.568337 0.001478] [0009.658] I> A/B: bin_type (17) slot 0
[9.573357 0.005020] [0009.662] I> Loading partition bpmp-fw-dtb at 0xd79f0000
[9.578661 0.005304] [0009.667] I> Reading two headers - addr:0xd79f0000 blocks:1
[9.584538 0.005877] [0009.673] I> Addr: 0xd79f0000, start-block: 18917745, num_blocks: 1
[9.592607 0.008069] [0009.681] I> Binary(17) of size 75472 is loaded @ 0xd79ed600
[9.625986 0.033379] [0009.716] I> BPMP-FW load address = 0xd7800000
[9.630547 0.004561] [0009.720] I> BPMP-FW DTB load address = 0x501ed600
[9.633658 0.003111] [0009.725] I> Loading SCE-FW ...
[9.642781 0.009123] [0009.728] W> No valid slot number is found in scratch register
[9.645309 0.002528] [0009.734] W> Return default slot: _a
[9.646744 0.001435] [0009.737] I> A/B: bin_type (12) slot 0
[9.651169 0.004425] [0009.741] I> Loading partition sce-fw at 0xd7300000
[9.656655 0.005486] [0009.746] I> Reading two headers - addr:0xd7300000 blocks:1
[9.662705 0.006050] [0009.751] I> Addr: 0xd7300000, start-block: 18919745, num_blocks: 1
[9.670943 0.008238] [0009.760] I> Binary(12) of size 76592 is loaded @ 0xd7300000
[9.673422 0.002479] [0009.765] I> Init SCE
[9.685778 0.012356] [0009.768] I> Copy BTCM section
[9.687246 0.001468] [0009.771] W> No valid slot number is found in scratch register
[9.689781 0.002535] [0009.776] W> Return default slot: _a
[9.691183 0.001402] [0009.780] I> A/B: bin_type (13) slot 0
[9.694782 0.003599] [0009.783] I> Loading partition cpu-bootloader at 0x96000000
[9.700358 0.005576] [0009.789] I> Reading two headers - addr:0x96000000 blocks:1
[9.705995 0.005637] [0009.794] I> Addr: 0x96000000, start-block: 18894849, num_blocks: 1
[9.722621 0.016626] [0009.806] I> Binary(13) of size 282736 is loaded @ 0x96000000
[9.725125 0.002504] [0009.811] W> No valid slot number is found in scratch register
[9.728039 0.002914] [0009.817] W> Return default slot: _a
[9.729532 0.001493] [0009.820] I> A/B: bin_type (20) slot 0
[9.735664 0.006132] [0009.824] I> Loading partition bootloader-dtb at 0x8520f400
[9.740867 0.005203] [0009.829] I> Reading two headers - addr:0x8520f400 blocks:1
[9.747106 0.006239] [0009.835] I> Addr: 0x8520f400, start-block: 18896897, num_blocks: 1
[9.760603 0.013497] [0009.845] I> Binary(20) of size 220048 is loaded @ 0x8520f400
[9.762627 0.002024] [0009.851] I> MB2-params(VA) @ 0xd7000000
[9.764556 0.001929] [0009.855] I> CPUBL-params(VA) @ 0xd7000000
[9.768661 0.004105] [0009.859] I> CPUBL-params(PA) @ 0x237000000
[9.772679 0.004018] [0009.863] I> CPU-BL loaded @ PA 0x96000000
[9.775459 0.002780] [0009.867] I> Loading TOS ...
[9.784723 0.009264] [0009.870] W> No valid slot number is found in scratch register
[9.785818 0.001095] [0009.876] W> Return default slot: _a
[9.788059 0.002241] [0009.879] I> A/B: bin_type (14) slot 0
[9.793388 0.005329] [0009.883] I> Loading partition secure-os at 0x8530f600
[9.798973 0.005585] [0009.888] I> Reading two headers - addr:0x8530f600 blocks:1
[9.805014 0.006041] [0009.893] I> Addr: 0x8530f600, start-block: 18898945, num_blocks: 1
[9.812712 0.007698] [0009.902] I> Binary(14) of size 62576 is loaded @ 0x8530f600
[9.819860 0.007148] [0009.907] I> Copying Monitor (length: 0xf270) from 0x8530f800 to 0x40000000
[9.824347 0.004487] [0009.914] I> Erasing Monitor @ 0x8530f800
[9.826850 0.002503] [0009.919] I> Unhalting SCE
[9.832237 0.005387] [0009.921] I> Primary Memory Start:80000000 Size:70000000
[9.837591 0.005354] [0009.927] I> Extended Memory Start:f0110000 Size:145ef0000
[9.842951 0.005360] [0009.933] I> Waypoint2-ACK: 0x52012714
[9.845810 0.002859] [0009.937] I> MB2(TBoot-BPMP) done
[9.846607 0.000797] 
[9.867686 0.021079] NOTICE:  BL31: v1.2(release):e1e4477
[9.869301 0.001615] NOTICE:  BL31: Built : 00:08:30, May 17 2018
[9.876609 0.007308] NOTICE:  Trusty image missing.
[9.877981 0.001372] ERROR:   Error initializing runtime service trusty_fast
[10.081718 0.203737] [0010.153] I> Welcome to Cboot
[10.083497 0.001779] [0010.156] I> Cboot Version: 00.00.2014.50-t186-0c600f85
[10.086445 0.002948] [0010.161] I> CPU-BL Params @ 0x237000000
[10.088801 0.002356] [0010.164] I>  0) Base:0x00000000 Size:0x00000000
[10.091830 0.003029] [0010.169] I>  1) Base:0x237f00000 Size:0x00100000
[10.094439 0.002609] [0010.173] I>  2) Base:0x237e00000 Size:0x00100000
[10.106019 0.011580] [0010.178] I>  3) Base:0x237d00000 Size:0x00100000
[10.109880 0.003861] [0010.182] I>  4) Base:0x237c00000 Size:0x00100000
[10.113294 0.003414] [0010.187] I>  5) Base:0x237b00000 Size:0x00100000
[10.115475 0.002181] [0010.191] I>  6) Base:0x237800000 Size:0x00200000
[10.116880 0.001405] [0010.196] I>  7) Base:0x237400000 Size:0x00400000
[10.126503 0.009623] [0010.201] I>  8) Base:0x237a00000 Size:0x00100000
[10.127284 0.000781] [0010.205] I>  9) Base:0x237300000 Size:0x00100000
[10.128072 0.000788] [0010.210] I> 10) Base:0x236800000 Size:0x00800000
[10.128835 0.000763] [0010.214] I> 11) Base:0x30000000 Size:0x00040000
[10.129584 0.000749] [0010.218] I> 12) Base:0xf0000000 Size:0x00100000
[10.148550 0.018966] [0010.223] I> 13) Base:0x30040000 Size:0x00001000
[10.149192 0.000642] [0010.227] I> 14) Base:0x30048000 Size:0x00001000
[10.149815 0.000623] [0010.232] I> 15) Base:0x30049000 Size:0x00001000
[10.150438 0.000623] [0010.236] I> 16) Base:0x3004a000 Size:0x00001000
[10.151057 0.000619] [0010.241] I> 17) Base:0x3004b000 Size:0x00001000
[10.171424 0.020367] [0010.245] I> 18) Base:0x3004c000 Size:0x00001000
[10.172089 0.000665] [0010.249] I> 19) Base:0x3004d000 Size:0x00001000
[10.172712 0.000623] [0010.254] I> 20) Base:0x3004e000 Size:0x00001000
[10.173334 0.000622] [0010.258] I> 21) Base:0x3004f000 Size:0x00001000
[10.173955 0.000621] [0010.263] I> 22) Base:0x00000000 Size:0x00000000
[10.193210 0.019255] [0010.267] I> 23) Base:0xf0100000 Size:0x00010000
[10.193870 0.000660] [0010.272] I> 24) Base:0x00000000 Size:0x00000000
[10.194503 0.000633] [0010.276] I> 25) Base:0x00000000 Size:0x00000000
[10.195138 0.000635] [0010.280] I> 26) Base:0x00000000 Size:0x00000000
[10.195790 0.000652] [0010.285] I> 27) Base:0x00000000 Size:0x00000000
[10.215662 0.019872] [0010.289] I> 28) Base:0x84400000 Size:0x00400000
[10.216427 0.000765] [0010.294] I> 29) Base:0x30000000 Size:0x00010000
[10.217151 0.000724] [0010.298] I> 30) Base:0x238000000 Size:0x08000000
[10.217882 0.000731] [0010.303] I> 31) Base:0x00000000 Size:0x00000000
[10.218618 0.000736] [0010.307] I> 32) Base:0x236000000 Size:0x00600000
[10.237736 0.019118] [0010.312] I> 33) Base:0x80000000 Size:0x70000000
[10.238595 0.000859] [0010.316] I> 34) Base:0xf0110000 Size:0x145ef0000
[10.239451 0.000856] [0010.321] I> 35) Base:0x00000000 Size:0x00000000
[10.240319 0.000868] [0010.325] I> 36) Base:0x00000000 Size:0x00000000
[10.241168 0.000849] [0010.329] I> 37) Base:0x2372e0000 Size:0x00020000
[10.260302 0.019134] [0010.334] I> 38) Base:0x84000000 Size:0x00400000
[10.261159 0.000857] [0010.338] I> 39) Base:0x96000000 Size:0x02400000
[10.262006 0.000847] [0010.343] I> 40) Base:0x85000000 Size:0x01200000
[10.262846 0.000840] [0010.347] I> 41) Base:0x237000000 Size:0x00280000
[10.263715 0.000869] [0010.352] I> 42) Base:0x00000000 Size:0x00000000
[10.282783 0.019068] [0010.356] I> 43) Base:0x00000000 Size:0x00000000
[10.283668 0.000885] [0010.361] GIC-SPI Target CPU: 4
[10.284243 0.000575] [0010.364] Interrupts Init done
[10.284855 0.000612] [0010.367] calling constructors
[10.285423 0.000568] [0010.370] initializing heap
[10.285928 0.000505] [0010.373] initializing threads
[10.286496 0.000568] [0010.376] initializing timers
[10.304889 0.018393] [0010.379] creating bootstrap completion thread
[10.306024 0.001135] [0010.384] top of bootstrap2()
[10.306890 0.000866] [0010.387] CPU: ARM Cortex A57
[10.307776 0.000886] [0010.390] CPU: MIDR: 0x411FD073, MPIDR: 0x80000100
[10.309183 0.001407] [0010.395] initializing platform
[10.310146 0.000963] [0010.398] I> Boot-device: eMMC
[10.311025 0.000879] [0010.402] I> Dram Scrub in progress
[15.588805 5.277780] [0015.675] I> DRAM Scrub Successfull
[15.590573 0.001768] [0015.679] I> sdmmc bdev is already initialized
[15.593265 0.002692] [0015.683] I> Reading GPT from 512 for device 00000003
[15.599856 0.006591] [0015.688] I> Reading GPT from 16776704 for device 00000003
[15.610014 0.010158] [0015.695] I> Found 13 partitions in 00000003 device
[15.611466 0.001452] [0015.700] I> Reading GPT from 512 for device 00010003
[15.623992 0.012526] [0015.706] I> Found 29 partitions in 00010003 device
[15.625673 0.001681] [0015.710] W> opt-in fuse is not set, skip fuse_burning
[15.627350 0.001677] [0015.715] I> Bl_dtb @0x8520f400
[15.628384 0.001034] [0015.718] I> gpio framework initialized
[15.649273 0.020889] [0015.722] I> tegrabl_gpio_driver_register: register 'tegra_gpio_main_driver' driver
[15.653061 0.003788] [0015.729] I> tegrabl_gpio_driver_register: register 'tegra_gpio_aon_driver' driver
[15.656715 0.003654] [0015.737] I> tegrabl_tca9539_init: i2c bus: 0, slave addr: 0xee
[15.667135 0.010420] [0015.744] E> i2c dev write failed
[15.668652 0.001517] [0015.747] E> tca9539_device_init: failed to write polar reg
[15.670955 0.002303] [0015.752] E> tegrabl_tca9539_init: failed to init device!
[15.673271 0.002316] [0015.758] E> GPIO TCA9539 driver init failed
[15.784061 0.110790] [0015.874] I> decompressor handler not found
[15.790340 0.006279] [0015.880] I> fixed regulator driver initialized
[15.821786 0.031446] [0015.912] I> register 'maxim' power off handle
[15.829583 0.007797] [0015.917] I> virtual i2c enabled
[15.831252 0.001669] [0015.920] I> registered 'maxim,max77620' pmic
[15.836822 0.005570] [0015.924] I> tegrabl_gpio_driver_register: register 'max77620-gpio' driver
[15.843496 0.006674] [0015.934] I> Find /i2c@c250000's alias i2c7
[15.845834 0.002338] [0015.938] I> Reading eeprom i2c=7 address=0x50
[15.877587 0.031753] [0015.968] I> Device at /i2c@c250000:0x50
[15.879641 0.002054] [0015.972] I> Reading eeprom i2c=7 address=0x57
[15.893671 0.014030] [0015.976] E> i2c dev read failed
[15.895354 0.001683] [0015.979] E> eeprom: Failed to read I2C slave device
[15.897777 0.002423] [0015.984] I> Eeprom read failed 0x1a89800d
[15.902956 0.005179] [0015.989] I> Find /i2c@c240000's alias i2c1
[15.905186 0.002230] [0015.993] I> Reading eeprom i2c=1 address=0x51
[15.911425 0.006239] [0015.998] E> i2c dev read failed
[15.913209 0.001784] [0016.001] E> eeprom: Retry to read I2C slave device.
[15.924040 0.010831] [0016.006] E> i2c dev read failed
[15.925496 0.001456] [0016.009] E> eeprom: Failed to read I2C slave device
[15.927698 0.002202] [0016.014] I> Eeprom read failed 0x1a89800d
[15.929402 0.001704] [0016.019] I> Find /i2c@3160000's alias i2c0
[15.931087 0.001685] [0016.023] I> Reading eeprom i2c=0 address=0x50
[15.944666 0.013579] [0016.027] E> i2c dev read failed
[15.946200 0.001534] [0016.030] E> eeprom: Failed to read I2C slave device
[15.948328 0.002128] [0016.035] I> Eeprom read failed 0x1a89800d
[15.950015 0.001687] [0016.040] I> Find /i2c@3180000's alias i2c2
[15.951820 0.001805] [0016.044] I> Reading eeprom i2c=2 address=0x54
[15.973996 0.022176] [0016.048] I> Enabling gpio chip_id = 2, gpio pin = 9
[15.976027 0.002031] [0016.053] C> GPIO driver for chip_id 0x2 could not be found
[15.978245 0.002218] [0016.058] E> cam_eeprom_read: Can't get gpio driver
[15.980242 0.001997] [0016.063] I> Eeprom read failed 0x2693400d
[15.989041 0.008799] [0016.067] I> create_pm_ids: id: 3489-0000-300-K, len: 15
[15.991373 0.002332] [0016.072] I> config: mem-type:00,power-config:00,misc-config:00,modem-config:00,touch-config:00,display-config:00,, len: 93
[15.996229 0.004856] [0016.086] I> found one nvdisp nodes at offset = 75908
[16.001348 0.005119] [0016.091] I> found one nvdisp nodes at offset = 76716
[16.005688 0.004340] [0016.095] I> found one nvdisp nodes at offset = 77624
[16.014043 0.008355] [0016.100] I> no valid display unit config found in dtb
[16.015326 0.001283] [0016.105] W> display init failed
[16.016044 0.000718] [0016.108] initializing target
[16.025001 0.008957] [0016.111] calling apps_init()
[16.025587 0.000586] [0016.114] starting app android_boot_app
[16.036043 0.010456] [0016.118] I> Gpio keyboard init success
[16.036900 0.000857] [0016.122] I> Kernel type = Normal
[16.037551 0.000651] [0016.125] I> Loading kernel/boot.img from storage ...
[16.038544 0.000993] [0016.130] W> No valid slot number is found in scratch register
[16.054702 0.016158] [0016.136] W> Return default slot: _a
[16.055939 0.001237] [0016.139] I> A/B: bin_type (0) slot 0
[16.057167 0.001228] [0016.143] I> Loading partition kernel at 0xa8000000
[16.815110 0.757943] [0016.903] I> tegrabl_auth_payload: partition kernel (bin_type 0)
[16.832853 0.017743] [0016.910] W> No valid slot number is found in scratch register
[16.837013 0.004160] [0016.915] W> Return default slot: _a
[16.838920 0.001907] [0016.919] I> A/B: bin_type (1) slot 0
[16.840866 0.001946] [0016.922] I> Loading partition kernel-dtb at 0x92000000
[16.845877 0.005011] [0016.934] I> tegrabl_auth_payload: partition kernel-dtb (bin_type 1)
[16.868850 0.022973] [0016.941] I> Kernel DTB @ 0x92000000
[16.870438 0.001588] [0016.944] I> Checking boot.img header magic ... [0016.948] I> [OK]
[16.872962 0.002524] [0016.950] I> Valid boot.img @ 0xa8000000
[16.874498 0.001536] [0016.954] I> decompressor handler not found
[16.876193 0.001695] [0016.958] I> Copying kernel image (474322 bytes) from 0xa8000800 to 0x80080000 ... [0016.965] I> Done
[16.879137 0.002944] [0016.967] I> Move ramdisk (len: 0) from 0xa8074800 to 0x9d000000
[16.883162 0.004025] [0016.974] I> Updated bpmp info to DTB
[16.892696 0.009534] [0016.979] I> Ramdisk: Base: 0x9d000000; Size: 0x0
[16.894016 0.001320] [0016.983] I> Updated initrd info to DTB
[16.914255 0.020239] [0016.987] E> tegrabl_linuxboot_add_disp_param, du 0 failed to get display params
[16.915530 0.001275] [0016.994] E> tegrabl_linuxboot_add_disp_param, du 0 failed to get display params
[16.916709 0.001179] [0017.001] E> tegrabl_linuxboot_add_disp_param, du 0 failed to get display params
[16.918027 0.001318] [0017.009] I> disabled_core_mask: 0xffffff0c
[16.918722 0.000695] [0017.013] W> No valid slot number is found in scratch register
[16.931739 0.013017] [0017.018] W> Return default slot: _a
[16.932308 0.000569] [0017.022] I> Active slot suffix: 
[16.932827 0.000519] [0017.025] I> add_boot_slot_suffix: slot_suffix = 
[16.935594 0.002767] [0017.029] I> add_serialno: Serial Num = 0320218172450
[16.963066 0.027472] [0017.034] I> Linux Cmdline: root=/dev/mmcblk0p1 rw rootwait console=ttyS0,115200n8 console=tty0 OS=l4t fbcon=map:0 net.ifnames=0 memtype=0 video=tegrafb no_console_suspend=1 earlycon=uart8250,mmio32,0x03100000 nvdumper_reserved=0x2372e0000 gpt tegraid=18.1.2.0.0 tegra_keep_boot_clocks maxcpus=6 boot.slot_suffix= boot.ratchetvalues=0.2.1 androidboot.serialno=0320218172450 bl_prof_dataptr=0x10000@0x237040000 sdhci_tegra.en_boot_part_access=1 
[16.991325 0.028259] [0017.073] I> Updated bootarg info to DTB
[16.992674 0.001349] [0017.077] E> "plugin-manager" doesn't exist, creating
[16.994330 0.001656] [0017.082] E> "odm-data" doesn't exist, creating
[16.998942 0.004612] [0017.087] I> eeprom_get_mac_addr: MAC (type: 0): 00:ff:ff:ff:ff:ff
[17.005433 0.006491] [0017.094] I> eeprom_get_mac_addr: MAC (type: 1): 00:ff:ff:ff:ff:ff
[17.011357 0.005924] [0017.100] I> eeprom_get_mac_addr: MAC (type: 2): 00:04:4b:ab:fa:5b
[17.015081 0.003724] [0017.106] E> "ids" doesn't exist, creating
[17.020003 0.004922] [0017.110] E> "connection" doesn't exist, creating
[17.024234 0.004231] [0017.114] E> "configs" doesn't exist, creating
[17.047036 0.022802] [0017.119] I> create_pm_ids: id: 3489-0000-300-K, len: 15
[17.048636 0.001600] [0017.124] I> config: mem-type:00,power-config:00,misc-config:00,modem-config:00,touch-config:00,display-config:00,, len: 93
[17.053666 0.005030] [0017.135] I> Adding plugin-manager/ids/3489-0000-300=/i2c@c250000:module@0x50
[17.057246 0.003580] [0017.142] E> "i2c@c250000" doesn't exist, creating
[17.059612 0.002366] [0017.146] E> "module@0x50" doesn't exist, creating
[17.062707 0.003095] [0017.152] I> Adding plugin-manager/ids/3489-0000-300-K
[17.070042 0.007335] [0017.159] I> Adding plugin-manager/configs/3489-mem-type 00
[17.075771 0.005729] [0017.164] I> Adding plugin-manager/configs/3489-power-config 00
[17.081558 0.005787] [0017.170] I> Adding plugin-manager/configs/3489-misc-config 00
[17.087133 0.005575] [0017.176] I> Adding plugin-manager/configs/3489-modem-config 00
[17.093209 0.006076] [0017.182] I> Adding plugin-manager/configs/3489-touch-config 00
[17.099206 0.005997] [0017.187] I> Adding plugin-manager/configs/3489-display-config 00
[17.103115 0.003909] [0017.193] E> "chip-id" doesn't exist, creating
[17.107463 0.004348] [0017.198] I> Adding plugin-manager/chip-id/A02P
[17.132022 0.024559] [0017.204] I> added [base:0x80000000, size:0x70000000] to /memory
[17.134645 0.002623] [0017.209] I> added [base:0xf0200000, size:0x145e00000] to /memory
[17.137209 0.002564] [0017.215] I> added [base:0x236600000, size:0x200000] to /memory
[17.139586 0.002377] [0017.221] E> WARNING: Failed to pass NS DRAM ranges to TOS
[17.141807 0.002221] [0017.226] I> Updated memory info to DTB
[17.143315 0.001508] [0017.231] E> "reset" doesn't exist, creating
[17.146087 0.002772] [0017.235] E> "pmc-reset-reason" doesn't exist, creating
[17.151141 0.005054] [0017.241] E> "pmic-reset-reason" doesn't exist, creating
[17.155459 0.004318] [0017.246] I> disabled_core_mask: 0xffffff0c
[17.165348 0.009889] [0017.255] I> Add serial number as DT property
[17.179728 0.014380] [0017.260] I> tegrabl_load_kernel_and_dtb: Done
[17.180859 0.001131] [0017.264] E> tegrabl_display_clear: display is not initialized
[17.182044 0.001185] [0017.270] W> Boot logo display failed...
[17.208265 0.026221] 
[17.208348 0.000083] 
[17.208378 0.000030] U-Boot 2016.07-00002-gfc6b608-dirty (Mar 04 2019 - 16:46:53 +0800)

We can see TX2i boot up time cost time 7 seconds vs 17 seconds (our carrier board vs EVM). Can you help me figure out which reason cause those different?

I have no idea. If you could dump the bpmp log, maybe we could have some clue.

If you can’t, please at least tell us what is different between your board and our devkit.

How could I dump bpmp.log? Can give more detail instruction?
The different between our board and devkit, may be some are external i2c chips exist on our board.
Maybe the below output log is some clue. I2C command failed twice then cause 9 seconds waste there.
Can you have any idea which i2c chips cause those diff, and how to eliminate this issue?

[0.000001 0.000001] [0000.086] C> I2C command failed
[0.003314 0.003313] [0000.089] C> block index = (4) and rail_id = (1)
[0.006004 0.002690] [0000.094] C> Addr: Reg = [0xe8:0x07]: 336166925
[0.011984 0.005980] [0000.098] C> I2C command failed
[0.013878 0.001894] [0000.101] C> block index = (5) and rail_id = (1)
[0.016327 0.002449] [0000.106] C> Addr: Reg = [0xe8:0x07]: 336166925
[9.367296 9.350969] [0009.453] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)

Another common case is both our board and evm are spend 5 seconds to do below task. Can we disable DRAM process and what side-effect will cause if DRAM check is disabled?

[10.310146 0.000963] [0010.398] I> Boot-device: eMMC
[10.311025 0.000879] [0010.402] I> Dram Scrub in progress
[15.588805 5.277780] [0015.675] I> DRAM Scrub Successfull
[15.590573 0.001768] [0015.679] I> sdmmc bdev is already

Could you share what devices are you connecting to your board?

We may remove some unused i2c chips on our board.
I don’t which devices you mentioned? I2C devices?Or other parts of devices?
Our board include some i2c, spi & pcie devices. But I don’t think those new devices could cause BPMP cost 9 seconds in that phase(TBoot), maybe that removed i2c chips may cause that 9 seconds delay.

Can you point me out which i2c device exist cause I2C command failed?

The best way to deal with current situation is to share what you’ve changed between your board and our devkit.

According to the bpmp logs, below i2c5 and i2c10 are enabled during first boot up.

i2c5 controller initialized
i2c10 controller initialized
initialized i2c mrq handling
i2c initialized

@WayneWWW I am afraid this issue may be not connect with the different between our board and devkit.
I have install TX2i & TX2 on the same devkit with JetPack3.2 (tegra-l4t-r28.2.1)
Focus on the Tboot log at start point.

  • TX2i Tboot Log

When log output “Welcome to MB2”, it already cost 9 seconds.

[0009.432] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)                                                                                                                        
[0009.441] I> Default Heap @ [0xd486400 - 0xd488400]
[0009.446] I> DMA Heap @ [0x85200000 - 0x86200000]
[0009.450] I> bit @ 0xd480000
[0009.453] I> BR-BCT relocated to 0xd7020000
[0009.457] I> Boot-device: eMMC 
[0009.461] I> sdmmc bdev is already initialized
[0009.466] I> pmic: reset reason (nverc)    : 0x4
[0009.470] I> Reading GPT from 512 for device 00000003
  • TX2 Tboot Log

When log output “Welcome to MB2”, it only cost 0.186 seconds.

[0000.186] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)                                                                                                                        
[0000.195] I> Default Heap @ [0xd486400 - 0xd488400]
[0000.199] I> DMA Heap @ [0x85200000 - 0x86200000]
[0000.204] I> bit @ 0xd480000
[0000.207] I> BR-BCT relocated to 0xd7020000
[0000.211] I> Boot-device: eMMC 
[0000.215] I> sdmmc bdev is already initialized
[0000.219] I> pmic: reset reason (nverc)    : 0x50

I guess TX2i do more works during Tboot start up, than cost 9 seconds more. Since we can’t get Tboot source code, can you help me figure out what is going on?

53216142,

Our TX2i doesn’t have such problem on devkit. Do you mean your UART log have to wait for 9 seconds to see the first log coming up?

@WanyeWWW Yes, I think 0009.432 is the time stamp added by Tboot.
We also use grabserail to grab serial log, also found TX2i boot up slower than TX2.

[0009.432] I> Welcome to MB2(TBoot-BPMP)(version: 01.00.160913-t186-M-00.00-mobile-c4328dc3)

You don’t such kind of problem? Can you share the TX2i&TX2 boot up here?

53216142,

Yes, I checked this with devkit twice for your issue. However, I am out of tx2i now so cannot share the log with you.

Are you using devkit? If so, do you have other TX2i module can do test?

I have tried another TX2i module. The issue is still there.

BTW, we install both TX2&TX2i on tx2 developer_kit. We don’t have tx2i developer_kit. Do we?

Yes, they are using same devkit. Are you using rel-28 or rel-32?
I think it is time to dump the bpmp log. Could you try to use minicom to open /dev/ttyUSB3? (ttyUSB2 was for your bootloader/kernel log).

We use JetPack3.2(tegra-l4t-r28.2.1).

What do you mean use /dev/ttyUSB3? Which port I should use.
Currently I use serial port below.
https://www.jetsonhacks.com/2017/03/24/serial-console-nvidia-jetson-tx2/

@WanyWWW Can you give me more help here?

hello 53216142,

suggest you check boot-up logs to narrow down the issue,
here are steps to check BPMP boot log,

  1. Convert the DTB to DTS using dtc tool in Linux_for_Tegra
    cd Linux_for_Tegra sudo kernel/dtc -I dtb bootloader/t186/tegra186-a02-quill-pxxxx.dtb -o test_bpmp.dts
  2. Change the DTS file to disable UART7
    $ sudo vi test_bpmp.dts
  3. Change the value of “port” under node serial to 255
  4. Rebuild the DTB file
    $ sudo kernel/dtc -I dts test_bpmp.dts -O dtb -o bootloader/t186/tegra186-a02-quill-pxxxx.dtb
  5. Flash the image to see the result
  6. You should able to read BPMP boot log via /sys/kernel/debug/bpmp/debug/ttyBPMP with superuser permission.

please also check Topic 1025679 for reference.
thanks

@JerryChang

Thank you very much for your replay.

As I know TX2 use tegra186-quill-p3310-1000-c03-00-base.dtb and TX2i tegra186-quill-p3489-1000-a00-00-ucm1.dtb as the final dtb file, can we just modify those two dtb file to meet the requirement?

Or Tboot use different dtb files?

/bootloader/t186ref$ ls *.dtb
tegra186-a02-bpmp-quill-p3310-1000-a00-00.dtb              tegra186-a02-bpmp-quill-p3310-1000-c01-00.dtb              tegra186-a02-bpmp-storm-p3489-a00-00-ta795sa-ecc-disabled-ucm1.dtb  tegra186-a02-bpmp-storm-p3489-evt-00-ta795sa-ecc-disabled-ucm1.dtb
tegra186-a02-bpmp-quill-p3310-1000-a00-00-te770d-ucm2.dtb  tegra186-a02-bpmp-quill-p3310-1000-c01-00-te770d-ucm2.dtb  tegra186-a02-bpmp-storm-p3489-a00-00-ta795sa-ecc-disabled-ucm2.dtb  tegra186-a02-bpmp-storm-p3489-evt-00-ta795sa-ecc-disabled-ucm2.dtb
tegra186-a02-bpmp-quill-p3310-1000-c00-00.dtb              tegra186-a02-bpmp-quill-p3310-1000-c04-00.dtb              tegra186-a02-bpmp-storm-p3489-a00-00-ta795sa-ucm1.dtb               tegra186-a02-bpmp-storm-p3489-evt-00-ta795sa-ucm1.dtb
tegra186-a02-bpmp-quill-p3310-1000-c00-00-te770d-ucm2.dtb  tegra186-a02-bpmp-quill-p3310-1000-c04-00-te770d-ucm2.dtb  tegra186-a02-bpmp-storm-p3489-a00-00-ta795sa-ucm2.dtb               tegra186-a02-bpmp-storm-p3489-evt-00-ta795sa-ucm2.dtb

I get too many dtb as show below, which dtb I should touch?
And what is the relationship between those dtbs and tegra186-quill-p3310-1000-c03-00-base.dtb/tegra186-quill-p3489-1000-a00-00-ucm1.dtb?

Then we can only update dtb with ./flash.sh -k kernel-dtb,right?

Sorry that it is a complicated task.
bpmp dtb is different from kernel dtb.

kernel dtb is something like below and is under Linux_for_Tegra/kernel/dtb

tegra186-quill-p3489-1000-a00-00-ucm1.dtb
tegra186-quill-p3310-1000-c03-00-base.dtb

p3489 series are for TX2i and p3310 is for TX2. ucm indicates some special dtb that has different thermal management.

Please check p2771-0000.conf.common to know which bpmp dtb your device is flashing.

Can you specify which keyword I should search in p2771-0000.conf.common?
Then I can get the correct bpmp dtb file.
Currently we can focus on TX2i firstly.