This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

Omap NAND driver fails MTD testsuite's sub-page test

Patform: 814x or 816x

The omap2 NAND kernel driver does not pass the MTD test suite because NAND sub-page support is broken in the driver. This causes errors with UBI/UBIFS.

Steps to reproduce the problem:

1) Configure a linux kernel with CONFIG_MTD_TESTS=m

    (Device drivers -> Memory Technology Devices (MTD) support -> MTD tests support)

2) Build and deploy kernel and modules to a 814x EVM or a 816x EVM board.

3) On the board, run the following command (as root)

NOTE: this module will work on a MTD partition. You need to supply a MTD partition number with the dev= module option which will be used for sup-page testing.

modprobe mtd_subpagetest.ko dev=5

The tests will start right after the module has been loaded. So after the module has been loaded, check the kernel message buffer for error messages by running dmesg on the command line:

dmesg

mtd_subpagetest: MTD device: 5

mtd_subpagetest: MTD device size 36700160, eraseblock size 131072, page size 2048, subpage size 512, count of eraseblocks 0, pages per eraseblock 0, OOB size 64

mtd_subpagetest: scanning for bad eraseblocks

mtd_subpagetest: scanned 280 eraseblocks, 0 are bad

mtd_subpagetest: erasing whole device

[...]

mtd_subpagetest: erased 280 eraseblocks

mtd_subpagetest: writing whole device

mtd_subpagetest: written up to eraseblock 0

mtd_subpagetest: written up to eraseblock 256

mtd_subpagetest: written 280 eraseblocks

mtd_subpagetest: verifying all eraseblocks

UNCORRECTED_ERROR default

ECC UNCORRECTED_ERROR B

mtd_subpagetest: error: read failed at 0x0

