i.MX Processors中的主题 Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

android6.0 imx6q & imx6dl kernel boot very slow （two issue）

昌清黄 — Tue, 28 Mar 2017 08:00:50 GMT

Our central control system started very slow, the customer asked to optimize the speed,
 I found two serious problems in kernel4.1.15

Starting kernel ...

[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.1.15 (huangcq@dell-PowerEdge-R720) (gcc version 4.9.x-google 20140827 (prerelease) (GCC) ) #53 SMP PREEMPT Tue Mar 28 15:40:18 CST 2017
[ 0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c53c7d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] Machine model: Freescale i.MX6 Quad SABRE Smart Device Board
[ 0.000000] cma: Reserved 384 MiB at 0x26000000
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] PERCPU: Embedded 13 pages/cpu @eeeda000 s22144 r8192 d22912 u53248
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522528
[ 0.000000] Kernel command line: console=ttymxc0,115200 init=/init video=mxcfb0:dev=ldb,bpp=32 video=mxcfb1:off video=mxcfb2:off video=mxcfb3:off vmalloc=256M androidboot.console=ttymxc0 consoleblank=0 androidboot.hardware=freescale cma=384M androidboot.selinux=disabled androidboot.dm_verity=disabled androidboot.serialno=011439d4e317e252
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 1664596K/2096128K available (11555K kernel code, 848K rwdata, 3532K rodata, 2048K init, 644K bss, 38316K reserved, 393216K cma-reserved, 1326080K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0xef800000 - 0xff000000 ( 248 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xef000000 ( 752 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc0fbbdb4 (16080 kB)
[ 0.000000] .init : 0xc1000000 - 0xc1200000 (2048 kB)
[ 0.000000] .data : 0xc1200000 - 0xc12d4010 ( 849 kB)
[ 0.000000] .bss : 0xc12d4010 - 0xc13752e4 ( 645 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] Additional per-CPU info printed with stalls.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] L2C-310 erratum 769419 enabled
[ 0.000000] L2C-310 enabling early BRESP for Cortex-A9
[ 0.000000] L2C-310 full line of zeros enabled for Cortex-A9
[ 0.000000] L2C-310 ID prefetch enabled, offset 16 lines
[ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[ 0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB
[ 0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76070001
[ 0.000000] mxc_clocksource_init 3000000
[ 0.000000] Switching to timer-based delay loop, resolution 333ns
[ 0.000006] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
[ 0.000024] clocksource mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
[ 0.001078] Console: colour dummy device 80x30
[ 0.001099] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
[ 0.001115] pid_max: default: 32768 minimum: 301
[ 0.001198] Security Framework initialized
[ 0.001211] SELinux: Initializing.
[ 0.001254] AppArmor: AppArmor disabled by boot time parameter
[ 0.001293] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001305] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.002014] Initializing cgroup subsys freezer
[ 0.002035] Initializing cgroup subsys debug
[ 0.002063] CPU: Testing write buffer coherency: ok
[ 0.002411] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.002516] Setting up static identity map for 0x10100000 - 0x10100058
[ 0.060297] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.080278] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[ 0.100274] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[ 0.100348] Brought up 4 CPUs
[ 0.100373] SMP: Total of 4 processors activated (24.00 BogoMIPS).
[ 0.100382] CPU: All CPU(s) started in SVC mode.
[ 0.101020] devtmpfs: initialized
[ 0.113179] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[ 0.113652] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.135537] pinctrl core: initialized pinctrl subsystem
[ 0.136774] NET: Registered protocol family 16
[ 0.146475] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.169692] cpuidle: using governor ladder
[ 0.199687] cpuidle: using governor menu
[ 0.200263] CPU identified as i.MX6Q, silicon rev 1.5
[ 0.200379] Use WDOG1 as reset source
[ 0.226802] !!request miniPCIE Power On gpio
[ 0.226853] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[ 0.226862] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.226882] VDSO is not a valid ELF object!
[ 0.227594] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/enetgrp
[ 0.227616] imx6q-pinctrl 20e0000.iomuxc: no fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/hdmicecgrp
[ 0.227657] imx6q-pinctrl 20e0000.iomuxc: no fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/pwm1grp
[ 0.227693] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/wdoggrp
[ 0.227708] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/gpio_leds/gpioledsgrp
[ 0.228042] imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
[ 0.272883] mxs-dma 110000.dma-apbh: initialized
[ 0.274557] MPCIE_3V3: Failed to request enable GPIO83: -16
[ 0.274680] reg-fixed-voltage regulators:regulator@3: Failed to register regulator: -16
[ 0.274709] reg-fixed-voltage: probe of regulators:regulator@3 failed with error -16
[ 0.277099] SCSI subsystem initialized
[ 0.277627] usbcore: registered new interface driver usbfs
[ 0.277711] usbcore: registered new interface driver hub
[ 0.277812] usbcore: registered new device driver usb
[ 0.278012] 2000000.aips-bus:usbphy_nop1 supply vcc not found, using dummy regulator
[ 0.278166] 2000000.aips-bus:usbphy_nop2 supply vcc not found, using dummy regulator
[ 0.279264] i2c i2c-0: Failed to register i2c client mma8451 at 0x1c (-16)
[ 0.279278] i2c i2c-0: of_i2c: Failure registering /soc/aips-bus@02100000/i2c@021a0000/mma8451@1c
[ 0.279440] i2c i2c-0: IMX I2C adapter registered
[ 0.279458] i2c i2c-0: can't use DMA
[ 0.280491] i2c i2c-1: IMX I2C adapter registered
[ 0.280507] i2c i2c-1: can't use DMA
[ 0.281272] i2c i2c-2: IMX I2C adapter registered
[ 0.281287] i2c i2c-2: can't use DMA
[ 0.281456] Linux video capture interface: v2.00
[ 0.299733] imx-ipuv3 2400000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
[ 0.319730] imx-ipuv3 2800000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
[ 0.321034] MIPI CSI2 driver module loaded
[ 0.321324] Advanced Linux Sound Architecture Driver Initialized.
[ 0.322681] Bluetooth: Core ver 2.20
[ 0.322730] NET: Registered protocol family 31
[ 0.322739] Bluetooth: HCI device and connection manager initialized
[ 0.322754] Bluetooth: HCI socket layer initialized
[ 0.322769] Bluetooth: L2CAP socket layer initialized
[ 0.322812] Bluetooth: SCO socket layer initialized
[ 0.324460] Switched to clocksource mxc_timer1
[ 0.406370] NET: Registered protocol family 2
[ 0.407139] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.407240] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.407401] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.407600] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.407647] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.407895] NET: Registered protocol family 1
[ 0.408303] RPC: Registered named UNIX socket transport module.
[ 0.408315] RPC: Registered udp transport module.
[ 0.408324] RPC: Registered tcp transport module.
[ 0.408332] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.408645] Trying to unpack rootfs image as initramfs...
[ 0.476431] Freeing initrd memory: 1008K (c5000000 - c50fc000)
[ 0.477340] CPU PMU: Failed to parse /soc/pmu/interrupt-affinity[0]
[ 0.477408] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
[ 0.479679] imx rpmsg driver is registered.
[ 0.480715] Bus freq driver module loaded
[ 0.481232] register_console pre console_unlock >>>>>>>>
[ 0.481881] register_console console_unlock() complete >>>>>>>>
[ 0.481938] console [pstore-1] enabled
[ 0.481950] pstore: Registered ramoops as persistent store backend
[ 0.481962] ramoops: attached 0x100000@0x8bf00000, ecc: 0/0
[ 0.481980] mxc_ramoops device success loaded
[ 0.482299] bt power gpio is:2
[ 0.482505] rfkill: BT RF going to : on
[ 0.482517] mxc_bt_rfkill_reset
[ 0.484580] mxc_bt_rfkill driver success loaded
[ 0.485886] futex hash table entries: 1024 (order: 4, 65536 bytes)
[ 0.485997] audit: initializing netlink subsys (disabled)
[ 0.486085] audit: type=2000 audit(0.480:1): initialized
[ 0.493679] VFS: Disk quotas dquot_6.6.0
[ 0.493881] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.496392] NFS: Registering the id_resolver key type
[ 0.496435] Key type id_resolver registered
[ 0.496448] Key type id_legacy registered
[ 0.496551] ntfs: driver 2.1.32 [Flags: R/W DEBUG].
[ 0.496852] jffs2: version 2.2. (NAND) 漏 2001-2006 Red Hat, Inc.
[ 0.497577] fuse init (API version 7.23)
[ 0.503272] bounce: pool size: 64 pages
[ 0.503296] io scheduler noop registered
[ 0.503316] io scheduler deadline registered
[ 0.503508] io scheduler cfq registered (default)
[ 0.504075] imx-weim 21b8000.weim: Driver registered.
[ 0.505549] pwm-backlight supply power not found, using dummy regulator
[ 0.507229] 21e0000.mipi supply disp-power-on not found, using dummy regulator
[ 0.507448] mxc_mipi_dsi 21e0000.mipi: i.MX MIPI DSI driver probed
[ 0.507580] MIPI DSI driver module loaded
[ 0.507838] MIPI DSI driver module loaded
[ 0.508131] ldb 2000000.aips-bus:ldb@020e0008: split mode
[ 0.508357] ldb 2000000.aips-bus:ldb@020e0008: split mode or dual mode, ignoring second output
[ 0.510376] mxc_sdc_fb fb@0: registered mxc display driver ldb
[ 0.510453] mxcfb_map_video_memory start >>>>>>>>>
[ 2.011318] mxc_sdc_fb fb@0: allocated fb @ paddr=0x26100000, size=5529600.
[ 2.024538] imx-ipuv3 2800000.ipu: IPU DMFC DP HIGH RESOLUTION: 1(0,1), 5B(2~5), 5F(6,7)
[ 2.101765] Console: switching to colour frame buffer device 240x45
[ 2.135702] mxcfb_map_video_memory start >>>>>>>>>
[ 2.140977] mxc_sdc_fb fb@0: allocated fb @ paddr=0x26700000, size=921600.
[ 2.141899] mxc_sdc_fb fb@2: Can't get fb option for mxcfb2!
[ 2.141978] mxc_sdc_fb fb@3: Can't get fb option for mxcfb3!
[ 2.144648] imx-sdma 20ec000.sdma: no iram assigned, using external mem
[ 2.145107] imx-sdma 20ec000.sdma: no event needs to be remapped
[ 2.145407] imx-sdma 20ec000.sdma: loaded firmware 3.3
[ 2.148220] imx-sdma 20ec000.sdma: initialized
[ 2.149130] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 24, base_baud = 5000000) is a IMX
[ 2.149189] register_console pre console_unlock >>>>>>>>
[ 3.203392] register_console console_unlock() complete >>>>>>>>
[ 3.209366] console [ttymxc0] enabled
[ 3.213751] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 296, base_baud = 5000000) is a IMX
[ 3.222983] 21ec000.serial: ttymxc2 at MMIO 0x21ec000 (irq = 297, base_baud = 5000000) is a IMX
[ 3.232225] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 298, base_baud = 5000000) is a IMX
[ 3.241473] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 299, base_baud = 5000000) is a IMX
[ 3.252503] imx sema4 driver is registered.
[ 3.256797] [drm] Initialized drm 1.1.0 20060810
[ 3.261992] [drm] Initialized vivante 1.0.0 20120216 on minor 0
[ 3.277947] brd: module loaded
[ 3.287632] loop: module loaded
[ 3.291370] zram: Created 1 device(s)

