Part Number: AM3351
Tool/software: Linux
Hi,
my custom board taking 50 seconds to get login screen. how to reduce this boot time
0 - 4.584 sec --> loading entire u-boot
4.584 - 10.341 --> copying kernel image
10.341 - 14.840 --> loading kernel
14.840 - 50.366 --> loading file system
please check attachment for more details.
column1 is elapsed time since first message
column2 is elapsed time since previous message
column3 is the message
0.000 0.000: �0.006 0.006: U-Boot SPL 2016.05-00230-g120a8a3-dirty (Dec 29 2017 - 12:45:00)
0.014 0.008: Trying to boot from MMC1
0.110 0.096: reading args
0.117 0.007: spl_load_image_fat_os: error reading image args, err - -1
0.119 0.002: reading u-boot.img
0.123 0.005: reading u-boot.img
0.131 0.008: reading u-boot.img
0.558 0.427: reading u-boot.img
0.706 0.147:
0.706 0.000:
0.711 0.006: U-Boot 2016.05-00230-g120a8a3-dirty (Dec 29 2017 - 12:45:00 +0530)
0.712 0.000:
0.714 0.002: Watchdog enabled
0.717 0.004: I2C: ready
0.719 0.002: DRAM: 256 MiB
1.055 0.336: NAND: 0 MiB
1.064 0.009: MMC: OMAP SD/MMC: 0, OMAP SD/MMC: 1
1.161 0.097: reading uboot.env
1.163 0.002:
1.167 0.004: ** Unable to read "uboot.env" from mmc0:1 **
1.169 0.002: Using default environment
1.169 0.000:
1.192 0.022: Net: No ethernet found.
1.202 0.011: Press SPACE to abort autoboot in 2 seconds
3.300 2.097: switch to partitions #0, OK
3.302 0.002: mmc0 is current device
3.399 0.097: SD/MMC found on device 0
3.403 0.004: reading boot.scr
3.407 0.005: ** Unable to read file boot.scr **
3.411 0.004: reading uEnv.txt
3.416 0.005: ** Unable to read file uEnv.txt **
3.515 0.099: switch to partitions #0, OK
3.517 0.002: mmc0 is current device
3.622 0.106: Scanning mmc 0:1...
3.764 0.141: switch to partitions #0, OK
3.766 0.002: mmc0 is current device
3.861 0.096: SD/MMC found on device 0
3.959 0.097: switch to partitions #0, OK
3.961 0.002: mmc0 is current device
4.058 0.097: SD/MMC found on device 0
4.061 0.004: reading boot.scr
4.066 0.005: ** Unable to read file boot.scr **
4.070 0.004: reading uEnv.txt
4.075 0.005: ** Unable to read file uEnv.txt **
4.512 0.437: 2920776 bytes read in 424 ms (6.6 MiB/s)
4.557 0.046: 39107 bytes read in 32 ms (1.2 MiB/s)
4.563 0.005: Kernel image @ 0x82000000 [ 0x000000 - 0x2c9148 ]
4.566 0.004: ## Flattened Device Tree blob at 88000000
4.570 0.004: Booting using the fdt blob at 0x88000000
4.577 0.007: Loading Device Tree to 8edaa000, end 8edb68c2 ... OK
4.581 0.005: Unsupported Ethernet port configuration
4.583 0.001:
4.584 0.002: Starting kernel ...
4.585 0.000:
10.341 5.756: [ 0.000000] Booting Linux on physical CPU 0x0
10.345 0.004: [ 0.000000] Initializing cgroup subsys cpu
10.350 0.004: [ 0.000000] Initializing cgroup subsys cpuacct
10.365 0.015: [ 0.000000] Linux version 4.4.12-g3639bea54a (root@sridhar-ThinkCentre-M73) (gcc version 5.3.1 20160113 (Linaro GCC 5.3-2016.02) ) #85 PREEMPT Thu Feb 8 09:52:59 IST 2018
10.372 0.007: [ 0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
10.380 0.008: [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
10.385 0.005: [ 0.000000] Machine model: TI AM335x BeagleBone Black
10.389 0.004: [ 0.000000] cma: Reserved 24 MiB at 0x8d000000
10.394 0.005: [ 0.000000] Memory policy: Data cache writeback
10.398 0.005: [ 0.000000] CPU: All CPU(s) started in SVC mode.
10.402 0.003: [ 0.000000] AM335X ES2.1 (neon )
10.410 0.008: [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64960
10.419 0.010: [ 0.000000] Kernel command line: console=ttyO0,115200n8 root=PARTUUID=0002a9d3-02 rw rootfstype=ext4 rootwait
10.425 0.006: [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
10.432 0.007: [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
10.439 0.007: [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
10.454 0.015: [ 0.000000] Memory: 226528K/262144K available (5635K kernel code, 212K rwdata, 1896K rodata, 252K init, 240K bss, 11040K reserved, 24576K cma-reserved, 0K highmem)
10.458 0.004: [ 0.000000] Virtual kernel memory layout:
10.463 0.006: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
10.469 0.006: [ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
10.475 0.006: [ 0.000000] vmalloc : 0xd0800000 - 0xff800000 ( 752 MB)
10.480 0.006: [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB)
10.486 0.006: [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
10.492 0.006: [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
10.497 0.006: [ 0.000000] .text : 0xc0008000 - 0xc0762f74 (7532 kB)
10.503 0.006: [ 0.000000] .init : 0xc0763000 - 0xc07a2000 ( 252 kB)
10.509 0.006: [ 0.000000] .data : 0xc07a2000 - 0xc07d7290 ( 213 kB)
10.515 0.006: [ 0.000000] .bss : 0xc07d9000 - 0xc0815224 ( 241 kB)
10.521 0.007: [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
10.526 0.005: [ 0.000000] Preemptible hierarchical RCU implementation.
10.532 0.005: [ 0.000000] Build-time adjustment of leaf fanout to 32.
10.535 0.004: [ 0.000000] NR_IRQS:16 nr_irqs:16 16
10.542 0.007: [ 0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
10.548 0.005: [ 0.000000] OMAP clockevent source: timer2 at 19200000 Hz
10.556 0.008: [ 0.000033] sched_clock: 32 bits at 19MHz, resolution 52ns, wraps every 111848106981ns
10.565 0.009: [ 0.000089] clocksource: timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 99544814920 ns
10.570 0.005: [ 0.000113] OMAP clocksource: timer1 at 19200000 Hz
10.576 0.006: [ 0.001174] clocksource_probe: no matching clocksources found
10.580 0.004: [ 0.001551] Console: colour dummy device 80x30
10.586 0.007: [ 0.001609] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
10.593 0.006: [ 0.001625] This ensures that you still see kernel messages. Please
10.597 0.004: [ 0.001639] update your kernel commandline.
10.603 0.006: [ 0.001673] Calibrating delay loop... 302.28 BogoMIPS (lpj=1511424)
10.608 0.005: [ 0.057706] pid_max: default: 32768 minimum: 301
10.614 0.007: [ 0.057985] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
10.621 0.007: [ 0.058016] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
10.625 0.004: [ 0.059554] Initializing cgroup subsys io
10.630 0.004: [ 0.059622] Initializing cgroup subsys memory
10.634 0.004: [ 0.059698] Initializing cgroup subsys devices
10.639 0.004: [ 0.059734] Initializing cgroup subsys freezer
10.643 0.005: [ 0.059767] Initializing cgroup subsys perf_event
10.647 0.004: [ 0.059799] Initializing cgroup subsys pids
10.652 0.005: [ 0.059862] CPU: Testing write buffer coherency: ok
10.659 0.007: [ 0.060632] Setting up static identity map for 0x80008200 - 0x80008258
10.662 0.003: [ 0.065786] devtmpfs: initialized
10.670 0.008: [ 0.094136] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
10.675 0.006: [ 0.127562] omap_hwmod: debugss: _wait_target_disable failed
10.681 0.006: [ 0.132530] omap_hwmod: d_can0: _wait_target_ready failed: -16
10.687 0.006: [ 0.132557] omap_hwmod: d_can0: cannot be enabled for reset (3)
10.693 0.006: [ 0.136442] omap_hwmod: d_can1: _wait_target_ready failed: -16
10.699 0.006: [ 0.136460] omap_hwmod: d_can1: cannot be enabled for reset (3)
10.709 0.010: [ 0.205569] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
10.714 0.005: [ 0.210338] pinctrl core: initialized pinctrl subsystem
10.718 0.004: [ 0.213165] NET: Registered protocol family 16
10.725 0.007: [ 0.218461] DMA: preallocated 256 KiB pool for atomic coherent allocations
10.729 0.004: [ 0.247720] cpuidle: using governor ladder
10.733 0.004: [ 0.277698] cpuidle: using governor menu
10.737 0.004: [ 0.289111] OMAP GPIO hardware version 0.1
10.750 0.013: [ 0.292167] omap_gpio 481ac000.gpio: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_gpio2_pins, deferring probe
10.763 0.013: [ 0.292955] omap_gpio 481ae000.gpio: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_gpio3_pins, deferring probe
10.777 0.013: [ 0.306295] omap-gpmc 50000000.gpmc: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/nandflash_pins_s0, deferring probe
10.782 0.006: [ 0.312862] hw-breakpoint: debug architecture 0x4 unsupported.
10.788 0.005: [ 0.368333] edma 49000000.edma: TI EDMA DMA engine driver
10.793 0.005: [ 0.376142] usbcore: registered new interface driver usbfs
10.799 0.005: [ 0.376344] usbcore: registered new interface driver hub
10.804 0.005: [ 0.376605] usbcore: registered new device driver usb
10.817 0.013: [ 0.377529] omap_i2c 44e0b000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c0_pins, deferring probe
10.829 0.013: [ 0.377778] omap_i2c 4819c000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c2_pins, deferring probe
10.834 0.005: [ 0.378172] pps_core: LinuxPPS API ver. 1 registered
10.843 0.009: [ 0.378195] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
10.847 0.004: [ 0.378271] PTP clock support registered
10.853 0.006: [ 0.380589] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
10.859 0.005: [ 0.383018] clocksource: Switched to clocksource timer1
10.863 0.004: [ 0.410447] NET: Registered protocol family 2
10.870 0.007: [ 0.412174] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
10.876 0.006: [ 0.412264] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
10.883 0.006: [ 0.412336] TCP: Hash tables configured (established 2048 bind 2048)
10.888 0.006: [ 0.412499] UDP hash table entries: 256 (order: 0, 4096 bytes)
10.895 0.006: [ 0.412549] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
10.899 0.004: [ 0.412884] NET: Registered protocol family 1
10.907 0.008: [ 0.415018] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
10.913 0.006: [ 0.419453] futex hash table entries: 256 (order: -1, 3072 bytes)
10.924 0.011: [ 0.444434] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
10.925 0.000: [ 0.444500] io scheduler noop registered
10.929 0.004: [ 0.444532] io scheduler deadline registered
10.933 0.005: [ 0.444970] io scheduler cfq registered (default)
10.940 0.007: [ 0.448623] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
10.947 0.006: [ 0.454376] backlight supply power not found, using dummy regulator
10.953 0.006: [ 0.611912] Serial: 8250/16550 driver, 10 ports, IRQ sharing disabled
10.962 0.009: [ 0.621421] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 94, base_baud = 3000000) is a 8250
10.965 0.004: [ 1.246761] console [ttyS0] enabled
10.977 0.011: [ 1.252845] 48022000.serial: ttyS2 at MMIO 0x48022000 (irq = 95, base_baud = 3000000) is a 8250
10.984 0.007: [ 1.264346] [drm] Initialized drm 1.1.0 20060810
10.995 0.011: [ 1.272139] of_graph_get_next_endpoint(): no port node found in /ocp/lcdc@4830e000
11.004 0.009: [ 1.281403] of_graph_get_next_endpoint(): no port node found in /ocp/lcdc@4830e000
11.012 0.008: [ 1.290092] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
11.018 0.006: [ 1.296851] [drm] No driver support for vblank timestamp query.
11.130 0.112: [ 1.321374] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000020): drivers/gpu/drm/tilcdc/tilcdc_crtc.cFIFO underfow
11.133 0.003: [ 1.321409] info->fifo_th = 0
11.136 0.003: [ 1.321437] bpp=32****reg=6000081
11.146 0.010: [ 1.324519] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000020): drivers/gpu/drm/tilcdc/tilcdc_crtc.cFIFO underfow
11.153 0.007: [ 1.325864] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
11.160 0.007: [ 1.342104] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
11.166 0.006: [ 1.365640] Console: switching to colour frame buffer device 160x50
11.172 0.006: [ 1.450974] tilcdc 4830e000.lcdc: fb0: frame buffer device
11.204 0.032: [ 1.483088] [drm] Initialized tilcdc 1.0.0 20121205 on minor 0
11.226 0.022: [ 1.507394] loop: module loaded
11.237 0.011: [ 1.515055] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
11.242 0.005: [ 1.521592] ehci-platform: EHCI generic platform driver
11.248 0.006: [ 1.527435] ehci-omap: OMAP-EHCI Host Controller driver
11.254 0.006: [ 1.532938] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
11.259 0.005: [ 1.539217] ohci-platform: OHCI generic platform driver
11.267 0.008: [ 1.546408] mousedev: PS/2 mouse device common for all mice
11.273 0.006: [ 1.553996] GTP driver installing...
11.277 0.003: [ 1.557870] i2c /dev entries driver
11.287 0.010: [ 1.565088] cpuidle: enable-method property 'ti,am3352' found operations
11.293 0.007: [ 1.572230] sdhci: Secure Digital Host Controller Interface driver
11.298 0.005: [ 1.578586] sdhci: Copyright(c) Pierre Ossman
11.304 0.006: [ 1.584384] omap_hsmmc 48060000.mmc: Got CD GPIO
11.346 0.042: [ 1.623833] pinctrl-single 44e10800.pinmux: bad data for mux pinmux_emmc_pins
11.354 0.008: [ 1.631291] pinctrl-single 44e10800.pinmux: no pins entries for pinmux_emmc_pins
11.405 0.051: [ 1.683656] Synopsys Designware Multimedia Card Interface Driver
11.412 0.007: [ 1.690839] sdhci-pltfm: SDHCI platform and OF driver helper
11.419 0.007: [ 1.697967] ledtrig-cpu: registered to indicate activity on CPUs
11.425 0.006: [ 1.704605] usbcore: registered new interface driver usbhid
11.429 0.004: [ 1.710165] usbhid: USB HID core driver
11.438 0.009: [ 1.718113] NET: Registered protocol family 10
11.445 0.007: [ 1.725391] sit: IPv6 over IPv4 tunneling driver
11.453 0.008: [ 1.730202] mmc0: host does not support reading read-only switch, assuming write-enable
11.460 0.007: [ 1.740290] NET: Registered protocol family 17
11.467 0.007: [ 1.745358] omap_voltage_late_init: Voltage driver support not added
11.472 0.006: [ 1.751949] mmc0: new high speed SDHC card at address e624
11.479 0.007: [ 1.759733] ThumbEE CPU extension supported.
11.485 0.006: [ 1.765534] mmcblk0: mmc0:e624 SU08G 7.40 GiB
11.491 0.006: [ 1.770953] Registering SWP/SWPB emulation handler
11.496 0.005: [ 1.777739] mmcblk0: p1 p2
11.518 0.022: [ 1.797871] omap-gpmc 50000000.gpmc: GPMC revision 6.0
11.533 0.015: [ 1.811655] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
11.544 0.012: [ 1.825592] nand: No NAND device found
11.555 0.011: [ 1.833118] omap2-nand 8000000.nand: scan failed, may be bus-width mismatch
11.614 0.059: [ 1.893490] tps65217 0-0024: TPS65217 ID 0xe version 1.2
11.625 0.011: [ 1.903767] 0-0014 supply vdd_ana not found, using dummy regulator
11.631 0.006: [ 1.910068] 0-0014 supply vcc_i2c not found, using dummy regulator
11.777 0.146: [ 2.053407] <<-GTP-ERROR->> I2C Read: 0x8047, 1 bytes failed, errcode: -121! Process reset.
11.893 0.117: [ 2.173038] <<-GTP-ERROR->> GTP i2c test failed time 1.
11.917 0.023: [ 2.193395] <<-GTP-ERROR->> I2C Read: 0x8047, 1 bytes failed, errcode: -121! Process reset.
12.053 0.136: [ 2.333036] <<-GTP-ERROR->> GTP i2c test failed time 2.
12.077 0.023: [ 2.353395] <<-GTP-ERROR->> I2C Read: 0x8047, 1 bytes failed, errcode: -121! Process reset.
12.193 0.117: [ 2.473036] <<-GTP-ERROR->> GTP i2c test failed time 3.
12.217 0.023: [ 2.493379] <<-GTP-ERROR->> I2C Read: 0x8047, 1 bytes failed, errcode: -121! Process reset.
12.353 0.137: [ 2.633033] <<-GTP-ERROR->> GTP i2c test failed time 4.
12.387 0.033: [ 2.663391] <<-GTP-ERROR->> I2C Read: 0x8047, 1 bytes failed, errcode: -121! Process reset.
12.523 0.137: [ 2.803035] <<-GTP-ERROR->> GTP i2c test failed time 5.
12.543 0.020: [ 2.823034] <<-GTP-ERROR->> I2C communication ERROR!
12.557 0.014: [ 2.833328] <<-GTP-ERROR->> I2C Read: 0x8140, 6 bytes failed, errcode: -121! Process reset.
12.683 0.126: [ 2.963062] <<-GTP-ERROR->> GTP read version failed
12.688 0.005: [ 2.967931] <<-GTP-ERROR->> Read version failed.
12.696 0.009: [ 2.972912] <<-GTP-ERROR->> I2C Read: 0x41E4, 1 bytes failed, errcode: -121! Process reset.
12.817 0.120: [ 3.093387] <<-GTP-ERROR->> I2C Read: 0x41E4, 1 bytes failed, errcode: -121! Process reset.
12.937 0.120: [ 3.213395] <<-GTP-ERROR->> I2C Read: 0x41E4, 1 bytes failed, errcode: -121! Process reset.
13.057 0.120: [ 3.333406] <<-GTP-ERROR->> I2C Read: 0x41E4, 1 bytes failed, errcode: -121! Process reset.
13.177 0.120: [ 3.453403] <<-GTP-ERROR->> I2C Read: 0x41E4, 1 bytes failed, errcode: -121! Process reset.
13.297 0.120: [ 3.573390] <<-GTP-ERROR->> I2C Read: 0x41E4, 1 bytes failed, errcode: -121! Process reset.
13.415 0.118: [ 3.693050] <<-GTP-ERROR->> I2C read 0x41E4, 1 bytes, double check failed!
13.424 0.009: [ 3.700236] <<-GTP-ERROR->> I2C Read: 0x814A, 1 bytes failed, errcode: -121! Process reset.
13.547 0.123: [ 3.823397] <<-GTP-ERROR->> I2C Read: 0x814A, 1 bytes failed, errcode: -121! Process reset.
13.667 0.120: [ 3.943397] <<-GTP-ERROR->> I2C Read: 0x814A, 1 bytes failed, errcode: -121! Process reset.
13.787 0.120: [ 4.063385] <<-GTP-ERROR->> I2C Read: 0x814A, 1 bytes failed, errcode: -121! Process reset.
13.907 0.120: [ 4.183401] <<-GTP-ERROR->> I2C Read: 0x814A, 1 bytes failed, errcode: -121! Process reset.
14.027 0.120: [ 4.303387] <<-GTP-ERROR->> I2C Read: 0x814A, 1 bytes failed, errcode: -121! Process reset.
14.145 0.118: [ 4.423055] <<-GTP-ERROR->> I2C read 0x814A, 1 bytes, double check failed!
14.151 0.006: [ 4.429946] <<-GTP-ERROR->> Failed to get sensor_id, No config sent!
14.156 0.005: [ 4.436310] <<-GTP-ERROR->> GTP init panel failed.
14.163 0.006: [ 4.441805] input: goodix-ts as /devices/virtual/input/input0
14.170 0.008: [ 4.448516] i2c i2c-0: Failed to register i2c client tps65217 at 0x24 (-16)
14.178 0.008: [ 4.455552] i2c i2c-0: of_i2c: Failure registering /ocp/i2c@44e0b000/tps65217@24
14.184 0.006: [ 4.463089] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
14.192 0.009: [ 4.471675] omap_i2c 4819c000.i2c: bus 2 rev0.11 at 50 kHz
14.202 0.010: [ 4.479850] cpufreq: cpufreq_online: CPU0: Running at unlisted freq: 303157 KHz
14.212 0.009: [ 4.487427] cpu cpu0: dev_pm_opp_domain_set_rate: failed to find current OPP for freq 303157894 (-34)
14.236 0.024: [ 4.512674] cpufreq: cpufreq_online: CPU0: Unlisted initial frequency changed to: 300000 KHz
14.311 0.075: [ 4.591610] EXT4-fs (mmcblk0p2): recovery complete
14.322 0.011: [ 4.599210] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
14.328 0.006: [ 4.607476] VFS: Mounted root (ext4 filesystem) on device 179:2.
14.342 0.014: [ 4.624052] devtmpfs: mounted
14.350 0.008: [ 4.628278] Freeing unused kernel memory: 252K (c0763000 - c07a2000)
14.356 0.007: [ 4.634779] This architecture does not have kernel memory protection.
14.724 0.368: [ 5.002510] systemd[1]: System time before build time, advancing clock.
14.785 0.061: [ 5.062792] random: systemd urandom read with 26 bits of entropy available
14.840 0.055: [ 5.107020] systemd[1]: systemd 229 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN)
14.847 0.007: [ 5.127008] systemd[1]: Detected architecture arm.
14.855 0.008:
14.858 0.003: Welcome to [1mArago 2016.05[0m!
14.858 0.000:
14.876 0.017: [ 5.155673] systemd[1]: Set hostname to <am335x-evm>.
15.699 0.823: [ 5.969169] systemd[1]: Configuration file /lib/systemd/system/psplash-start.service is marked executable. Please remove executable permission bits. Proceeding anyway.
15.719 0.020: [ 5.984515] systemd[1]: Configuration file /lib/systemd/system/psplash-start.service is marked world-inaccessible. This has no effect as configuration data is accessible via APIs without restrictions. Proceeding anyway.
15.732 0.013: [ 6.007181] systemd[1]: psplash-start.service: Service lacks both ExecStart= and ExecStop= setting. Refusing.
15.992 0.260: [ 6.262150] systemd[1]: Configuration file /lib/systemd/system/sysconsole_app.service is marked executable. Please remove executable permission bits. Proceeding anyway.
16.078 0.086: [ 6.349760] systemd[1]: psplash-start.service: Cannot add dependency job, ignoring: Unit psplash-start.service is not loaded properly: Invalid argument.
16.100 0.022: [ 6.380122] systemd[1]: Listening on Syslog Socket.
16.108 0.008: [[0;32m OK [0m] Listening on Syslog Socket.
16.167 0.059: [ 6.448086] systemd[1]: Reached target Swap.
16.174 0.006: [[0;32m OK [0m] Reached target Swap.
16.202 0.028: [ 6.481944] systemd[1]: Created slice System Slice.
16.209 0.007: [[0;32m OK [0m] Created slice System Slice.
16.240 0.031: [ 6.514932] systemd[1]: systemd-networkd.socket: Socket service systemd-networkd.service not loaded, refusing.
16.247 0.008: [ 6.525504] systemd[1]: Failed to listen on Network Service Netlink Socket.
16.256 0.009: [[0;1;31mFAILED[0m] Failed to listen on Network Service Netlink Socket.
16.275 0.019: See 'systemctl status systemd-networkd.socket' for details.
16.296 0.021: [ 6.574449] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
16.305 0.009: [[0;32m OK [0m] Listening on /dev/initctl Compatibility Named Pipe.
16.328 0.023: [ 6.607014] systemd[1]: Created slice system-serial\x2dgetty.slice.
16.336 0.008: [[0;32m OK [0m] Created slice system-serial\x2dgetty.slice.
16.355 0.019: [ 6.634543] systemd[1]: Listening on udev Control Socket.
16.362 0.007: [0;32m OK [0m] Listening on udev Control Socket.t
16.385 0.024: y[ 6.664311] systemd[1]: Listening on Journal Socket (/dev/log).
16.392 0.007: [[0;32m OK [0m] Listening on Journal Socket (/dev/log).
16.415 0.022: [ 6.694274] systemd[1]: Listening on udev Kernel Socket.
16.421 0.007: [[0;32m OK [0m] Listening on udev Kernel Socket.
16.444 0.023: [ 6.723926] systemd[1]: Reached target Remote File Systems.
16.451 0.007: [[0;32m OK [0m] Reached target Remote File Systems.
16.477 0.026: [ 6.757069] systemd[1]: Created slice system-getty.slice.
16.485 0.007: [[0;32m OK [0m] Created slice system-getty.slice.
16.508 0.023: [ 6.784705] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
16.517 0.010: [[0;32m OK [0m] Started Dispatch Password Requests to Console Directory Watch.
16.534 0.017: [ 6.814548] systemd[1]: Listening on Journal Socket.
16.541 0.006: [[0;32m OK [0m] Listening on Journal Socket.
16.584 0.043: [ 6.864073] systemd[1]: Starting Journal Service...
16.599 0.015: Starting Journal Service...
16.685 0.087: [ 6.965197] systemd[1]: Mounting Temporary Directory...
16.710 0.025: Mounting Temporary Directory...
16.785 0.075: [ 7.064847] systemd[1]: Starting Apply Kernel Variables...
16.821 0.036: Starting Apply Kernel Variables...
16.906 0.085: [ 7.184604] systemd[1]: Starting Create Static Device Nodes in /dev...
16.949 0.043: Starting Create Static Device Nodes in /dev...
17.021 0.071: [ 7.299305] systemd[1]: Mounting POSIX Message Queue File System...
17.061 0.041: Mounting POSIX Message Queue File System...
17.088 0.026: [ 7.365027] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
17.145 0.057: [[0;32m OK [0m] Started Forward Password Requests to Wall Directory Watch.
17.151 0.006: [ 7.431364] systemd[1]: Reached target Paths.
17.184 0.033: [[0;32m OK [0m] Reached target Paths.
17.208 0.024: [ 7.487046] systemd[1]: Created slice User and Session Slice.
17.244 0.036: [[0;32m OK [0m] Created slice User and Session Slice.
17.264 0.020: [ 7.544180] systemd[1]: Reached target Slices.
17.270 0.006: [[0;32m OK [0m] Reached target Slices.
17.322 0.053: [ 7.600634] systemd[1]: Starting Remount Root and Kernel File Systems...
17.353 0.030: Starting Remount Root and Kernel File Systems...
17.416 0.063: [ 7.695584] systemd[1]: Mounting Debug File System...
17.485 0.070: Mounting Debug File System...
17.550 0.064: [ 7.829361] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
17.592 0.042: [ 7.871239] systemd[1]: Starting Setup Virtual Console...
17.646 0.055: Starting Setup Virtual Console...
17.791 0.145: [ 8.071076] systemd[1]: Mounted Debug File System.
17.798 0.007: [[0;32m OK [0m] Mounted Debug File System.
17.815 0.017: [ 8.094321] systemd[1]: Mounted POSIX Message Queue File System.
17.823 0.008: [[0;32m OK [0m] Mounted POSIX Message Queue File System.
17.844 0.021: [ 8.124300] systemd[1]: Mounted Temporary Directory.
17.851 0.006: [[0;32m OK [0m] Mounted Temporary Directory.
17.875 0.025: [ 8.155563] systemd[1]: Started Journal Service.
17.881 0.006: [[0;32m OK [0m] Started Journal Service.
17.927 0.045: [[0;32m OK [0m] Started Apply Kernel Variables.
17.958 0.031: [[0;32m OK [0m] Started Create Static Device Nodes in /dev.
17.989 0.031: [[0;32m OK [0m] Started Remount Root and Kernel File Systems.
18.028 0.039: [[0;32m OK [0m] Started Setup Virtual Console.
19.615 1.587: Starting udev Coldplug all Devices...
19.646 0.031: [[0;32m OK [0m] Reached target Local File Systems (Pre).
19.714 0.069: Mounting /var/volatile...
19.807 0.092: Mounting /media/ram...
19.921 0.114: Starting udev Kernel Device Manager...
20.036 0.115: Starting Flush Journal to Persistent Storage...
20.285 0.249: [[0;32m OK [0m] Mounted /var/volatile.
20.312 0.027: [[0;32m OK [0m] Mounted /media/ram.
23.024 2.712: [[[0;32m OK [0m] Started udev Kernel Device Manager.
[ 13.301240] systemd-journald[61]: Received request to flush runtime journal from PID 1
23.101 0.077: [[0;32m OK [0m] Started Flush Journal to Persistent Storage.
23.435 0.333: Starting Load/Save Random Seed...
23.472 0.038: [[0;32m OK [0m] Reached target Local File Systems.
23.557 0.084: Starting Create Volatile Files and Directories...
23.654 0.097: [[0;32m OK [0m] Started Load/Save Random Seed.
23.945 0.292: [[0;32m OK [0m] Started Create Volatile Files and Directories.
25.784 1.838: [[0;32m OK [0m] Started udev Coldplug all Devices.
26.155 0.371: [[0;32m OK [0m] Found device /dev/ttyS0.
27.635 1.480: [[0;32m OK [0m] Created slice system-systemd\x2dbacklight.slice.
27.817 0.181: Starting Load/Save Screen Backlight...htness of backlight:backlight...
28.093 0.276: Starting Network Time Synchronization...
28.393 0.300: Starting Update UTMP about System Boot/Shutdown...
28.867 0.474: [[0;32m OK [0m] Started Load/Save Screen Backlight Brightness of backlight:backlight.
29.805 0.938: [[0;32m OK [0m] Started Network Time Synchronization.
30.033 0.228: [[0;32m OK [0m] Found device /dev/ttyS3.
31.698 1.665: [ 21.978299] FAT-fs (mmcblk0p1): codepage cp437 not found
33.791 2.092: [[0;32m OK [0m] Started Update UTMP about System Boot/Shutdown.
33.843 0.053: [ 24.123255] FAT-fs (mmcblk0p1): codepage cp437 not found
35.863 2.020: [ 26.143217] random: nonblocking pool is initialized
37.928 2.065: Starting Synchronize System and HW clocks...
37.962 0.034: [[0;32m OK [0m] Reached target System Time Synchronized.
38.030 0.069: [[0;1;31mFAILED[0m] Failed to start Synchronize System and HW clocks.
38.055 0.025: See 'systemctl status sync-clocks.service' for details.
38.276 0.221: [[0;32m OK [0m] Reached target System Initialization.
38.302 0.026: [[0;32m OK [0m] Listening on RPCbind Server Activation Socket.
38.332 0.030: [[0;32m OK [0m] Listening on D-Bus System Message Bus Socket.
38.359 0.027: [[0;32m OK [0m] Reached target Sockets.
38.389 0.030: [[0;32m OK [0m] Reached target Basic System.
38.437 0.047: [[0;32m OK [0m] Started Kernel Logging Service.
38.518 0.081: [[0;32m OK [0m] Started D-Bus System Message Bus.
38.946 0.428: [[0;32m OK [0m] Started System Logging Service.
39.032 0.086: Starting Login Service...
39.131 0.098: Starting Network Name Resolution...
39.362 0.231: [[0;32m OK [0m] Started SystemConsoleApplication.
Starting rc.pvr.service...
39.484 0.123: [[0;32m OK [0m] Started Dhara.
39.645 0.161: Starting Permit User Sessions...
39.676 0.031: [[0;32m OK [0m] Started Daily Cleanup of Temporary Directories.
39.739 0.063: [[0;32m OK [0m] Reached target Timers.
39.804 0.065: [ 30.060759] 1sysconsole_app.sh[377]: Set register 7: 12 (c)
39.858 0.054: [[0;32m OK [0m] Started Network Name Resolution.
39.907 0.049: [ 30.167052] 1sysconsole_app.sh[377]: Set register 8: 97 (61)
39.939 0.032: [[0;32m OK [0m] Started Permit User Sessions.
42.871 2.932: [[0;32m OK [0m] Started rc.pvr.service.
43.363 0.492: [[0;32m OK [0m] Stopped Serial Getty on ttyGS0.
43.462 0.100: Starting telnetd.service...
43.604 0.141: [[0;32m OK [0m] Started Getty on tty1.
43.668 0.064: [[0;32m OK [0m] Started Serial Getty on ttyS0.
43.714 0.046: [[0;32m OK [0m] Started Serial Getty on ttyS3.
43.832 0.118: [[0;32m OK [0m] Started telnetd.service.
43.876 0.044: [[0;32m OK [0m] Started Login Service.
44.183 0.308: Starting thttpd.service...
44.736 0.552: [[0;32m OK [0m] Started thttpd.service.
44.809 0.073: Starting thermal-zone-init.service...
45.024 0.215: [[0;32m OK [0m] Started thermal-zone-init.service.
45.354 0.330: Starting gplv3-notice.service...
47.092 0.008: _____ _____ _ _
47.097 0.005: | _ |___ ___ ___ ___ | _ |___ ___ |_|___ ___| |_
47.225 0.128: | | _| .'| . | . | | __| _| . | | | -_| _| _|
47.230 0.005: |__|__|_| |__,|_ |___| |__| |_| |___|_| |___|___|_|
47.235 0.005: |___| |___|
47.235 0.000:
47.240 0.005: Arago Project http://arago-project.org am335x-evm ttyS0
47.240 0.000:
47.243 0.003: Arago 2016.05 am335x-evm ttyS0
47.243 0.000:
50.366 3.123: am335x-evm login: [ 50.022204] 1sysconsole_app.sh[377]: No such plugin for spec "Auto"