mtd_subpagetest: error -74 occurred

 

  • Thilo,

    We have currently not validated subpage support in our NAND driver.

    Regards,

    Parth

  • This breaks UBI and UBIFS. It is a critical flaw since UBIFS is the flash file system for Embedded Linux. Not having full UBIFS support is unacceptable.

    Also, this flaw has been documented and is known to Texas Instruments for 7 months now (see e.g. here: <http://e2e.ti.com/support/dsp/sitara_arm174_microprocessors/f/416/p/115399/584239.aspx#584239> ).

    We urgently require a fix for this defect.

  • Thilo,

    We have documented how to create UBI/UBIFS images without subpage support. This is what we use and is working well for us. You can follow the steps mentioned in our UBIFS support user guide to get a working UBIFS filesystem.

    Regards,

    Parth

  • Here is the link for the same:

    http://ap-fpdsp-swapps.dal.design.ti.com/index.php/UBIFS-Support

  • The externally accessible link is:

    http://processors.wiki.ti.com/index.php/UBIFS_Support

  • This crude work-around is not an acceptable fix. Your driver reports sub-pages of 512 bytes when queried (try mtdinfo /dev/mtd0 on a TI Linux device). But the same driver spits out CRC errors when user space software actually tries to make use of said sub-pages. You surely don't expect your paying customers to work around this bug for every single sub-page-aware user space program? The UBIFS user space tooling is probably not the only software you broke with this.

    Either:

    - fix your driver (i.e. add sub-page support)

    or

    - make it stop reporting sub-pages because it does not really support sub-pages

    Please fix.

  • Hi,

    Since this problem has been known for almost 3/4 of a year now and Texas Instruments hasn't reacted on this thread for over two weeks I suppose you expect us to just accept the buggy and incomprehensive platform support as it is?

  • Thilo,

    As mentioned before, we currently do not support subpage. The same information will now be explicitly mentioned in our release notes and data sheets. Since we do understand the issue faced by you, we plan to fix our driver and implement subpage support as we go about improving our Nand driver development. We will discuss this within the team and allocate time to cater to the same.

    Thanks and Regards,

    Parth

  • Hello,

    I'm afraid we have a communication issue here. Your statement

    " As mentioned before, we currently do not support subpage. "

    is plain and simply wrong. See yourself:

    root@hidav:~# mtdinfo /dev/mtd0
    mtd0
    Name: bootloader
    Type: nand
    Eraseblock size: 131072 bytes, 128.0 KiB
    Amount of eraseblocks: 8 (1048576 bytes, 1024.0 KiB)
    Minimum input/output unit size: 2048 bytes
    Sub-page size: 512 bytes
    OOB size: 64 bytes
    Character device major/minor: 90:0
    Bad blocks are allowed: true
    Device is writable: true

    Please pay special attention to the line

    Sub-page size: 512 bytes

    This line means that your driver claims to support sub-pages. If you in fact really do not support sub-pages at this time then this is clearly a bug.

    There are quite a few tools in the Linux world which explicitly ask the NAND driver for this information with the sole reason of using this information afterwards to optimize NAND accesses.

    Your driver lies to them, effectively breaking all the tools.

    So if support for sub-page access is such a big deal for a company of the size of Texas Instruments that you have to explicitly schedule resources for the implementation nine months after the issue has been reported the first time then at least PLEASE fix your driver so that it does not report capabilities it is actually NOT capable of.

    Have a look at include/linux/mtd/nand.h, lines 195, 213, and 350/376, 457/516 for a start.

    I really don't see why you are so hesitant to fix this issue while implementing sub-page support in the long run.


  • I would like to add that this bug seems to also break yaffs2. We are currently using yaffs2 with kernel 3.3 on a Omap4430 and we have many problems with the flash.

    Do you have a patch somewhere for this issue ?

    Thanks in advance

    Patrick

  • I found this thread extremely "picky". As the TI guys says, if we just don't consider the output of mtdinfo, driver and UBI works perfect (no ECC errors at all, i run all the mtd-utils tests for ubi fs and also the power cut testt) _without_ subpages.

    I use kernel 3.5.1 where OMAP-L sub-page support was still not enabled (now it is from 3.10.x).

    For a 128KB PEB / 2048B page based NAND, I generate the image from buildroot as:

        [*] ubifs root filesystem                                             │ │  
      │ │    (0x1f000) UBI logical erase block size                                │ │  
      │ │    (0x800) UBI minimum I/O size                                          │ │  
      │ │    (1024) Maximum LEB count                                              │ │  
      │ │          ubifs runtime compression (gzip)  --->                          │ │  
      │ │          Compression method (no compression)  --->                       │ │  
      │ │    [*]   Embed into an UBI image                                         │ │  
      │ │    (0x20000) UBI physical erase block size                               │ │  
      │ │    (0)     UBI sub-page size
    
    

    regards

    Angelo

  •             Hi I have kernel code I want to run MTD test separately but  /drivers/mtd/test/*.c all are using some kernel api's may I know how to run the mtd test separately without building them with kernel. Out requirement is to test the driver separately and capture the result to report for the we have to run the test separately from kernel. I also want to know how to build this test. Please provide the information as soon as possible.


    Thanks & regards

    Narendra kumar Chepuri.

  • I know this thread is about 4 years old. But it looks like there still is no sub-page write support in the NAND driver for OMAP2 (AM335x). Is this correct?
  • Hi Christian,

    Please refer to the below wiki page regarding the latest status:
    processors.wiki.ti.com/.../Linux_Core_NAND_User's_Guide

    Regards,
    Pavel
  • Hi Pavel,

    thanks for your answer. I checked this site and the OMAP NAND driver (still) does not support sub-page writes. On the other hand the driver reports to the MTD subsystem, that it supports sub-page writes. The following patch sets the NAND_NO_SUBPAGE_WRITE option flag. This seems to resolve the issue for us.

    From a25bb78059397f335b57ea59234433ce7073b62e Mon Sep 17 00:00:00 2001
    From: Christian Andersen <c.andersen@kostal.com>
    Date: Fri, 22 Jul 2016 09:54:50 +0200
    Subject: [PATCH] mtd: nand: omap2: OMAP NAND driver does not support sub-page
    writes
    
    According to the TI Linux Core NAND User's Guide the OMAP NAND driver does not support sub-page writes
    (processors.wiki.ti.com/.../Linux_Core_NAND_User's_Guide. In this case
    the option flag NAND_NO_SUBPAGE_WRITE should be set. If this flag is missing, the MTD subsystem assumes
    that sub-page writes are supported and reports this through SYSFS. This results in wrong behaviour of UBI
    and UBIFS.
    ---
    drivers/mtd/nand/omap2.c | 5 +++++
    1 file changed, 5 insertions(+)
    
    diff --git a/drivers/mtd/nand/omap2.c b/drivers/mtd/nand/omap2.c
    index f8dde30..7103b8e 100644
    --- a/drivers/mtd/nand/omap2.c
    +++ b/drivers/mtd/nand/omap2.c
    @@ -2129,6 +2129,11 @@ static int omap_nand_probe(struct platform_device *pdev)
    }
    nand_chip->ecc.layout = ecclayout;
    
    + /* TI OMAP driver does not support sub-page writes, so we have to set this flag
    + * to disable sub-page writes
    + * ref: processors.wiki.ti.com/.../Linux_Core_NAND_User's_Guide */
    + nand_chip->options |= NAND_NO_SUBPAGE_WRITE;
    +
    scan_tail:
    /* second phase scan */
    if (nand_scan_tail(mtd)) {
    -- 
    2.5.0

  • Hi Christian,

    Thanks for the info. I will forward this to the AM335x SDK team.

    Note that sub-page write support is removed by default for the TI KeyStone 2 device in the below NAND driver:

    linux-4.4.12/drivers/mtd/nand/davinci_nand.c

    static struct davinci_nand_pdata
    *nand_davinci_get_pdata(struct platform_device *pdev)
    {

    if (of_device_is_compatible(pdev->dev.of_node, "ti,keystone-nand")) {
    pdata->options |= NAND_NO_SUBPAGE_WRITE;
    }
    }

    The sub-page write is also removed for DM81xx/AM38xx devices in the below NAND driver:

    linux-2.6.37/drivers/mtd/nand/omap2.c

    static int __devinit omap_nand_probe(struct platform_device *pdev)
    {

    info->nand.options &= ~NAND_SUBPAGE_READ;
    info->nand.options |= NAND_NO_SUBPAGE_WRITE;
    }

    Regards,
    Pavel

  • Christian,

    Christian Andersen said:
    On the other hand the driver reports to the MTD subsystem, that it supports sub-page writes. The following patch sets the NAND_NO_SUBPAGE_WRITE option flag. This seems to resolve the issue for us.

    We need more details regarding the issue you have when the flag is not set, to be able to reproduce it on our side. Could you please provide more info regarding the issue?

    Could you please let us know if you are using AM335x TI EVM or AM335x based custom board? Do you use the latest PSDK 03.00.00.04 that come with TI kernel v4.4 or mainline linux v4.7-rc7 or else?


    Regards,
    Pavel

  • Hello Pavel,

    we are using an AM335x based custom board (with Samsung K9F4G08U0E NAND flash). We are also using the TI Linux Kernel (ti-lsk-linux-4.4.y branch). The system (Kernel, U-Boot etc.) is built using Yocto 2.1 and the meta-ti layer.

    The problem is that mtdinfo reports the following:

    mtd13
    Name:                           NAND.file-system
    Type:                           nand
    Eraseblock size:                131072 bytes, 128.0 KiB
    Amount of eraseblocks:          3930 (515112960 bytes, 491.2 MiB)
    Minimum input/output unit size: 2048 bytes
    Sub-page size:                  512 bytes
    OOB size:                       64 bytes
    Character device major/minor:   90:26
    Bad blocks are allowed:         true
    Device is writable:             true

    The problem is the line "Sub-page size: 512 bytes". This is not true, since the TI OMAP NAND driver does not support sub-page writes. The UBI/UBIFS tools now require explicit arguments to disable the sub-page writes, e.g.

    ubiformat /dev/mtd13 -s 2048 -O 2048
    ubiattach /dev/ubi_ctrl -m 13 -O 2048

    The options "-s 2048" and "-O 2048" should not be necessary. I know that these options are explicitly mentioned in your NAND and UBI documentation. But I think that this is only a workaround for the wrong information provided by the NAND driver. Because the ubi-tools would pay attention to the subpagesize reported via SYSFS and MTD. Without these options it is not possible the attach the mtd/ubi device after a reset. The error is nearly identical to the case described in the UBI FAQ (www.linux-mtd.infradead.org/.../ubi.html. But in this case the ubi tools try to use sub-page writes and fail. After disabling the sub-page writes using the flag NAND_NO_SUBPAGE_WRITE attaching and mounting of ubi volumes is possible without specifying any special options:

    ubiformat /dev/mtd13
    ubiattach /dev/ubi_ctrl -m 13

    When we set the flag NAND_NO_SUBPAGE_WRITE in nand_chip->options (in omap2.c, see my patch), the NAND base driver (nand_base.c) uses this information, e.g. in nand_scan_tail:

    	/* Allow subpage writes up to ecc.steps. Not possible for MLC flash */
    	if (!(chip->options & NAND_NO_SUBPAGE_WRITE) && nand_is_slc(chip)) {
    		switch (ecc->steps) {
    		case 2:
    			mtd->subpage_sft = 1;
    			break;
    		case 4:
    		case 8:
    		case 16:
    			mtd->subpage_sft = 2;
    			break;
    		}
    	}
    	chip->subpagesize = mtd->writesize >> mtd->subpage_sft;

  • Hi Christian,

    We tested v4.4 kernel with ubifs and subpage test on AM335x EVM and both pass. We are not passing any arguments to ubiformat and ubiattach to override the default subpage size.

    ubifs test pass log:

    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.4.20-g00f19d3e53 (gtbldadm@vm03) (gcc version 5.3.1 20160113 (Linaro GCC 5.3-2016.02) ) #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016
    [    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
    [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [    0.000000] Machine model: TI AM335x EVM
    [    0.000000] cma: Reserved 24 MiB at 0xbe800000
    [    0.000000] Memory policy: Data cache writeback
    [    0.000000] CPU: All CPU(s) started in SVC mode.
    [    0.000000] AM335X ES2.1 (sgx neon )
    [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 260416
    [    0.000000] Kernel command line: console=ttyO0,115200n8 earlyprintk=serial,ttyO0,115200n8 rootwait   ip=:::::eth0:dhcp  root=/dev/nfs rw nfsroot=192.168.0.1:/home/tigtfarm04/NFS_exports/linux/am335x-evm/autofs/b12391b17f5a95e11a1a3fee15f5eb52,nolock,v3,tcp,rsize=4096,wsize=4096 
    [    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: 1003984K/1048576K available (6523K kernel code, 314K rwdata, 2376K rodata, 264K init, 265K bss, 20016K reserved, 24576K cma-reserved, 237568K highmem)
    [    0.000000] Virtual kernel memory layout:
    [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    [    0.000000]     vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
    [    0.000000]     lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
    [    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
    [    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
    [    0.000000]       .text : 0xc0008000 - 0xc08b9014   (8901 kB)
    [    0.000000]       .init : 0xc08ba000 - 0xc08fc000   ( 264 kB)
    [    0.000000]       .data : 0xc08fc000 - 0xc094aa10   ( 315 kB)
    [    0.000000]        .bss : 0xc094aa10 - 0xc098d098   ( 266 kB)
    [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
    [    0.000000] Preemptible hierarchical RCU implementation.
    [    0.000000] 	Build-time adjustment of leaf fanout to 32.
    [    0.000000] NR_IRQS:16 nr_irqs:16 16
    [    0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
    [    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
    [    0.000013] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 89478484971ns
    [    0.000033] clocksource: timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
    [    0.000042] OMAP clocksource: timer1 at 24000000 Hz
    [    0.000197] clocksource_probe: no matching clocksources found
    [    0.000370] Console: colour dummy device 80x30
    [    0.000399] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
    [    0.000404] This ensures that you still see kernel messages. Please
    [    0.000409] update your kernel commandline.
    [    0.000428] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
    [    0.089217] pid_max: default: 32768 minimum: 301
    [    0.089335] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.089347] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.090009] Initializing cgroup subsys io
    [    0.090043] Initializing cgroup subsys memory
    [    0.090081] Initializing cgroup subsys devices
    [    0.090097] Initializing cgroup subsys freezer
    [    0.090110] Initializing cgroup subsys perf_event
    [    0.090121] Initializing cgroup subsys pids
    [    0.090146] CPU: Testing write buffer coherency: ok
    [    0.090559] Setting up static identity map for 0x80008200 - 0x80008258
    [    0.092449] devtmpfs: initialized
    [    0.103739] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
    [    0.116729] omap_hwmod: debugss: _wait_target_disable failed
    [    0.172291] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
    [    0.174358] pinctrl core: initialized pinctrl subsystem
    [    0.175584] NET: Registered protocol family 16
    [    0.177375] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [    0.199210] cpuidle: using governor ladder
    [    0.229197] cpuidle: using governor menu
    [    0.233138] OMAP GPIO hardware version 0.1
    [    0.240656] omap-gpmc 50000000.gpmc: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/nandflash_pins_s0, deferring probe
    [    0.243130] hw-breakpoint: debug architecture 0x4 unsupported.
    [    0.276495] edma 49000000.edma: TI EDMA DMA engine driver
    [    0.280564] omap_i2c 44e0b000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c0_pins, deferring probe
    [    0.280621] omap_i2c 4802a000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c1_pins, deferring probe
    [    0.280739] media: Linux media interface: v0.10
    [    0.280792] Linux video capture interface: v2.00
    [    0.280833] pps_core: LinuxPPS API ver. 1 registered
    [    0.280840] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.280864] PTP clock support registered
    [    0.280910] EDAC MC: Ver: 3.0.0
    [    0.281988] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
    [    0.282331] Advanced Linux Sound Architecture Driver Initialized.
    [    0.283456] clocksource: Switched to clocksource timer1
    [    0.292927] NET: Registered protocol family 2
    [    0.293720] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
    [    0.293799] TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
    [    0.293866] TCP: Hash tables configured (established 8192 bind 8192)
    [    0.293976] UDP hash table entries: 512 (order: 1, 8192 bytes)
    [    0.294000] UDP-Lite hash table entries: 512 (order: 1, 8192 bytes)
    [    0.294148] NET: Registered protocol family 1
    [    0.294559] RPC: Registered named UNIX socket transport module.
    [    0.294575] RPC: Registered udp transport module.
    [    0.294581] RPC: Registered tcp transport module.
    [    0.294587] RPC: Registered tcp NFSv4.1 backchannel transport module.
    [    0.295518] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
    [    0.297332] futex hash table entries: 256 (order: -1, 3072 bytes)
    [    0.304383] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    [    0.305230] NFS: Registering the id_resolver key type
    [    0.305305] Key type id_resolver registered
    [    0.305314] Key type id_legacy registered
    [    0.305385] ntfs: driver 2.1.32 [Flags: R/O].
    [    0.308652] bounce: pool size: 64 pages
    [    0.308905] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
    [    0.308929] io scheduler noop registered
    [    0.308942] io scheduler deadline registered
    [    0.309081] io scheduler cfq registered (default)
    [    0.310378] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
    [    0.312957] backlight supply power not found, using dummy regulator
    [    0.365476] Serial: 8250/16550 driver, 10 ports, IRQ sharing disabled
    [    0.369171] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 158, base_baud = 3000000) is a 8250
    [    1.014344] console [ttyS0] enabled
    [    1.019067] 48022000.serial: ttyS1 at MMIO 0x48022000 (irq = 159, base_baud = 3000000) is a 8250
    [    1.029013] [drm] Initialized drm 1.1.0 20060810
    [    1.036054] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
    [    1.042711] [drm] No driver support for vblank timestamp query.
    [    1.075785] Console: switching to colour frame buffer device 100x30
    [    1.086693] tilcdc 4830e000.lcdc: fb0:  frame buffer device
    [    1.113627] [drm] Initialized tilcdc 1.0.0 20121205 on minor 0
    [    1.125965] loop: module loaded
    [    1.131524] libphy: Fixed MDIO Bus: probed
    [    1.193492] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
    [    1.199632] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
    [    1.206743] libphy: 4a101000.mdio: probed
    [    1.210774] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver Atheros 8031 ethernet
    [    1.220886] cpsw 4a100000.ethernet: Detected MACID = d0:ff:50:57:02:d9
    [    1.229401] mousedev: PS/2 mouse device common for all mice
    [    1.235765] i2c /dev entries driver
    [    1.240224] cpuidle: enable-method property 'ti,am3352' found operations
    [    1.247914] omap_hsmmc 48060000.mmc: Got CD GPIO
    [    1.397526] ledtrig-cpu: registered to indicate activity on CPUs
    [    1.407949] NET: Registered protocol family 10
    [    1.415018] sit: IPv6 over IPv4 tunneling driver
    [    1.420409] NET: Registered protocol family 17
    [    1.425351] Key type dns_resolver registered
    [    1.429898] omap_voltage_late_init: Voltage driver support not added
    [    1.439665] omap-gpmc 50000000.gpmc: GPMC revision 6.0
    [    1.445110] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
    [    1.452583] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xda
    [    1.459128] nand: Micron MT29F2G08ABAEAWP
    [    1.463160] nand: 256 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 64
    [    1.470832] nand: using OMAP_ECC_BCH8_CODE_HW ECC scheme
    [    1.476294] 10 ofpart partitions found on MTD device 8000000.nand
    [    1.482413] Creating 10 MTD partitions on "8000000.nand":
    [    1.487858] 0x000000000000-0x000000020000 : "NAND.SPL"
    [    1.494367] 0x000000020000-0x000000040000 : "NAND.SPL.backup1"
    [    1.501299] 0x000000040000-0x000000060000 : "NAND.SPL.backup2"
    [    1.508263] 0x000000060000-0x000000080000 : "NAND.SPL.backup3"
    [    1.515266] 0x000000080000-0x0000000c0000 : "NAND.u-boot-spl-os"
    [    1.522333] 0x0000000c0000-0x0000001c0000 : "NAND.u-boot"
    [    1.529223] 0x0000001c0000-0x0000001e0000 : "NAND.u-boot-env"
    [    1.536107] 0x0000001e0000-0x000000200000 : "NAND.u-boot-env.backup1"
    [    1.543688] 0x000000200000-0x000000a00000 : "NAND.kernel"
    [    1.552811] 0x000000a00000-0x000010000000 : "NAND.file-system"
    [    1.663706] tps65910 0-002d: No interrupt support, no core IRQ
    [    1.691106] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
    [    1.698474] omap_i2c 4802a000.i2c: bus 1 rev0.11 at 100 kHz
    [    1.704920] omap_hsmmc 48060000.mmc: Got CD GPIO
    [    1.709970] vmmc: supplied by vbat
    [    1.754140] vdd_mpu: supplied by vbat
    [    1.763238] input: volume_keys@0 as /devices/platform/volume_keys@0/input/input0
    [    1.771563] hctosys: unable to open rtc device (rtc0)
    [    1.797569] net eth0: initializing cpsw version 1.12 (0)
    [    1.803012] net eth0: initialized cpsw ale version 1.4
    [    1.808240] net eth0: ALE Table size 1024
    [    1.818290] mmc1: host does not support reading read-only switch, assuming write-enable
    [    1.828273] mmc1: new high speed SDHC card at address 59b4
    [    1.834552] mmcblk0: mmc1:59b4 NCard 7.51 GiB 
    [    1.840266]  mmcblk0: p1 p2 p3
    [    1.894223] net eth0: phy found : id is : 0x4dd074
    [    1.899161] libphy: PHY 4a101000.mdio:01 not found
    [    1.904004] net eth0: phy "4a101000.mdio:01" not found on slave 1, err -19
    [    1.916788] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
    [    5.894520] cpsw 4a100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
    [    5.902528] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
    [    5.923517] Sending DHCP requests ., OK
    [    5.973536] IP-Config: Got DHCP answer from 192.168.0.1, my address is 192.168.0.53
    [    5.981702] IP-Config: Complete:
    [    5.985149]      device=eth0, hwaddr=d0:ff:50:57:02:d9, ipaddr=192.168.0.53, mask=255.255.255.0, gw=192.168.0.1
    [    5.995516]      host=192.168.0.53, domain=ti.com, nis-domain=(none)
    [    6.001977]      bootserver=0.0.0.0, rootserver=192.168.0.1, rootpath=
    [    6.008475]      nameserver0=192.0.2.2, nameserver1=192.0.2.3
    [    6.014747] lis3_reg: disabling
    [    6.017996] wlan-en-regulator: disabling
    [    6.022543] ALSA device list:
    [    6.025617]   No soundcards found.
    [    6.048136] VFS: Mounted root (nfs filesystem) on device 0:15.
    [    6.054973] devtmpfs: mounted
    [    6.058871] Freeing unused kernel memory: 264K (c08ba000 - c08fc000)
    [    6.065464] This architecture does not have kernel memory protection.
    [    6.358238] systemd[1]: System time before build time, advancing clock.
    [    6.428377] random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available)
    [    6.447759] random: systemd: uninitialized urandom read (16 bytes read, 62 bits of entropy available)
    [    6.466261] 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)
    [    6.485373] systemd[1]: Detected architecture arm.
    
    Welcome to [1mArago 2016.08[0m!
    
    [    6.515329] systemd[1]: Set hostname to <am335x-evm>.
    [    6.658611] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 74 bits of entropy available)
    [    6.697291] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 77 bits of entropy available)
    [    6.725969] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 79 bits of entropy available)
    [    6.774662] random: systemd: uninitialized urandom read (16 bytes read, 82 bits of entropy available)
    [    6.792603] random: systemd: uninitialized urandom read (16 bytes read, 83 bits of entropy available)
    [    6.802682] random: systemd: uninitialized urandom read (16 bytes read, 83 bits of entropy available)
    [    6.812909] random: systemd: uninitialized urandom read (16 bytes read, 83 bits of entropy available)
    [    6.857279] random: systemd: uninitialized urandom read (16 bytes read, 87 bits of entropy available)
    [    7.200503] systemd[1]: Listening on Syslog Socket.
    [[0;32m  OK  [0m] Listening on Syslog Socket.
    [    7.224873] systemd[1]: Listening on udev Control Socket.
    [[0;32m  OK  [0m] Listening on udev Control Socket.
    [    7.254775] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
    [[0;32m  OK  [0m] Listening on /dev/initctl Compatibility Named Pipe.
    [    7.286151] systemd[1]: Created slice User and Session Slice.
    [[0;32m  OK  [0m] Created slice User and Session Slice.
    [    7.314160] systemd[1]: Listening on udev Kernel Socket.
    [[0;32m  OK  [0m] Listening on udev Kernel Socket.
    [    7.344583] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
    [[0;32m  OK  [0m] Started Dispatch Password Requests to Console Directory Watch.
    [    7.374525] systemd[1]: Listening on Network Service Netlink Socket.
    [[0;32m  OK  [0m] Listening on Network Service Netlink Socket.
    [    7.403840] systemd[1]: Reached target Remote File Systems.
    [[0;32m  OK  [0m] Reached target Remote File Systems.
    [    7.434486] systemd[1]: Listening on Journal Socket.
    [[0;32m  OK  [0m] Listening on Journal Socket.
    [    7.464433] systemd[1]: Listening on Journal Socket (/dev/log).
    [[0;32m  OK  [0m] Listening on Journal Socket (/dev/log).
    [    7.493943] systemd[1]: Reached target Swap.
    [[0;32m  OK  [0m] Reached target Swap.
    [    7.515702] systemd[1]: Created slice System Slice.
    [[0;32m  OK  [0m] Created slice System Slice.
    [    7.550336] systemd[1]: Mounting POSIX Message Queue File System...
             Mounting POSIX Message Queue File System...
    [    7.584179] systemd[1]: Reached target Slices.
    [[0;32m  OK  [0m] Reached target Slices.
    [    7.636447] systemd[1]: Created slice system-serial\x2dgetty.slice.
    [[0;32m  OK  [0m] Created slice system-serial\x2dgetty.slice.
    [    7.681749] systemd[1]: Starting Create list of required static device nodes for the current kernel...
             Starting Create list of required st... nodes for the current kernel...
    [    7.741942] systemd[1]: Mounting Temporary Directory...
             Mounting Temporary Directory...
    [    7.788982] systemd[1]: Starting Remount Root and Kernel File Systems...
             Starting Remount Root and Kernel File Systems...
    [    7.869006] systemd[1]: Starting Setup Virtual Console...
             Starting Setup Virtual Console...
    [    7.953279] systemd[1]: Mounting Debug File System...
             Mounting Debug File System...
    [    8.040261] systemd[1]: Starting Load Kernel Modules...
    [    8.061751] random: nonblocking pool is initialized
             Starting Load Kernel Modules...
    [    8.088936] systemd[1]: Starting Journal Service...
             Starting Journal Service...
    [    8.154704] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
    [[0;32m  OK  [0m] Started Forward Password Requests to Wall Directory Watch.[    8.195058] cryptodev: driver 1.8 loaded.
    
    [    8.214061] systemd[1]: Reached target Paths.
    [[0;32m  OK  [0m] Reached target Paths.
    [    8.230538] systemd[1]: Created slice system-getty.slice.
    [[0;32m  OK  [0m] Created slice system-getty.slice.
    [    8.301864] systemd[1]: Mounted POSIX Message Queue File System.
    [[0;32m  OK  [0m] Mounted POSIX Message Queue File System.
    [    8.344244] systemd[1]: Mounted Debug File System.
    [[0;32m  OK  [0m] Mounted Debug File System.
    [    8.358131] systemd[1]: Mounted Temporary Directory.
    [[0;32m  OK  [0m] Mounted Temporary Directory.
    [    8.394733] systemd[1]: Started Journal Service.
    [[0;32m  OK  [0m] Started Journal Service.
    [[0;32m  OK  [0m] Started Create list of required sta...ce nodes for the current kernel.
    [[0;32m  OK  [0m] Started Remount Root and Kernel File Systems.
    [[0;32m  OK  [0m] Started Setup Virtual Console.
    [[0;32m  OK  [0m] Started Load Kernel Modules.
             Starting Apply Kernel Variables...
             Starting udev Coldplug all Devices...
             Starting Create Static Device Nodes in /dev...
             Starting Flush Journal to Persistent Storage...
    [[0;32m  OK  [0m] Started Apply Kernel Variables.
    [[0;32m  OK  [0m] Started Create Static Device Nodes in /dev.
    [    9.919704] systemd-journald[110]: Received request to flush runtime journal from PID 1
    [[0;32m  OK  [0m] Started Flush Journal to Persistent Storage.
    [[0;32m  OK  [0m] Reached target Local File Systems (Pre).
             Mounting /media/ram...
             Mounting /var/volatile...
             Starting udev Kernel Device Manager...
    [[0;32m  OK  [0m] Mounted /var/volatile.
    [[0;32m  OK  [0m] Mounted /media/ram.
    [[0;32m  OK  [0m] Started udev Kernel Device Manager.
    [[0;32m  OK  [0m] Reached target Local File Systems.
    [         Starting Create Volatile Files and Directories...
             Starting Load/Save Random Seed...
    [[0;32m  OK  [0m] Started Load/Save Random Seed.
    [   11.727049] input: matrix_keypad@0 as /devices/platform/matrix_keypad@0/input/input1
    [   11.905687] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
    [   11.957281] input: ti-tsc as /devices/platform/ocp/44e0d000.tscadc/TI-am335x-tsc/input/input2
    [   12.007329] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
    [   12.060146] 47401300.usb-phy supply vcc not found, using dummy regulator
    [   12.166388] 47401b00.usb-phy supply vcc not found, using dummy regulator
    [[0;32m  OK  [0m] Started udev Coldplug all Devices.
    [[0;32m  OK  [0m] Started Create Volatile Files and Directories.
    [   12.556714] vaux2: supplied by vbat
    [[0;32m  OK  [0m] Found device /dev/ttyS0.
    [   12.933258] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
    [   13.097528] ti-pruss 4a300000.pruss: creating PRU cores and other child platform devices
    [   13.200781] irq: no irq domain found for /ocp/pruss@4a300000/intc@4a320000 !
    [   13.279623] irq: no irq domain found for /ocp/pruss@4a300000/intc@4a320000 !
    [   13.428605]  remoteproc0: 4a334000.pru0 is available
    [   13.533926] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
    [   13.546826]  remoteproc0: Note: remoteproc is still under development and considered experimental.
    [   13.685310]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
             Starting Network Time Synchronization...
             Starting Update UTMP about System Boot/Shutdown...
    [[0;32m  OK  [0m] Created slice system-systemd\x2dbacklight.slice.
    [   13.947922]  remoteproc0: registered virtio0 (type 7)
    [   13.953089] pru-rproc 4a334000.pru0: PRU rproc node /ocp/pruss@4a300000/pru0@4a334000 probed successfully
             Starting Load/Save Screen Backlight...htness of backlight:backlight...
    [   14.088417]  remoteproc1: 4a338000.pru1 is available
    [   14.173989]  remoteproc1: Note: remoteproc is still under development and considered experimental.
    [   14.183020]  remoteproc1: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
    [[0;32m  OK  [0m] Started Load/Save Screen Backlight Brightness of backlight:backlight.
    [   14.478532]  remoteproc1: registered virtio1 (type 7)
    [   14.535001] pru-rproc 4a338000.pru1: PRU rproc node /ocp/pruss@4a300000/pru1@4a338000 probed successfully
    [[0;32m  OK  [0m] Started Network Time Synchronization.
    [   15.436424] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
    [   16.242707] [drm] Initialized pvr 1.14.3699939 20110701 on minor 1
    [   16.315580]  remoteproc2: wkup_m3 is available
    [   16.320071]  remoteproc2: Note: remoteproc is still under development and considered experimental.
    [   16.499185]  remoteproc2: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
    [   16.733835] PM: bootloader does not support rtc-only!
    [   16.746850]  remoteproc2: powering up wkup_m3
    [   16.767128]  remoteproc2: Booting fw image am335x-pm-firmware.elf, size 217228
    [   16.914982]  remoteproc2: remote processor wkup_m3 is now up
    [   16.915001] wkup_m3_ipc 44e11324.wkup_m3_ipc: CM3 Firmware Version = 0x192
    [   17.048839] asoc-simple-card sound: tlv320aic3x-hifi <-> 4803c000.mcasp mapping ok
    [[0;32m  OK  [0m] Started Update UTMP about System Boot/Shutdown.
    [   17.347865] EXT4-fs (mmcblk0p2): mounting ext3 file system using the ext4 subsystem
    [   17.396806] EXT4-fs (mmcblk0p3): mounting ext2 file system using the ext4 subsystem
    [   17.455765] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
    [   17.469294] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [   17.488234] EXT4-fs (mmcblk0p3): warning: mounting unchecked fs, running e2fsck is recommended
    [   17.555892] EXT4-fs (mmcblk0p3): mounted filesystem without journal. Opts: (null)
    [[0;32m  OK  [0m] Found device /dev/ttyS3.
    [[0;32m  OK  [0m] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
             Starting Synchronize System and HW clocks...
    [[0;32m  OK  [0m] Reached target System Time Synchronized.
    [[0;32m  OK  [0m] Started Synchronize System and HW clocks.
    [   21.754951] usbcore: registered new interface driver usbfs
    [   21.760573] usbcore: registered new interface driver hub
    [   21.843120] usbcore: registered new device driver usb
    [   21.989165] musb-hdrc musb-hdrc.0.auto: MUSB HDRC host driver
    [   22.036450] musb-hdrc musb-hdrc.0.auto: new USB bus registered, assigned bus number 1
    [   22.110121] hub 1-0:1.0: USB hub found
    [   22.153722] hub 1-0:1.0: 1 port detected
    [   22.185192]  remoteproc0: powering up 4a334000.pru0
    [   22.209936] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
    [   22.229077]  remoteproc0: Booting fw image am335x-pru0-fw, size 75128
    [   22.271018] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 2
    [   22.279257] ti-pruss 4a300000.pruss: configured system_events = 0x0000000000030000 intr_channels = 0x00000005 host_intr = 0x00000005
    [   22.345667] hub 2-0:1.0: USB hub found
    [   22.367064] hub 2-0:1.0: 1 port detected
    [   22.371590]  remoteproc0: remote processor 4a334000.pru0 is now up
    [   22.401270] virtio_rpmsg_bus virtio0: creating channel rpmsg-pru addr 0x1e
    [   22.410559] virtio_rpmsg_bus virtio0: rpmsg host is online
    [   22.455196]  remoteproc1: powering up 4a338000.pru1
    [   22.488945]  remoteproc1: Booting fw image am335x-pru1-fw, size 75128
    [   22.533886] ti-pruss 4a300000.pruss: configured system_events = 0x00000000000c0000 intr_channels = 0x0000000a host_intr = 0x0000000a
    [   22.617547]  remoteproc1: remote processor 4a338000.pru1 is now up
    [   22.650859] virtio_rpmsg_bus virtio1: creating channel rpmsg-pru addr 0x1f
    [   22.659705] virtio_rpmsg_bus virtio1: rpmsg host is online
    [   22.774132] rpmsg_pru rpmsg0: new rpmsg_pru device: /dev/rpmsg_pru30
    [   22.788203] rpmsg_pru rpmsg1: new rpmsg_pru device: /dev/rpmsg_pru31
    [   22.794902] usb 2-1: new high-speed USB device number 2 using musb-hdrc
    [   22.957101] hub 2-1:1.0: USB hub found
    [   22.961924] hub 2-1:1.0: 4 ports detected
    [   23.423605] usb 2-1.1: new high-speed USB device number 3 using musb-hdrc
    [   23.548062] hub 2-1.1:1.0: USB hub found
    [   23.560549] hub 2-1.1:1.0: 4 ports detected
    [   23.673610] usb 2-1.2: new full-speed USB device number 4 using musb-hdrc
    [   23.883663] usb 2-1.1.2: new high-speed USB device number 5 using musb-hdrc
    [   23.965024] input: Logitech Logitech USB Headset as /devices/platform/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1/2-1.2/2-1.2:1.3/0003:046D:0A44.0001/input/input3
    [   24.104071] hid-generic 0003:046D:0A44.0001: input: USB HID v1.00 Device [Logitech Logitech USB Headset] on usb-musb-hdrc.1.auto-1.2/input3
    [   24.126221] usbcore: registered new interface driver usbhid
    [   24.132395] usbhid: USB HID core driver
    [   24.303617] usb 2-1.3: new high-speed USB device number 6 using musb-hdrc
    [[0;32m  OK  [0m] Reached target Sound Card.
    [[0;32m  OK  [0m] Reached target System Initialization.
    [[0;32m  OK  [0m] Listening on RPCbind Server Activation Socket.
    [[0;32m  OK  [0m] Started Daily Cleanup of Temporary Directories.
    [[0;32m  OK  [0m] Reached target Timers.
    [[0;32m  OK  [0m] Listening on dropbear.socket.
    [[0;32m  OK  [0m] Listening on D-Bus System Message Bus Socket.
    [[0;32m  OK  [0m] Reached target Sockets.
    [[0;32m  OK  [0m] Reached target Basic System.
             Starting uim-sysfs.service...
    [[0;32m  OK  [0m] Started strongSwan IPsec IKEv1/IKEv2 daemon using ipsec.conf.
    [[0;32m  OK  [0m] Started Kernel Logging Service.
    [[0;32m  OK  [0m] Started System Logging Service.
             Starting Permit User Sessions...
    [[0;32m  OK  [0m] Started D-Bus System Message Bus.
    [   25.624138] usb 2-1.1.2: set resolution quirk: cval->res = 384
    [   25.677776] usbcore: registered new interface driver snd-usb-audio
    [   25.803764] usb 2-1.1.3: new high-speed USB device number 7 using musb-hdrc
    [   25.962114] SCSI subsystem initialized
    [   25.993700] uvcvideo: Found UVC 1.00 device <unnamed> (046d:081b)
    [   26.043819] usb 2-1.4: new high-speed USB device number 8 using musb-hdrc
    [   26.189785] usb-storage 2-1.3:1.0: USB Mass Storage device detected
    [   26.211735] input: UVC Camera (046d:081b) as /devices/platform/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1/2-1.1/2-1.1.2/2-1.1.2:1.0/input/input4
    [   26.274175] scsi host0: usb-storage 2-1.3:1.0
    [   26.300077] usb-storage 2-1.1.3:1.0: USB Mass Storage device detected
    [   26.334903] usbcore: registered new interface driver uvcvideo
    [   26.346105] usb-storage 2-1.4:1.0: USB Mass Storage device detected
    [   26.371646] USB Video Class driver (1.1.1)
    [   26.396804] scsi host2: usb-storage 2-1.1.3:1.0
    [   26.411057] scsi host1: usb-storage 2-1.4:1.0
    [   26.442664] usbcore: registered new interface driver usb-storage
             Starting Network Service...
             Starting Login Service...
             Starting Print notice about GPLv3 packages...
             Starting Save/Restore Sound Card State...
    [   27.263331] NET: Registered protocol family 15
    [[0;32m  OK  [0m] Started Permit User Sessions.
    [   27.302750] scsi 0:0:0:0: Direct-Access     Kingston DataTraveler 3.0 PMAP PQ: 0 ANSI: 6
    [   27.442194] scsi 2:0:0:0: Direct-Access     SanDisk  Extreme          0001 PQ: 0 ANSI: 6
    [   27.454508] scsi 1:0:0:0: Direct-Access     PNY      USB 3.0 FD       PMAP PQ: 0 ANSI: 6
    [   27.565772] sd 0:0:0:0: [sda] 30277632 512-byte logical blocks: (15.5 GB/14.4 GiB)
    [   27.613344] sd 2:0:0:0: [sdb] 30651688 512-byte logical blocks: (15.7 GB/14.6 GiB)
    [   27.653831] sd 0:0:0:0: [sda] Write Protect is off
    [   27.688910] sd 2:0:0:0: [sdb] Write Protect is off
    [   27.712347] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [   27.754476] sd 2:0:0:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [[0;32m  OK  [0m] Started Network Service.
    [   27.921478]  sdb: sdb1
    [   27.924649]  sda: sda1
    [   27.938102] sd 0:0:0:0: [sda] Attached SCSI removable disk
    [[0;32m  OK  [0m] Started Save/Restore Sound Card State.
    [   27.992455] sd 2:0:0:0: [sdb] Attached SCSI removable disk
    [   28.116782] sd 1:0:0:0: [sdc] 30965760 512-byte logical blocks: (15.9 GB/14.8 GiB)
    [   28.168414] sd 1:0:0:0: [sdc] Write Protect is off
    [   28.209331] sd 1:0:0:0: [sdc] No Caching mode page found
    [   28.262628] sd 1:0:0:0: [sdc] Assuming drive cache: write through
    [   28.318797]  sdc: sdc1
    [   28.357264] sd 1:0:0:0: [sdc] Attached SCSI removable disk
    [   29.113278] Initializing XFRM netlink socket
    [   31.299062] FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [   31.603812] FAT-fs (sdc1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [[0;32m  OK  [0m] Started Login Service.
    [[0;32m  OK  [0m] Reached target Network.
             Starting Lightning Fast Webserver With Light System Requirements...
             Starting Network Name Resolution...
    [[0;32m  OK  [0m] Started Serial Getty on ttyS3.
    [[0;32m  OK  [0m] Started Serial Getty on ttyS0.
    [[0;32m  OK  [0m] Started Getty on tty1.
    [[0;32m  OK  [0m] Started Lightning Fast Webserver With Light System Requirements.
    [[0;32m  OK  [0m] Started Network Name Resolution.
    [[0;32m  OK  [0m] Started uim-sysfs.service.
             Starting rc.pvr.service...
    [   36.052101] PVR_K: UM DDK-(3699939) and KM DDK-(3699939) match. [ OK ]
    [[0;32m  OK  [0m] Started rc.pvr.service.
             Starting weston.service...
    [[0;32m  OK  [0m] Started weston.service.
             Starting telnetd.service...
    ***************************************************************
    ***************************************************************
    NOTICE: This file system contains the following GPLv3 packages:
    	autoconf
    	binutils
    	cpp-symlinks
    	cpp
    	dosfstools
    	g++-symlinks
    	g++
    	gcc-symlinks
    	gcc
    	gdb
    	gdbserver
    	gstreamer1.0-libav
    	libgmp10
    	libidn11
    	libmpc3
    	libmpfr4
    	make
    	nettle
    
    [[0;32m  OK  [0m] Started telnetd.service.
    If you do not wish to distribute GPLv3 components please remove
    the above packages prior to distribution.  This can be done using
    the opkg remove command.  i.e.:
        opkg remove <package>
    Where <package> is the name printed in the list above
    
    NOTE: If the package is a dependency of another package you
          will be notified of the dependent packages.  You should
          use the --force-removal-of-dependent-packages option to
          also remove the dependent packages as well
    ***************************************************************
    ***************************************************************
             Starting thttpd.service...
    [[0;32m  OK  [0m] Started Print notice about GPLv3 packages.
    [   37.209470] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000020): FIFO underfow
    [   37.213738] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.214698] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.229922] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.230835] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.245709] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.246046] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.247010] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   37.267464] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [   37.281411] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [   37.300448] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [[0;32m  OK  [0m] Started thttpd.service.
             Starting rng-tools.service...
    [   37.553997] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost flood detected, disabling the interrupt
    [[0;32m  OK  [0m] Started rng-tools.service.
             Starting matrix-gui-2.0.service...
    [[0;32m  OK  [0m] Started matrix-gui-2.0.service.
             Starting thermal-zone-init.service...
             Starting parse-ip.service...
    [[0;32m  OK  [0m] Started thermal-zone-init.service.
    [[0;32m  OK  [0m] Started parse-ip.service.
    
    
     _____                    _____           _         _   
    |  _  |___ ___ ___ ___   |  _  |___ ___  |_|___ ___| |_ 
    |     |  _| .'| . | . |  |   __|  _| . | | | -_|  _|  _|
    |__|__|_| |__,|_  |___|  |__|  |_| |___|_| |___|___|_|  
                  |___|                    |___|            
    
    Arago Project http://arago-project.org am335x-evm ttyS0
    
    Arago 2016.08 am335x-evm ttyS0
    
    am335x-evm login: 
    - 17:30:10 [INFO] Host: root
    - 17:30:17 [INFO] Target: 
    root
    
    7[r[999;999H[6nroot@am335x-evm:~# 
    - 17:30:17 [INFO] Sleeping 15 secs to allow systemd to finish starting processes...
    - 17:30:32 [INFO] Disconnected serial from am335x-evm
    - 17:30:32 [INFO] Connected to am335x-evm via serial 
    - 17:30:32 [INFO] Host: uname -a
    - 17:30:32 [INFO] Target: 
    uname -a
    Linux am335x-evm 4.4.20-g00f19d3e53 #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016 armv7l GNU/Linux
    root@am335x-evm:~# 
    - 17:30:32 [INFO] Host: cat /proc/cmdline
    - 17:30:32 [INFO] Target: 
    cat /proc/cmdline
    console=ttyO0,115200n8 earlyprintk=serial,ttyO0,115200n8 rootwait   ip=:::::eth0:dhcp  root=/dev/nfs rw nfsroot=192.168.0.1:/home/tigtfarm04/NFS_exports/linux/am335x-evm/autofs/b12391b17f5a95e11a1a3fee15f5eb52,nolock,v3,tcp,rsize=4096,wsize=4096 
    root@am335x-evm:~# 
    - 17:30:32 [INFO] Host: uname -a
    - 17:30:32 [INFO] Target: 
    uname -a
    Linux am335x-evm 4.4.20-g00f19d3e53 #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016 armv7l GNU/Linux
    root@am335x-evm:~# 
    - 17:30:32 [INFO] Host: cat /proc/mtd
    - 17:30:32 [INFO] Target: 
    cat /proc/mtd
    dev:    size   erasesize  name
    mtd0: 00020000 00020000 "NAND.SPL"
    mtd1: 00020000 00020000 "NAND.SPL.backup1"
    mtd2: 00020000 00020000 "NAND.SPL.backup2"
    mtd3: 00020000 00020000 "NAND.SPL.backup3"
    mtd4: 00040000 00020000 "NAND.u-boot-spl-os"
    mtd5: 00100000 00020000 "NAND.u-boot"
    mtd6: 00020000 00020000 "NAND.u-boot-env"
    mtd7: 00020000 00020000 "NAND.u-boot-env.backup1"
    mtd8: 00800000 00020000 "NAND.kernel"
    mtd9: 0f600000 00020000 "NAND.file-system"
    root@am335x-evm:~# 
    - 17:30:32 [INFO] Host: cat /proc/diskstats
    - 17:30:33 [INFO] Target: 
    cat /proc/diskstats
       7       0 loop0 0 0 0 0 0 0 0 0 0 0 0
       7       1 loop1 0 0 0 0 0 0 0 0 0 0 0
       7       2 loop2 0 0 0 0 0 0 0 0 0 0 0
       7       3 loop3 0 0 0 0 0 0 0 0 0 0 0
       7       4 loop4 0 0 0 0 0 0 0 0 0 0 0
       7       5 loop5 0 0 0 0 0 0 0 0 0 0 0
       7       6 loop6 0 0 0 0 0 0 0 0 0 0 0
       7       7 loop7 0 0 0 0 0 0 0 0 0 0 0
      31       0 mtdblock0 0 0 0 0 0 0 0 0 0 0 0
      31       1 mtdblock1 0 0 0 0 0 0 0 0 0 0 0
      31       2 mtdblock2 0 0 0 0 0 0 0 0 0 0 0
      31       3 mtdblock3 0 0 0 0 0 0 0 0 0 0 0
      31       4 mtdblock4 0 0 0 0 0 0 0 0 0 0 0
      31       5 mtdblock5 0 0 0 0 0 0 0 0 0 0 0
      31       6 mtdblock6 0 0 0 0 0 0 0 0 0 0 0
      31       7 mtdblock7 0 0 0 0 0 0 0 0 0 0 0
      31       8 mtdblock8 0 0 0 0 0 0 0 0 0 0 0
      31       9 mtdblock9 0 0 0 0 0 0 0 0 0 0 0
     179       0 mmcblk0 215 58 15213 1090 7 0 21 110 0 590 1200
     179       1 mmcblk0p1 65 0 5179 390 5 0 5 90 0 330 480
     179       2 mmcblk0p2 56 29 4472 300 1 0 8 10 0 220 310
     179       3 mmcblk0p3 57 29 4450 280 1 0 8 10 0 220 290
       8       0 sda 75 0 4176 350 0 0 0 0 0 230 350
       8       1 sda1 57 0 3120 250 0 0 0 0 0 140 250
       8      16 sdb 112 11 6395 510 0 0 0 0 0 280 510
       8      17 sdb1 106 11 6347 480 0 0 0 0 0 270 480
       8      32 sdc 113 27 6363 380 0 0 0 0 0 240 380
       8      33 sdc1 95 27 5307 280 0 0 0 0 0 190 280
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: cat /proc/interrupts
    - 17:30:33 [INFO] Target: 
    cat /proc/interrupts
               CPU0       
     16:       6243      INTC  68 Level     gp_timer
     19:          1      INTC  78 Level     wkup_m3_txev
     20:        799      INTC  12 Level     49000000.edma_ccint
     22:          6      INTC  14 Level     49000000.edma_ccerrint
     26:          0      INTC  96 Level     44e07000.gpio
     29:          0  44e07000.gpio   2 Edge      volume-up
     30:          0  44e07000.gpio   3 Edge      volume-down
     33:          0  44e07000.gpio   6 Edge      48060000.mmc cd
     59:          0      INTC  98 Level     4804c000.gpio
     85:          0  4804c000.gpio  25 Edge      matrix-keypad
     86:          0  4804c000.gpio  26 Edge      matrix-keypad
     87:          0  4804c000.gpio  27 Edge      matrix-keypad
     92:          0      INTC  32 Level     481ac000.gpio
    125:          0      INTC  62 Level     481ae000.gpio
    158:        395      INTC  72 Level     44e09000.serial
    160:        299      INTC  70 Level     44e0b000.i2c
    161:          0      INTC  71 Level     4802a000.i2c
    162:        695      INTC  64 Level     mmc1
    163:         13      INTC  29 Level     mmc0
    165:          0      INTC  77 Level     wkup_m3
    171:          0      INTC  75 Level     rtc0
    172:          0      INTC  76 Level     rtc0
    174:      68793      INTC  41 Level     4a100000.ethernet
    175:      61067      INTC  42 Level     4a100000.ethernet
    177:          0      INTC   4 Level     48080000.elm
    178:       3892      INTC  36 Level     tilcdc
    179:          0      INTC  16 Level     TI-am335x-tsc, TI-am335x-adc
    180:          0      INTC 100 Level     gpmc
    181:         12      INTC 109 Level     53100000.sham
    183:          0      INTC  82 Level     4803c000.mcasp_tx
    184:          0      INTC  83 Level     4803c000.mcasp_rx
    185:          0      INTC 111 Level     48310000.rng
    186:        693      INTC  37 Level     SGX ISR
    190:          0      INTC  18 Level     musb-hdrc.0.auto
    191:        753      INTC  19 Level     musb-hdrc.1.auto
    192:      17956      INTC  17 Level     47400000.dma-controller
    201:          1  4a320000.intc  16 Edge      remoteproc0
    203:          1  4a320000.intc  18 Edge      remoteproc1
    Err:          0
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: cat /proc/softirqs
    - 17:30:33 [INFO] Target: 
    cat /proc/softirqs
                        CPU0       
              HI:          4
           TIMER:       5138
          NET_TX:         12
          NET_RX:     119499
           BLOCK:        495
    BLOCK_IOPOLL:          0
         TASKLET:        864
           SCHED:          0
         HRTIMER:          0
             RCU:      12200
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: export IPERFHOST=192.168.0.1
    - 17:30:33 [INFO] Target: 
    export IPERFHOST=192.168.0.1
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: export NFS_SERVER=192.168.0.1
    - 17:30:33 [INFO] Target: 
    export NFS_SERVER=192.168.0.1
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: export NFS_ROOT_PATH=/home/tigtfarm04/NFS_exports/linux/am335x-evm
    - 17:30:33 [INFO] Target: 
    export NFS_ROOT_PATH=/home/tigtfarm04/NFS_exports/linux/am335 
    x-evm
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: export AP_SSID=
    - 17:30:33 [INFO] Target: 
    export AP_SSID=
    root@am335x-evm:~# 
    - 17:30:33 [INFO] Host: mkdir -p -m 777 /test
    - 17:30:34 [INFO] Target: 
    mkdir -p -m 777 /test
    root@am335x-evm:~# 
    - 17:30:34 [INFO] Host: cd /test
    - 17:30:34 [INFO] Target: 
    cd /test
    root@am335x-evm:/test# 
    - 17:30:34 [INFO] Host: cat > test.sh << EOF
    - 17:30:34 [INFO] Target: 
    cat > test.sh << EOF
    > 
    - 17:30:34 [INFO] Host: failtest() {
    
    - 17:30:34 [INFO] Target: 
    failtest() {
    > 
    - 17:30:34 [INFO] Host:   echo 1 >&3
    
    - 17:30:34 [INFO] Target: 
      echo 1 >&3
    > 
    - 17:30:34 [INFO] Host: }
    
    - 17:30:34 [INFO] Target: 
    }
    > 
    - 17:30:34 [INFO] Host: timeout=600
    
    - 17:30:34 [INFO] Target: 
    timeout=600
    > 
    - 17:30:34 [INFO] Host: 
    
    - 17:30:34 [INFO] Target: 
    
    > 
    - 17:30:34 [INFO] Host: # Start of user's script logic
    
    - 17:30:34 [INFO] Target: 
    # Start of user's script logic
    > 
    - 17:30:34 [INFO] Host: cd /opt/ltp
    
    - 17:30:34 [INFO] Target: 
    cd /opt/ltp
    > 
    - 17:30:34 [INFO] Host: ./runltp -P am335x-evm -f ddt/nand_mtd_dd_rw_ubifs -s "NAND_S_FUNC_DD_RW_UBIFS_ERASESIZE "
    
    - 17:30:35 [INFO] Target: 
    ./runltp -P am335x-evm -f ddt/nand_mtd_dd_rw_ubifs -s "NAND_S_FUNC_DD_RW_UBIFS 
    _ERASESIZE "
    > 
    - 17:30:35 [INFO] Host: EOF
    - 17:30:35 [INFO] Target: 
    EOF
    root@am335x-evm:/test# 
    - 17:30:35 [INFO] Host: eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | head -1`;ifconfig $eth
    - 17:30:35 [INFO] Target: 
    eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | hea 
    d -1`;ifconfig $eth
    eth0      Link encap:Ethernet  HWaddr D0:FF:50:57:02:D9  
              inet addr:192.168.0.53  Bcast:192.168.0.255  Mask:255.255.255.0
              inet6 addr: fe80::d2ff:50ff:fe57:2d9%3068146456/64 Scope:Link
              UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
              RX packets:80115 errors:0 dropped:0 overruns:0 frame:0
              TX packets:69607 errors:0 dropped:0 overruns:0 carrier:0
              collisions:0 txqueuelen:1000 
              RX bytes:92815506 (88.5 MiB)  TX bytes:9788588 (9.3 MiB)
              Interrupt:174 
    
    root@am335x-evm:/test# 
    - 17:30:35 [INFO] Host: eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | head -1`;ifconfig $eth
    - 17:30:35 [INFO] Target: 
    eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | hea 
    d -1`;ifconfig $eth
    eth0      Link encap:Ethernet  HWaddr D0:FF:50:57:02:D9  
              inet addr:192.168.0.53  Bcast:192.168.0.255  Mask:255.255.255.0
              inet6 addr: fe80::d2ff:50ff:fe57:2d9%3068896024/64 Scope:Link
              UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
              RX packets:80131 errors:0 dropped:0 overruns:0 frame:0
              TX packets:69625 errors:0 dropped:0 overruns:0 carrier:0
              collisions:0 txqueuelen:1000 
              RX bytes:92818418 (88.5 MiB)  TX bytes:9791696 (9.3 MiB)
              Interrupt:174 
    
    root@am335x-evm:/test# 
    - 17:31:07 [INFO] Connected to am335x-evm via telnet 
    - 17:31:08 [INFO] Host: cd /test
    - 17:31:08 [INFO] Target: 
    cd /test
    root@am335x-evm:/test# 
    - 17:31:08 [INFO] Host: chmod +x test.sh
    - 17:31:08 [INFO] Target: 
    chmod +x test.sh
    root@am335x-evm:/test# 
    - 17:31:08 [INFO] Host: ./test.sh 2>&1 3> result.log
    - 17:31:41 [INFO] Target: 
    ./test.sh 2>&1 3> result.log
    INFO: creating /opt/ltp/results directory
    INFO: Filtering testscenarios based on am335x-evm capabilities
    Checking for required user/group ids
    
    'nobody' user id and group found.
    'bin' user id and group found.
    'daemon' user id and group found.
    Users group found.
    Sys group found.
    Required users/groups exist.
    If some fields are empty or look unusual you may have an old version.
    Compare to the current minimal requirements in Documentation/Changes.
     
    ID="arago"
    NAME="Arago"
    VERSION="2016.08"
    VERSION_ID="2016.08"
    PRETTY_NAME="Arago 2016.08"
    Linux am335x-evm 4.4.20-g00f19d3e53 #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016 armv7l GNU/Linux
     
    Gnu C                  gcc (Linaro GCC 5.3-2016.02) 5.3.1 20160113
    Gnu make               4.1
    util-linux             /opt/ltp/ver_linux: line 29: fdformat: command not found
    mount                  linux 2.27.1 (libmount 2.27.0: assert, debug)
    modutils               22
    e2fsprogs              1.43-WIP
    /opt/ltp/ver_linux: line 50: ldd: command not found
    Linux C Library        r..    1 root     root           323 Sep 10 06:30 alltests
    Linux C Library        .    1 root     root          1054 Sep 10 06:30 alltests.orig
    Linux C Library        drwxr.xr.x   25 root     root           500 Sep 10 06:30 platform
    /opt/ltp/ver_linux: line 54: ldd: command not found
    Linux C++ Library      /../lib/libstdc++
    Procps                 3.3.11
    iproute2              iproute2-ss160111
    Kbd                    2.0.3
    Sh-utils               --v
    Modules Loaded         bc_example sha512_generic sha512_arm drbg des_generic cbc xfrm_user xfrm4_tunnel ipcomp xfrm_ipcomp esp4 ah4 sd_mod af_key xfrm_algo usb_storage scsi_mod uvcvideo videobuf2_vmalloc snd_usb_audio snd_hwdep snd_usbmidi_lib snd_rawmidi usbhid rpmsg_pru virtio_rpmsg_bus musb_dsps musb_hdrc udc_core usbcore ti_am335x_adc kfifo_buf snd_soc_simple_card pm33xx wkup_m3_ipc ti_emif_sram wkup_m3_rproc ecb sha256_generic hmac md5 sha1_generic sha1_arm_neon sha1_arm pvrsrvkm omap_aes_driver omap_sham pru_rproc pruss_intc pruss remoteproc virtio virtio_ring omap_rng rng_core snd_soc_tlv320aic3x ti_am335x_tsc musb_am335x rtc_omap omap_wdt ti_am335x_tscadc matrix_keypad matrix_keymap sch_fq_codel cryptodev
    
    free reports:
                  total        used        free      shared  buff/cache   available
    Mem:        1028824       56312      841064       15156      131448      933140
    Swap:             0           0           0
    
    /proc/cpuinfo
    processor	: 0
    model name	: ARMv7 Processor rev 2 (v7l)
    BogoMIPS	: 996.14
    Features	: half thumb fastmult vfp edsp neon vfpv3 tls vfpd32 
    CPU implementer	: 0x41
    CPU architecture: 7
    CPU variant	: 0x3
    CPU part	: 0xc08
    CPU revision	: 2
    
    Hardware	: Generic AM33XX (Flattened Device Tree)
    Revision	: 0000
    Serial		: 0000000000000000
    no big block device was specified on commandline.
    Tests which require a big block device are disabled.
    You can specify it with option -z
    COMMAND:    /opt/ltp/bin/ltp-pan  -e -S   -a 1085     -n 1085  -p  -f /tmp/ltp-XXXXnLPQHA/alltests -l /tmp/tmp.BYFo4v  -C /opt/ltp/output/LTP_RUN_ON-tmp.BYFo4v.failed -T /opt/ltp/output/LTP_RUN_ON-tmp.BYFo4v.tconf
    INFO: Restricted to NAND_S_FUNC_DD_RW_UBIFS_ERASESIZE 
    LOG File: /tmp/tmp.BYFo4v
    FAILED COMMAND File: /opt/ltp/output/LTP_RUN_ON-tmp.BYFo4v.failed
    TCONF COMMAND File: /opt/ltp/output/LTP_RUN_ON-tmp.BYFo4v.tconf
    Running tests.......
    <<<test_start>>>
    tag=NAND_S_FUNC_DD_RW_UBIFS_ERASESIZE stime=1473489020
    cmdline="source "common.sh"; install_modules.sh "nand"; part=`get_mtd_partition_number.sh "nand"` || die "error getting mtd part number: $part"; size=`get_mtd_erase_size.sh "$part"` || die "error getting mtd erase size: $size"; blk_device_dd_readwrite_test.sh -f "ubifs" -b "$size" -c 10 -d "nand""
    contacts=""
    analysis=exit
    <<<test_output>>>
    incrementing stop
    |TRACE LOG|DEV_NODE returned from get_blk_device_node is: /dev/mtdblock9|
    |TRACE LOG|DEV_NODE: /dev/mtdblock9|
    |TRACE LOG|MNT_POINT: /mnt/partition_nand_1698|
    |TRACE LOG|FS_TYPE: ubifs|
    |TRACE LOG|Inside do_cmd:CMD=printout_model /dev/mtdblock9 nand|
    |TRACE LOG|model info is not available for non scsi devices.|
    |TRACE LOG|Inside do_cmd:CMD=blk_device_prepare_format.sh -d nand -n /dev/mtdblock9 -f ubifs -m /mnt/partition_nand_1698|
    |TRACE LOG|DEV_NODE: /dev/mtdblock9|
    |TRACE LOG|MNT_POINT: /mnt/partition_nand_1698|
    |TRACE LOG|FS_TYPE: ubifs|
    |TRACE LOG|MNT_MODE: async|
    |TRACE LOG|Erasing/Formatting this partition and then mount it|
    |TRACE LOG|Inside do_cmd:CMD=blk_device_erase_format_part.sh -d nand -n /dev/mtdblock9 -f ubifs -m /mnt/partition_nand_1698|
    |TRACE LOG|DEVICE TYPE: nand|
    |TRACE LOG|DEVICE NODE: /dev/mtdblock9|
    |TRACE LOG|FS TYPE: ubifs|
    |TRACE LOG|Umount /dev/mtdblock9 or /dev/mtdblock if it is mounted|
    |TRACE LOG|device type is mtd|
    |TRACE LOG|mtd eraseblocks: 1968|
    |TRACE LOG|mtd subpage size: 512|
    |TRACE LOG|mtd pagesize: 2048|
    |TRACE LOG|Detach /dev/mtd9|
    |TRACE LOG|umount /mnt/partition_nand_1698|
    umount: can't unmount /mnt/partition_nand_1698: No such file or directory
    |TRACE LOG|ubidetach -p /dev/mtd9|
    ubidetach: error!: cannot detach "/dev/mtd9"
               error 19 (No such device)
    /dev/ubi_ctrl
    |TRACE LOG|Inside do_cmd:CMD=ubiformat /dev/mtd9 -y -q|
    |TRACE LOG|Inside do_cmd:CMD=ubiattach -p /dev/mtd9 |
    [  112.580919] ubi0: attaching mtd9
    [  113.113981] ubi0: scanning is finished
    [  113.132277] ubi0: attached mtd9 (name "NAND.file-system", size 246 MiB)
    [  113.147518] ubi0: PEB size: 131072 bytes (128 KiB), LEB size: 129024 bytes
    [  113.154671] ubi0: min./max. I/O unit sizes: 2048/2048, sub-page size 512
    [  113.161402] ubi0: VID header offset: 512 (aligned 512), data offset: 2048
    [  113.173385] ubi0: good PEBs: 1966, bad PEBs: 2, corrupted PEBs: 0
    [  113.181712] ubi0: user volume: 0, internal volumes: 1, max. volumes count: 128
    [  113.191132] ubi0: max/mean erase counter: 0/0, WL threshold: 4096, image sequence number: 127215645
    [  113.202300] ubi0: available PEBs: 1924, total reserved PEBs: 42, PEBs reserved for bad PEB handling: 38
    [  113.213856] ubi0: background thread "ubi_bgt0d" started, PID 2006
    UBI device number 0, total 1966 LEBs (253661184 bytes, 241.9 MiB), available 1924 LEBs (248242176 bytes, 236.7 MiB), LEB size 129024 bytes (126.0 KiB)
    |TRACE LOG|ubi device: ubi0 |
    |TRACE LOG|Inside do_cmd:CMD=ls /dev/ub*|
    /dev/ubi0      /dev/ubi_ctrl
    |TRACE LOG|Inside do_cmd:CMD=ubimkvol /dev/ubi0 -N test -S 1924|
    Volume ID 0, size 1924 LEBs (248242176 bytes, 236.7 MiB), LEB size 129024 bytes (126.0 KiB), dynamic, name "test", alignment 1
    |TRACE LOG|Inside do_cmd:CMD=blk_device_do_mount.sh -n /dev/mtdblock9 -f ubifs -d nand -m /mnt/partition_nand_1698 -o async|
    |TRACE LOG|Umount /mnt/partition_nand_1698 if it is mounted|
    |TRACE LOG|Inside do_cmd:CMD=mkdir -p /mnt/partition_nand_1698|
    |TRACE LOG|Mounting the partition|
    |TRACE LOG|Inside do_cmd:CMD=mount -t ubifs -o async ubi0:test /mnt/partition_nand_1698|
    [  116.979752] UBIFS (ubi0:0): default file-system created
    [  116.998917] UBIFS (ubi0:0): background thread "ubifs_bgt0_0" started, PID 2049
    [  117.057024] UBIFS (ubi0:0): UBIFS: mounted UBI device 0, volume 0, name "test"
    [  117.064612] UBIFS (ubi0:0): LEB size: 129024 bytes (126 KiB), min./max. I/O unit sizes: 2048 bytes/2048 bytes
    [  117.080736] UBIFS (ubi0:0): FS size: 246564864 bytes (235 MiB, 1911 LEBs), journal size 12386304 bytes (11 MiB, 96 LEBs)
    [  117.099458] UBIFS (ubi0:0): reserved for root: 4952683 bytes (4836 KiB)
    [  117.106403] UBIFS (ubi0:0): media format: w4/r0 (latest is w4/r0), UUID 6923540A-6AB8-434A-AFAF-ED95D795661C, small LPT model
    |TRACE LOG|Inside do_cmd:CMD=mount | grep /mnt/partition_nand_1698|
    ubi0:test on /mnt/partition_nand_1698 type ubifs (rw,relatime)
    |TRACE LOG|Doing read/write test for 1 times|
    |TRACE LOG|Inside do_cmd:CMD=time dd if=/dev/urandom of=/home/root/srctest_file_nand_1698 bs=131072 count=10|
    10+0 records in
    10+0 records out
    real	0m 0.45s
    user	0m 0.00s
    sys	0m 0.37s
    |TRACE LOG|Inside do_cmd:CMD=ls -lh /home/root/srctest_file_nand_1698|
    -rw-rw-rw-    1 root     root        1.3M Sep 14  2016 /home/root/srctest_file_nand_1698
    |TRACE LOG|Inside do_cmd:CMD=df -h|
    Filesystem                Size      Used Available Use% Mounted on
    192.168.0.1:/home/tigtfarm04/NFS_exports/linux/am335x-evm/autofs/b12391b17f5a95e11a1a3fee15f5eb52
                            885.4G    644.4G    196.0G  77% /
    devtmpfs                490.2M      4.0K    490.2M   0% /dev
    tmpfs                   502.4M         0    502.4M   0% /dev/shm
    tmpfs                   502.4M      7.9M    494.4M   2% /run
    tmpfs                   502.4M         0    502.4M   0% /sys/fs/cgroup
    tmpfs                   502.4M     26.4M    476.0M   5% /tmp
    tmpfs                    16.0M         0     16.0M   0% /media/ram
    tmpfs                    50.0M     24.0K     50.0M   0% /var/volatile
    /dev/mmcblk0p2          871.9M      1.5M    825.2M   0% /run/media/mmcblk0p2
    /dev/mmcblk0p1           69.5M    838.0K     68.6M   1% /run/media/mmcblk0p1
    /dev/mmcblk0p3            2.6G      4.0M      2.5G   0% /run/media/mmcblk0p3
    /dev/sdb1                14.6G      8.0K     14.6G   0% /run/media/sdb1
    /dev/sdc1                14.8G      1.1M     14.7G   0% /run/media/sdc1
    tmpfs                   100.5M         0    100.5M   0% /run/user/0
    ubi0:test               220.5M     20.0K    215.7M   0% /mnt/partition_nand_1698
    ============R/W LOOP: 0============
    |TRACE LOG|Inside do_cmd:CMD=date|
    Sat Sep 10 06:30:47 UTC 2016
    |TRACE LOG|Inside do_cmd:CMD=time dd if=/home/root/srctest_file_nand_1698 of=/mnt/partition_nand_1698/test_file_1698 bs=131072 count=10|
    10+0 records in
    10+0 records out
    real	0m 0.02s
    user	0m 0.01s
    sys	0m 0.01s
    |TRACE LOG|Inside do_cmd:CMD=sync|
    |TRACE LOG|Inside do_cmd:CMD=echo 3 > /proc/sys/vm/drop_caches|
    [  129.911268] blk_device_dd_r (1698): drop_caches: 3
    |TRACE LOG|diff /home/root/srctest_file_nand_1698 /mnt/partition_nand_1698/test_file_1698 |
    |TRACE LOG|Inside do_cmd:CMD=time dd if=/mnt/partition_nand_1698/test_file_1698 of=/dev/null bs=131072 count=10|
    10+0 records in
    10+0 records out
    real	0m 0.02s
    user	0m 0.00s
    sys	0m 0.01s
    |TRACE LOG|Inside do_cmd:CMD=sync|
    |TRACE LOG|Inside do_cmd:CMD=echo 3 > /proc/sys/vm/drop_caches|
    [  130.345645] blk_device_dd_r (1698): drop_caches: 3
    |TRACE LOG|Inside do_cmd:CMD=rm /mnt/partition_nand_1698/test_file_1698|
    |TRACE LOG|Inside do_cmd:CMD=date|
    Sat Sep 10 06:30:49 UTC 2016
    |TRACE LOG|Inside do_cmd:CMD=df -h|
    Filesystem                Size      Used Available Use% Mounted on
    192.168.0.1:/home/tigtfarm04/NFS_exports/linux/am335x-evm/autofs/b12391b17f5a95e11a1a3fee15f5eb52
                            885.4G    644.4G    196.0G  77% /
    devtmpfs                490.2M      4.0K    490.2M   0% /dev
    tmpfs                   502.4M         0    502.4M   0% /dev/shm
    tmpfs                   502.4M      7.9M    494.4M   2% /run
    tmpfs                   502.4M         0    502.4M   0% /sys/fs/cgroup
    tmpfs                   502.4M     26.4M    476.0M   5% /tmp
    tmpfs                    16.0M         0     16.0M   0% /media/ram
    tmpfs                    50.0M     24.0K     50.0M   0% /var/volatile
    /dev/mmcblk0p2          871.9M      1.5M    825.2M   0% /run/media/mmcblk0p2
    /dev/mmcblk0p1           69.5M    838.0K     68.6M   1% /run/media/mmcblk0p1
    /dev/mmcblk0p3            2.6G      4.0M      2.5G   0% /run/media/mmcblk0p3
    /dev/sdb1                14.6G      8.0K     14.6G   0% /run/media/sdb1
    /dev/sdc1                14.8G      1.1M     14.7G   0% /run/media/sdc1
    tmpfs                   100.5M         0    100.5M   0% /run/user/0
    ubi0:test               220.5M     24.0K    215.7M   0% /mnt/partition_nand_1698
    clean up.......
    Removing srcfile
    |TRACE LOG|Inside do_cmd:CMD=rm /home/root/srctest_file_nand_1698|
    |TRACE LOG|Inside do_cmd:CMD=blk_device_unprepare.sh -n /dev/mtdblock9 -d nand -f ubifs -m /mnt/partition_nand_1698|
    |TRACE LOG|Inside do_cmd:CMD=blk_device_umount.sh -m /mnt/partition_nand_1698|
    |TRACE LOG|Umounting device|
    |TRACE LOG|MNT_POINT: /mnt/partition_nand_1698|
    |TRACE LOG|Inside do_cmd:CMD=umount /mnt/partition_nand_1698|
    [  130.659071] UBIFS (ubi0:0): un-mount UBI device 0
    [  130.687579] UBIFS (ubi0:0): background thread "ubifs_bgt0_0" stops
    |TRACE LOG|Inside do_cmd:CMD=rm -rf /mnt/partition_nand_1698|
    |TRACE LOG|Inside do_cmd:CMD=ubirmvol /dev/ubi0 -N test|
    |TRACE LOG|Inside do_cmd:CMD=ubidetach -d 0|
    [  130.986809] ubi0: detaching mtd9
    [  130.993153] ubi0: mtd9 is detached
    done with clean up
    <<<execution_status>>>
    initiation_status="ok"
    duration=29 termination_type=exited termination_id=0 corefile=no
    cutime=144 cstime=530
    <<<test_end>>>
    INFO: ltp-pan reported all tests PASS
    LTP Version: 20160510
            
           ###############################################################"
            
                Done executing testcases."
                LTP Version:  20160510
                Result log is in the /tmp/tmp.BYFo4v "
           ###############################################################"
           
    Test Start Time: Sat Sep 10 06:30:20 2016
    -----------------------------------------
    Testcase                       Result     Exit Value
    --------                       ------     ----------
    NAND_S_FUNC_DD_RW_UBIFS_ERASES PASS       0    
    
    -----------------------------------------------
    Total Tests: 1
    Total Skipped Tests: 0
    Total Failures: 0
    Kernel Version: 4.4.20-g00f19d3e53
    Machine Architecture: armv7l
    Hostname: am335x-evm
    

    subpage test log

    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.4.20-g00f19d3e53 (gtbldadm@vm03) (gcc version 5.3.1 20160113 (Linaro GCC 5.3-2016.02) ) #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016
    [    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
    [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [    0.000000] Machine model: TI AM335x EVM
    [    0.000000] cma: Reserved 24 MiB at 0xbe800000
    [    0.000000] Memory policy: Data cache writeback
    [    0.000000] CPU: All CPU(s) started in SVC mode.
    [    0.000000] AM335X ES2.1 (sgx neon )
    [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 260416
    [    0.000000] Kernel command line: console=ttyO0,115200n8 earlyprintk=serial,ttyO0,115200n8 rootwait   ip=:::::eth0:dhcp  root=/dev/nfs rw nfsroot=192.168.0.1:/home/tigtfarm11/NFS_exports/linux/am335x-evm/autofs/b12391b17f5a95e11a1a3fee15f5eb52,nolock,v3,tcp,rsize=4096,wsize=4096 
    [    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: 1003984K/1048576K available (6523K kernel code, 314K rwdata, 2376K rodata, 264K init, 265K bss, 20016K reserved, 24576K cma-reserved, 237568K highmem)
    [    0.000000] Virtual kernel memory layout:
    [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    [    0.000000]     vmalloc : 0xf0800000 - 0xff800000   ( 240 MB)
    [    0.000000]     lowmem  : 0xc0000000 - 0xf0000000   ( 768 MB)
    [    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
    [    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
    [    0.000000]       .text : 0xc0008000 - 0xc08b9014   (8901 kB)
    [    0.000000]       .init : 0xc08ba000 - 0xc08fc000   ( 264 kB)
    [    0.000000]       .data : 0xc08fc000 - 0xc094aa10   ( 315 kB)
    [    0.000000]        .bss : 0xc094aa10 - 0xc098d098   ( 266 kB)
    [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
    [    0.000000] Preemptible hierarchical RCU implementation.
    [    0.000000] 	Build-time adjustment of leaf fanout to 32.
    [    0.000000] NR_IRQS:16 nr_irqs:16 16
    [    0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
    [    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
    [    0.000012] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 89478484971ns
    [    0.000032] clocksource: timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
    [    0.000041] OMAP clocksource: timer1 at 24000000 Hz
    [    0.000200] clocksource_probe: no matching clocksources found
    [    0.000374] Console: colour dummy device 80x30
    [    0.000403] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
    [    0.000408] This ensures that you still see kernel messages. Please
    [    0.000413] update your kernel commandline.
    [    0.000431] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
    [    0.089221] pid_max: default: 32768 minimum: 301
    [    0.089343] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.089355] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.090024] Initializing cgroup subsys io
    [    0.090057] Initializing cgroup subsys memory
    [    0.090092] Initializing cgroup subsys devices
    [    0.090106] Initializing cgroup subsys freezer
    [    0.090120] Initializing cgroup subsys perf_event
    [    0.090130] Initializing cgroup subsys pids
    [    0.090155] CPU: Testing write buffer coherency: ok
    [    0.090567] Setting up static identity map for 0x80008200 - 0x80008258
    [    0.092463] devtmpfs: initialized
    [    0.103768] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
    [    0.116789] omap_hwmod: debugss: _wait_target_disable failed
    [    0.172343] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
    [    0.174420] pinctrl core: initialized pinctrl subsystem
    [    0.175661] NET: Registered protocol family 16
    [    0.177437] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [    0.199215] cpuidle: using governor ladder
    [    0.229201] cpuidle: using governor menu
    [    0.233163] OMAP GPIO hardware version 0.1
    [    0.240641] omap-gpmc 50000000.gpmc: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/nandflash_pins_s0, deferring probe
    [    0.243105] hw-breakpoint: debug architecture 0x4 unsupported.
    [    0.276497] edma 49000000.edma: TI EDMA DMA engine driver
    [    0.280580] omap_i2c 44e0b000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c0_pins, deferring probe
    [    0.280639] omap_i2c 4802a000.i2c: could not find pctldev for node /ocp/l4_wkup@44c00000/scm@210000/pinmux@800/pinmux_i2c1_pins, deferring probe
    [    0.280762] media: Linux media interface: v0.10
    [    0.280814] Linux video capture interface: v2.00
    [    0.280856] pps_core: LinuxPPS API ver. 1 registered
    [    0.280862] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.280886] PTP clock support registered
    [    0.280932] EDAC MC: Ver: 3.0.0
    [    0.282020] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
    [    0.282359] Advanced Linux Sound Architecture Driver Initialized.
    [    0.283480] clocksource: Switched to clocksource timer1
    [    0.292944] NET: Registered protocol family 2
    [    0.293753] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
    [    0.293832] TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
    [    0.293898] TCP: Hash tables configured (established 8192 bind 8192)
    [    0.294009] UDP hash table entries: 512 (order: 1, 8192 bytes)
    [    0.294033] UDP-Lite hash table entries: 512 (order: 1, 8192 bytes)
    [    0.294178] NET: Registered protocol family 1
    [    0.294587] RPC: Registered named UNIX socket transport module.
    [    0.294604] RPC: Registered udp transport module.
    [    0.294610] RPC: Registered tcp transport module.
    [    0.294615] RPC: Registered tcp NFSv4.1 backchannel transport module.
    [    0.295558] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
    [    0.297364] futex hash table entries: 256 (order: -1, 3072 bytes)
    [    0.304424] squashfs: version 4.0 (2009/01/31) Phillip Lougher
    [    0.305266] NFS: Registering the id_resolver key type
    [    0.305341] Key type id_resolver registered
    [    0.305348] Key type id_legacy registered
    [    0.305419] ntfs: driver 2.1.32 [Flags: R/O].
    [    0.308698] bounce: pool size: 64 pages
    [    0.308946] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
    [    0.308968] io scheduler noop registered
    [    0.308981] io scheduler deadline registered
    [    0.309119] io scheduler cfq registered (default)
    [    0.310427] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
    [    0.312985] backlight supply power not found, using dummy regulator
    [    0.365522] Serial: 8250/16550 driver, 10 ports, IRQ sharing disabled
    [    0.369227] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 158, base_baud = 3000000) is a 8250
    [    1.014390] console [ttyS0] enabled
    [    1.019104] 48022000.serial: ttyS1 at MMIO 0x48022000 (irq = 159, base_baud = 3000000) is a 8250
    [    1.029053] [drm] Initialized drm 1.1.0 20060810
    [    1.036080] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
    [    1.042736] [drm] No driver support for vblank timestamp query.
    [    1.075806] Console: switching to colour frame buffer device 100x30
    [    1.086703] tilcdc 4830e000.lcdc: fb0:  frame buffer device
    [    1.113647] [drm] Initialized tilcdc 1.0.0 20121205 on minor 0
    [    1.125971] loop: module loaded
    [    1.131537] libphy: Fixed MDIO Bus: probed
    [    1.193510] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
    [    1.199653] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
    [    1.206720] libphy: 4a101000.mdio: probed
    [    1.210751] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver Atheros 8031 ethernet
    [    1.220858] cpsw 4a100000.ethernet: Detected MACID = d0:ff:50:56:df:fa
    [    1.229369] mousedev: PS/2 mouse device common for all mice
    [    1.235753] i2c /dev entries driver
    [    1.240218] cpuidle: enable-method property 'ti,am3352' found operations
    [    1.247940] omap_hsmmc 48060000.mmc: Got CD GPIO
    [    1.397557] ledtrig-cpu: registered to indicate activity on CPUs
    [    1.407961] NET: Registered protocol family 10
    [    1.415033] sit: IPv6 over IPv4 tunneling driver
    [    1.420435] NET: Registered protocol family 17
    [    1.425384] Key type dns_resolver registered
    [    1.429926] omap_voltage_late_init: Voltage driver support not added
    [    1.439723] omap-gpmc 50000000.gpmc: GPMC revision 6.0
    [    1.445169] gpmc_mem_init: disabling cs 0 mapped at 0x0-0x1000000
    [    1.452629] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xda
    [    1.459174] nand: Micron MT29F2G08ABAEAWP
    [    1.463207] nand: 256 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 64
    [    1.470881] nand: using OMAP_ECC_BCH8_CODE_HW ECC scheme
    [    1.476344] 10 ofpart partitions found on MTD device 8000000.nand
    [    1.482467] Creating 10 MTD partitions on "8000000.nand":
    [    1.487916] 0x000000000000-0x000000020000 : "NAND.SPL"
    [    1.494421] 0x000000020000-0x000000040000 : "NAND.SPL.backup1"
    [    1.501335] 0x000000040000-0x000000060000 : "NAND.SPL.backup2"
    [    1.508310] 0x000000060000-0x000000080000 : "NAND.SPL.backup3"
    [    1.515311] 0x000000080000-0x0000000c0000 : "NAND.u-boot-spl-os"
    [    1.522405] 0x0000000c0000-0x0000001c0000 : "NAND.u-boot"
    [    1.529299] 0x0000001c0000-0x0000001e0000 : "NAND.u-boot-env"
    [    1.536199] 0x0000001e0000-0x000000200000 : "NAND.u-boot-env.backup1"
    [    1.543800] 0x000000200000-0x000000a00000 : "NAND.kernel"
    [    1.552946] 0x000000a00000-0x000010000000 : "NAND.file-system"
    [    1.663730] tps65910 0-002d: No interrupt support, no core IRQ
    [    1.691085] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
    [    1.698464] omap_i2c 4802a000.i2c: bus 1 rev0.11 at 100 kHz
    [    1.704906] omap_hsmmc 48060000.mmc: Got CD GPIO
    [    1.709949] vmmc: supplied by vbat
    [    1.754163] vdd_mpu: supplied by vbat
    [    1.763221] input: volume_keys@0 as /devices/platform/volume_keys@0/input/input0
    [    1.771551] hctosys: unable to open rtc device (rtc0)
    [    1.797539] net eth0: initializing cpsw version 1.12 (0)
    [    1.802974] net eth0: initialized cpsw ale version 1.4
    [    1.808196] net eth0: ALE Table size 1024
    [    1.832942] mmc1: host does not support reading read-only switch, assuming write-enable
    [    1.844458] mmc1: new high speed SDHC card at address aaaa
    [    1.850664] mmcblk0: mmc1:aaaa SL08G 7.40 GiB 
    [    1.856703]  mmcblk0: p1 p2 p3
    [    1.894272] net eth0: phy found : id is : 0x4dd074
    [    1.899209] libphy: PHY 4a101000.mdio:01 not found
    [    1.904054] net eth0: phy "4a101000.mdio:01" not found on slave 1, err -19
    [    1.916826] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
    [    5.894548] cpsw 4a100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
    [    5.902554] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
    [    5.923540] Sending DHCP requests ., OK
    [    5.973564] IP-Config: Got DHCP answer from 192.168.0.1, my address is 192.168.0.241
    [    5.981810] IP-Config: Complete:
    [    5.985257]      device=eth0, hwaddr=d0:ff:50:56:df:fa, ipaddr=192.168.0.241, mask=255.255.255.0, gw=192.168.0.1
    [    5.995669]      host=192.168.0.241, domain=ti.com, nis-domain=(none)
    [    6.002217]      bootserver=0.0.0.0, rootserver=192.168.0.1, rootpath=
    [    6.008720]      nameserver0=192.0.2.2, nameserver1=192.0.2.3
    [    6.015043] lis3_reg: disabling
    [    6.018222] wlan-en-regulator: disabling
    [    6.022785] ALSA device list:
    [    6.025861]   No soundcards found.
    [    6.051803] VFS: Mounted root (nfs filesystem) on device 0:15.
    [    6.058676] devtmpfs: mounted
    [    6.062579] Freeing unused kernel memory: 264K (c08ba000 - c08fc000)
    [    6.069187] This architecture does not have kernel memory protection.
    [    6.358462] systemd[1]: System time before build time, advancing clock.
    [    6.427029] random: systemd: uninitialized urandom read (16 bytes read, 62 bits of entropy available)
    [    6.446321] random: systemd: uninitialized urandom read (16 bytes read, 63 bits of entropy available)
    [    6.464823] 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)
    [    6.484020] systemd[1]: Detected architecture arm.
    
    Welcome to [1mArago 2016.08[0m!
    
    [    6.505277] systemd[1]: Set hostname to <am335x-evm>.
    [    6.658734] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 76 bits of entropy available)
    [    6.682736] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 77 bits of entropy available)
    [    6.713402] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 80 bits of entropy available)
    [    6.758916] random: systemd: uninitialized urandom read (16 bytes read, 83 bits of entropy available)
    [    6.776554] random: systemd: uninitialized urandom read (16 bytes read, 84 bits of entropy available)
    [    6.786609] random: systemd: uninitialized urandom read (16 bytes read, 84 bits of entropy available)
    [    6.796831] random: systemd: uninitialized urandom read (16 bytes read, 84 bits of entropy available)
    [    6.840870] random: systemd: uninitialized urandom read (16 bytes read, 88 bits of entropy available)
    [    7.137203] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
    [[0;32m  OK  [0m] Started Forward Password Requests to Wall Directory Watch.
    [    7.166436] systemd[1]: Listening on Network Service Netlink Socket.
    [[0;32m  OK  [0m] Listening on Network Service Netlink Socket.
    [    7.194806] systemd[1]: Listening on Journal Socket (/dev/log).
    [[0;32m  OK  [0m] Listening on Journal Socket (/dev/log).
    [    7.224295] systemd[1]: Listening on Journal Socket.
    [[0;32m  OK  [0m] Listening on Journal Socket.
    [    7.253940] systemd[1]: Reached target Remote File Systems.
    [[0;32m  OK  [0m] Reached target Remote File Systems.
    [    7.308160] systemd[1]: Created slice System Slice.
    [[0;32m  OK  [0m] Created slice System Slice.
    [    7.335377] systemd[1]: Created slice system-serial\x2dgetty.slice.
    [[0;32m  OK  [0m] Created slice system-serial\x2dgetty.slice.
    [    7.368122] systemd[1]: Mounting Debug File System...
             Mounting Debug File System...
    [    7.430522] systemd[1]: Mounting Temporary Directory...
             Mounting Temporary Directory...
    [    7.480091] systemd[1]: Starting Remount Root and Kernel File Systems...
             Starting Remount Root and Kernel File Systems...
    [    7.564531] systemd[1]: Listening on Syslog Socket.
    [[0;32m  OK  [0m] Listening on Syslog Socket.
    [    7.625143] systemd[1]: Starting Journal Service...
             Starting Journal Service...
    [    7.701045] systemd[1]: Starting Load Kernel Modules...
    [    7.735826] random: nonblocking pool is initialized
             Starting Load Kernel Modules...
    [    7.758922] systemd[1]: Starting Setup Virtual Console...
             Starting Setup Virtual Console...
    [    7.859383] systemd[1]: Starting Create list of required static device nodes for the current kernel...
    [    7.901487] cryptodev: driver 1.8 loaded.
             Starting Create list of required st... nodes for the current kernel...
    [    7.964507] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
    [[0;32m  OK  [0m] Started Dispatch Password Requests to Console Directory Watch.
    [    8.005245] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
    [[0;32m  OK  [0m] Listening on /dev/initctl Compatibility Named Pipe.
    [    8.048789] systemd[1]: Mounting POSIX Message Queue File System...
             Mounting POSIX Message Queue File System...
    [    8.095700] systemd[1]: Created slice system-getty.slice.
    [[0;32m  OK  [0m] Created slice system-getty.slice.
    [    8.111207] systemd[1]: Reached target Paths.
    [[0;32m  OK  [0m] Reached target Paths.
    [    8.144776] systemd[1]: Listening on udev Kernel Socket.
    [[0;32m  OK  [0m] Listening on udev Kernel Socket.
    [    8.174920] systemd[1]: Listening on udev Control Socket.
    [[0;32m  OK  [0m] Listening on udev Control Socket.
    [    8.205253] systemd[1]: Created slice User and Session Slice.
    [[0;32m  OK  [0m] Created slice User and Session Slice.
    [    8.233928] systemd[1]: Reached target Slices.
    [[0;32m  OK  [0m] Reached target Slices.
    [    8.253894] systemd[1]: Reached target Swap.
    [[0;32m  OK  [0m] Reached target Swap.
    [    8.287347] systemd[1]: Mounted Debug File System.
    [[0;32m  OK  [0m] Mounted Debug File System.
    [    8.324099] systemd[1]: Mounted POSIX Message Queue File System.
    [[0;32m  OK  [0m] Mounted POSIX Message Queue File System.
    [    8.354048] systemd[1]: Mounted Temporary Directory.
    [[0;32m  OK  [0m] Mounted Temporary Directory.
    [    8.384698] systemd[1]: Started Journal Service.
    [[0;32m  OK  [0m] Started Journal Service.
    [[0;32m  OK  [0m] Started Remount Root and Kernel File Systems.
    [[0;32m  OK  [0m] Started Load Kernel Modules.
    [[0;32m  OK  [0m] Started Setup Virtual Console.
    [[0;32m  OK  [0m] Started Create list of required sta...ce nodes for the current kernel.
             Starting Create Static Device Nodes in /dev...
             Starting Apply Kernel Variables...
             Starting udev Coldplug all Devices...
             Starting Flush Journal to Persistent Storage...
    [[0;32m  OK  [0m] Started Apply Kernel Variables.
    [[0;32m  OK  [0m] Started Create Static Device Nodes in /dev.
    [   10.050201] systemd-journald[93]: Received request to flush runtime journal from PID 1
    [[0;32m  OK  [0m] Started Flush Journal to Persistent Storage.
             Starting udev Kernel Device Manager...
    [[0;32m  OK  [0m] Reached target Local File Systems (Pre).
             Mounting /media/ram...
             Mounting /var/volatile...
    [[0;32m  OK  [0m] Mounted /var/volatile.
    [[0;32m  OK  [0m] Mounted /media/ram.
    [[0;32m  OK  [0m] Started udev Kernel Device Manager.
             Starting Load/Save Random Seed...
    [[0;32m  OK  [0m] Reached target Local File Systems.
             Starting Create Volatile Files and Directories...
    [[0;32m  OK  [0m] Started Load/Save Random Seed.
    [   11.768684] input: matrix_keypad@0 as /devices/platform/matrix_keypad@0/input/input1
    [   11.957031] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
    [   12.027733] input: ti-tsc as /devices/platform/ocp/44e0d000.tscadc/TI-am335x-tsc/input/input2
    [   12.062155] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
    [   12.136757] 47401300.usb-phy supply vcc not found, using dummy regulator
    [   12.237247] 47401b00.usb-phy supply vcc not found, using dummy regulator
    [[0;32m  OK  [0m] Started udev Coldplug all Devices.
    [   12.649347] vaux2: supplied by vbat
    [[0;32m  OK  [0m] Found device /dev/ttyS0.
    [[0;32m  OK  [0m] Started Create Volatile Files and Directories.
    [   13.035866] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
    [   13.506942] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
    [   13.801266]  remoteproc0: wkup_m3 is available
    [   13.833226]  remoteproc0: Note: remoteproc is still under development and considered experimental.
    [   13.962377]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
             Starting Update UTMP about System Boot/Shutdown...
             Starting Network Time Synchronization...
    [[0;32m  OK  [0m] Created slice system-systemd\x2dbacklight.slice.
            Starting Load/Save Screen Backlight...htness of backlight:backlight...n
     [[0;32m  OK  [0m] Started Load/Save Screen Backlight Brightness of backlight:backlight.
    [[0;32m  OK  [0m] Started Network Time Synchronization.
    [   15.306879] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
    [   16.018688] ti-pruss 4a300000.pruss: creating PRU cores and other child platform devices
    [   16.108960] irq: no irq domain found for /ocp/pruss@4a300000/intc@4a320000 !
    [   16.210664] irq: no irq domain found for /ocp/pruss@4a300000/intc@4a320000 !
    [   16.323428] [drm] Initialized pvr 1.14.3699939 20110701 on minor 1
    [   16.410771]  remoteproc1: 4a334000.pru0 is available
    [   16.518236]  remoteproc1: Note: remoteproc is still under development and considered experimental.
    [   16.641473]  remoteproc1: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
    [   16.883311]  remoteproc0: powering up wkup_m3
    [[0;32m  OK  [0m] Started Update UTMP about System Boot/Shutdown.
    [   16.965055]  remoteproc1: registered virtio0 (type 7)
    [   16.988778]  remoteproc0: Booting fw image am335x-pm-firmware.elf, size 217228
    [   17.012526] pru-rproc 4a334000.pru0: PRU rproc node /ocp/pruss@4a300000/pru0@4a334000 probed successfully
    [   17.038984] PM: bootloader does not support rtc-only!
    [   17.104278]  remoteproc0: remote processor wkup_m3 is now up
    [   17.104304] wkup_m3_ipc 44e11324.wkup_m3_ipc: CM3 Firmware Version = 0x192
    [   17.133455]  remoteproc2: 4a338000.pru1 is available
    [   17.189319]  remoteproc2: Note: remoteproc is still under development and considered experimental.
    [   17.321388]  remoteproc2: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
    [   17.442451]  remoteproc2: registered virtio1 (type 7)
    [   17.479124] EXT4-fs (mmcblk0p3): mounting ext2 file system using the ext4 subsystem
    [   17.488521] EXT4-fs (mmcblk0p2): warning: maximal mount count reached, running e2fsck is recommended
    [   17.505087] pru-rproc 4a338000.pru1: PRU rproc node /ocp/pruss@4a300000/pru1@4a338000 probed successfully
    [   17.515937] asoc-simple-card sound: tlv320aic3x-hifi <-> 4803c000.mcasp mapping ok
    [   17.576855] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
    [   17.615965] EXT4-fs (mmcblk0p3): mounted filesystem without journal. Opts: (null)
    [   17.623759] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [[0;32m  OK  [0m] Found device /dev/ttyS3.
    [[0;32m  OK  [0m] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
             Starting Synchronize System and HW clocks...
    [[0;32m  OK  [0m] Reached target System Time Synchronized.
    [[0;32m  OK  [0m] Started Synchronize System and HW clocks.
    [   21.736507] usbcore: registered new interface driver usbfs
    [   21.742118] usbcore: registered new interface driver hub
    [   21.808195] usbcore: registered new device driver usb
    [   21.943325] musb-hdrc musb-hdrc.0.auto: MUSB HDRC host driver
    [   21.991210] musb-hdrc musb-hdrc.0.auto: new USB bus registered, assigned bus number 1
    [   22.057167] hub 1-0:1.0: USB hub found
    [   22.081302] hub 1-0:1.0: 1 port detected
    [   22.160426] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
    [   22.252697] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 2
    [   22.266569]  remoteproc1: powering up 4a334000.pru0
    [   22.297164]  remoteproc1: Booting fw image am335x-pru0-fw, size 75128
    [   22.321227] hub 2-0:1.0: USB hub found
    [   22.349494] hub 2-0:1.0: 1 port detected
    [   22.355684] ti-pruss 4a300000.pruss: configured system_events = 0x0000000000030000 intr_channels = 0x00000005 host_intr = 0x00000005
    [   22.429135]  remoteproc1: remote processor 4a334000.pru0 is now up
    [   22.462250] virtio_rpmsg_bus virtio0: creating channel rpmsg-pru addr 0x1e
    [   22.470607] virtio_rpmsg_bus virtio0: rpmsg host is online
    [   22.513871]  remoteproc2: powering up 4a338000.pru1
    [   22.542334]  remoteproc2: Booting fw image am335x-pru1-fw, size 75128
    [   22.606078] ti-pruss 4a300000.pruss: configured system_events = 0x00000000000c0000 intr_channels = 0x0000000a host_intr = 0x0000000a
    [   22.687541]  remoteproc2: remote processor 4a338000.pru1 is now up
    [   22.726277] virtio_rpmsg_bus virtio1: creating channel rpmsg-pru addr 0x1f
    [   22.736229] virtio_rpmsg_bus virtio1: rpmsg host is online
    [   22.825031] rpmsg_pru rpmsg0: new rpmsg_pru device: /dev/rpmsg_pru30
    [   22.838876] rpmsg_pru rpmsg1: new rpmsg_pru device: /dev/rpmsg_pru31
    [   23.703626] usb 2-1: new high-speed USB device number 2 using musb-hdrc
    [   23.981677] SCSI subsystem initialized
    [   24.020181] usb-storage 2-1:1.0: USB Mass Storage device detected
    [   24.032149] scsi host0: usb-storage 2-1:1.0
    [   24.050796] usbcore: registered new interface driver usb-storage
    [[0;32m  OK  [0m] Reached target Sound Card.
    [[0;32m  OK  [0m] Reached target System Initialization.
    [[0;32m  OK  [0m] Started Daily Cleanup of Temporary Directories.
    [[0;32m  OK  [0m] Reached target Timers.
    [[0;32m  OK  [0m] Listening on RPCbind Server Activation Socket.
    [[0;32m  OK  [0m] Listening on dropbear.socket.
    [[0;32m  OK  [0m] Listening on D-Bus System Message Bus Socket.
    [[0;32m  OK  [0m] Reached target Sockets.
    [[0;32m  OK  [0m] Reached target Basic System.
             Starting Print notice about GPLv3 packages...
    [[0;32m  OK  [0m] Started Kernel Logging Service.
    [[0;32m  OK  [0m] Started System Logging Service.
             Starting uim-sysfs.service...
             Starting Permit User Sessions...
    [   25.065787] scsi 0:0:0:0: Direct-Access     CENTON   CENTON USB       8.07 PQ: 0 ANSI: 4
    [[0;32m  OK  [0m] Started strongSwan IPsec IKEv1/IKEv2 daemon using ipsec.conf.
    [[0;32m  OK  [0m] Started D-Bus System Message Bus.
    [   25.318872] sd 0:0:0:0: [sda] 3932160 512-byte logical blocks: (2.01 GB/1.88 GiB)
    [   25.383855] sd 0:0:0:0: [sda] Write Protect is off
    [   25.419073] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
    [   25.515772]  sda: sda1
    [   25.554899] sd 0:0:0:0: [sda] Attached SCSI removable disk
             Starting Network Service...
             Starting Save/Restore Sound Card State...
             Starting Login Service...
    [[0;32m  OK  [0m] Started Permit User Sessions.
    [   26.808959] NET: Registered protocol family 15
    [[0;32m  OK  [0m] Started Network Service.
    [[0;32m  OK  [0m] Started Save/Restore Sound Card State.
    [   28.069298] Initializing XFRM netlink socket
    [   28.362154] EXT4-fs (sda1): mounting ext2 file system using the ext4 subsystem
    [   28.428157] EXT4-fs (sda1): warning: mounting unchecked fs, running e2fsck is recommended
    [   28.487908] EXT4-fs (sda1): mounted filesystem without journal. Opts: (null)
    [[0;32m  OK  [0m] Started Login Service.
    [[0;32m  OK  [0m] Reached target Network.
             Starting Lightning Fast Webserver With Light System Requirements...
             Starting Network Name Resolution...
    [[0;32m  OK  [0m] Started Serial Getty on ttyS3.
    [[0;32m  OK  [0m] Started Getty on tty1.
    [[0;32m  OK  [0m] Started Serial Getty on ttyS0.
    [[0;32m  OK  [0m] Started Lightning Fast Webserver With Light System Requirements.
    [[0;32m  OK  [0m] Started Network Name Resolution.
    [[0;32m  OK  [0m] Started uim-sysfs.service.
             Starting rc.pvr.service...
    [   33.290721] PVR_K: UM DDK-(3699939) and KM DDK-(3699939) match. [ OK ]
    [[0;32m  OK  [0m] Started rc.pvr.service.
             Starting weston.service...
    [[0;32m  OK  [0m] Started weston.service.
             Starting telnetd.service...
    ***************************************************************
    ***************************************************************
    NOTICE: This file system contains the following GPLv3 packages:
    	autoconf
    	binutils
    	cpp-symlinks
    	cpp
    	dosfstools
    	g++-symlinks
    	g++
    	gcc-symlinks
    	gcc
    	gdb
    	gdbserver
    	gstreamer1.0-libav
    	libgmp10
    	libidn11
    	libmpc3
    	libmpfr4
    	make
    	nettle
    
    If you do not wish to distribute GPLv3 components please remove
    the above packages prior to distribution.  This can be done using
    the opkg remove command.  i.e.:
        opkg remove <package>
    Where <package> is the name printed in the list above
    
    NOTE: If the package is a dependency of another package you
          will be notified of the dependent packages.  You should
          use the --force-removal-of-dependent-packages option to
          also remove the dependent packages as well
    ***************************************************************
    ***************************************************************
    [[0;32m  OK  [0m] Started Print notice about GPLv3 packages.
    [[0;32m  OK  [0m] Started telnetd.service.
    [   34.331056] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000020): FIFO underfow
    [   34.337880] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   34.338810] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   34.358432] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   34.369820] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [   34.370179] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   34.377663] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost
    [   34.391189] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [   34.405897] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [   34.422496] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
    [   34.437087] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000104): Sync lost
             Starting thttpd.service...
    [[0;32m  OK  [0m] Started thttpd.service.
    [   34.661972] tilcdc 4830e000.lcdc: tilcdc_crtc_irq(0x00000004): Sync lost flood detected, disabling the interrupt
             Starting rng-tools.service...
    [[0;32m  OK  [0m] Started rng-tools.service.
             Starting matrix-gui-2.0.service...
    [[0;32m  OK  [0m] Started matrix-gui-2.0.service.
             Starting parse-ip.service...
             Starting thermal-zone-init.service...
    [[0;32m  OK  [0m] Started thermal-zone-init.service.
    
    
     _____                    _____           _         _   
    |  _  |___ ___ ___ ___   |  _  |___ ___  |_|___ ___| |_ 
    |     |  _| .'| . | . |  |   __|  _| . | | | -_|  _|  _|
    |__|__|_| |__,|_  |___|  |__|  |_| |___|_| |___|___|_|  
                  |___|                    |___|            
    
    Arago Project http://arago-project.org am335x-evm ttyS0
    
    Arago 2016.08 am335x-evm ttyS0
    
    am335x-evm login: 
    - 04:47:06 [INFO] Host: root
    - 04:47:14 [INFO] Target: 
    root
    
    7[r[999;999H[6nroot@am335x-evm:~# 
    - 04:47:14 [INFO] Sleeping 15 secs to allow systemd to finish starting processes...
    - 04:47:29 [INFO] Disconnected serial from am335x-evm
    - 04:47:29 [INFO] Connected to am335x-evm via serial 
    - 04:47:29 [INFO] Host: uname -a
    - 04:47:29 [INFO] Target: 
    uname -a
    Linux am335x-evm 4.4.20-g00f19d3e53 #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016 armv7l GNU/Linux
    root@am335x-evm:~# 
    - 04:47:29 [INFO] Host: cat /proc/cmdline
    - 04:47:29 [INFO] Target: 
    cat /proc/cmdline
    console=ttyO0,115200n8 earlyprintk=serial,ttyO0,115200n8 rootwait   ip=:::::eth0:dhcp  root=/dev/nfs rw nfsroot=192.168.0.1:/home/tigtfarm11/NFS_exports/linux/am335x-evm/autofs/b12391b17f5a95e11a1a3fee15f5eb52,nolock,v3,tcp,rsize=4096,wsize=4096 
    root@am335x-evm:~# 
    - 04:47:29 [INFO] Host: uname -a
    - 04:47:29 [INFO] Target: 
    uname -a
    Linux am335x-evm 4.4.20-g00f19d3e53 #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016 armv7l GNU/Linux
    root@am335x-evm:~# 
    - 04:47:29 [INFO] Host: cat /proc/mtd
    - 04:47:29 [INFO] Target: 
    cat /proc/mtd
    dev:    size   erasesize  name
    mtd0: 00020000 00020000 "NAND.SPL"
    mtd1: 00020000 00020000 "NAND.SPL.backup1"
    mtd2: 00020000 00020000 "NAND.SPL.backup2"
    mtd3: 00020000 00020000 "NAND.SPL.backup3"
    mtd4: 00040000 00020000 "NAND.u-boot-spl-os"
    mtd5: 00100000 00020000 "NAND.u-boot"
    mtd6: 00020000 00020000 "NAND.u-boot-env"
    mtd7: 00020000 00020000 "NAND.u-boot-env.backup1"
    mtd8: 00800000 00020000 "NAND.kernel"
    mtd9: 0f600000 00020000 "NAND.file-system"
    root@am335x-evm:~# 
    - 04:47:29 [INFO] Host: cat /proc/diskstats
    - 04:47:29 [INFO] Target: 
    cat /proc/diskstats
       7       0 loop0 0 0 0 0 0 0 0 0 0 0 0
       7       1 loop1 0 0 0 0 0 0 0 0 0 0 0
       7       2 loop2 0 0 0 0 0 0 0 0 0 0 0
       7       3 loop3 0 0 0 0 0 0 0 0 0 0 0
       7       4 loop4 0 0 0 0 0 0 0 0 0 0 0
       7       5 loop5 0 0 0 0 0 0 0 0 0 0 0
       7       6 loop6 0 0 0 0 0 0 0 0 0 0 0
       7       7 loop7 0 0 0 0 0 0 0 0 0 0 0
      31       0 mtdblock0 0 0 0 0 0 0 0 0 0 0 0
      31       1 mtdblock1 0 0 0 0 0 0 0 0 0 0 0
      31       2 mtdblock2 0 0 0 0 0 0 0 0 0 0 0
      31       3 mtdblock3 0 0 0 0 0 0 0 0 0 0 0
      31       4 mtdblock4 0 0 0 0 0 0 0 0 0 0 0
      31       5 mtdblock5 0 0 0 0 0 0 0 0 0 0 0
      31       6 mtdblock6 0 0 0 0 0 0 0 0 0 0 0
      31       7 mtdblock7 0 0 0 0 0 0 0 0 0 0 0
      31       8 mtdblock8 0 0 0 0 0 0 0 0 0 0 0
      31       9 mtdblock9 0 0 0 0 0 0 0 0 0 0 0
     179       0 mmcblk0 208 59 15235 960 7 0 21 50 0 510 1000
     179       1 mmcblk0p1 63 0 5177 320 5 0 5 40 0 270 360
     179       2 mmcblk0p2 55 30 4470 250 1 0 8 0 0 210 240
     179       3 mmcblk0p3 53 29 4476 290 1 0 8 10 0 210 300
       8       0 sda 112 29 6566 500 1 0 8 0 0 320 500
       8       1 sda1 75 29 5454 370 1 0 8 0 0 240 370
    root@am335x-evm:~# 
    - 04:47:29 [INFO] Host: cat /proc/interrupts
    - 04:47:30 [INFO] Target: 
    cat /proc/interrupts
               CPU0       
     16:       5809      INTC  68 Level     gp_timer
     19:          1      INTC  78 Level     wkup_m3_txev
     20:        794      INTC  12 Level     49000000.edma_ccint
     22:          5      INTC  14 Level     49000000.edma_ccerrint
     26:          0      INTC  96 Level     44e07000.gpio
     29:          0  44e07000.gpio   2 Edge      volume-up
     30:          0  44e07000.gpio   3 Edge      volume-down
     33:          0  44e07000.gpio   6 Edge      48060000.mmc cd
     59:          0      INTC  98 Level     4804c000.gpio
     85:          0  4804c000.gpio  25 Edge      matrix-keypad
     86:          0  4804c000.gpio  26 Edge      matrix-keypad
     87:          0  4804c000.gpio  27 Edge      matrix-keypad
     92:          0      INTC  32 Level     481ac000.gpio
    125:          0      INTC  62 Level     481ae000.gpio
    158:        392      INTC  72 Level     44e09000.serial
    160:        299      INTC  70 Level     44e0b000.i2c
    161:          0      INTC  71 Level     4802a000.i2c
    162:        676      INTC  64 Level     mmc1
    163:         13      INTC  29 Level     mmc0
    165:          0      INTC  77 Level     wkup_m3
    171:          0      INTC  75 Level     rtc0
    172:          0      INTC  76 Level     rtc0
    174:      70461      INTC  41 Level     4a100000.ethernet
    175:      60469      INTC  42 Level     4a100000.ethernet
    177:          0      INTC   4 Level     48080000.elm
    178:       3706      INTC  36 Level     tilcdc
    179:          0      INTC  16 Level     TI-am335x-tsc, TI-am335x-adc
    180:          0      INTC 100 Level     gpmc
    181:         12      INTC 109 Level     53100000.sham
    183:          0      INTC  82 Level     4803c000.mcasp_tx
    184:          0      INTC  83 Level     4803c000.mcasp_rx
    185:          0      INTC 111 Level     48310000.rng
    186:        649      INTC  37 Level     SGX ISR
    190:          0      INTC  18 Level     musb-hdrc.0.auto
    191:         33      INTC  19 Level     musb-hdrc.1.auto
    192:       6913      INTC  17 Level     47400000.dma-controller
    201:          1  4a320000.intc  16 Edge      remoteproc1
    203:          1  4a320000.intc  18 Edge      remoteproc2
    Err:          0
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: cat /proc/softirqs
    - 04:47:30 [INFO] Target: 
    cat /proc/softirqs
                        CPU0       
              HI:          4
           TIMER:       4807
          NET_TX:         11
          NET_RX:     120044
           BLOCK:        167
    BLOCK_IOPOLL:          0
         TASKLET:        856
           SCHED:          0
         HRTIMER:          0
             RCU:      11518
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: export IPERFHOST=192.168.0.1
    - 04:47:30 [INFO] Target: 
    export IPERFHOST=192.168.0.1
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: export NFS_SERVER=192.168.0.1
    - 04:47:30 [INFO] Target: 
    export NFS_SERVER=192.168.0.1
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: export NFS_ROOT_PATH=/home/tigtfarm11/NFS_exports/linux/am335x-evm
    - 04:47:30 [INFO] Target: 
    export NFS_ROOT_PATH=/home/tigtfarm11/NFS_exports/linux/am335 
    x-evm
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: export AP_SSID=
    - 04:47:30 [INFO] Target: 
    export AP_SSID=
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: mkdir -p -m 777 /test
    - 04:47:30 [INFO] Target: 
    mkdir -p -m 777 /test
    root@am335x-evm:~# 
    - 04:47:30 [INFO] Host: cd /test
    - 04:47:30 [INFO] Target: 
    cd /test
    root@am335x-evm:/test# 
    - 04:47:30 [INFO] Host: cat > test.sh << EOF
    - 04:47:30 [INFO] Target: 
    cat > test.sh << EOF
    > 
    - 04:47:30 [INFO] Host: failtest() {
    
    - 04:47:30 [INFO] Target: 
    failtest() {
    > 
    - 04:47:30 [INFO] Host:   echo 1 >&3
    
    - 04:47:31 [INFO] Target: 
      echo 1 >&3
    > 
    - 04:47:31 [INFO] Host: }
    
    - 04:47:31 [INFO] Target: 
    }
    > 
    - 04:47:31 [INFO] Host: timeout=3600
    
    - 04:47:31 [INFO] Target: 
    timeout=3600
    > 
    - 04:47:31 [INFO] Host: 
    
    - 04:47:31 [INFO] Target: 
    
    > 
    - 04:47:31 [INFO] Host: # Start of user's script logic
    
    - 04:47:31 [INFO] Target: 
    # Start of user's script logic
    > 
    - 04:47:31 [INFO] Host: cd /opt/ltp
    
    - 04:47:31 [INFO] Target: 
    cd /opt/ltp
    > 
    - 04:47:31 [INFO] Host: ./runltp -P am335x-evm -f ddt/nand_mtdtests -s "NAND_M_MODULAR_MTD_SUBPAGETEST "
    
    - 04:47:31 [INFO] Target: 
    ./runltp -P am335x-evm -f ddt/nand_mtdtests -s "NAND_M_MODULAR_MTD_SUBPAGETEST 
     "
    > 
    - 04:47:31 [INFO] Host: EOF
    - 04:47:31 [INFO] Target: 
    EOF
    root@am335x-evm:/test# 
    - 04:47:31 [INFO] Host: eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | head -1`;ifconfig $eth
    - 04:47:31 [INFO] Target: 
    eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | hea 
    d -1`;ifconfig $eth
    eth0      Link encap:Ethernet  HWaddr D0:FF:50:56:DF:FA  
              inet addr:192.168.0.241  Bcast:192.168.0.255  Mask:255.255.255.0
              inet6 addr: fe80::d2ff:50ff:fe56:dffa%3068699416/64 Scope:Link
              UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
              RX packets:78576 errors:0 dropped:0 overruns:0 frame:0
              TX packets:67805 errors:0 dropped:0 overruns:0 carrier:0
              collisions:0 txqueuelen:1000 
              RX bytes:91876422 (87.6 MiB)  TX bytes:9695552 (9.2 MiB)
              Interrupt:174 
    
    root@am335x-evm:/test# 
    - 04:47:31 [INFO] Host: eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | head -1`;ifconfig $eth
    - 04:47:32 [INFO] Target: 
    eth=`ls /sys/class/net/ | awk '/.*eth.*/{print $1}' | hea 
    d -1`;ifconfig $eth
    eth0      Link encap:Ethernet  HWaddr D0:FF:50:56:DF:FA  
              inet addr:192.168.0.241  Bcast:192.168.0.255  Mask:255.255.255.0
              inet6 addr: fe80::d2ff:50ff:fe56:dffa%3068814104/64 Scope:Link
              UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
              RX packets:78592 errors:0 dropped:0 overruns:0 frame:0
              TX packets:67823 errors:0 dropped:0 overruns:0 carrier:0
              collisions:0 txqueuelen:1000 
              RX bytes:91879334 (87.6 MiB)  TX bytes:9698724 (9.2 MiB)
              Interrupt:174 
    
    root@am335x-evm:/test# 
    - 04:48:04 [INFO] Connected to am335x-evm via telnet 
    - 04:48:04 [INFO] Host: cd /test
    - 04:48:04 [INFO] Target: 
    cd /test
    root@am335x-evm:/test# 
    - 04:48:04 [INFO] Host: chmod +x test.sh
    - 04:48:04 [INFO] Target: 
    chmod +x test.sh
    root@am335x-evm:/test# 
    - 04:48:04 [INFO] Host: ./test.sh 2>&1 3> result.log
    - 04:50:58 [INFO] Target: 
    ./test.sh 2>&1 3> result.log
    INFO: creating /opt/ltp/results directory
    INFO: Filtering testscenarios based on am335x-evm capabilities
    Checking for required user/group ids
    
    'nobody' user id and group found.
    'bin' user id and group found.
    'daemon' user id and group found.
    Users group found.
    Sys group found.
    Required users/groups exist.
    If some fields are empty or look unusual you may have an old version.
    Compare to the current minimal requirements in Documentation/Changes.
     
    ID="arago"
    NAME="Arago"
    VERSION="2016.08"
    VERSION_ID="2016.08"
    PRETTY_NAME="Arago 2016.08"
    Linux am335x-evm 4.4.20-g00f19d3e53 #1 PREEMPT Mon Sep 12 22:40:45 EDT 2016 armv7l GNU/Linux
     
    Gnu C                  gcc (Linaro GCC 5.3-2016.02) 5.3.1 20160113
    Gnu make               4.1
    util-linux             /opt/ltp/ver_linux: line 29: fdformat: command not found
    mount                  linux 2.27.1 (libmount 2.27.0: assert, debug)
    modutils               22
    e2fsprogs              1.43-WIP
    /opt/ltp/ver_linux: line 50: ldd: command not found
    Linux C Library        r..    1 root     root           408 Sep 10 06:30 alltests
    Linux C Library        .    1 root     root          2963 Sep 10 06:30 alltests.orig
    Linux C Library        drwxr.xr.x   25 root     root           500 Sep 10 06:30 platform
    /opt/ltp/ver_linux: line 54: ldd: command not found
    Linux C++ Library      /../lib/libstdc++
    Procps                 3.3.11
    iproute2              iproute2-ss160111
    Kbd                    2.0.3
    Sh-utils               --v
    Modules Loaded         bc_example sha512_generic sha512_arm drbg des_generic cbc xfrm_user xfrm4_tunnel ipcomp xfrm_ipcomp esp4 ah4 af_key xfrm_algo sd_mod usb_storage scsi_mod rpmsg_pru virtio_rpmsg_bus musb_dsps musb_hdrc udc_core usbcore ti_am335x_adc kfifo_buf snd_soc_simple_card pm33xx ti_emif_sram wkup_m3_ipc pru_rproc pruss_intc ecb sha256_generic hmac md5 sha1_generic sha1_arm_neon wkup_m3_rproc sha1_arm pruss pvrsrvkm remoteproc virtio virtio_ring omap_aes_driver omap_sham omap_rng rng_core snd_soc_tlv320aic3x musb_am335x ti_am335x_tsc rtc_omap omap_wdt ti_am335x_tscadc matrix_keypad matrix_keymap sch_fq_codel cryptodev
    
    free reports:
                  total        used        free      shared  buff/cache   available
    Mem:        1028824       54808      844632       15020      129384      935216
    Swap:             0           0           0
    
    /proc/cpuinfo
    processor	: 0
    model name	: ARMv7 Processor rev 2 (v7l)
    BogoMIPS	: 996.14
    Features	: half thumb fastmult vfp edsp neon vfpv3 tls vfpd32 
    CPU implementer	: 0x41
    CPU architecture: 7
    CPU variant	: 0x3
    CPU part	: 0xc08
    CPU revision	: 2
    
    Hardware	: Generic AM33XX (Flattened Device Tree)
    Revision	: 0000
    Serial		: 0000000000000000
    no big block device was specified on commandline.
    Tests which require a big block device are disabled.
    You can specify it with option -z
    COMMAND:    /opt/ltp/bin/ltp-pan  -e -S   -a 992     -n 992  -p  -f /tmp/ltp-XXXXxIhduz/alltests -l /tmp/tmp.HnXcpt  -C /opt/ltp/output/LTP_RUN_ON-tmp.HnXcpt.failed -T /opt/ltp/output/LTP_RUN_ON-tmp.HnXcpt.tconf
    INFO: Restricted to NAND_M_MODULAR_MTD_SUBPAGETEST 
    LOG File: /tmp/tmp.HnXcpt
    FAILED COMMAND File: /opt/ltp/output/LTP_RUN_ON-tmp.HnXcpt.failed
    TCONF COMMAND File: /opt/ltp/output/LTP_RUN_ON-tmp.HnXcpt.tconf
    Running tests.......
    <<<test_start>>>
    tag=NAND_M_MODULAR_MTD_SUBPAGETEST stime=1473489018
    cmdline="source "common.sh"; install_modules.sh "nand"; rmmod.sh "mtd_subpagetest"; part=`get_mtd_partition_number.sh "nand"`; do_cmd flash_eraseall -q /dev/mtd$part; do_cmd sleep 1; dmesg -c > /dev/null; do_cmd insmod.sh "mtd_subpagetest" dev="$part"; dmesg; dmesg | grep -E "finished\s*with\s*0\s*errors" && (rmmod.sh "mtd_subpagetest";exit 0) || (rmmod.sh "mtd_subpagetest";exit 1) "
    contacts=""
    analysis=exit
    <<<test_output>>>
    incrementing stop
    |TRACE LOG|Inside do_cmd:CMD=modprobe -r mtd_subpagetest|
    |TRACE LOG|Inside do_cmd:CMD=lsmod | grep 'mtd_subpagetest ' && die mtd_subpagetest should not be seen in lsmod || exit 0|
    |TRACE LOG|Inside do_cmd:CMD=flash_eraseall -q /dev/mtd9|
    flash_eraseall has been replaced by `flash_erase <mtddev> 0 0`; please use it
    |TRACE LOG|Inside do_cmd:CMD=sleep 1|
    |TRACE LOG|Inside do_cmd:CMD=insmod.sh mtd_subpagetest dev=9|
    |TRACE LOG|Inside do_cmd:CMD=depmod -a|
    |TRACE LOG|Inside do_cmd:CMD=modprobe mtd_subpagetest dev=9|
    [  105.116008] 
    [  105.117538] =================================================
    [  105.140663] mtd_subpagetest: MTD device: 9
    [  105.145409] mtd_subpagetest: MTD device size 257949696, eraseblock size 131072, page size 2048, subpage size 512, count of eraseblocks 1968, pages per eraseblock 64, OOB size 64
    [  105.170128] mtd_test: scanning for bad eraseblocks
    [  105.186666] mtd_test: block 20 is bad
    [  105.190393] mtd_test: block 21 is bad
    [  105.323367] mtd_test: scanned 1968 eraseblocks, 2 are bad
    [  106.207813] mtd_subpagetest: writing whole device
    [  106.213346] mtd_subpagetest: written up to eraseblock 0
    [  106.414801] mtd_subpagetest: written up to eraseblock 256
    [  106.615721] mtd_subpagetest: written up to eraseblock 512
    [  106.815823] mtd_subpagetest: written up to eraseblock 768
    [  107.135741] mtd_subpagetest: written up to eraseblock 1024
    [  107.362543] mtd_subpagetest: written up to eraseblock 1280
    [  107.563833] mtd_subpagetest: written up to eraseblock 1536
    [  107.764197] mtd_subpagetest: written up to eraseblock 1792
    [  107.904699] mtd_subpagetest: written 1968 eraseblocks
    [  107.909791] mtd_subpagetest: verifying all eraseblocks
    [  107.918669] mtd_subpagetest: verified up to eraseblock 0
    [  107.986171] mtd_subpagetest: verified up to eraseblock 256
    [  108.054248] mtd_subpagetest: verified up to eraseblock 512
    [  108.122471] mtd_subpagetest: verified up to eraseblock 768
    [  108.190559] mtd_subpagetest: verified up to eraseblock 1024
    [  108.258590] mtd_subpagetest: verified up to eraseblock 1280
    [  108.326632] mtd_subpagetest: verified up to eraseblock 1536
    [  108.394844] mtd_subpagetest: verified up to eraseblock 1792
    [  108.443900] mtd_subpagetest: verified 1968 eraseblocks
    [  109.328670] mtd_subpagetest: verifying all eraseblocks for 0xff
    [  109.351863] mtd_subpagetest: verified up to eraseblock 0
    [  113.177470] mtd_subpagetest: verified up to eraseblock 256
    [  117.030458] mtd_subpagetest: verified up to eraseblock 512
    [  121.034281] mtd_subpagetest: verified up to eraseblock 768
    [  124.890626] mtd_subpagetest: verified up to eraseblock 1024
    [  128.891714] mtd_subpagetest: verified up to eraseblock 1280
    [  132.748083] mtd_subpagetest: verified up to eraseblock 1536
    [  136.601122] mtd_subpagetest: verified up to eraseblock 1792
    [  139.383451] mtd_subpagetest: verified 1968 eraseblocks
    [  139.388671] mtd_subpagetest: writing whole device
    [  139.428638] mtd_subpagetest: written up to eraseblock 0
    [  147.436533] mtd_subpagetest: written up to eraseblock 256
    [  155.626123] mtd_subpagetest: written up to eraseblock 512
    [  163.756883] mtd_subpagetest: written up to eraseblock 768
    [  171.869617] mtd_subpagetest: written up to eraseblock 1024
    [  179.986838] mtd_subpagetest: written up to eraseblock 1280
    [  187.961886] mtd_subpagetest: written up to eraseblock 1536
    [  196.093815] mtd_subpagetest: written up to eraseblock 1792
    [  201.710468] mtd_subpagetest: written 1968 eraseblocks
    [  201.715607] mtd_subpagetest: verifying all eraseblocks
    [  201.740781] mtd_subpagetest: verified up to eraseblock 0
    [  205.769627] mtd_subpagetest: verified up to eraseblock 256
    [  209.986158] mtd_subpagetest: verified up to eraseblock 512
    [  214.049124] mtd_subpagetest: verified up to eraseblock 768
    [  218.122074] mtd_subpagetest: verified up to eraseblock 1024
    [  222.339196] mtd_subpagetest: verified up to eraseblock 1280
    [  226.403960] mtd_subpagetest: verified up to eraseblock 1536
    [  230.610779] mtd_subpagetest: verified up to eraseblock 1792
    [  233.392589] mtd_subpagetest: verified 1968 eraseblocks
    [  235.033835] mtd_subpagetest: verifying all eraseblocks for 0xff
    [  235.057948] mtd_subpagetest: verified up to eraseblock 0
    [  238.877612] mtd_subpagetest: verified up to eraseblock 256
    [  242.883942] mtd_subpagetest: verified up to eraseblock 512
    [  246.738364] mtd_subpagetest: verified up to eraseblock 768
    [  250.745294] mtd_subpagetest: verified up to eraseblock 1024
    [  254.600186] mtd_subpagetest: verified up to eraseblock 1280
    [  258.453250] mtd_subpagetest: verified up to eraseblock 1536
    [  262.455919] mtd_subpagetest: verified up to eraseblock 1792
    [  265.094257] mtd_subpagetest: verified 1968 eraseblocks
    [  265.099443] mtd_subpagetest: finished with 0 errors
    [  265.108208] =================================================
    mtd_subpagetest         5772  0
    [  105.116008] 
    [  105.117538] =================================================
    [  105.140663] mtd_subpagetest: MTD device: 9
    [  105.145409] mtd_subpagetest: MTD device size 257949696, eraseblock size 131072, page size 2048, subpage size 512, count of eraseblocks 1968, pages per eraseblock 64, OOB size 64
    [  105.170128] mtd_test: scanning for bad eraseblocks
    [  105.186666] mtd_test: block 20 is bad
    [  105.190393] mtd_test: block 21 is bad
    [  105.323367] mtd_test: scanned 1968 eraseblocks, 2 are bad
    [  106.207813] mtd_subpagetest: writing whole device
    [  106.213346] mtd_subpagetest: written up to eraseblock 0
    [  106.414801] mtd_subpagetest: written up to eraseblock 256
    [  106.615721] mtd_subpagetest: written up to eraseblock 512
    [  106.815823] mtd_subpagetest: written up to eraseblock 768
    [  107.135741] mtd_subpagetest: written up to eraseblock 1024
    [  107.362543] mtd_subpagetest: written up to eraseblock 1280
    [  107.563833] mtd_subpagetest: written up to eraseblock 1536
    [  107.764197] mtd_subpagetest: written up to eraseblock 1792
    [  107.904699] mtd_subpagetest: written 1968 eraseblocks
    [  107.909791] mtd_subpagetest: verifying all eraseblocks
    [  107.918669] mtd_subpagetest: verified up to eraseblock 0
    [  107.986171] mtd_subpagetest: verified up to eraseblock 256
    [  108.054248] mtd_subpagetest: verified up to eraseblock 512
    [  108.122471] mtd_subpagetest: verified up to eraseblock 768
    [  108.190559] mtd_subpagetest: verified up to eraseblock 1024
    [  108.258590] mtd_subpagetest: verified up to eraseblock 1280
    [  108.326632] mtd_subpagetest: verified up to eraseblock 1536
    [  108.394844] mtd_subpagetest: verified up to eraseblock 1792
    [  108.443900] mtd_subpagetest: verified 1968 eraseblocks
    [  109.328670] mtd_subpagetest: verifying all eraseblocks for 0xff
    [  109.351863] mtd_subpagetest: verified up to eraseblock 0
    [  113.177470] mtd_subpagetest: verified up to eraseblock 256
    [  117.030458] mtd_subpagetest: verified up to eraseblock 512
    [  121.034281] mtd_subpagetest: verified up to eraseblock 768
    [  124.890626] mtd_subpagetest: verified up to eraseblock 1024
    [  128.891714] mtd_subpagetest: verified up to eraseblock 1280
    [  132.748083] mtd_subpagetest: verified up to eraseblock 1536
    [  136.601122] mtd_subpagetest: verified up to eraseblock 1792
    [  139.383451] mtd_subpagetest: verified 1968 eraseblocks
    [  139.388671] mtd_subpagetest: writing whole device
    [  139.428638] mtd_subpagetest: written up to eraseblock 0
    [  147.436533] mtd_subpagetest: written up to eraseblock 256
    [  155.626123] mtd_subpagetest: written up to eraseblock 512
    [  163.756883] mtd_subpagetest: written up to eraseblock 768
    [  171.869617] mtd_subpagetest: written up to eraseblock 1024
    [  179.986838] mtd_subpagetest: written up to eraseblock 1280
    [  187.961886] mtd_subpagetest: written up to eraseblock 1536
    [  196.093815] mtd_subpagetest: written up to eraseblock 1792
    [  201.710468] mtd_subpagetest: written 1968 eraseblocks
    [  201.715607] mtd_subpagetest: verifying all eraseblocks
    [  201.740781] mtd_subpagetest: verified up to eraseblock 0
    [  205.769627] mtd_subpagetest: verified up to eraseblock 256
    [  209.986158] mtd_subpagetest: verified up to eraseblock 512
    [  214.049124] mtd_subpagetest: verified up to eraseblock 768
    [  218.122074] mtd_subpagetest: verified up to eraseblock 1024
    [  222.339196] mtd_subpagetest: verified up to eraseblock 1280
    [  226.403960] mtd_subpagetest: verified up to eraseblock 1536
    [  230.610779] mtd_subpagetest: verified up to eraseblock 1792
    [  233.392589] mtd_subpagetest: verified 1968 eraseblocks
    [  235.033835] mtd_subpagetest: verifying all eraseblocks for 0xff
    [  235.057948] mtd_subpagetest: verified up to eraseblock 0
    [  238.877612] mtd_subpagetest: verified up to eraseblock 256
    [  242.883942] mtd_subpagetest: verified up to eraseblock 512
    [  246.738364] mtd_subpagetest: verified up to eraseblock 768
    [  250.745294] mtd_subpagetest: verified up to eraseblock 1024
    [  254.600186] mtd_subpagetest: verified up to eraseblock 1280
    [  258.453250] mtd_subpagetest: verified up to eraseblock 1536
    [  262.455919] mtd_subpagetest: verified up to eraseblock 1792
    [  265.094257] mtd_subpagetest: verified 1968 eraseblocks
    [  265.099443] mtd_subpagetest: finished with 0 errors
    [  265.108208] =================================================
    [  265.099443] mtd_subpagetest: finished with 0 errors
    |TRACE LOG|Inside do_cmd:CMD=modprobe -r mtd_subpagetest|
    |TRACE LOG|Inside do_cmd:CMD=lsmod | grep 'mtd_subpagetest ' && die mtd_subpagetest should not be seen in lsmod || exit 0|
    <<<execution_status>>>
    initiation_status="ok"
    duration=169 termination_type=exited termination_id=0 corefile=no
    cutime=82 cstime=15885
    <<<test_end>>>
    INFO: ltp-pan reported all tests PASS
    LTP Version: 20160510
            
           ###############################################################"
            
                Done executing testcases."
                LTP Version:  20160510
                Result log is in the /tmp/tmp.HnXcpt "
           ###############################################################"
           
    Test Start Time: Sat Sep 10 06:30:18 2016
    -----------------------------------------
    Testcase                       Result     Exit Value
    --------                       ------     ----------
    NAND_M_MODULAR_MTD_SUBPAGETEST PASS       0    
    
    -----------------------------------------------
    Total Tests: 1
    Total Skipped Tests: 0
    Total Failures: 0
    Kernel Version: 4.4.20-g00f19d3e53
    Machine Architecture: armv7l
    Hostname: am335x-evm
    

    These logs are coming from our automated testing and I apologize for the fact that it is not coming out as you would type on a command line. But I hope it does show these tests passing.

    I do realize that mtdinfo dump is not available in these logs. I will get the automated test update to add that as well. Is there any other test you would like us to run to test that there is no need to add the NAND_NO_SUBPAGE_WRITE flag in chip->options.

  • I just ran the same test on a Variscite VAR-SOM-AM33, CPU Texas Instruments AM335x, Cortex™-A8, Linux kernel 4.4.19, NAND Micron MT29F4G08ABADA. It passes.

    Can I count on this as verification that sub-pages are fully functional and officially supported? Thanks.