trace log：

[ 0.510453] mxcfb_map_video_memory start >>>>>>>>>
[ 2.011318] mxc_sdc_fb fb@0: allocated fb @ paddr=0x26100000, size=5529600.
[ 2.024538] imx-ipuv3 2800000.ipu: IPU DMFC DP HIGH RESOLUTION: 1(0,1), 5B(2~5), 5F(6,7)

code：

myandroid/kernel_imx/drivers/video/fbdev/mxc/mxc_ipuv3_fb.c

static int mxcfb_map_video_memory(struct fb_info *fbi)
{
struct mxcfb_info *mxc_fbi = (struct mxcfb_info *)fbi->par;

printk("%s start >>>>>>>>>\n", __func__);

if (fbi->fix.smem_len < fbi->var.yres_virtual * fbi->fix.line_length)
fbi->fix.smem_len = fbi->var.yres_virtual *
fbi->fix.line_length;

if (mxc_fbi->resolve && mxc_fbi->gpu_sec_buf_off) {
if (fbi->var.vmode & FB_VMODE_YWRAP)
fbi->fix.smem_len = mxc_fbi->gpu_sec_buf_off +
fbi->fix.smem_len / 2;
else
fbi->fix.smem_len = mxc_fbi->gpu_sec_buf_off *
(fbi->var.yres_virtual / fbi->var.yres) +
fbi->fix.smem_len / 2;
}

fbi->screen_base = dma_alloc_writecombine(fbi->device,
fbi->fix.smem_len,
(dma_addr_t *)&fbi->fix.smem_start,
GFP_DMA | GFP_KERNEL);
if (fbi->screen_base == 0) {
dev_err(fbi->device, "Unable to allocate framebuffer memory\n");
fbi->fix.smem_len = 0;
fbi->fix.smem_start = 0;
return -EBUSY;
}

dev_dbg(fbi->device, "allocated fb @ paddr=0x%08X, size=%d.\n",
(uint32_t) fbi->fix.smem_start, fbi->fix.smem_len);

[ 2.149130] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 24, base_baud = 5000000) is a IMX
[ 2.149189] register_console pre console_unlock >>>>>>>>
[ 3.203392] register_console console_unlock() complete >>>>>>>>
[ 3.209366] console [ttymxc0] enabled
[ 3.213751] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 296, base_baud = 5000000) is a IMX

code:

diff --git a/myandroid/kernel_imx/kernel/printk/printk.c b/myandroid/kernel_imx/kernel/printk/printk.c
index 58562f5..457bf31 100644
--- a/myandroid/kernel_imx/kernel/printk/printk.c
+++ b/myandroid/kernel_imx/kernel/printk/printk.c
+       printk("%s pre console_unlock >>>>>>>>\n", __func__);
        console_unlock();
+       printk("%s console_unlock() complete >>>>>>>>\n", __func__);
        console_sysfs_notify();

Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

昌清黄 — Tue, 28 Mar 2017 08:05:07 GMT

igorpadykov‌ please provide technical support ，thanks！

Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

igorpadykov — Tue, 28 Mar 2017 11:26:13 GMT

please try to narrow down issue running minimal linux image (without gui) from

i.MX 6 / i.MX 7 Series Software and Development Tool|NXP

also there are logs, like:

"..iomuxc: no fsl,pins property in node.."

try to remove or fix unused peripherals from build

Best regards
igor
-----------------------------------------------------------------------------------------------------------------------
Note: If this post answers your question, please click the Correct Answer button. Thank you!
-----------------------------------------------------------------------------------------------------------------------

Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

昌清黄 — Tue, 28 Mar 2017 13:17:42 GMT

I disable unused peripherals but also has this issue。

dma initialization is not completed when the system alloc dma memory.

or other reasons？

[ 0.060311] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.080297] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[ 0.100293] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[ 0.100371] Brought up 4 CPUs
[ 0.100395] SMP: Total of 4 processors activated (24.00 BogoMIPS).
[ 0.100405] CPU: All CPU(s) started in SVC mode.
[ 0.101047] devtmpfs: initialized
[ 0.112703] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[ 0.113187] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.135455] pinctrl core: initialized pinctrl subsystem
[ 0.136711] NET: Registered protocol family 16
[ 0.146472] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.169707] cpuidle: using governor ladder
[ 0.199706] cpuidle: using governor menu
[ 0.200210] CPU identified as i.MX6Q, silicon rev 1.5
[ 0.200324] Use WDOG1 as reset source
[ 0.224121] !!request miniPCIE Power On gpio
[ 0.224178] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[ 0.224188] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.224210] VDSO is not a valid ELF object!
[ 0.225239] imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
[ 0.272837] mxs-dma 110000.dma-apbh: initialized
[ 0.274485] MPCIE_3V3: Failed to request enable GPIO83: -16
[ 0.274616] reg-fixed-voltage regulators:regulator@3: Failed to register regulator: -16
[ 0.274645] reg-fixed-voltage: probe of regulators:regulator@3 failed with error -16
[ 0.276867] SCSI subsystem initialized
[ 0.277431] usbcore: registered new interface driver usbfs
[ 0.277508] usbcore: registered new interface driver hub
[ 0.277612] usbcore: registered new device driver usb
[ 0.277788] 2000000.aips-bus:usbphy_nop1 supply vcc not found, using dummy regulator
[ 0.277947] 2000000.aips-bus:usbphy_nop2 supply vcc not found, using dummy regulator
[ 0.279141] i2c i2c-0: IMX I2C adapter registered
[ 0.279161] i2c i2c-0: can't use DMA
[ 0.280204] i2c i2c-1: IMX I2C adapter registered
[ 0.280223] i2c i2c-1: can't use DMA
[ 0.280944] i2c i2c-2: IMX I2C adapter registered
[ 0.280960] i2c i2c-2: can't use DMA
[ 0.299751] imx-ipuv3 2400000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
[ 0.319745] imx-ipuv3 2800000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
[ 0.320989] MIPI CSI2 driver module loaded
[ 0.321260] Advanced Linux Sound Architecture Driver Initialized.
[ 0.322564] Bluetooth: Core ver 2.20
[ 0.322613] NET: Registered protocol family 31
[ 0.322624] Bluetooth: HCI device and connection manager initialized
[ 0.322641] Bluetooth: HCI socket layer initialized
[ 0.322655] Bluetooth: L2CAP socket layer initialized
[ 0.322697] Bluetooth: SCO socket layer initialized
[ 0.324285] Switched to clocksource mxc_timer1
[ 0.403600] NET: Registered protocol family 2
[ 0.404406] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.404499] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.404642] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.404832] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.404882] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.405117] NET: Registered protocol family 1
[ 0.405531] RPC: Registered named UNIX socket transport module.
[ 0.405542] RPC: Registered udp transport module.
[ 0.405550] RPC: Registered tcp transport module.
[ 0.405559] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.405858] Trying to unpack rootfs image as initramfs...
[ 0.473343] Freeing initrd memory: 1008K (c5000000 - c50fc000)
[ 0.474175] CPU PMU: Failed to parse /soc/pmu/interrupt-affinity[0]
[ 0.474247] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
[ 0.476517] imx rpmsg driver is registered.
[ 0.477502] Bus freq driver module loaded
[ 0.477999] register_console pre console_unlock >>>>>>>>
[ 0.478618] register_console console_unlock() complete >>>>>>>>
[ 0.478673] console [pstore-1] enabled
[ 0.478685] pstore: Registered ramoops as persistent store backend
[ 0.478697] ramoops: attached 0x100000@0x8bf00000, ecc: 0/0
[ 0.478714] mxc_ramoops device success loaded
[ 0.479011] bt power gpio is:2
[ 0.479196] rfkill: BT RF going to : on
[ 0.479209] mxc_bt_rfkill_reset
[ 0.484396] mxc_bt_rfkill driver success loaded
[ 0.485689] futex hash table entries: 1024 (order: 4, 65536 bytes)
[ 0.485800] audit: initializing netlink subsys (disabled)
[ 0.485899] audit: type=2000 audit(0.480:1): initialized
[ 0.493390] VFS: Disk quotas dquot_6.6.0
[ 0.493587] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.496206] NFS: Registering the id_resolver key type
[ 0.496258] Key type id_resolver registered
[ 0.496271] Key type id_legacy registered
[ 0.496377] ntfs: driver 2.1.32 [Flags: R/W DEBUG].
[ 0.496691] jffs2: version 2.2. (NAND) 漏 2001-2006 Red Hat, Inc.
[ 0.497404] fuse init (API version 7.23)
[ 0.503256] bounce: pool size: 64 pages
[ 0.503280] io scheduler noop registered
[ 0.503300] io scheduler deadline registered
[ 0.503488] io scheduler cfq registered (default)
[ 0.504029] imx-weim 21b8000.weim: Driver registered.
[ 0.505319] ldb 2000000.aips-bus:ldb@020e0008: split mode
[ 0.505543] ldb 2000000.aips-bus:ldb@020e0008: split mode or dual mode, ignoring second output
[ 0.506812] mxc_sdc_fb fb@0: registered mxc display driver ldb
[ 0.506892] mxcfb_map_video_memory start >>>>>>>>>
[ 2.008140] mxc_sdc_fb fb@0: allocated fb @ paddr=0x26100000, size=5529600.
[ 2.024375] imx-ipuv3 2800000.ipu: IPU DMFC DP HIGH RESOLUTION: 1(0,1), 5B(2~5), 5F(6,7)
[ 2.101583] Console: switching to colour frame buffer device 240x45
[ 2.135565] mxcfb_map_video_memory start >>>>>>>>>
[ 2.140800] mxc_sdc_fb fb@0: allocated fb @ paddr=0x26700000, size=921600.
[ 2.141704] mxc_sdc_fb fb@2: Can't get fb option for mxcfb2!
[ 2.141785] mxc_sdc_fb fb@3: Can't get fb option for mxcfb3!
[ 2.143635] imx-sdma 20ec000.sdma: no iram assigned, using external mem
[ 2.144092] imx-sdma 20ec000.sdma: no event needs to be remapped
[ 2.146946] imx-sdma 20ec000.sdma: initialized
[ 2.147702] imx-sdma 20ec000.sdma: loaded firmware 3.3
[ 2.148155] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 22, base_baud = 5000000) is a IMX
[ 2.148197] register_console pre console_unlock >>>>>>>>
[ 3.092386] register_console console_unlock() complete >>>>>>>>
[ 3.098361] console [ttymxc0] enabled
[ 3.102745] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 290, base_baud = 5000000) is a IMX
[ 3.111983] 21ec000.serial: ttymxc2 at MMIO 0x21ec000 (irq = 291, base_baud = 5000000) is a IMX
[ 3.121216] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 292, base_baud = 5000000) is a IMX
[ 3.130480] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 293, ba

Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

昌清黄 — Fri, 31 Mar 2017 07:00:23 GMT

thanks, This reason is caused by improper use of mdelay

Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

昌清黄 — Tue, 09 May 2017 03:36:50 GMT

igorpadykov‌ I have minimized kernel，but register_console takes too long！

this is a bug!

Please help check this question, 
as if there are a lot of imx6 customers are feedback on this issue

Starting kernel ...

[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.1.15 (huangcq@dell-PowerEdge-R720) (gcc version 4.9.x-google 20140827 (prerelease) (GCC) ) #101 SMP PREEMPT Tue Apr 25 17:52:20 CST 2017
[ 0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c53c7d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[ 0.000000] Machine model: Freescale i.MX6 Quad SABRE Smart Device Board
[ 0.000000] cma: Reserved 384 MiB at 0x26000000
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] PERCPU: Embedded 13 pages/cpu @eeee2000 s22144 r8192 d22912 u53248
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522528
[ 0.000000] Kernel command line: console=ttymxc0,115200 init=/init video=mxcfb0:dev=ldb,bpp=32 video=mxcfb1:off video=mxcfb2:off video=mxcfb3:off vmalloc=256M androidboot.console=ttymxc0 consoleblank=0 androidboot.hardware=freescale cma=384M androidboot.selinux=disabled androidboot.dm_verity=disabled androidboot.serialno=0a1139d4e317e252
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 1667552K/2096128K available (9465K kernel code, 622K rwdata, 2772K rodata, 2048K init, 611K bss, 35360K reserved, 393216K cma-reserved, 1326080K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0xef800000 - 0xff000000 ( 248 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xef000000 ( 752 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc0cf37fc (13230 kB)
[ 0.000000] .init : 0xc0d00000 - 0xc0f00000 (2048 kB)
[ 0.000000] .data : 0xc0f00000 - 0xc0f9bb50 ( 623 kB)
[ 0.000000] .bss : 0xc0f9bb50 - 0xc10347ac ( 612 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] Additional per-CPU info printed with stalls.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] L2C-310 erratum 769419 enabled
[ 0.000000] L2C-310 enabling early BRESP for Cortex-A9
[ 0.000000] L2C-310 full line of zeros enabled for Cortex-A9
[ 0.000000] L2C-310 ID prefetch enabled, offset 16 lines
[ 0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
[ 0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB
[ 0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76070001
[ 0.000000] mxc_clocksource_init 3000000
[ 0.000000] Switching to timer-based delay loop, resolution 333ns
[ 0.000007] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
[ 0.000026] clocksource mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
[ 0.000873] Console: colour dummy device 80x30
[ 0.000894] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
[ 0.000909] pid_max: default: 32768 minimum: 301
[ 0.000990] Security Framework initialized
[ 0.001003] SELinux: Initializing.
[ 0.001047] AppArmor: AppArmor disabled by boot time parameter
[ 0.001085] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001097] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001804] Initializing cgroup subsys freezer
[ 0.001824] Initializing cgroup subsys debug
[ 0.001851] CPU: Testing write buffer coherency: ok
[ 0.002168] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.002280] Setting up static identity map for 0x10100000 - 0x10100058
[ 0.060421] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.080405] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[ 0.100416] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[ 0.100489] Brought up 4 CPUs
[ 0.100515] SMP: Total of 4 processors activated (24.00 BogoMIPS).
[ 0.100525] CPU: All CPU(s) started in SVC mode.
[ 0.101161] devtmpfs: initialized
[ 0.109863] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
[ 0.110327] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.132839] pinctrl core: initialized pinctrl subsystem
[ 0.134034] NET: Registered protocol family 16
[ 0.143498] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.169819] cpuidle: using governor ladder
[ 0.199817] cpuidle: using governor menu
[ 0.200264] CPU identified as i.MX6Q, silicon rev 1.5
[ 0.200357] Use WDOG1 as reset source
[ 0.222680] imx6q_1588_init: failed to find fec node
[ 0.223001] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
[ 0.223014] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.223036] VDSO is not a valid ELF object!
[ 0.223333] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/wdoggrp
[ 0.223351] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/gpio_leds/gpioledsgrp
[ 0.223678] imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
[ 0.262856] mxs-dma 110000.dma-apbh: initialized
[ 0.264424] SCSI subsystem initialized
[ 0.264954] usbcore: registered new interface driver usbfs
[ 0.265025] usbcore: registered new interface driver hub
[ 0.265139] usbcore: registered new device driver usb
[ 0.265313] 2000000.aips-bus:usbphy_nop1 supply vcc not found, using dummy regulator
[ 0.265467] 2000000.aips-bus:usbphy_nop2 supply vcc not found, using dummy regulator
[ 0.266491] i2c i2c-0: IMX I2C adapter registered
[ 0.266509] i2c i2c-0: can't use DMA
[ 0.267160] i2c i2c-1: IMX I2C adapter registered
[ 0.267177] i2c i2c-1: can't use DMA
[ 0.267308] Linux video capture interface: v2.00
[ 0.279866] imx-ipuv3 2400000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
[ 0.299859] imx-ipuv3 2800000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
[ 0.300928] Advanced Linux Sound Architecture Driver Initialized.
[ 0.303001] Switched to clocksource mxc_timer1
[ 0.369996] NET: Registered protocol family 2
[ 0.370885] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.370978] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.371142] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.371332] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.371383] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.371641] NET: Registered protocol family 1
[ 0.372023] RPC: Registered named UNIX socket transport module.
[ 0.372035] RPC: Registered udp transport module.
[ 0.372044] RPC: Registered tcp transport module.
[ 0.372051] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.372359] Trying to unpack rootfs image as initramfs...
[ 0.489636] Freeing initrd memory: 1428K (c5000000 - c5165000)
[ 0.490401] CPU PMU: Failed to parse /soc/pmu/interrupt-affinity[0]
[ 0.490471] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
[ 0.493134] Bus freq driver module loaded
[ 0.493615] register_console pre console_unlock >>>>>>>>
[ 0.494170] register_console console_unlock() complete >>>>>>>>
[ 0.494215] console [pstore-1] enabled
[ 0.494227] pstore: Registered ramoops as persistent store backend
[ 0.494239] ramoops: attached 0x100000@0x8bf00000, ecc: 0/0
[ 0.494256] mxc_ramoops device success loaded
[ 0.494551] wifi reset gpio is:55
[ 0.533036] gps power gpio is:94
[ 0.533232] rfkill: BT RF going to : on
[ 0.533243] mxc_bt_rfkill_reset
[ 0.533263] mxc_bt_rfkill driver success loaded
[ 0.534449] futex hash table entries: 1024 (order: 4, 65536 bytes)
[ 0.534561] audit: initializing netlink subsys (disabled)
[ 0.534626] audit: type=2000 audit(0.530:1): initialized
[ 0.542111] VFS: Disk quotas dquot_6.6.0
[ 0.542323] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.544929] NFS: Registering the id_resolver key type
[ 0.544993] Key type id_resolver registered
[ 0.545005] Key type id_legacy registered
[ 0.545106] ntfs: driver 2.1.32 [Flags: R/W DEBUG].
[ 0.545403] jffs2: version 2.2. (NAND) 漏 2001-2006 Red Hat, Inc.
[ 0.546131] fuse init (API version 7.23)
[ 0.552319] bounce: pool size: 64 pages
[ 0.552344] io scheduler noop registered
[ 0.552362] io scheduler deadline registered
[ 0.552542] io scheduler cfq registered (default)
[ 0.553116] imx-weim 21b8000.weim: Driver registered.
[ 0.553771] ldb 2000000.aips-bus:ldb@020e0008: split mode
[ 0.553981] ldb 2000000.aips-bus:ldb@020e0008: split mode or dual mode, ignoring second output
[ 0.555239] mxc_sdc_fb fb@0: registered mxc display driver ldb
[ 0.603091] imx-ipuv3 2800000.ipu: IPU DMFC DP HIGH RESOLUTION: 1(0,1), 5B(2~5), 5F(6,7)
[ 0.680301] Console: switching to colour frame buffer device 240x45
[ 0.720406] mxc_sdc_fb fb@2: Can't get fb option for mxcfb2!
[ 0.720484] mxc_sdc_fb fb@3: Can't get fb option for mxcfb3!
[ 0.722299] imx-sdma 20ec000.sdma: no iram assigned, using external mem
[ 0.722763] imx-sdma 20ec000.sdma: no event needs to be remapped
[ 0.723262] imx-sdma 20ec000.sdma: loaded firmware 3.3
[ 0.726010] imx-sdma 20ec000.sdma: initialized
[ 0.726845] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 23, base_baud = 5000000) is a IMX
[ 0.726904] register_console pre console_unlock >>>>>>>>
[ 1.613831] register_console console_unlock() complete >>>>>>>>
[ 1.619792] console [ttymxc0] enabled
[ 1.624176] 21e8000.serial: ttymxc1 at MMIO 0x21e8000 (irq = 291, base_baud = 5000000) is a IMX
[ 1.633401] 21ec000.serial: ttymxc2 at MMIO 0x21ec000 (irq = 292, base_baud = 5000000) is a IMX
[ 1.642630] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 293, base_baud = 5000000) is a IMX
[ 1.651857] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 294, base_baud = 5000000) is a IMX
[ 1.662479] [drm] Initialized drm 1.1.0 20060810
[ 1.667652] [drm] Initialized vivante 1.0.0 20120216 on minor 0
[ 1.683613] brd: module loaded
[ 1.693243] loop: module loaded
[ 1.696985] zram: Created 1 device(s)
[ 1.702981] tun: Universal TUN/TAP device driver, 1.6
[ 1.708101] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[ 1.714509] PPP generic driver version 2.4.2

Re: android6.0 imx6q & imx6dl kernel boot very slow （two issue）

jiujinhong — Thu, 18 Jan 2018 03:45:52 GMT

Hi Huang,

I met the same issue.

20180118_11:43:12][    0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c53c7d
20180118_11:43:12][    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
20180118_11:43:12][    0.000000] Machine model: Freescale i.MX6 Quad SABRE Smart Device Board
20180118_11:43:12][    0.000000] cma: Reserved 448 MiB at 0x2a000000
20180118_11:43:12][    0.000000] Memory policy: Data cache writealloc
20180118_11:43:12][    0.000000] On node 0 totalpages: 524032
20180118_11:43:12][    0.000000] free_area_init_node: node 0, pgdat c11f3400, node_mem_map d9000000
20180118_11:43:12][    0.000000]   Normal zone: 1760 pages used for memmap
20180118_11:43:12][    0.000000]   Normal zone: 0 pages reserved
20180118_11:43:12][    0.000000]   Normal zone: 225280 pages, LIFO batch:31
20180118_11:43:12][    0.000000]   HighMem zone: 298752 pages, LIFO batch:31
20180118_11:43:12][    0.000000] PERCPU: Embedded 13 pages/cpu @f6ecc000 s22784 r8192 d22272 u53248
20180118_11:43:12][    0.000000] pcpu-alloc: s22784 r8192 d22272 u53248 alloc=13*4096
20180118_11:43:12][    0.000000] pcpu-alloc: [0] 0 [0] 1
20180118_11:43:12][    0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 522272
20180118_11:43:12][    0.000000] Kernel command line: console=ttymxc3,115200 init=/init video=mxcfb0:dev=ldb,bpp=32 video=mxcfb1:off vmalloc=128M androidboot.console=ttymxc3 consoleblank=0 androidboot.hardware=freescale cma=448M androidboot.selinux=permissive androidboot.dm_verity=disabled loglevel=8 buildvariant=eng androidboot.serialno=1f0809d4ea9a1c14 androidboot.bootreason=normal
20180118_11:43:12][    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
20180118_11:43:12][    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
20180118_11:43:12][    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
20180118_11:43:12][    0.000000] Memory: 1599236K/2096128K available (11264K kernel code, 1014K rwdata, 3556K rodata, 1024K init, 678K bss, 38140K reserved, 458752K cma-reserved, 1195008K highmem)
20180118_11:43:12][    0.000000] Virtual kernel memory layout:
20180118_11:43:12][    0.000000]     vector : 0xffff0000 - 0xffff1000   (   4 kB)
20180118_11:43:12][    0.000000]     fixmap : 0xffc00000 - 0xfff00000   (3072 kB)
20180118_11:43:12][    0.000000]     vmalloc : 0xf7800000 - 0xff000000   ( 120 MB)
20180118_11:43:12][    0.000000]     lowmem : 0xc0000000 - 0xf7000000   ( 880 MB)
20180118_11:43:12][    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
20180118_11:43:12][    0.000000]     modules : 0xbf000000 - 0xbfe00000   ( 14 MB)
20180118_11:43:12][    0.000000]       .text : 0xc0008000 - 0xc0c00000   (12256 kB)
20180118_11:43:12][    0.000000]       .init : 0xc1000000 - 0xc1100000   (1024 kB)
20180118_11:43:12][    0.000000]       .data : 0xc1100000 - 0xc11fda70   (1015 kB)
20180118_11:43:12][    0.000000]        .bss : 0xc11fda70 - 0xc12a7488   ( 679 kB)
20180118_11:43:12][    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
20180118_11:43:12][    0.000000] Preemptible hierarchical RCU implementation.
20180118_11:43:12][    0.000000] Additional per-CPU info printed with stalls.
20180118_11:43:12][    0.000000] RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2.
20180118_11:43:12][    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
20180118_11:43:12][    0.000000] NR_IRQS:16 nr_irqs:16 16
20180118_11:43:12][    0.000000] L2C-310 erratum 769419 enabled
20180118_11:43:12][    0.000000] L2C-310 enabling early BRESP for Cortex-A9
20180118_11:43:12][    0.000000] L2C-310 full line of zeros enabled for Cortex-A9
20180118_11:43:12][    0.000000] L2C-310 ID prefetch enabled, offset 16 lines
20180118_11:43:12][    0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
20180118_11:43:12][    0.000000] L2C-310 cache controller enabled, 16 ways, 1024 kB
20180118_11:43:12][    0.000000] L2C-310: CACHE_ID 0x410000c7, AUX_CTRL 0x76070001
20180118_11:43:12][    0.000000] mxc_clocksource_init 3000000
20180118_11:43:12][    0.000000] Switching to timer-based delay loop, resolution 333ns
20180118_11:43:12][    0.000006] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
20180118_11:43:12][    0.000025] clocksource mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
20180118_11:43:12][    0.000056] MXC_Early serial console at MMIO 0x21f0000 (options '115200')
20180118_11:43:12][    0.000068] register_console pre console_unlock >>>>>>>>
20180118_11:43:12][    0.353819] register_console console_unlock() complete >>>>>>>>
20180118_11:43:12][    0.359757] bootconsole [ttymxc3] enabled
20180118_11:43:12][    0.364752] Console: colour dummy device 80x30
20180118_11:43:12][    0.369221] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
20180118_11:43:12][    0.379455] pid_max: default: 32768 minimum: 301
20180118_11:43:12][    0.384168] Security Framework initialized
20180118_11:43:12][    0.388283] SELinux: Initializing.
20180118_11:43:12][    0.391827] SELinux: Starting in permissive mode
20180118_11:43:12][    0.396548] AppArmor: AppArmor disabled by boot time parameter
20180118_11:43:12][    0.402441] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
20180118_11:43:12][    0.409076] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
20180118_11:43:12][    0.416950] Initializing cgroup subsys freezer
20180118_11:43:12][    0.421437] Initializing cgroup subsys debug
20180118_11:43:12][    0.425747] CPU: Testing write buffer coherency: ok
20180118_11:43:12][    0.430960] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
20180118_11:43:12][    0.436737] Setting up static identity map for 0x10100000 - 0x10100058
20180118_11:43:12][    0.520324] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
20180118_11:43:12][    0.520409] Brought up 2 CPUs
20180118_11:43:12][    0.529066] SMP: Total of 2 processors activated (12.00 BogoMIPS).
20180118_11:43:12][    0.535283] CPU: All CPU(s) started in SVC mode.
20180118_11:43:12][    0.540510] devtmpfs: initialized
20180118_11:43:12][    0.556713] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
20180118_11:43:12][    0.564910] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
20180118_11:43:12][    0.600140] pinctrl core: initialized pinctrl subsystem
20180118_11:43:12][    0.605982] regulator-dummy: no parameters
20180118_11:43:12][    0.610943] NET: Registered protocol family 16
20180118_11:43:12][    0.625848] DMA: preallocated 256 KiB pool for atomic coherent allocations
20180118_11:43:12][    0.659707] cpuidle: using governor ladder
20180118_11:43:12][    0.689702] cpuidle: using governor menu
20180118_11:43:12][    0.694273] CPU identified as i.MX6Q, silicon rev 1.5
20180118_11:43:12][    0.711459] vdd1p1: 800 <--> 1375 mV at 1100 mV
20180118_11:43:12][    0.716643] vdd3p0: 2625 <--> 3400 mV at 3000 mV
20180118_11:43:12][    0.721940] vdd2p5: 2000 <--> 2750 mV at 2400 mV
20180118_11:43:12][    0.727172] vddarm: 725 <--> 1450 mV at 1150 mV
20180118_11:43:12][    0.732328] vddpu: 725 <--> 1450 mV at 1250 mV
20180118_11:43:12][    0.737402] vddsoc: 725 <--> 1450 mV at 1175 mV
20180118_11:43:12][    0.742693] mxs_phy 20c9000.usbphy: Looking up phy-3p0-supply from device tree
20180118_11:43:12][    0.750467] mxs_phy 20ca000.usbphy: Looking up phy-3p0-supply from device tree
20180118_11:43:12][    0.773590] !!request miniPCIE Power On gpio
20180118_11:43:12][    0.777919] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
20180118_11:43:12][    0.785969] hw-breakpoint: maximum watchpoint size is 4 bytes.
20180118_11:43:12][    0.792240] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/ecspi1grp
20180118_11:43:12][    0.804914] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/gpio_keysgrp
20180118_11:43:12][    0.817846] imx6q-pinctrl 20e0000.iomuxc: Invalid fsl,pins property in node /soc/aips-bus@02000000/iomuxc@020e0000/imx6qdl-sabresd/ipu1grp
20180118_11:43:12][    0.830767] imx6q-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
20180118_11:43:12][    0.838568] bootconsole [ttymxc3] disabled
20180118_11:43:12][    0.843862] imx-gpc 20dc000.gpc: Looking up pu-supply from device tree
20180118_11:43:12][    0.893362] mxs-dma 110000.dma-apbh: initialized
20180118_11:43:12][    0.894316] usb_otg_vbus: 5000 mV
20180118_11:43:12][    0.894381] reg-fixed-voltage regulators:regulator@0: usb_otg_vbus supplying 5000000uV
20180118_11:43:12][    0.894642] usb_h1_vbus: 5000 mV
20180118_11:43:12][    0.894702] reg-fixed-voltage regulators:regulator@1: usb_h1_vbus supplying 5000000uV
20180118_11:43:12][    0.894952] wm8962-supply: no parameters
20180118_11:43:12][    0.895019] reg-fixed-voltage regulators:regulator@2: wm8962-supply supplying 0uV
20180118_11:43:12][    0.895345] MPCIE_3V3: Failed to request enable GPIO83: -16
20180118_11:43:12][    0.895487] reg-fixed-voltage regulators:regulator@3: Failed to register regulator: -16
20180118_11:43:12][    0.895520] reg-fixed-voltage: probe of regulators:regulator@3 failed with error -16
20180118_11:43:12][    0.895781] sensor-supply: 3300 mV
20180118_11:43:12][    0.895839] reg-fixed-voltage regulators:regulator@4: sensor-supply supplying 3300000uV
20180118_11:43:12][    0.896095] hdmi-5v-supply: 5000 mV
20180118_11:43:12][    0.896174] reg-fixed-voltage regulators:regulator@5: hdmi-5v-supply supplying 5000000uV
20180118_11:43:12][    0.896435] mipi_dsi_pwr_on: no parameters
20180118_11:43:12][    0.896496] reg-fixed-voltage regulators:mipi_dsi_pwr_on: mipi_dsi_pwr_on supplying 0uV
20180118_11:43:12][    0.896757] wlreg_on: 5000 mV
20180118_11:43:12][    0.896815] reg-fixed-voltage regulators:fixedregulator@100: wlreg_on supplying 5000000uV
20180118_11:43:12][    0.898396] SCSI subsystem initialized
20180118_11:43:12][    0.898617] libata version 3.00 loaded.
20180118_11:43:12][    0.898994] usbcore: registered new interface driver usbfs
20180118_11:43:12][    0.899079] usbcore: registered new interface driver hub
20180118_11:43:12][    0.899178] usbcore: registered new device driver usb
20180118_11:43:12][    0.899382] usb_phy_generic 2000000.aips-bus:usbphy_nop1: Looking up vcc-supply from device tree
20180118_11:43:12][    0.899402] usb_phy_generic 2000000.aips-bus:usbphy_nop1: Looking up vcc-supply property in node /soc/aips-bus@02000000/usbphy_nop1 failed
20180118_11:43:12][    0.899419] 2000000.aips-bus:usbphy_nop1 supply vcc not found, using dummy regulator
20180118_11:43:12][    0.899571] usb_phy_generic 2000000.aips-bus:usbphy_nop2: Looking up vcc-supply from device tree
20180118_11:43:12][    0.899589] usb_phy_generic 2000000.aips-bus:usbphy_nop2: Looking up vcc-supply property in node /soc/aips-bus@02000000/usbphy_nop2 failed
20180118_11:43:12][    0.899601] 2000000.aips-bus:usbphy_nop2 supply vcc not found, using dummy regulator
20180118_11:43:12][    0.901383] i2c i2c-0: IMX I2C adapter registered
20180118_11:43:12][    0.901403] i2c i2c-0: can't use DMA
20180118_11:43:12][    0.902119] i2c i2c-1: IMX I2C adapter registered
20180118_11:43:12][    0.902138] i2c i2c-1: can't use DMA
20180118_11:43:12][    0.902832] i2c i2c-2: IMX I2C adapter registered
20180118_11:43:12][    0.902851] i2c i2c-2: can't use DMA
20180118_11:43:12][    0.903027] Linux video capture interface: v2.00
20180118_11:43:12][    0.903129] pps_core: LinuxPPS API ver. 1 registered
20180118_11:43:12][    0.903141] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
20180118_11:43:12][    0.903174] PTP clock support registered
20180118_11:43:12][    0.919752] imx-ipuv3 2400000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
20180118_11:43:12][    0.940401] imx-ipuv3 2800000.ipu: IPU DMFC NORMAL mode: 1(0~1), 5B(4,5), 5F(6,7)
20180118_11:43:12][    0.941879] mxc_mipi_csi2 21dc000.mipi_csi: i.MX MIPI CSI2 driver probed
20180118_11:43:12][    0.941896] mxc_mipi_csi2 21dc000.mipi_csi: i.MX MIPI CSI2 dphy version is 0x3130302a
20180118_11:43:12][    0.942009] MIPI CSI2 driver module loaded
20180118_11:43:12][    0.942241] Advanced Linux Sound Architecture Driver Initialized.
20180118_11:43:12][    0.943757] Bluetooth: Core ver 2.20
20180118_11:43:12][    0.943813] NET: Registered protocol family 31
20180118_11:43:12][    0.943823] Bluetooth: HCI device and connection manager initialized
20180118_11:43:12][    0.943843] Bluetooth: HCI socket layer initialized
20180118_11:43:12][    0.943859] Bluetooth: L2CAP socket layer initialized
20180118_11:43:12][    0.943908] Bluetooth: SCO socket layer initialized
20180118_11:43:12][    0.945460] Switched to clocksource mxc_timer1
20180118_11:43:12][    1.035654] NET: Registered protocol family 2
20180118_11:43:12][    1.036379] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
20180118_11:43:12][    1.036493] TCP bind hash table entries: 8192 (order: 5, 163840 bytes)
20180118_11:43:12][    1.036822] TCP: Hash tables configured (established 8192 bind 8192)
20180118_11:43:12][    1.037009] UDP hash table entries: 512 (order: 2, 24576 bytes)
20180118_11:43:12][    1.037078] UDP-Lite hash table entries: 512 (order: 2, 24576 bytes)
20180118_11:43:12][    1.037375] NET: Registered protocol family 1
20180118_11:43:12][    1.037800] RPC: Registered named UNIX socket transport module.
20180118_11:43:12][    1.037813] RPC: Registered udp transport module.
20180118_11:43:12][    1.037822] RPC: Registered tcp transport module.
20180118_11:43:12][    1.037831] RPC: Registered tcp NFSv4.1 backchannel transport module.
20180118_11:43:12][    1.038157] Trying to unpack rootfs image as initramfs...
20180118_11:43:12][    1.148075] Freeing initrd memory: 1600K (c5000000 - c5190000)
20180118_11:43:12][    1.149060] CPU PMU: Failed to parse /soc/pmu/interrupt-affinity[0]
20180118_11:43:13][    1.149133] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
20180118_11:43:13][    1.151964] Bus freq driver module loaded
20180118_11:43:13][    1.152575] register_console pre console_unlock >>>>>>>>
20180118_11:43:13][    1.153480] register_console console_unlock() complete >>>>>>>>
20180118_11:43:13][    1.153540] console [pstore-1] enabled
20180118_11:43:13][    1.153554] pstore: Registered ramoops as persistent store backend
20180118_11:43:13][    1.153567] ramoops: attached 0x100000@0x8bf00000, ecc: 0/0
20180118_11:43:13][    1.153586] mxc_ramoops device success loaded
20180118_11:43:13][    1.153953] bt power gpio is:2
20180118_11:43:13][    1.154186] rfkill: BT RF going to : on
20180118_11:43:13][    1.154201] mxc_bt_rfkill_reset
20180118_11:43:13][    1.155543] mxc_bt_rfkill driver success loaded
20180118_11:43:13][    1.156820] futex hash table entries: 512 (order: 3, 32768 bytes)
20180118_11:43:13][    1.156902] audit: initializing netlink subsys (disabled)
20180118_11:43:13][    1.156968] audit: type=2000 audit(0.790:1): initialized
20180118_11:43:13][    1.165325] VFS: Disk quotas dquot_6.6.0
20180118_11:43:13][    1.165613] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
20180118_11:43:13][    1.168220] NFS: Registering the id_resolver key type
20180118_11:43:13][    1.168270] Key type id_resolver registered
20180118_11:43:13][    1.168284] Key type id_legacy registered
20180118_11:43:13][    1.168390] ntfs: driver 2.1.32 [Flags: R/W DEBUG].
20180118_11:43:13][    1.168708] jffs2: version 2.2. (NAND) © 2001-2006 Red Hat, Inc.
20180118_11:43:13][    1.169384] fuse init (API version 7.23)
20180118_11:43:13][    1.170434] SELinux: Registering netfilter hooks
20180118_11:43:13][    1.177372] bounce: pool size: 64 pages
20180118_11:43:13][    1.177397] io scheduler noop registered
20180118_11:43:13][    1.177416] io scheduler deadline registered
20180118_11:43:13][    1.177611] io scheduler cfq registered (default)
20180118_11:43:13][    1.178190] imx-weim 21b8000.weim: Driver registered.
20180118_11:43:13][    1.179749] pwm-backlight pwm-backlight: Looking up power-supply from device tree
20180118_11:43:13][    1.179773] pwm-backlight pwm-backlight: Looking up power-supply property in node /pwm-backlight failed
20180118_11:43:13][    1.179795] pwm-backlight supply power not found, using dummy regulator
20180118_11:43:13][    1.181537] mxc_mipi_dsi 21e0000.mipi: Looking up disp-power-on-supply from device tree
20180118_11:43:13][    1.181760] mxc_mipi_dsi 21e0000.mipi: i.MX MIPI DSI driver probed
20180118_11:43:13][    1.181891] MIPI DSI driver module loaded
20180118_11:43:13][    1.182171] MIPI DSI driver module loaded
20180118_11:43:13][    1.183833] mxc_hdmi 20e0000.hdmi_video: Looking up HDMI-supply from device tree
20180118_11:43:13][    1.184846] mxc_sdc_fb fb@0: registered mxc display driver ldb
20180118_11:43:13][    2.685564] imx-ipuv3 2800000.ipu: IPU DMFC DP HIGH RESOLUTION: 1(0,1), 5B(2~5), 5F(6,7)
20180118_11:43:13][    2.751198] Console: switching to colour frame buffer device 128x48
20180118_11:43:13][    2.789949] mxc_sdc_fb fb@1: Can't get fb option for mxcfb1!
20180118_11:43:13][    2.790046] mxc_sdc_fb fb@2: registered mxc display driver lcd
20180118_11:43:13][    2.798656] mxc_sdc_fb fb@3: registered mxc display driver ldb
20180118_11:43:13][    2.811238] imx-sdma 20ec000.sdma: no iram assigned, using external mem
20180118_11:43:13][    2.811732] imx-sdma 20ec000.sdma: no event needs to be remapped
20180118_11:43:13][    2.812045] imx-sdma 20ec000.sdma: loaded firmware 3.3
20180118_11:43:13][    2.815619] imx-sdma 20ec000.sdma: initialized
20180118_11:43:13][    2.817421] pfuze100-regulator 0-0008: Full layer: 2, Metal layer: 1
20180118_11:43:13][    2.818057] pfuze100-regulator 0-0008: FAB: 0, FIN: 0
20180118_11:43:13][    2.818074] pfuze100-regulator 0-0008: pfuze100 found.
20180118_11:43:13][    2.819758] SW1AB: 300 <--> 1875 mV at 1375 mV
20180118_11:43:13][    2.821276] SW1C: 300 <--> 1875 mV at 1375 mV
20180118_11:43:13][    2.823219] SW2: 800 <--> 3300 mV at 3300 mV
20180118_11:43:13][    2.824070] SW3A: 400 <--> 1975 mV at 1500 mV
20180118_11:43:13][    2.824933] SW3B: 400 <--> 1975 mV at 1500 mV
20180118_11:43:13][    2.825794] SW4: 800 <--> 3300 mV at 3150 mV
20180118_11:43:13][    2.826698] SWBST: 5000 <--> 5150 mV at 5000 mV
20180118_11:43:13][    2.828034] VSNVS: 1000 <--> 3000 mV at 3000 mV
20180118_11:43:13][    2.828264] VREFDDR: override min_uV, 1 -> 750000
20180118_11:43:13][    2.828279] VREFDDR: override max_uV, 2147483647 -> 750000
20180118_11:43:13][    2.828916] VREFDDR: 750 mV
20180118_11:43:13][    2.829774] VGEN1: 800 <--> 1550 mV at 1500 mV
20180118_11:43:13][    2.830655] VGEN2: 800 <--> 1550 mV at 1500 mV
20180118_11:43:13][    2.831533] VGEN3: 1800 <--> 3300 mV at 2800 mV
20180118_11:43:13][    2.832408] VGEN4: 1800 <--> 3300 mV at 1800 mV
20180118_11:43:13][    2.833279] VGEN5: 1800 <--> 3300 mV at 3000 mV
20180118_11:43:13][    2.834151] VGEN6: 1800 <--> 3300 mV at 3300 mV
20180118_11:43:13][    2.834930] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 25, base_baud = 5000000) is a IMX
20180118_11:43:13][    2.835783] 21f0000.serial: ttymxc3 at MMIO 0x21f0000 (irq = 301, base_baud = 5000000) is a IMX
20180118_11:43:13][    2.835843] register_console pre console_unlock >>>>>>>>
20180118_11:43:13][    4.225332] register_console console_unlock() complete >>>>>>>>
20180118_11:43:13][    4.231314] console [ttymxc3] enabled
20180118_11:43:13][    4.235678] 21f4000.serial: ttymxc4 at MMIO 0x21f4000 (irq = 302, base_baud = 5000000) is a IMX
20180118_11:43:13][    4.246606] [drm] Initialized drm 1.1.0 20060810
20180118_11:43:13][    4.251863] [drm] Initialized vivante 1.0.0 20120216 o