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.

System with wl1835 and Atmel sama5d31, get "WL18xx - "mmc2: card 0001 got removed" error after initialization

Other Parts Discussed in Thread: WL1271, WL1835

Hi,

Please also reference

        https://e2e.ti.com/support/wireless_connectivity/wilink_wifi_bluetooth/f/307/t/466638

When system boots,
   we see "mmc2: new high speed SDIO card at address 0001" which is what we want to see but later we see
               "mmc2: bus.c  card 0001 removed"

  And we never see the wlan0 come up but see the error below
             "Missing WLAN0 interface"

Wondering if you could help under stand why we get the "removed" after it comes up ??
Any help/information would be helpful.

Thanks,
Asha

  • Can you please provide a full kernel boot log showing the error?
    In addition, are you using our latest drivers (R8.7_SP1)?

    BR,
    Eyal
  • Hi Eyal,

    So I am attaching the kernel boot log.

    First line 256 shows "[    1.740000] mmc2: new high speed SDIO card at address 0001"

    Later -- lines 320 to 322 shows

      " Cannot find device "wlan0"
        Bind socket to interface: No such device
        Failed to bring up wlan0."

    Followed by line 344 shows    "[     33.750000] mmc2: card 0001 removed" 

                         line 348 shows "[   33.830000] wlcore: ERROR error requesting time_sync gpio"

    This happens intermittently.

    We would like to know the difference in R8.7_SP1 and R8.6 because if we change completely to R8.7_SP1 we may encounter some other issues and for this we would like to remain with R8.6. 

    Thank you,

    Asha

    �RomBOOT
    
    
    AT91Bootstrap 3.6.1-00078-g5415d4e (Tue Feb  4 15:36:46 CET 2014)
    
    NAND: ONFI flash detected
    NAND: Manufacturer ID: 0x2c Chip ID: 0x34
    NAND: Disable On-Die ECC
    NAND: Initialize PMECC params, cap: 0x4, sector: 0x200
    NAND: Image: Copy 0x80000 bytes from 0x40000 to 0x26f00000
    NAND: Done to load image
    
    
    U-Boot 2013.07 (Feb 04 2014 - 15:36:32)
    
    CPU: SAMA5D31
    Crystal frequency:       12 MHz
    CPU clock        :      528 MHz
    Master clock     :      132 MHz
    DRAM:  256 MiB
    NAND:  512 MiB
    MMC:   mci: 0, mci: 1
    In:    serial
    Out:   serial
    Err:   serial
    Net:   miiphy_register: non unique device name 'macb0'
    macb0
    Warning: failed to set MAC address
    , macb0
    Warning: failed to set MAC address
    
    Hit any key to stop autoboot:  0
    
    NAND read: device 0 offset 0x180000, size 0x8673
     34419 bytes read: OK
    
    NAND read: device 0 offset 0x200000, size 0x3553a0
     3494816 bytes read: OK
    Kernel image @ 0x22000000 [ 0x000000 - 0x3553a0 ]
    ## Flattened Device Tree blob at 21000000
       Booting using the fdt blob at 0x21000000
       Loading Device Tree to 2bb0f000, end 2bb1a672 ... OK
    
    Starting kernel ...
    
    Uncompressing Linux... done, booting the kernel.
    [    0.000000] Booting Linux on physical CPU 0x0
    [    0.000000] Linux version 3.16.5-sama5-armv7-r8 (root@john-VirtualBox) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #27 Mon Dec 14 17:34:00 PST 2015
    [    0.000000] CPU: ARMv7 Processor [410fc051] revision 1 (ARMv7), cr=50c53c7d
    [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [    0.000000] Machine model: SAMA5D3 Xplained
    [    0.000000] Memory policy: Data cache writeback
    [    0.000000] AT91: Detected soc type: sama5d3
    [    0.000000] AT91: Detected soc subtype: sama5d31
    [    0.000000] AT91: sram at 0x300000 of 0x20000 mapped at 0xfef58000
    [    0.000000] CPU: All CPU(s) started in SVC mode.
    [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 65024
    [    0.000000] Kernel command line: console=ttyS0,115200 mem=256M mmcrootfstype=ext4 root=/dev/mmcblk0p1 r rootwait
    [    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
    [    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
    [    0.000000] Memory: 254396K/262144K available (3311K kernel code, 202K rwdata, 1456K rodata, 148K init, 159K bss, 7748K reserved)
    [    0.000000] Virtual kernel memory layout:
    [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    [    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 kB)
    [    0.000000]     vmalloc : 0xd0800000 - 0xff000000   ( 744 MB)
    [    0.000000]     lowmem  : 0xc0000000 - 0xd0000000   ( 256 MB)
    [    0.000000]     modules : 0xbf800000 - 0xc0000000   (   8 MB)
    [    0.000000]       .text : 0xc0008000 - 0xc04aff48   (4768 kB)
    [    0.000000]       .init : 0xc04b0000 - 0xc04d53a4   ( 149 kB)
    [    0.000000]       .data : 0xc04d6000 - 0xc0508820   ( 203 kB)
    [    0.000000]        .bss : 0xc0508820 - 0xc0530710   ( 160 kB)
    [    0.000000] NR_IRQS:16 nr_irqs:16 16
    [    0.000000] sched_clock: 32 bits at 100 Hz, resolution 10000000ns, wraps every 21474836480000000ns
    [    0.000000] Console: colour dummy device 80x30
    [    0.050000] Calibrating delay loop... 351.43 BogoMIPS (lpj=1757184)
    [    0.060000] pid_max: default: 32768 minimum: 301
    [    0.060000] Security Framework initialized
    [    0.060000] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] CPU: Testing write buffer coherency: ok
    [    0.060000] Setting up static identity map for 0x2031d8c0 - 0x2031d90c
    [    0.060000] devtmpfs: initialized
    [    0.060000] VFP support v0.3: implementor 41 architecture 2 part 30 variant 5 rev 1
    [    0.060000] pinctrl core: initialized pinctrl subsystem
    [    0.060000] regulator-dummy: no parameters
    [    0.080000] NET: Registered protocol family 16
    [    0.080000] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [    0.100000] No ATAGs?
    [    0.100000] AT91: Power Management
    [    0.100000] gpio-at91 fffff200.gpio: at address fefff200
    [    0.100000] gpio-at91 fffff400.gpio: at address fefff400
    [    0.100000] gpio-at91 fffff600.gpio: at address fefff600
    [    0.100000] gpio-at91 fffff800.gpio: at address fefff800
    [    0.100000] gpio-at91 fffffa00.gpio: at address fefffa00
    [    0.100000] pinctrl-at91 ahb:apb:pinctrl@fffff200: initialized AT91 pinctrl driver
    [    0.150000] at_hdmac ffffe600.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] at_hdmac ffffe800.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] wlan-en-regulator: 1800 mV
    [    0.150000] SCSI subsystem initialized
    [    0.150000] usbcore: registered new interface driver usbfs
    [    0.150000] usbcore: registered new interface driver hub
    [    0.150000] usbcore: registered new device driver usb
    [    0.150000] at91_i2c f0014000.i2c: using dma0chan0 (tx) and dma0chan1 (rx) for DMA transfers
    [    0.160000] at91_i2c f0014000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f0018000.i2c: using dma0chan2 (tx) and dma0chan3 (rx) for DMA transfers
    [    0.160000] at91_i2c f0018000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f801c000.i2c: can't get a DMA channel for tx
    [    0.160000] at91_i2c f801c000.i2c: can't use DMA
    [    0.160000] at91_i2c f801c000.i2c: AT91 i2c bus driver.
    [    0.170000] pps_core: LinuxPPS API ver. 1 registered
    [    0.170000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.170000] PTP clock support registered
    [    0.170000] Bluetooth: Core ver 2.19
    [    0.170000] NET: Registered protocol family 31
    [    0.170000] Bluetooth: HCI device and connection manager initialized
    [    0.170000] Bluetooth: HCI socket layer initialized
    [    0.170000] Bluetooth: L2CAP socket layer initialized
    [    0.170000] Bluetooth: SCO socket layer initialized
    [    0.170000] Switched to clocksource tcb_clksrc
    [    0.210000] NET: Registered protocol family 2
    [    0.210000] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.210000] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.210000] TCP: Hash tables configured (established 2048 bind 2048)
    [    0.210000] TCP: reno registered
    [    0.210000] UDP hash table entries: 256 (order: 0, 4096 bytes)
    [    0.210000] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
    [    0.210000] NET: Registered protocol family 1
    [    0.210000] futex hash table entries: 256 (order: -1, 3072 bytes)
    [    0.210000] msgmni has been set to 496
    [    0.220000] NET: Registered protocol family 38
    [    0.220000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
    [    0.220000] io scheduler noop registered (default)
    [    0.220000] f001c000.serial: ttyS1 at MMIO 0xf001c000 (irq = 30, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.220000] f0020000.serial: ttyS2 at MMIO 0xf0020000 (irq = 31, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.230000] f8020000.serial: ttyS3 at MMIO 0xf8020000 (irq = 38, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.240000] ffffee00.serial: ttyS0 at MMIO 0xffffee00 (irq = 44, base_baud = 8250000) is a ATMEL_SERIAL
    [    0.720000] console [ttyS0] enabled
    [    0.730000] f0024000.serial: ttyS5 at MMIO 0xf0024000 (irq = 54, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.740000] [drm] Initialized drm 1.1.0 20060810
    [    0.750000] brd: module loaded
    [    0.760000] loop: module loaded
    [    0.760000] zram: Created 1 device(s) ...
    [    0.770000] atmel_nand_nfc 70000000.nfc: NFC is probed.
    [    0.780000] atmel_nand 60000000.nand: Use On Flash BBT
    [    0.780000] atmel_nand 60000000.nand: Using dma0chan4 for DMA transfers.
    [    0.800000] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xdc
    [    0.800000] nand: Micron MT29F4G08ABADAWP
    [    0.810000] nand: 512MiB, SLC, page size: 2048, OOB size: 64
    [    0.810000] atmel_nand 60000000.nand: minimum ECC: 4 bits in 512 bytes
    [    0.820000] atmel_nand 60000000.nand: Initialize PMECC params, cap: 4, sector: 512
    [    0.830000] atmel_nand 60000000.nand: Using NFC Sram read
    [    0.830000] nand: WARNING: MT29F4G08ABADAWP: the ECC used on your system is too weak compared to the one required by the NAND chip
    [    0.840000] Bad block table found at page 262080, version 0x01
    [    0.850000] Bad block table found at page 262016, version 0x01
    [    0.860000] 6 ofpart partitions found on MTD device atmel_nand
    [    0.860000] Creating 6 MTD partitions on "atmel_nand":
    [    0.870000] 0x000000000000-0x000000040000 : "at91bootstrap"
    [    0.870000] 0x000000040000-0x0000000c0000 : "bootloader"
    [    0.880000] 0x0000000c0000-0x000000180000 : "bootloader env"
    [    0.890000] 0x000000180000-0x000000200000 : "device tree"
    [    0.900000] 0x000000200000-0x000000800000 : "kernel"
    [    0.910000] 0x000000800000-0x000010000000 : "rootfs"
    [    0.910000] atmel_spi f0004000.spi: version: 0x213
    [    0.920000] atmel_spi f0004000.spi: Using dma0chan5 (tx) and dma0chan6 (rx) for DMA transfers
    [    0.930000] atmel_spi f0004000.spi: Atmel SPI Controller at 0xf0004000 (irq 26)
    [    0.940000] atmel_spi f8008000.spi: version: 0x213
    [    0.940000] atmel_spi f8008000.spi: Using dma1chan0 (tx) and dma1chan1 (rx) for DMA transfers
    [    0.950000] atmel_spi f8008000.spi: Atmel SPI Controller at 0xf8008000 (irq 35)
    [    0.960000] PPP generic driver version 2.4.2
    [    0.970000] PPP BSD Compression module registered
    [    0.970000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [    0.980000] ehci-atmel: EHCI Atmel driver
    [    0.980000] atmel-ehci 700000.ehci: EHCI Host Controller
    [    0.990000] atmel-ehci 700000.ehci: new USB bus registered, assigned bus number 1
    [    1.000000] atmel-ehci 700000.ehci: irq 56, io mem 0x00700000
    [    1.020000] atmel-ehci 700000.ehci: USB 2.0 started, EHCI 1.00
    [    1.020000] hub 1-0:1.0: USB hub found
    [    1.030000] hub 1-0:1.0: 3 ports detected
    [    1.030000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [    1.040000] ohci-atmel: OHCI Atmel driver
    [    1.040000] at91_ohci 600000.ohci: OHCI Host Controller
    [    1.050000] at91_ohci 600000.ohci: new USB bus registered, assigned bus number 2
    [    1.060000] at91_ohci 600000.ohci: irq 56, io mem 0x00600000
    [    1.120000] hub 2-0:1.0: USB hub found
    [    1.120000] hub 2-0:1.0: 3 ports detected
    [    1.130000] usbcore: registered new interface driver cdc_acm
    [    1.140000] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
    [    1.140000] usbcore: registered new interface driver usb-storage
    [    1.150000] usbcore: registered new interface driver usbserial
    [    1.160000] usbcore: registered new interface driver usbserial_generic
    [    1.160000] usbserial: USB Serial support registered for generic
    [    1.170000] usbcore: registered new interface driver ftdi_sio
    [    1.180000] usbserial: USB Serial support registered for FTDI USB Serial Device
    [    1.180000] usbcore: registered new interface driver pl2303
    [    1.190000] usbserial: USB Serial support registered for pl2303
    [    1.190000] atmel_usba_udc 500000.gadget: MMIO registers at 0xf8030000 mapped at d08c8000
    [    1.200000] atmel_usba_udc 500000.gadget: FIFO at 0x00500000 mapped at d2200000
    [    1.210000] g_serial gadget: Gadget Serial v2.4
    [    1.220000] g_serial gadget: g_serial ready
    [    1.220000] rtc (null): invalid alarm value: 1900-1-1 0:2:30
    [    1.230000] at91_rtc fffffeb0.rtc: rtc core: registered fffffeb0.rtc as rtc0
    [    1.240000] at91_rtc fffffeb0.rtc: AT91 Real Time Clock driver.
    [    1.240000] i2c /dev entries driver
    [    1.250000] Bluetooth: HCI UART driver ver 2.2
    [    1.250000] Bluetooth: HCI H4 protocol initialized
    [    1.260000] usbcore: registered new interface driver btusb
    [    1.270000] atmel_aes f8038000.aes: version: 0x135
    [    1.270000] atmel_aes f8038000.aes: Atmel AES - Using dma1chan2, dma1chan3 for DMA transfers
    [    1.280000] atmel_sha f8034000.sha: version: 0x410
    [    1.290000] atmel_sha f8034000.sha: using dma1chan4 for DMA transfers
    [    1.290000] atmel_sha f8034000.sha: Atmel SHA1/SHA256/SHA224/SHA384/SHA512
    [    1.300000] atmel_tdes f803c000.tdes: version: 0x701
    [    1.310000] atmel_tdes f803c000.tdes: using dma1chan5, dma1chan6 for DMA transfers
    [    1.320000] atmel_tdes f803c000.tdes: Atmel DES/TDES
    [    1.320000] usbcore: registered new interface driver usbhid
    [    1.330000] usbhid: USB HID core driver
    [    1.330000] iio iio:device0: Resolution used: 12 bits
    [    1.340000] iio iio:device0: ADC Touch screen is disabled.
    [    1.350000] nf_conntrack version 0.5.0 (3974 buckets, 15896 max)
    [    1.350000] ip_tables: (C) 2000-2006 Netfilter Core Team
    [    1.360000] TCP: cubic registered
    [    1.360000] NET: Registered protocol family 10
    [    1.370000] sit: IPv6 over IPv4 tunneling driver
    [    1.370000] NET: Registered protocol family 17
    [    1.380000] Bridge firewalling registered
    [    1.380000] Bluetooth: RFCOMM TTY layer initialized
    [    1.390000] Bluetooth: RFCOMM socket layer initialized
    [    1.390000] Bluetooth: RFCOMM ver 1.11
    [    1.410000] registered taskstats version 1
    [    1.420000] input: gpio_keys as /devices/gpio_keys/input/input0
    [    1.420000] at91_rtc fffffeb0.rtc: setting system clock to 2007-01-01 00:02:39 UTC (1167609759)
    [    1.430000] atmel_mci f0000000.mmc: version: 0x505
    [    1.440000] atmel_mci f0000000.mmc: using dma0chan7 for DMA transfers
    [    1.440000] atmel_mci f0000000.mmc: No vmmc regulator found
    [    1.450000] atmel_mci f0000000.mmc: No vqmmc regulator found
    [    1.500000] atmel_mci f0000000.mmc: Atmel MCI controller at 0xf0000000 irq 25, 1 slots
    [    1.500000] atmel_mci f8000000.mmc: version: 0x505
    [    1.510000] atmel_mci f8000000.mmc: using dma1chan7 for DMA transfers
    [    1.520000] atmel_mci f8000000.mmc: No vmmc regulator found
    [    1.520000] atmel_mci f8000000.mmc: No vqmmc regulator found
    [    1.570000] atmel_mci f8000000.mmc: Atmel MCI controller at 0xf8000000 irq 33, 1 slots
    [    1.570000] atmel_mci f8004000.mmc: version: 0x505
    [    1.580000] atmel_mci f8004000.mmc: no DMA channel available
    [    1.580000] atmel_mci f8004000.mmc: using PIO
    [    1.590000] atmel_mci f8004000.mmc: No vqmmc regulator found
    [    1.630000] atmel_mci f8004000.mmc: Atmel MCI controller at 0xf8004000 irq 34, 1 slots
    [    1.640000] Waiting for root device /dev/mmcblk0p1...
    [    1.680000] mmc1: host does not support reading read-only switch. assuming write-enable.
    [    1.690000] mmc1: new high speed SDHC card at address 59b4
    [    1.700000] mmcblk0: mmc1:59b4 USDU1 14.9 GiB
    [    1.700000]  mmcblk0: p1 p2
    [    1.710000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [    1.730000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [    1.740000] mmc2: new high speed SDIO card at address 0001
    [    1.750000] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
    [    1.760000] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
    [    1.780000] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
    [    1.780000] VFS: Mounted root (ext4 filesystem) readonly on device 179:1.
    [    1.820000] devtmpfs: mounted
    [    1.820000] Freeing unused kernel memory: 148K (c04b0000 - c04d5000)
    [    2.010000] usb 2-3: new full-speed USB device number 2 using at91_ohci
    
    INIT: version 2.88 booting
    
    [    2.250000] ftdi_sio 2-3:1.0: FTDI USB Serial Device converter detected
    [    2.250000] usb 2-3: Detected FT232RL
    [    2.260000] usb 2-3: Number of endpoints 2
    [    2.260000] usb 2-3: Endpoint 1 MaxPacketSize 64
    [    2.260000] usb 2-3: Endpoint 2 MaxPacketSize 64
    [    2.270000] usb 2-3: Setting MaxPacketSize 64
    [    2.280000] usb 2-3: FTDI USB Serial Device converter now attached to ttyUSB0
    [info] Using makefile-style concurrent boot in runlevel S.
    [....] Starting the hotplug events dispatcher: udevd[    3.330000] udevd[711]: starting version 175
    . ok
    [    5.140000] VCC_1V8: 1800 mV hotplug events...
    [    5.510000] VCC_1V2: 1200 mV
    [    5.520000] VCC_3V3: 3300 mV
    [    5.540000] FUSE_2V5: 2500 mV
    [    5.550000] VDDANA: 3300 mV
    [    5.550000] LDO_REG3: at 600 mV
    [ ok [    5.650000] LDO_REG4: at 600 mV
    [    5.690000] random: nonblocking pool is initialized
                                                     [    5.740000] Loading modules backported from Linux version R8.6-0-g3f5b34f
    [    5.750000] Backport generated by backports.git R8.6SP1-0-g4677dc3
    done.
    [....] [    5.980000] cfg80211: Calling CRDA to update world regulatory domain
    Waiting for /dev to be fully populated...[    6.160000] wlcore: Time Sync: gpio requested
    [    6.260000] cfg80211: World regulatory domain updated:
    [    6.270000] cfg80211:  DFS Master region: unset
    [    6.270000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [    6.280000] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.290000] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.300000] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.310000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [    6.320000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [    6.320000] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [    6.330000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.340000] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    done.
    [ ok ] Activating swap...done.
    [    7.600000] EXT4-fs (mmcblk0p1): warning: mounting fs with errors, running e2fsck is recommended
    [    7.620000] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
    [ ok ] Cleaning up temporary files....
    [info] Loading kernel module g_serial.
    [ ok ] Activating lvm and md swap...done.
    [....] Checking file systems...fsck from util-linux 2.20.1
    done.
    [....] Mounting local filesystems...[   13.030000] FAT-fs (mmcblk0p2): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    done.
    [ ok ] Activating swapfile swap...done.
    [ ok ] Cleaning up temporary files....
    [ ok ] Setting kernel variables ...done.
    [....] Configuring network interfaces...Internet Systems Consortium DHCP Client 4.2.2
    Copyright 2004-2011 Internet Systems Consortium.
    All rights reserved.
    For info, please visit https://www.isc.org/software/dhcp/
    
    Cannot find device "wlan0"
    Bind socket to interface: No such device
    Failed to bring up wlan0.
    done.
    [ ok ] Cleaning up temporary files....
    UIM SYSFS Node Not Found
    
    INIT: Entering runlevel: 2
    
    [info] Using makefile-style concurrent boot in runlevel 2.
    [ ok ] Starting enhanced syslogd: rsyslogd.
    [ ok ] Starting periodic command scheduler: cron.
    [ ok ] Starting system message bus: dbus.
    [ ok ] Starting bluetooth: bluetoothd.
    [ ok ] Starting NTP server: ntpd.
    [ ok ] Starting OpenBSD Secure Shell server: sshd.
    Starting very small Busybox based DHCP server: Starting /usr/sbin/udhcpd...
    udhcpd.
    BT Enabled
    Charger Config
    Enabling TI Chip (/dev/ttyUSB0)
    Found a Texas Instruments' chip!
    Firmware file : /lib/firmware/ti-connectivity/TIInit_11.8.32.bts
    Loaded BTS script version 1
    [   33.750000] mmc2: card 0001 removed
    [   33.790000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [   33.810000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [   33.820000] mmc2: new high speed SDIO card at address 0001
    [   33.830000] wlcore: ERROR error requesting time_sync gpio
    [   33.830000] wlcore: ERROR can't allocate hw
    [   33.840000] wl18xx_driver: probe of wl18xx.0.auto failed with error -16
    Can't set device: Protocol not supported
    Can't initialize device: Protocol not supported
    Device setup complete
    Starting COHDA
    enabling COHDA module
    [   47.700000] usb 1-2: new high-speed USB device number 3 using atmel-ehci
    Downloading COHDA FW
    Downloading COHDA Firmware
    dfu-util 0.5
    
    (C) 2005-2008 by Weston Schmidt, Harald Welte and OpenMoko Inc.
    (C) 2010-2011 Tormod Volden (DfuSe support)
    This program is Free Software and has ABSOLUTELY NO WARRANTY
    
    dfu-util does currently only support DFU version 1.0
    
    Filter on vendor = 0x1fc9 product = 0x0102
    Opening DFU USB device... ID 1fc9:0102
    Deducing device DFU version from functional descriptor length
    Run-time device DFU version 0100
    Claiming USB DFU Runtime Interface...
    Determining device status: state = dfuIDLE, status = 0
    WARNING: Runtime device already in DFU state ?!?
    Found Runtime: [1fc9:0102] devnum=0, cfg=1, intf=0, alt=0, name="UNDEFINED"
    Claiming USB DFU Interface...
    Setting Alternate Setting #0 ...
    Determining device status: state = dfuIDLE, status = 0
    dfuIDLE, continuing
    Deducing device DFU version from functional descriptor length
    DFU mode device DFU version 0100
    Device returned transfer size 4096
    No valid DFU suffix signature
    Warning: File has no DFU suffix
    bytes_per_hash=7821
    Copying data from PC to DFU device
    Starting download: [##################################################] finished!
    state(8) = dfuMANIFEST-WAIT-RESET, status(0) = No error condition is present
    Done!
    can't detach
    Resetting USB to switch back to runtime mode
    [   63.410000] usb 1-2: reset high-speed USB device number 3 using atmel-ehci
    [   63.580000] usb 1-2: device firmware changed
    [   63.580000] usb 1-2: USB disconnect, device number 3
    [   63.720000] usb 1-2: new high-speed USB device number 4 using atmel-ehci
    Installing llc ko
    Installing cw-llc kernel module
    [   78.790000] LLC_USBOutReq: USB device not present
    [   78.800000] LLC_USBOutReq: USB device not present
    [   78.890000] LLC_USBInterfaceProbe: MKx now attached to cw-llc-1
    [   78.890000] usbcore: registered new interface driver cw-llc
    
    Debian GNU/Linux 7 OpenXC-VI-V2X-9589 ttyS0
    
    OpenXC-VI-V2X-9589 login: root
    
    Password:
    Last login: Mon Jan  1 01:06:22 CET 2007 on ttyS0
    Linux OpenXC-VI-V2X-9589 3.16.5-sama5-armv7-r8 #27 Mon Dec 14 17:34:00 PST 2015 armv7l
    
    The programs included with the Debian GNU/Linux system are free software;
    the exact distribution terms for each program are described in the
    individual files in /usr/share/doc/*/copyright.
    
    Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
    permitted by applicable law.
    ===>>> Missing WLAN0 interface.
    ===>>> Please restart your system !
    root@OpenXC-VI-V2X-9589:~# lsmod
    Module                  Size  Used by
    cw_llc                112900  0
    wl18xx                 65637  0
    wlcore                135969  1 wl18xx
    mac80211              292500  2 wl18xx,wlcore
    cfg80211              151065  3 mac80211,wl18xx,wlcore
    wlcore_sdio             5232  0
    compat                  7591  4 cfg80211,mac80211,wl18xx,wlcore_sdio
    act8865_regulator       3121  0
    regmap_i2c              1744  1 act8865_regulator
    uio_pdrv_genirq         2472  0
    root@OpenXC-VI-V2X-9589:~#
    
    

     

  • Hi Eyal,
    We also tried R8.7_SP1. Here we do not see the "wlcore: ERROR error requesting time_sync gpio" but we still see the rest of the errors mentioned earlier. IF you have additional insight -- that would be very helpful.
    Thanks,
    Asha
  • First of all it is good that you don't see the time_sync gpio error as it was trying to allocate a bogus gpio which is bad anyway.

    The card removed error should not be there. It means that the system interpreted the wlan_en off as a removal of the sdio card which is not the case. I think I have seen this before when was working with the atmel sama5d2-xplained. Can you check that you have the following patch in your kernel? If I recall correctly this has helped me with a similar issues:

    git.ti.com/.../0001-mmc-sdhci-restore-behavior-when-setting-VDD-via-exte.patch

    BR,
    Eyal
  • 1266 static void sdhci_set_power(struct sdhci_host *host, unsigned char mode,
    1267                             unsigned short vdd)
    1268 {
    1269         struct mmc_host *mmc = host->mmc;
    1270         u8 pwr = 0;
    1271 
    1272         if (!IS_ERR(mmc->supply.vmmc)) {
    1273                 spin_unlock_irq(&host->lock);
    1274                 mmc_regulator_set_ocr(mmc, mmc->supply.vmmc, vdd);
    1275                 spin_lock_irq(&host->lock);
    1276 
    1277                 if (mode != MMC_POWER_OFF)
    1278                         sdhci_writeb(host, SDHCI_POWER_ON, SDHCI_POWER_CONTROL);
    1279                 else
    1280                         sdhci_writeb(host, 0, SDHCI_POWER_CONTROL);
    1281 
    1282                 return;
    1283         }
    1284 
    1285         if (mode != MMC_POWER_OFF) {
    1286                 switch (1 << vdd) {
    1287                 case MMC_VDD_165_195:
    1288                         pwr = SDHCI_POWER_180;
    1289                         break;
    1290                 case MMC_VDD_29_30:
    1291                 case MMC_VDD_30_31:
    1292                         pwr = SDHCI_POWER_300;
    1293                         break;
    1294                 case MMC_VDD_32_33:
    1295                 case MMC_VDD_33_34:
    1296                         pwr = SDHCI_POWER_330;
    1297                         break;
    1298                 default:
    1299                         BUG();
    1300                 }
    1301         }
    1302 
    1303         if (host->pwr == pwr)
    1304                 return;
    1305 
    1306         host->pwr = pwr;
    1307 
    1308         if (pwr == 0) {
    1309                 sdhci_writeb(host, 0, SDHCI_POWER_CONTROL);
    1310                 if (host->quirks2 & SDHCI_QUIRK2_CARD_ON_NEEDS_BUS_ON)
    1311                         sdhci_runtime_pm_bus_off(host);
    1312                 vdd = 0;
    1313         } else {
    1314                 /*
    1315                  * Spec says that we should clear the power reg before setting
    1316                  * a new value. Some controllers don't seem to like this though.
    1317                  */
    1318                 if (!(host->quirks & SDHCI_QUIRK_SINGLE_POWER_WRITE))
    1319                         sdhci_writeb(host, 0, SDHCI_POWER_CONTROL);
    1320 
    1321                 /*
    1322                  * At least the Marvell CaFe chip gets confused if we set the
    1323                  * voltage and set turn on power at the same time, so set the
    1324                  * voltage first.
    1325                  */
    1326                 if (host->quirks & SDHCI_QUIRK_NO_SIMULT_VDD_AND_POWER)
    1327                         sdhci_writeb(host, pwr, SDHCI_POWER_CONTROL);
    1328 
    1329                 pwr |= SDHCI_POWER_ON;
    1330 
    1331                 sdhci_writeb(host, pwr, SDHCI_POWER_CONTROL);
    1332 
    1333                 if (host->quirks2 & SDHCI_QUIRK2_CARD_ON_NEEDS_BUS_ON)
    1334                         sdhci_runtime_pm_bus_on(host);
    1335 
    1336                 /*
    1337                  * Some controllers need an extra 10ms delay of 10ms before
    1338                  * they can apply clock after applying power
    1339                  */
    1340                 if (host->quirks & SDHCI_QUIRK_DELAY_AFTER_POWER)
    1341                         mdelay(10);
    1342         }
    1343 }
    1344 
    static void sdhci_set_power(struct sdhci_host *host, unsigned char mode,
    1224                             unsigned short vdd)
    1225 {
    1226         u8 pwr = 0;
    1227 
    1228         if (mode != MMC_POWER_OFF) {
    1229                 switch (1 << vdd) {
    1230                 case MMC_VDD_165_195:
    1231                         pwr = SDHCI_POWER_180;
    1232                         break;
    1233                 case MMC_VDD_29_30:
    1234                 case MMC_VDD_30_31:
    1235                         pwr = SDHCI_POWER_300;
    1236                         break;
    1237                 case MMC_VDD_32_33:
    1238                 case MMC_VDD_33_34:
    1239                         pwr = SDHCI_POWER_330;
    1240                         break;
    1241                 default:
    1242                         BUG();
    1243                 }
    1244         }
    1245 
    1246         if (host->pwr == pwr)
    1247                 return;
    1248 
    1249         host->pwr = pwr;
    1250 
    1251         if (pwr == 0) {
    1252                 sdhci_writeb(host, 0, SDHCI_POWER_CONTROL);
    1253                 if (host->quirks2 & SDHCI_QUIRK2_CARD_ON_NEEDS_BUS_ON)
    1254                         sdhci_runtime_pm_bus_off(host);
    1255                 vdd = 0;
    1256         } else {
    1257                 /*
    1258                  * Spec says that we should clear the power reg before setting
    1259                  * a new value. Some controllers don't seem to like this though.
    1260                  */
    1261                 if (!(host->quirks & SDHCI_QUIRK_SINGLE_POWER_WRITE))
    1262                         sdhci_writeb(host, 0, SDHCI_POWER_CONTROL);
    1263 
    1264                 /*
    1265                  * At least the Marvell CaFe chip gets confused if we set the
    1266                  * voltage and set turn on power at the same time, so set the
    1267                  * voltage first.
    1268                  */
    1269                 if (host->quirks & SDHCI_QUIRK_NO_SIMULT_VDD_AND_POWER)
    1270                         sdhci_writeb(host, pwr, SDHCI_POWER_CONTROL);
    1271 
    1272                 pwr |= SDHCI_POWER_ON;
    1273 
    1274                 sdhci_writeb(host, pwr, SDHCI_POWER_CONTROL);
    1275 
    1276                 if (host->quirks2 & SDHCI_QUIRK2_CARD_ON_NEEDS_BUS_ON)
    1277                         sdhci_runtime_pm_bus_on(host);
    1278 
    1279                 /*
    1280                  * Some controllers need an extra 10ms delay of 10ms before
    1281                  * they can apply clock after applying power
    1282                  */
    1283                 if (host->quirks & SDHCI_QUIRK_DELAY_AFTER_POWER)
    1284                         mdelay(10);
    1285         }
    1286 
    1287         if (host->vmmc) {
    1288                 spin_unlock_irq(&host->lock);
    1289                 mmc_regulator_set_ocr(host->mmc, host->vmmc, vdd);
    1290                 spin_lock_irq(&host->lock);
    1291         }
    1292 }
    1293 
    Hi Eyal,

    So this patch that you mention is for Kernel 4.1.  We are using Kernel 3.16.5

    It seems the patch is for sdhci_set_power() in file sdhci.c

    I looked at the changes and it seems that the patch kind of is there for 3.16.5

    I am attaching 2 text files that has sdhci_set_power().  

    K4.1.txt is for kernel 4.1 and you can see below that the mentioned patch is not there because it is not at end of function.

              if (!IS_ERR(mmc->supply.vmmc)) {

                    spin_unlock_irq(&host->lock);

                    mmc_regulator_set_ocr(mmc, mmc->supply.vmmc, vdd);

                    spin_lock_irq(&host->lock);

                    if (mode != MMC_POWER_OFF)

                            sdhci_writeb(host, SDHCI_POWER_ON, SDHCI_POWER_CONTROL);

                    else

                            sdhci_writeb(host, 0, SDHCI_POWER_CONTROL);

                    return;

            }

    K3.16.4.txt is for kernel 3.16.5 and the patch is there

              if (host->vmmc) {

                    spin_unlock_irq(&host->lock);

                   mmc_regulator_set_ocr(host->mmc, host->vmmc, vdd);

                    spin_lock_irq(&host->lock);

            }

    Am I thinking correct?

    Thanks,

    Asha

  • Hi,

    There are other differences in this function between 4.1 and 3.16.
    I suggest adding some debug prints into this function and also checking the logic that lead to the "card 0001 removed" message and try to avoid it from happening.
    Just to verify, you do have the following in your .dts file, right?

    + keep-power-in-suspend;
    + non-removable;

    BR,
    Eyal
  • Hi Eyal,

    I have reverted to R8.6 because this is a customer issue and we did not want additional changes.

    I have added printfs in( sdhci_set_power(), file sdhci.c)this function but I never see them.
    I have also added printfs in bus.c where the "card 0001 removed" is actually detected I bus.c, function mmc_remove_card() and below is what my printfs show.

    In dd.c, function really_probe(), the call pinctrl_bind_pins(dev) returns error -19 as well as call
    to pinctrl_bind_pins(dev) returns -19

    Also note that we do have the below in our dts file
    + keep-power-in-suspend;
    + non-removable;

    =========================================================

    [ 34.000000] mmc2: bus.c AAA 1 card 0001 removed
    [ 34.040000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [ 34.060000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [ 34.070000] mmc2: new high speed SDIO card at address 0001
    [ 34.070000] dd.c AAA 3 bus=mmc,drv=mmcblk,dev=mmc2:0001,err=-19
    [ 34.090000] dd.c AAA 3 bus=sdio,drv=wl1271_sdio,dev=mmc2:0001:1,err=-19
    [ 34.100000] wlcore: ERROR error requesting time_sync gpio
    [ 34.100000] wlcore: ERROR can't allocate hw
    [ 34.110000] dd.c AAA 4 bus=platform,drv=wl18xx_driver,dev=wl18xx.0.auto,err=-16
    [ 34.110000] wl18xx_driver: dd.c AAA 5 probe of wl18xx.0.auto failed with error -16


    Additional help would be appreciated.
    Thanks,
    Asha
  • hi ,.
    - R8.7_SP1 is latest driver release and it is recommended you update to latest driver
    - enabled MMC_DEBUG logs in kernel
    - share complete kernel logs
    - share your dts file

    Saurabh
  • Hi Saurabh, 

    I am working alongside with Asha on this issue. Updating the driver to R8.7 does not solve any issues, if anything it might bring more up. 

    Below please find the the complete kernel log for when the wlan0 does not initialize correctly, and the at91-sama5d3_xplained.dts file. 

    RomBOOT


    AT91Bootstrap 3.6.1-00078-g5415d4e (Tue Feb 4 15:36:46 CET 2014)

    NAND: ONFI flash detected
    NAND: Manufacturer ID: 0x2c Chip ID: 0x34
    NAND: Disable On-Die ECC
    NAND: Initialize PMECC params, cap: 0x4, sector: 0x200
    NAND: Image: Copy 0x80000 bytes from 0x40000 to 0x26f00000
    NAND: Done to load image


    U-Boot 2013.07 (Feb 04 2014 - 15:36:32)

    CPU: SAMA5D31
    Crystal frequency: 12 MHz
    CPU clock : 528 MHz
    Master clock : 132 MHz
    DRAM: 256 MiB
    NAND: 512 MiB
    MMC: mci: 0, mci: 1
    In: serial
    Out: serial
    Err: serial
    Net: miiphy_register: non unique device name 'macb0'
    macb0
    Warning: failed to set MAC address
    , macb0
    Warning: failed to set MAC address

    Hit any key to stop autoboot: 1 0

    NAND read: device 0 offset 0x180000, size 0x8673
    34419 bytes read: OK

    NAND read: device 0 offset 0x200000, size 0x355df8
    3497464 bytes read: OK
    Kernel image @ 0x22000000 [ 0x000000 - 0x355df8 ]
    ## Flattened Device Tree blob at 21000000
    Booting using the fdt blob at 0x21000000
    Loading Device Tree to 2bb0f000, end 2bb1a672 ... OK

    Starting kernel ...

    Uncompressing Linux... done, booting the kernel.
    [ 0.000000] Booting Linux on physical CPU 0x0
    [ 0.000000] Linux version 3.16.5-sama5-armv7-r8 (root@john-VirtualBox) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #28 Wed Oct 12 10:53:08 PDT 2016
    [ 0.000000] CPU: ARMv7 Processor [410fc051] revision 1 (ARMv7), cr=50c53c7d
    [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [ 0.000000] Machine model: SAMA5D3 Xplained
    [ 0.000000] Memory policy: Data cache writeback
    [ 0.000000] AT91: Detected soc type: sama5d3
    [ 0.000000] AT91: Detected soc subtype: sama5d31
    [ 0.000000] AT91: sram at 0x300000 of 0x20000 mapped at 0xfef58000
    [ 0.000000] CPU: All CPU(s) started in SVC mode.
    [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 65024
    [ 0.000000] Kernel command line: console=ttyS0,115200 mem=256M mmcrootfstype=ext4 root=/dev/mmcblk0p1 r rootwait
    [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
    [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
    [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
    [ 0.000000] Memory: 254388K/262144K available (3315K kernel code, 202K rwdata, 1460K rodata, 149K init, 159K bss, 7756K reserved)
    [ 0.000000] Virtual kernel memory layout:
    [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
    [ 0.000000] fixmap : 0xffc00000 - 0xffe00000 (2048 kB)
    [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB)
    [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB)
    [ 0.000000] modules : 0xbf800000 - 0xc0000000 ( 8 MB)
    [ 0.000000] .text : 0xc0008000 - 0xc04b1f64 (4776 kB)
    [ 0.000000] .init : 0xc04b2000 - 0xc04d7424 ( 150 kB)
    [ 0.000000] .data : 0xc04d8000 - 0xc050a820 ( 203 kB)
    [ 0.000000] .bss : 0xc050a820 - 0xc0532710 ( 160 kB)
    [ 0.000000] NR_IRQS:16 nr_irqs:16 16
    [ 0.000000] sched_clock: 32 bits at 100 Hz, resolution 10000000ns, wraps every 21474836480000000ns
    [ 0.000000] Console: colour dummy device 80x30
    [ 0.050000] Calibrating delay loop... 351.43 BogoMIPS (lpj=1757184)
    [ 0.060000] pid_max: default: 32768 minimum: 301
    [ 0.060000] Security Framework initialized
    [ 0.060000] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [ 0.060000] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [ 0.060000] CPU: Testing write buffer coherency: ok
    [ 0.060000] Setting up static identity map for 0x2031e508 - 0x2031e554
    [ 0.060000] devtmpfs: initialized
    [ 0.060000] VFP support v0.3: implementor 41 architecture 2 part 30 variant 5 rev 1
    [ 0.060000] pinctrl core: initialized pinctrl subsystem
    [ 0.060000] regulator-dummy: no parameters
    [ 0.080000] NET: Registered protocol family 16
    [ 0.080000] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [ 0.090000] No ATAGs?
    [ 0.090000] AT91: Power Management
    [ 0.100000] gpio-at91 fffff200.gpio: at address fefff200
    [ 0.100000] gpio-at91 fffff400.gpio: at address fefff400
    [ 0.100000] gpio-at91 fffff600.gpio: at address fefff600
    [ 0.100000] gpio-at91 fffff800.gpio: at address fefff800
    [ 0.100000] gpio-at91 fffffa00.gpio: at address fefffa00
    [ 0.100000] pinctrl-at91 ahb:apb:pinctrl@fffff200: initialized AT91 pinctrl driver
    [ 0.150000] at_hdmac ffffe600.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [ 0.150000] at_hdmac ffffe800.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [ 0.150000] wlan-en-regulator: 1800 mV
    [ 0.150000] SCSI subsystem initialized
    [ 0.150000] usbcore: registered new interface driver usbfs
    [ 0.150000] usbcore: registered new interface driver hub
    [ 0.160000] usbcore: registered new device driver usb
    [ 0.160000] at91_i2c f0014000.i2c: using dma0chan0 (tx) and dma0chan1 (rx) for DMA transfers
    [ 0.160000] at91_i2c f0014000.i2c: AT91 i2c bus driver.
    [ 0.160000] at91_i2c f0018000.i2c: using dma0chan2 (tx) and dma0chan3 (rx) for DMA transfers
    [ 0.160000] at91_i2c f0018000.i2c: AT91 i2c bus driver.
    [ 0.160000] at91_i2c f801c000.i2c: can't get a DMA channel for tx
    [ 0.160000] at91_i2c f801c000.i2c: can't use DMA
    [ 0.160000] at91_i2c f801c000.i2c: AT91 i2c bus driver.
    [ 0.160000] pps_core: LinuxPPS API ver. 1 registered
    [ 0.160000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [ 0.160000] PTP clock support registered
    [ 0.170000] Bluetooth: Core ver 2.19
    [ 0.170000] NET: Registered protocol family 31
    [ 0.170000] Bluetooth: HCI device and connection manager initialized
    [ 0.170000] Bluetooth: HCI socket layer initialized
    [ 0.170000] Bluetooth: L2CAP socket layer initialized
    [ 0.170000] Bluetooth: SCO socket layer initialized
    [ 0.170000] Switched to clocksource tcb_clksrc
    [ 0.200000] NET: Registered protocol family 2
    [ 0.200000] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
    [ 0.200000] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
    [ 0.200000] TCP: Hash tables configured (established 2048 bind 2048)
    [ 0.200000] TCP: reno registered
    [ 0.200000] UDP hash table entries: 256 (order: 0, 4096 bytes)
    [ 0.200000] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
    [ 0.200000] NET: Registered protocol family 1
    [ 0.210000] futex hash table entries: 256 (order: -1, 3072 bytes)
    [ 0.220000] msgmni has been set to 496
    [ 0.220000] NET: Registered protocol family 38
    [ 0.220000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
    [ 0.220000] io scheduler noop registered (default)
    [ 0.230000] f001c000.serial: ttyS1 at MMIO 0xf001c000 (irq = 30, base_baud = 4125000) is a ATMEL_SERIAL
    [ 0.230000] f0020000.serial: ttyS2 at MMIO 0xf0020000 (irq = 31, base_baud = 4125000) is a ATMEL_SERIAL
    [ 0.230000] f8020000.serial: ttyS3 at MMIO 0xf8020000 (irq = 38, base_baud = 4125000) is a ATMEL_SERIAL
    [ 0.230000] ffffee00.serial: ttyS0 at MMIO 0xffffee00 (irq = 44, base_baud = 8250000) is a ATMEL_SERIAL
    [ 0.720000] console [ttyS0] enabled
    [ 0.720000] f0024000.serial: ttyS5 at MMIO 0xf0024000 (irq = 54, base_baud = 4125000) is a ATMEL_SERIAL
    [ 0.730000] [drm] Initialized drm 1.1.0 20060810
    [ 0.740000] brd: module loaded
    [ 0.760000] loop: module loaded
    [ 0.760000] zram: Created 1 device(s) ...
    [ 0.770000] atmel_nand_nfc 70000000.nfc: NFC is probed.
    [ 0.780000] atmel_nand 60000000.nand: Use On Flash BBT
    [ 0.780000] atmel_nand 60000000.nand: Using dma0chan4 for DMA transfers.
    [ 0.790000] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xdc
    [ 0.800000] nand: Micron MT29F4G08ABADAWP
    [ 0.800000] nand: 512MiB, SLC, page size: 2048, OOB size: 64
    [ 0.810000] atmel_nand 60000000.nand: minimum ECC: 4 bits in 512 bytes
    [ 0.810000] atmel_nand 60000000.nand: Initialize PMECC params, cap: 4, sector: 512
    [ 0.820000] atmel_nand 60000000.nand: Using NFC Sram read
    [ 0.820000] nand: WARNING: MT29F4G08ABADAWP: the ECC used on your system is too weak compared to the one required by the NAND chip
    [ 0.830000] Bad block table found at page 262080, version 0x01
    [ 0.840000] Bad block table found at page 262016, version 0x01
    [ 0.840000] 6 ofpart partitions found on MTD device atmel_nand
    [ 0.850000] Creating 6 MTD partitions on "atmel_nand":
    [ 0.850000] 0x000000000000-0x000000040000 : "at91bootstrap"
    [ 0.860000] 0x000000040000-0x0000000c0000 : "bootloader"
    [ 0.870000] 0x0000000c0000-0x000000180000 : "bootloader env"
    [ 0.880000] 0x000000180000-0x000000200000 : "device tree"
    [ 0.880000] 0x000000200000-0x000000800000 : "kernel"
    [ 0.890000] 0x000000800000-0x000010000000 : "rootfs"
    [ 0.900000] atmel_spi f0004000.spi: version: 0x213
    [ 0.910000] atmel_spi f0004000.spi: Using dma0chan5 (tx) and dma0chan6 (rx) for DMA transfers
    [ 0.920000] atmel_spi f0004000.spi: Atmel SPI Controller at 0xf0004000 (irq 26)
    [ 0.920000] atmel_spi f8008000.spi: version: 0x213
    [ 0.930000] atmel_spi f8008000.spi: Using dma1chan0 (tx) and dma1chan1 (rx) for DMA transfers
    [ 0.940000] atmel_spi f8008000.spi: Atmel SPI Controller at 0xf8008000 (irq 35)
    [ 0.950000] PPP generic driver version 2.4.2
    [ 0.950000] PPP BSD Compression module registered
    [ 0.960000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [ 0.960000] ehci-atmel: EHCI Atmel driver
    [ 0.970000] atmel-ehci 700000.ehci: EHCI Host Controller
    [ 0.970000] atmel-ehci 700000.ehci: new USB bus registered, assigned bus number 1
    [ 0.980000] atmel-ehci 700000.ehci: irq 56, io mem 0x00700000
    [ 1.010000] atmel-ehci 700000.ehci: USB 2.0 started, EHCI 1.00
    [ 1.010000] hub 1-0:1.0: USB hub found
    [ 1.020000] hub 1-0:1.0: 3 ports detected
    [ 1.020000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [ 1.030000] ohci-atmel: OHCI Atmel driver
    [ 1.030000] at91_ohci 600000.ohci: OHCI Host Controller
    [ 1.040000] at91_ohci 600000.ohci: new USB bus registered, assigned bus number 2
    [ 1.050000] at91_ohci 600000.ohci: irq 56, io mem 0x00600000
    [ 1.110000] hub 2-0:1.0: USB hub found
    [ 1.110000] hub 2-0:1.0: 3 ports detected
    [ 1.120000] usbcore: registered new interface driver cdc_acm
    [ 1.130000] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
    [ 1.130000] usbcore: registered new interface driver usb-storage
    [ 1.140000] usbcore: registered new interface driver usbserial
    [ 1.150000] usbcore: registered new interface driver usbserial_generic
    [ 1.150000] usbserial: USB Serial support registered for generic
    [ 1.160000] usbcore: registered new interface driver ftdi_sio
    [ 1.170000] usbserial: USB Serial support registered for FTDI USB Serial Device
    [ 1.170000] usbcore: registered new interface driver pl2303
    [ 1.180000] usbserial: USB Serial support registered for pl2303
    [ 1.180000] atmel_usba_udc 500000.gadget: MMIO registers at 0xf8030000 mapped at d08c8000
    [ 1.190000] atmel_usba_udc 500000.gadget: FIFO at 0x00500000 mapped at d2200000
    [ 1.200000] g_serial gadget: Gadget Serial v2.4
    [ 1.210000] g_serial gadget: g_serial ready
    [ 1.210000] rtc (null): invalid alarm value: 1900-1-2 14:55:12
    [ 1.220000] at91_rtc fffffeb0.rtc: rtc core: registered fffffeb0.rtc as rtc0
    [ 1.230000] at91_rtc fffffeb0.rtc: AT91 Real Time Clock driver.
    [ 1.230000] i2c /dev entries driver
    [ 1.240000] Bluetooth: HCI UART driver ver 2.2
    [ 1.240000] Bluetooth: HCI H4 protocol initialized
    [ 1.250000] usbcore: registered new interface driver btusb
    [ 1.250000] atmel_aes f8038000.aes: version: 0x135
    [ 1.260000] atmel_aes f8038000.aes: Atmel AES - Using dma1chan2, dma1chan3 for DMA transfers
    [ 1.270000] atmel_sha f8034000.sha: version: 0x410
    [ 1.280000] atmel_sha f8034000.sha: using dma1chan4 for DMA transfers
    [ 1.280000] atmel_sha f8034000.sha: Atmel SHA1/SHA256/SHA224/SHA384/SHA512
    [ 1.290000] atmel_tdes f803c000.tdes: version: 0x701
    [ 1.300000] atmel_tdes f803c000.tdes: using dma1chan5, dma1chan6 for DMA transfers
    [ 1.310000] atmel_tdes f803c000.tdes: Atmel DES/TDES
    [ 1.310000] usbcore: registered new interface driver usbhid
    [ 1.320000] usbhid: USB HID core driver
    [ 1.320000] iio iio:device0: Resolution used: 12 bits
    [ 1.330000] iio iio:device0: ADC Touch screen is disabled.
    [ 1.340000] nf_conntrack version 0.5.0 (3974 buckets, 15896 max)
    [ 1.340000] ip_tables: (C) 2000-2006 Netfilter Core Team
    [ 1.350000] TCP: cubic registered
    [ 1.350000] NET: Registered protocol family 10
    [ 1.360000] sit: IPv6 over IPv4 tunneling driver
    [ 1.360000] NET: Registered protocol family 17
    [ 1.370000] Bridge firewalling registered
    [ 1.370000] Bluetooth: RFCOMM TTY layer initialized
    [ 1.380000] Bluetooth: RFCOMM socket layer initialized
    [ 1.380000] Bluetooth: RFCOMM ver 1.11
    [ 1.400000] registered taskstats version 1
    [ 1.400000] input: gpio_keys as /devices/gpio_keys/input/input0
    [ 1.410000] at91_rtc fffffeb0.rtc: setting system clock to 2007-01-02 14:56:07 UTC (1167749767)
    [ 1.420000] atmel_mci f0000000.mmc: version: 0x505
    [ 1.420000] atmel_mci f0000000.mmc: using dma0chan7 for DMA transfers
    [ 1.430000] atmel_mci f0000000.mmc: No vmmc regulator found
    [ 1.440000] atmel_mci f0000000.mmc: No vqmmc regulator found
    [ 1.480000] atmel_mci f0000000.mmc: Atmel MCI controller at 0xf0000000 irq 25, 1 slots
    [ 1.480000] atmel_mci f8000000.mmc: version: 0x505
    [ 1.490000] atmel_mci f8000000.mmc: using dma1chan7 for DMA transfers
    [ 1.500000] atmel_mci f8000000.mmc: No vmmc regulator found
    [ 1.500000] atmel_mci f8000000.mmc: No vqmmc regulator found
    [ 1.510000] mmc0: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [ 1.520000] mmc0: mmc_rescan_try_freq: trying to init card at 300000 Hz
    [ 1.550000] atmel_mci f8000000.mmc: Atmel MCI controller at 0xf8000000 irq 33, 1 slots
    [ 1.550000] atmel_mci f8004000.mmc: version: 0x505
    [ 1.560000] atmel_mci f8004000.mmc: no DMA channel available
    [ 1.560000] atmel_mci f8004000.mmc: using PIO
    [ 1.570000] atmel_mci f8004000.mmc: No vqmmc regulator found
    [ 1.590000] mmc0: mmc_rescan_try_freq: trying to init card at 257813 Hz
    [ 1.610000] atmel_mci f8004000.mmc: Atmel MCI controller at 0xf8004000 irq 34, 1 slots
    [ 1.620000] Waiting for root device /dev/mmcblk0p1...
    [ 1.640000] mmc1: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [ 1.920000] mmc1: host does not support reading read-only switch. assuming write-enable.
    [ 1.930000] mmc1: new high speed SDHC card at address 59b4
    [ 1.940000] mmcblk0: mmc1:59b4 USDU1 14.9 GiB
    [ 1.950000] mmcblk0: p1 p2
    [ 1.950000] mmc2: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [ 1.970000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [ 2.000000] usb 2-3: new full-speed USB device number 2 using at91_ohci
    [ 2.010000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [ 2.020000] mmc2: new high speed SDIO card at address 0001
    [ 2.060000] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
    [ 2.070000] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
    [ 2.090000] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
    [ 2.100000] VFS: Mounted root (ext4 filesystem) readonly on device 179:1.
    [ 2.130000] devtmpfs: mounted
    [ 2.130000] Freeing unused kernel memory: 148K (c04b2000 - c04d7000)
    [ 2.230000] ftdi_sio 2-3:1.0: FTDI USB Serial Device converter detected
    [ 2.240000] usb 2-3: Detected FT232RL
    [ 2.240000] usb 2-3: Number of endpoints 2
    [ 2.250000] usb 2-3: Endpoint 1 MaxPacketSize 64
    [ 2.250000] usb 2-3: Endpoint 2 MaxPacketSize 64
    [ 2.260000] usb 2-3: Setting MaxPacketSize 64
    [ 2.270000] usb 2-3: FTDI USB Serial Device converter now attached to ttyUSB0
    INIT: version 2.88 booting
    [info] Using makefile-style concurrent boot in runlevel S.
    [....] Starting the hotplug events dispatcher: udevd[ 3.760000] udevd[711]: starting version 175
    [ ok .
    [....] Synthesizing the initial hotplug events...[ ok [ 5.310000] VCC_1V8: 1800 mV
    [ 5.320000] VCC_1V2: 1200 mV
    [ 5.320000] VCC_3V3: 3300 mV
    [ 5.330000] FUSE_2V5: 2500 mV
    [ 5.330000] VDDANA: 3300 mV
    [ 5.340000] LDO_REG3: at 600 mV
    [ 5.340000] LDO_REG4: at 600 mV
    done.
    [ 6.270000] random: nonblocking pool is initialized
    [ 6.350000] Loading modules backported from Linux version R8.6-0-g3f5b34f
    [ 6.350000] Backport generated by backports.git R8.6SP1-0-g4677dc3
    [....] Waiting for /dev to be fully populated...[ 6.540000] cfg80211: Calling CRDA to update world regulatory domain
    [ 6.790000] wlcore: Time Sync: gpio requested
    [ 6.860000] wlcore: ERROR could not get configuration binary ti-connectivity/wl18xx-conf.bin: -2
    [ 6.870000] wlcore: WARNING falling back to default config
    [ 6.900000] mmc2: mmc_power_restore_host: powering up
    [ 6.970000] cfg80211: World regulatory domain updated:
    [ 6.970000] cfg80211: DFS Master region: unset
    [ 6.980000] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [ 6.990000] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [ 7.000000] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [ 7.000000] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [ 7.010000] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [ 7.020000] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [ 7.030000] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [ 7.040000] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [ 7.050000] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    [ ok done.
    [....] Activating swap...[ ok done.
    [ 8.480000] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
    [....] Cleaning up temporary files...[ ok .
    [info] Loading kernel module g_serial.
    [....] Activating lvm and md swap...[ ok done.
    [....] Checking file systems...fsck from util-linux 2.20.1
    [ ok done.
    [....] Mounting local filesystems...[ 13.920000] FAT-fs (mmcblk0p2): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [ ok done.
    [....] Activating swapfile swap...[ ok done.
    [....] Root filesystem has insufficient free space; mounting tmpfs on /tmp ...[warn (warning).
    [....] Cleaning up temporary files...[ ok .
    [....] Setting kernel variables ...[ ok done.
    [....] Configuring network interfaces...[ ok done.
    [....] Cleaning up temporary files...[ ok .
    UIM SYSFS Node Not Found
    INIT: Entering runlevel: 2
    [info] Using makefile-style concurrent boot in runlevel 2.
    dmesg: write failed: No space left on device
    [....] Starting enhanced syslogd: rsyslogd[ ok .
    [....] Starting periodic command scheduler: cron[ ok .
    [....] Starting system message bus: dbus[ ok .
    [....] Starting bluetooth: bluetoothd[ ok .
    [....] Starting NTP server: ntpd[ ok .
    [....] Starting OpenBSD Secure Shell server: sshd[ ok .
    Starting very small Busybox based DHCP server: Starting /usr/sbin/udhcpd...
    udhcpd.
    BT Enabled
    Charger Config
    Enabling TI Chip (/dev/ttyUSB0)
    Found a Texas Instruments' chip!
    Firmware file : /lib/firmware/ti-connectivity/TIInit_11.8.32.bts
    Loaded BTS script version 1
    Can't set device: Protocol not supported
    Can't initialize device: Protocol not supported
    Device setup complete
    Starting COHDA
    enabling COHDA module
    Downloading COHDA FW
    Downloading COHDA Firmware
    dfu-util 0.5

    (C) 2005-2008 by Weston Schmidt, Harald Welte and OpenMoko Inc.
    (C) 2010-2011 Tormod Volden (DfuSe support)
    This program is Free Software and has ABSOLUTELY NO WARRANTY

    dfu-util does currently only support DFU version 1.0

    Filter on vendor = 0x1fc9 product = 0x0102
    No DFU capable USB device found
    Installing llc ko
    Installing cw-llc kernel module
    [ 74.270000] LLC_USBOutReq: USB device not present
    [ 74.270000] LLC_USBOutReq: USB device not present
    [ 74.370000] usbcore: registered new interface driver cw-llc

    Debian GNU/Linux 7 OpenXC-VI-V2X-9327 ttyS0

    OpenXC-VI-V2X-9327 login: root
    Password:
    Last login: Tue Jan 2 15:53:01 CET 2007 on ttyS0
    Linux OpenXC-VI-V2X-9327 3.16.5-sama5-armv7-r8 #28 Wed Oct 12 10:53:08 PDT 2016 armv7l

    The programs included with the Debian GNU/Linux system are free software;
    the exact distribution terms for each program are described in the
    individual files in /usr/share/doc/*/copyright.

    Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
    permitted by applicable law.
    ===>>> Missing WLAN0 interface.
    ===>>> Please restart your system !
    root@OpenXC-VI-V2X-9327:~#

    /*
     * at91-sama5d3_xplained.dts - Device Tree file for the SAMA5D3 Xplained board
     *
     *  Copyright (C) 2014 Atmel,
     *		  2014 Nicolas Ferre <nicolas.ferre@atmel.com>
     *
     * Licensed under GPLv2 or later.
     */
    /dts-v1/;
    #include "sama5d36.dtsi"
    
    / {
    	model = "SAMA5D3 Xplained";
    	compatible = "atmel,sama5d3-xplained", "atmel,sama5d3", "atmel,sama5";
    
    	chosen {
    		bootargs = "console=ttyS0,115200";
    	};
    
    	memory {
    		reg = <0x20000000 0x10000000>;
    	};
    
    	slow_xtal {
    		clock-frequency = <32768>;
    	};
    
    	main_xtal {
    		clock-frequency = <12000000>;
    	};
    
    	ahb {
    		apb {
    			mmc0: mmc@f0000000 {
    				pinctrl-0 = <&pinctrl_mmc0_clk_cmd_dat0 &pinctrl_mmc0_dat1_3 &pinctrl_mmc0_dat4_7 &pinctrl_mmc0_cd>;
    				status = "okay";
    				slot@0 {
    					reg = <0>;
    					bus-width = <8>;
    					cd-gpios = <&pioE 0 GPIO_ACTIVE_LOW>;
    				};
    			};
    			
    			spi0: spi@f0004000 {
    				cs-gpios = <&pioD 13 0>, <0>, <0>, <&pioD 16 0>;
    				status = "okay";
    			};
    
    			can0: can@f000c000 {
    				status = "okay";
    			};
    
    			i2c0: i2c@f0014000 {
    				pinctrl-0 = <&pinctrl_i2c0_pu>;
    				status = "okay";
    			};
    
    			i2c1: i2c@f0018000 {
    				status = "okay";
    
    				pmic: act8865@5b {
    					compatible = "active-semi,act8865";
    					reg = <0x5b>;
    					status = "okay";
    
    					regulators {
    						vcc_1v8_reg: DCDC_REG1 {
    							regulator-name = "VCC_1V8";
    							regulator-min-microvolt = <1800000>;
    							regulator-max-microvolt = <1800000>;
    							regulator-always-on;
    						};
    
    						vcc_1v2_reg: DCDC_REG2 {
    							regulator-name = "VCC_1V2";
    							regulator-min-microvolt = <1200000>;
    							regulator-max-microvolt = <1200000>;
    							regulator-always-on;
    						};
    
    						vcc_3v3_reg: DCDC_REG3 {
    							regulator-name = "VCC_3V3";
    							regulator-min-microvolt = <3300000>;
    							regulator-max-microvolt = <3300000>;
    							regulator-always-on;
    						};
    
    						vddfuse_reg: LDO_REG1 {
    							regulator-name = "FUSE_2V5";
    							regulator-min-microvolt = <2500000>;
    							regulator-max-microvolt = <2500000>;
    						};
    
    						vddana_reg: LDO_REG2 {
    							regulator-name = "VDDANA";
    							regulator-min-microvolt = <3300000>;
    							regulator-max-microvolt = <3300000>;
    							regulator-always-on;
    						};
    					};
    				};
    			};
    
    			macb0: ethernet@f0028000 {
    				phy-mode = "rgmii";
    				status = "okay";
    			};
    			
    			pwm0: pwm@f002c000 {
    				pinctrl-names = "default";
    				pinctrl-0 = <&pinctrl_pwm0_pwmh0_0 &pinctrl_pwm0_pwmh1_0>;
    				status = "okay";
    			};
    
    			/* FLEX */	
    			usart0: serial@f001c000 {
    				pinctrl-0 = <&pinctrl_usart0 &pinctrl_usart0_rts_cts>;
    				status = "okay";
    			};
    
    			/* FLEX
    			*usart0: serial@f001c000 {
    			*	status = "okay";
    			}; */
    
    			usart1: serial@f0020000 {
    				pinctrl-0 = <&pinctrl_usart1 &pinctrl_usart1_rts_cts>;
    				status = "okay";
    			};
    
    			/* FLEX, enable BT debug */
    			usart2: serial@f8020000 {
    				pinctrl-0 = <&pinctrl_usart2>;
    				status = "okay";
    			};
    
    			uart0: serial@f0024000 {
    				status = "okay";
    			};
    
    			/* FLEX, Micro SD Card Detect */
    			mmc1: mmc@f8000000 {
    				pinctrl-0 = <&pinctrl_mmc1_clk_cmd_dat0 &pinctrl_mmc1_dat1_3 &pinctrl_mmc1_cd>;
    				status = "okay";
    				slot@0 {
    					reg = <0>;
    					bus-width = <4>;
    					cd-gpios = <&pioA 9 GPIO_ACTIVE_LOW>;
    				};
    			};
    
    			/* FLEX, WiFi */
    			mmc2: mmc@f8004000 {
    				pinctrl-0 = <&pinctrl_mmc2_clk_cmd_dat0 &pinctrl_mmc2_dat1_3>;
    				vmmc-supply = <&wlan_en_reg>;
    				status = "okay";
    				slot@0 {
    					reg = <0>;
    					bus-width = <4>;
    					cap-mmc-highspeed;
    					none-removable;
    					cap-power-off-card;
    					keep-power-in-suspend;
    					wlcore: wlcore@0 {
    						compatible = "ti,wl1835";
    						reg = <2>;
    						interrupt-parent = <&pioA>;
    						interrupts = <3 IRQ_TYPE_LEVEL_LOW>;
    					};
    				};
    			};
    
    			/* Power Control using a Fixed Voltage Regulator */
    			wlan_en_reg: fixedregulator@2 {
    				compatible = "regulator-fixed";
    				regulator-name = "wlan-en-regulator";
    				regulator-min-microvolt = <1800000>;
    				regulator-max-microvolt = <1800000>;
    				/* regulator-always-on; */
    				
    			/* WLAN_EN GPIO */
    				gpio = <&pioA 2 GPIO_ACTIVE_LOW>;
    			
    			/* WLAN card specific delay */
    				/* startup-delay-us = <70000>; */
    				enable-active-high;
    			};
    
    			spi1: spi@f8008000 {
    				cs-gpios = <&pioC 25 0>;
    				status = "okay";
    			};
    
    			adc0: adc@f8018000 {
    				pinctrl-0 = <
    					&pinctrl_adc0_adtrg
    					&pinctrl_adc0_ad0
    					&pinctrl_adc0_ad1
    					&pinctrl_adc0_ad2
    					&pinctrl_adc0_ad3
    					&pinctrl_adc0_ad4
    					&pinctrl_adc0_ad5
    					&pinctrl_adc0_ad6
    					&pinctrl_adc0_ad7
    					&pinctrl_adc0_ad8
    					&pinctrl_adc0_ad9
    					&pinctrl_adc0_ad10
    					&pinctrl_adc0_ad11
    					>;
    				status = "okay";
    			};
    
    			i2c2: i2c@f801c000 {
    				dmas = <0>, <0>;	/* Do not use DMA for i2c2 */
    				pinctrl-0 = <&pinctrl_i2c2_pu>;
    				status = "okay";
    			};
    
    			macb1: ethernet@f802c000 {
    				phy-mode = "rmii";
    				status = "okay";
    			};
    			
    			dbgu: serial@ffffee00 {
    				status = "okay";
    			};
    
    			pinctrl@fffff200 {
    				board {
    					pinctrl_i2c0_pu: i2c0_pu {
    						atmel,pins =
    							<AT91_PIOA 30 AT91_PERIPH_A AT91_PINCTRL_PULL_UP>,
    							<AT91_PIOA 31 AT91_PERIPH_A AT91_PINCTRL_PULL_UP>;
    					};
    
    					pinctrl_i2c2_pu: i2c2_pu {
    						atmel,pins =
    							<AT91_PIOA 18 AT91_PERIPH_B AT91_PINCTRL_PULL_UP>,
    							<AT91_PIOA 19 AT91_PERIPH_B AT91_PINCTRL_PULL_UP>;
    					};
    
    					pinctrl_mmc0_cd: mmc0_cd {
    						atmel,pins =
    							<AT91_PIOE 0 AT91_PERIPH_GPIO AT91_PINCTRL_PULL_UP_DEGLITCH>;
    					};
    					
    					pinctrl_mmc1_cd: mmc1_cd {
    						atmel,pins =
    							<AT91_PIOA 9 AT91_PERIPH_GPIO AT91_PINCTRL_PULL_UP_DEGLITCH>;
    					};
    
    					pinctrl_usba_vbus: usba_vbus {
    						atmel,pins =
    							<AT91_PIOA 11 AT91_PERIPH_GPIO AT91_PINCTRL_DEGLITCH>;	/* PE9, conflicts with A9 */
    					};
    
    					pinctrl_key_gpio: key_gpio_0 {
    						atmel,pins =
    							<AT91_PIOE 31 AT91_PERIPH_GPIO AT91_PINCTRL_PULL_UP_DEGLITCH
    							 AT91_PIOA 7 AT91_PERIPH_GPIO AT91_PINCTRL_NONE
    							 AT91_PIOA 8 AT91_PERIPH_GPIO AT91_PINCTRL_PULL_UP_DEGLITCH
    							 AT91_PIOA 10 AT91_PERIPH_GPIO AT91_PINCTRL_NONE>;
    					};
    				};
    			};
    
    			pmc: pmc@fffffc00 {
    				main: mainck {
    					clock-frequency = <12000000>;
    				};
    			};
    		};
    
    		nand0: nand@60000000 {
    			nand-bus-width = <8>;
    			nand-ecc-mode = "hw";
    			atmel,has-pmecc;
    			atmel,pmecc-cap = <4>;
    			atmel,pmecc-sector-size = <512>;
    			nand-on-flash-bbt;
    			status = "okay";
    
    			at91bootstrap@0 {
    				label = "at91bootstrap";
    				reg = <0x0 0x40000>;
    			};
    
    			bootloader@40000 {
    				label = "bootloader";
    				reg = <0x40000 0x80000>;
    			};
    
    			bootloaderenv@c0000 {
    				label = "bootloader env";
    				reg = <0xc0000 0xc0000>;
    			};
    
    			dtb@180000 {
    				label = "device tree";
    				reg = <0x180000 0x80000>;
    			};
    
    			kernel@200000 {
    				label = "kernel";
    				reg = <0x200000 0x600000>;
    			};
    
    			rootfs@800000 {
    				label = "rootfs";
    				reg = <0x800000 0x0f800000>;
    			};
    		};
    
    		usb0: gadget@00500000 {
    			atmel,vbus-gpio = <&pioA 11 GPIO_ACTIVE_HIGH>;	/* PE9, conflicts with A9 */
    			pinctrl-names = "default";
    			pinctrl-0 = <&pinctrl_usba_vbus>;
    			status = "okay";
    		};
    
    		usb1: ohci@00600000 {
    			num-ports = <3>;
    			atmel,vbus-gpio = <0
    					   &pioE 3 GPIO_ACTIVE_LOW
    					   &pioE 4 GPIO_ACTIVE_LOW
    					  >;
    			status = "okay";
    		};
    
    		usb2: ehci@00700000 {
    			status = "okay";
    		};
    	};
    
    	/* FLEX */
    	gpio_keys {
    		compatible = "gpio-keys";
    
    		pinctrl-names = "default";
    		pinctrl-0 = <&pinctrl_key_gpio>;
    
    		sw2 {
    			label = "PB_RST";
    			gpios = <&pioE 31 GPIO_ACTIVE_LOW>;
    			linux,code = <0x194>;
    			gpio-key,wakeup;
    		};
    
    		r2wake {
    			label = "R2_WAKE";
    			gpios = <&pioA 7 GPIO_ACTIVE_LOW>;
    			linux,code = <0x192>;
    			gpio-key,wakeup;
    		};
    
    		simcd {
    			label = "SIM_CD";
    			gpios = <&pioA 10 GPIO_ACTIVE_LOW>;
    			linux,code = <0x191>;
    			gpio-key,wakeup;
    		};
    	};
    
    	/* FLEX */
    	leds {
    		compatible = "gpio-leds";
    
    		d10_grn {
    			label = "bat_grn"; /* Red Battery LED */
    			gpios = <&pioA 20 GPIO_ACTIVE_HIGH>;
    			linux,default-trigger = "default-on";
    		};
    
    		d10_red {
    			label = "bat_red"; /* Green Battery LED */
    			gpios = <&pioA 21 GPIO_ACTIVE_HIGH>;
    			linux,default-trigger = "none";
    		};
    
    		d11 {
    			label = "bt"; /* BT LED */
    			gpios = <&pioA 22 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "heartbeat";
    		};
    
    		d12 {
    			label = "gps"; /* GPS LED */
    			gpios = <&pioA 24 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "heartbeat";
    		};
    
    		d13 {
    			label = "wifi"; /* WIFI LED */
    			gpios = <&pioA 23 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "heartbeat";
    		};
    
    		d14 {
    			label = "r2_3g"; /* 3G LED */
    			gpios = <&pioA 25 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "heartbeat";
    		};
    
    		chg {
    			label = "CHG_CE";
    			gpios = <&pioA 13 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "default-on";
    		};
    
    		3v3r1en {
    			label = "3v3_r1_en";
    			gpios = <&pioA 0 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "none";
    		};
    
    		r2disable {
    			label = "r2_wdisable";
    			gpios = <&pioA 5 GPIO_ACTIVE_LOW>;
    			linux,default-trigger = "none";
    		};
    	};
    };
    

  • hi , in dts file 'none-removable;' should be changed to 'non-removable;'
    Saurabh
  • Hi Saurabh,

    Thank you for your help! We did not notice that typo!

    Unfortunately the issue persists.

    Attached please find 4 files, 2 logs for when wlan0 boots up & when it doesn't, and 2 dmesg's when wlan0 boots up & when it doesn't. Whenever the wlan0 boots up, the following text is outputted always, after the first set of frequency bandwidth's:

    [ 6.940000] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
    [ 6.960000] mmc2: mmc_power_save_host: powering down
    [ 6.980000] wlcore: loaded
    [ 6.980000] wlcore: driver version: R8.6-dirty
    [ 6.980000] wlcore: compilation time: Wed Oct 12 11:01:12 2016

    RomBOOT
    
    
    AT91Bootstrap 3.6.1-00078-g5415d4e (Tue Feb  4 15:36:46 CET 2014)
    
    NAND: ONFI flash detected
    NAND: Manufacturer ID: 0x2c Chip ID: 0x34
    NAND: Disable On-Die ECC
    NAND: Initialize PMECC params, cap: 0x4, sector: 0x200
    NAND: Image: Copy 0x80000 bytes from 0x40000 to 0x26f00000
    NAND: Done to load image
    
    
    U-Boot 2013.07 (Feb 04 2014 - 15:36:32)
    
    CPU: SAMA5D31
    Crystal frequency:       12 MHz
    CPU clock        :      528 MHz
    Master clock     :      132 MHz
    DRAM:  256 MiB
    NAND:  512 MiB
    MMC:   mci: 0, mci: 1
    In:    serial
    Out:   serial
    Err:   serial
    Net:   miiphy_register: non unique device name 'macb0'
    macb0
    Warning: failed to set MAC address
    , macb0
    Warning: failed to set MAC address
    
    Hit any key to stop autoboot:  1  0 
    
    NAND read: device 0 offset 0x180000, size 0x8672
     34418 bytes read: OK
    
    NAND read: device 0 offset 0x200000, size 0x355df8
     3497464 bytes read: OK
    Kernel image @ 0x22000000 [ 0x000000 - 0x355df8 ]
    ## Flattened Device Tree blob at 21000000
       Booting using the fdt blob at 0x21000000
       Loading Device Tree to 2bb0f000, end 2bb1a671 ... OK
    
    Starting kernel ...
    
    Uncompressing Linux... done, booting the kernel.
    [    0.000000] Booting Linux on physical CPU 0x0
    [    0.000000] Linux version 3.16.5-sama5-armv7-r8 (root@john-VirtualBox) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #28 Wed Oct 12 10:53:08 PDT 2016
    [    0.000000] CPU: ARMv7 Processor [410fc051] revision 1 (ARMv7), cr=50c53c7d
    [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [    0.000000] Machine model: SAMA5D3 Xplained
    [    0.000000] Memory policy: Data cache writeback
    [    0.000000] AT91: Detected soc type: sama5d3
    [    0.000000] AT91: Detected soc subtype: sama5d31
    [    0.000000] AT91: sram at 0x300000 of 0x20000 mapped at 0xfef58000
    [    0.000000] CPU: All CPU(s) started in SVC mode.
    [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 65024
    [    0.000000] Kernel command line: console=ttyS0,115200 mem=256M mmcrootfstype=ext4 root=/dev/mmcblk0p1 r rootwait
    [    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
    [    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
    [    0.000000] Memory: 254388K/262144K available (3315K kernel code, 202K rwdata, 1460K rodata, 149K init, 159K bss, 7756K reserved)
    [    0.000000] Virtual kernel memory layout:
    [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    [    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 kB)
    [    0.000000]     vmalloc : 0xd0800000 - 0xff000000   ( 744 MB)
    [    0.000000]     lowmem  : 0xc0000000 - 0xd0000000   ( 256 MB)
    [    0.000000]     modules : 0xbf800000 - 0xc0000000   (   8 MB)
    [    0.000000]       .text : 0xc0008000 - 0xc04b1f64   (4776 kB)
    [    0.000000]       .init : 0xc04b2000 - 0xc04d7424   ( 150 kB)
    [    0.000000]       .data : 0xc04d8000 - 0xc050a820   ( 203 kB)
    [    0.000000]        .bss : 0xc050a820 - 0xc0532710   ( 160 kB)
    [    0.000000] NR_IRQS:16 nr_irqs:16 16
    [    0.000000] sched_clock: 32 bits at 100 Hz, resolution 10000000ns, wraps every 21474836480000000ns
    [    0.000000] Console: colour dummy device 80x30
    [    0.050000] Calibrating delay loop... 351.43 BogoMIPS (lpj=1757184)
    [    0.060000] pid_max: default: 32768 minimum: 301
    [    0.060000] Security Framework initialized
    [    0.060000] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] CPU: Testing write buffer coherency: ok
    [    0.060000] Setting up static identity map for 0x2031e508 - 0x2031e554
    [    0.060000] devtmpfs: initialized
    [    0.060000] VFP support v0.3: implementor 41 architecture 2 part 30 variant 5 rev 1
    [    0.060000] pinctrl core: initialized pinctrl subsystem
    [    0.060000] regulator-dummy: no parameters
    [    0.080000] NET: Registered protocol family 16
    [    0.080000] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [    0.090000] No ATAGs?
    [    0.090000] AT91: Power Management
    [    0.100000] gpio-at91 fffff200.gpio: at address fefff200
    [    0.100000] gpio-at91 fffff400.gpio: at address fefff400
    [    0.100000] gpio-at91 fffff600.gpio: at address fefff600
    [    0.100000] gpio-at91 fffff800.gpio: at address fefff800
    [    0.100000] gpio-at91 fffffa00.gpio: at address fefffa00
    [    0.100000] pinctrl-at91 ahb:apb:pinctrl@fffff200: initialized AT91 pinctrl driver
    [    0.150000] at_hdmac ffffe600.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] at_hdmac ffffe800.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] wlan-en-regulator: 1800 mV 
    [    0.150000] SCSI subsystem initialized
    [    0.150000] usbcore: registered new interface driver usbfs
    [    0.150000] usbcore: registered new interface driver hub
    [    0.160000] usbcore: registered new device driver usb
    [    0.160000] at91_i2c f0014000.i2c: using dma0chan0 (tx) and dma0chan1 (rx) for DMA transfers
    [    0.160000] at91_i2c f0014000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f0018000.i2c: using dma0chan2 (tx) and dma0chan3 (rx) for DMA transfers
    [    0.160000] at91_i2c f0018000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f801c000.i2c: can't get a DMA channel for tx
    [    0.160000] at91_i2c f801c000.i2c: can't use DMA
    [    0.160000] at91_i2c f801c000.i2c: AT91 i2c bus driver.
    [    0.160000] pps_core: LinuxPPS API ver. 1 registered
    [    0.160000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.160000] PTP clock support registered
    [    0.170000] Bluetooth: Core ver 2.19
    [    0.170000] NET: Registered protocol family 31
    [    0.170000] Bluetooth: HCI device and connection manager initialized
    [    0.170000] Bluetooth: HCI socket layer initialized
    [    0.170000] Bluetooth: L2CAP socket layer initialized
    [    0.170000] Bluetooth: SCO socket layer initialized
    [    0.170000] Switched to clocksource tcb_clksrc
    [    0.200000] NET: Registered protocol family 2
    [    0.200000] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.200000] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.200000] TCP: Hash tables configured (established 2048 bind 2048)
    [    0.200000] TCP: reno registered
    [    0.200000] UDP hash table entries: 256 (order: 0, 4096 bytes)
    [    0.200000] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
    [    0.200000] NET: Registered protocol family 1
    [    0.210000] futex hash table entries: 256 (order: -1, 3072 bytes)
    [    0.210000] msgmni has been set to 496
    [    0.220000] NET: Registered protocol family 38
    [    0.220000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
    [    0.220000] io scheduler noop registered (default)
    [    0.220000] f001c000.serial: ttyS1 at MMIO 0xf001c000 (irq = 30, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.220000] f0020000.serial: ttyS2 at MMIO 0xf0020000 (irq = 31, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.220000] f8020000.serial: ttyS3 at MMIO 0xf8020000 (irq = 38, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.230000] ffffee00.serial: ttyS0 at MMIO 0xffffee00 (irq = 44, base_baud = 8250000) is a ATMEL_SERIAL
    [    0.710000] console [ttyS0] enabled
    [    0.730000] f0024000.serial: ttyS5 at MMIO 0xf0024000 (irq = 54, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.740000] [drm] Initialized drm 1.1.0 20060810
    [    0.750000] brd: module loaded
    [    0.760000] loop: module loaded
    [    0.760000] zram: Created 1 device(s) ...
    [    0.770000] atmel_nand_nfc 70000000.nfc: NFC is probed.
    [    0.780000] atmel_nand 60000000.nand: Use On Flash BBT
    [    0.780000] atmel_nand 60000000.nand: Using dma0chan4 for DMA transfers.
    [    0.790000] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xdc
    [    0.800000] nand: Micron MT29F4G08ABADAWP
    [    0.800000] nand: 512MiB, SLC, page size: 2048, OOB size: 64
    [    0.810000] atmel_nand 60000000.nand: minimum ECC: 4 bits in 512 bytes
    [    0.810000] atmel_nand 60000000.nand: Initialize PMECC params, cap: 4, sector: 512
    [    0.820000] atmel_nand 60000000.nand: Using NFC Sram read 
    [    0.830000] nand: WARNING: MT29F4G08ABADAWP: the ECC used on your system is too weak compared to the one required by the NAND chip
    [    0.840000] Bad block table found at page 262080, version 0x01
    [    0.850000] Bad block table found at page 262016, version 0x01
    [    0.850000] 6 ofpart partitions found on MTD device atmel_nand
    [    0.860000] Creating 6 MTD partitions on "atmel_nand":
    [    0.870000] 0x000000000000-0x000000040000 : "at91bootstrap"
    [    0.870000] 0x000000040000-0x0000000c0000 : "bootloader"
    [    0.880000] 0x0000000c0000-0x000000180000 : "bootloader env"
    [    0.890000] 0x000000180000-0x000000200000 : "device tree"
    [    0.900000] 0x000000200000-0x000000800000 : "kernel"
    [    0.910000] 0x000000800000-0x000010000000 : "rootfs"
    [    0.910000] atmel_spi f0004000.spi: version: 0x213
    [    0.920000] atmel_spi f0004000.spi: Using dma0chan5 (tx) and dma0chan6 (rx) for DMA transfers
    [    0.930000] atmel_spi f0004000.spi: Atmel SPI Controller at 0xf0004000 (irq 26)
    [    0.940000] atmel_spi f8008000.spi: version: 0x213
    [    0.940000] atmel_spi f8008000.spi: Using dma1chan0 (tx) and dma1chan1 (rx) for DMA transfers
    [    0.950000] atmel_spi f8008000.spi: Atmel SPI Controller at 0xf8008000 (irq 35)
    [    0.960000] PPP generic driver version 2.4.2
    [    0.970000] PPP BSD Compression module registered
    [    0.970000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [    0.980000] ehci-atmel: EHCI Atmel driver
    [    0.980000] atmel-ehci 700000.ehci: EHCI Host Controller
    [    0.990000] atmel-ehci 700000.ehci: new USB bus registered, assigned bus number 1
    [    0.990000] atmel-ehci 700000.ehci: irq 56, io mem 0x00700000
    [    1.020000] atmel-ehci 700000.ehci: USB 2.0 started, EHCI 1.00
    [    1.020000] hub 1-0:1.0: USB hub found
    [    1.030000] hub 1-0:1.0: 3 ports detected
    [    1.030000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [    1.040000] ohci-atmel: OHCI Atmel driver
    [    1.040000] at91_ohci 600000.ohci: OHCI Host Controller
    [    1.050000] at91_ohci 600000.ohci: new USB bus registered, assigned bus number 2
    [    1.060000] at91_ohci 600000.ohci: irq 56, io mem 0x00600000
    [    1.120000] hub 2-0:1.0: USB hub found
    [    1.120000] hub 2-0:1.0: 3 ports detected
    [    1.130000] usbcore: registered new interface driver cdc_acm
    [    1.140000] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
    [    1.140000] usbcore: registered new interface driver usb-storage
    [    1.150000] usbcore: registered new interface driver usbserial
    [    1.160000] usbcore: registered new interface driver usbserial_generic
    [    1.160000] usbserial: USB Serial support registered for generic
    [    1.170000] usbcore: registered new interface driver ftdi_sio
    [    1.170000] usbserial: USB Serial support registered for FTDI USB Serial Device
    [    1.180000] usbcore: registered new interface driver pl2303
    [    1.190000] usbserial: USB Serial support registered for pl2303
    [    1.190000] atmel_usba_udc 500000.gadget: MMIO registers at 0xf8030000 mapped at d08c8000
    [    1.200000] atmel_usba_udc 500000.gadget: FIFO at 0x00500000 mapped at d2200000
    [    1.210000] g_serial gadget: Gadget Serial v2.4
    [    1.220000] g_serial gadget: g_serial ready
    [    1.220000] rtc (null): invalid alarm value: 1900-1-2 17:13:41
    [    1.230000] at91_rtc fffffeb0.rtc: rtc core: registered fffffeb0.rtc as rtc0
    [    1.240000] at91_rtc fffffeb0.rtc: AT91 Real Time Clock driver.
    [    1.240000] i2c /dev entries driver
    [    1.250000] Bluetooth: HCI UART driver ver 2.2
    [    1.250000] Bluetooth: HCI H4 protocol initialized
    [    1.260000] usbcore: registered new interface driver btusb
    [    1.260000] atmel_aes f8038000.aes: version: 0x135
    [    1.270000] atmel_aes f8038000.aes: Atmel AES - Using dma1chan2, dma1chan3 for DMA transfers
    [    1.280000] atmel_sha f8034000.sha: version: 0x410
    [    1.290000] atmel_sha f8034000.sha: using dma1chan4 for DMA transfers
    [    1.290000] atmel_sha f8034000.sha: Atmel SHA1/SHA256/SHA224/SHA384/SHA512
    [    1.300000] atmel_tdes f803c000.tdes: version: 0x701
    [    1.310000] atmel_tdes f803c000.tdes: using dma1chan5, dma1chan6 for DMA transfers
    [    1.320000] atmel_tdes f803c000.tdes: Atmel DES/TDES
    [    1.320000] usbcore: registered new interface driver usbhid
    [    1.330000] usbhid: USB HID core driver
    [    1.330000] iio iio:device0: Resolution used: 12 bits
    [    1.340000] iio iio:device0: ADC Touch screen is disabled.
    [    1.340000] nf_conntrack version 0.5.0 (3974 buckets, 15896 max)
    [    1.350000] ip_tables: (C) 2000-2006 Netfilter Core Team
    [    1.360000] TCP: cubic registered
    [    1.360000] NET: Registered protocol family 10
    [    1.370000] sit: IPv6 over IPv4 tunneling driver
    [    1.370000] NET: Registered protocol family 17
    [    1.380000] Bridge firewalling registered
    [    1.380000] Bluetooth: RFCOMM TTY layer initialized
    [    1.390000] Bluetooth: RFCOMM socket layer initialized
    [    1.390000] Bluetooth: RFCOMM ver 1.11
    [    1.400000] registered taskstats version 1
    [    1.400000] input: gpio_keys as /devices/gpio_keys/input/input0
    [    1.410000] at91_rtc fffffeb0.rtc: setting system clock to 2007-01-02 17:14:15 UTC (1167758055)
    [    1.420000] atmel_mci f0000000.mmc: version: 0x505
    [    1.420000] atmel_mci f0000000.mmc: using dma0chan7 for DMA transfers
    [    1.430000] atmel_mci f0000000.mmc: No vmmc regulator found
    [    1.440000] atmel_mci f0000000.mmc: No vqmmc regulator found
    [    1.480000] atmel_mci f0000000.mmc: Atmel MCI controller at 0xf0000000 irq 25, 1 slots
    [    1.480000] atmel_mci f8000000.mmc: version: 0x505
    [    1.490000] atmel_mci f8000000.mmc: using dma1chan7 for DMA transfers
    [    1.500000] atmel_mci f8000000.mmc: No vmmc regulator found
    [    1.500000] atmel_mci f8000000.mmc: No vqmmc regulator found
    [    1.510000] mmc0: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.520000] mmc0: mmc_rescan_try_freq: trying to init card at 300000 Hz
    [    1.550000] atmel_mci f8000000.mmc: Atmel MCI controller at 0xf8000000 irq 33, 1 slots
    [    1.550000] atmel_mci f8004000.mmc: version: 0x505
    [    1.560000] atmel_mci f8004000.mmc: no DMA channel available
    [    1.560000] atmel_mci f8004000.mmc: using PIO
    [    1.570000] atmel_mci f8004000.mmc: No vqmmc regulator found
    [    1.600000] mmc0: mmc_rescan_try_freq: trying to init card at 257813 Hz
    [    1.610000] atmel_mci f8004000.mmc: Atmel MCI controller at 0xf8004000 irq 34, 1 slots
    [    1.620000] Waiting for root device /dev/mmcblk0p1...
    [    1.640000] mmc1: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.920000] mmc1: host does not support reading read-only switch. assuming write-enable.
    [    1.930000] mmc1: new high speed SDHC card at address 59b4
    [    1.940000] mmcblk0: mmc1:59b4 USDU1 14.9 GiB 
    [    1.950000]  mmcblk0: p1 p2
    [    1.950000] mmc2: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.970000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [    2.000000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [    2.020000] usb 2-3: new full-speed USB device number 2 using at91_ohci
    [    2.020000] mmc2: new high speed SDIO card at address 0001
    [    2.060000] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
    [    2.070000] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
    [    2.090000] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
    [    2.100000] VFS: Mounted root (ext4 filesystem) readonly on device 179:1.
    [    2.120000] devtmpfs: mounted
    [    2.120000] Freeing unused kernel memory: 148K (c04b2000 - c04d7000)
    [    2.250000] ftdi_sio 2-3:1.0: FTDI USB Serial Device converter detected
    [    2.260000] usb 2-3: Detected FT232RL
    [    2.260000] usb 2-3: Number of endpoints 2
    [    2.270000] usb 2-3: Endpoint 1 MaxPacketSize 64
    [    2.270000] usb 2-3: Endpoint 2 MaxPacketSize 64
    [    2.280000] usb 2-3: Setting MaxPacketSize 64
    [    2.290000] usb 2-3: FTDI USB Serial Device converter now attached to ttyUSB0
    INIT: version 2.88 booting
    [info] Using makefile-style concurrent boot in runlevel S.
    [....] Starting the hotplug events dispatcher: udevd[    3.690000] udevd[711]: starting version 175
    [ ok .
    [....] Synthesizing the initial hotplug events...[    5.390000] VCC_1V8: 1800 mV 
    [    5.390000] VCC_1V2: 1200 mV 
    [    5.440000] VCC_3V3: 3300 mV 
    [    5.560000] FUSE_2V5: 2500 mV 
    [    5.570000] VDDANA: 3300 mV 
    [    5.580000] LDO_REG3: at 600 mV 
    [    5.590000] LDO_REG4: at 600 mV 
    [    6.130000] random: nonblocking pool is initialized
    [ ok [    6.230000] Loading modules backported from Linux version R8.6-0-g3f5b34f
    [    6.230000] Backport generated by backports.git R8.6SP1-0-g4677dc3
    done.
    [    6.530000] cfg80211: Calling CRDA to update world regulatory domain
    [....] Waiting for /dev to be fully populated...[    6.750000] wlcore: Time Sync: gpio requested
    [    6.790000] wlcore: ERROR could not get configuration binary ti-connectivity/wl18xx-conf.bin: -2
    [    6.790000] wlcore: WARNING falling back to default config
    [    6.830000] mmc2: mmc_power_restore_host: powering up
    [    6.950000] cfg80211: World regulatory domain updated:
    [    6.960000] cfg80211:  DFS Master region: unset
    [    6.960000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [    6.970000] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.980000] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.990000] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [    7.000000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [    7.010000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [    7.020000] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [    7.020000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [    7.030000] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    [ ok done.
    [....] Activating swap...[ ok done.
    [    8.410000] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
    [....] Cleaning up temporary files...[ ok .
    [info] Loading kernel module g_serial.
    [....] Activating lvm and md swap...[ ok done.
    [....] Checking file systems...fsck from util-linux 2.20.1
    [ ok done.
    [....] Mounting local filesystems...[   13.840000] FAT-fs (mmcblk0p2): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
    [ ok done.
    [....] Activating swapfile swap...[ ok done.
    [....] Root filesystem has insufficient free space; mounting tmpfs on /tmp ...[warn (warning).
    [....] Cleaning up temporary files...[ ok .
    [....] Setting kernel variables ...[ ok done.
    [....] Configuring network interfaces...[ ok done.
    [....] Cleaning up temporary files...[ ok .
    UIM SYSFS Node Not Found
    INIT: Entering runlevel: 2
    [info] Using makefile-style concurrent boot in runlevel 2.
    [....] Starting enhanced syslogd: rsyslogd[ ok .
    
    gzip: /var/log//dmesg.0.gz: No space left on device
    mv: cannot stat `/var/log//dmesg.0.gz': No such file or directory
    dmesg: write failed: No space left on device
    [....] Starting periodic command scheduler: cron[ ok .
    [....] Starting system message bus: dbus[ ok .
    [....] Starting bluetooth: bluetoothd[ ok .
    [....] Starting NTP server: ntpd[ ok .
    [....] Starting OpenBSD Secure Shell server: sshd[ ok .
    Starting very small Busybox based DHCP server: Starting /usr/sbin/udhcpd...
    udhcpd.
    BT Enabled
    Charger Config
    Enabling TI Chip (/dev/ttyUSB0)
    Found a Texas Instruments' chip!
    Firmware file : /lib/firmware/ti-connectivity/TIInit_11.8.32.bts
    Loaded BTS script version 1
    Can't set device: Protocol not supported
    Can't initialize device: Protocol not supported
    Device setup complete
    Starting COHDA
    enabling COHDA module
    Downloading COHDA FW
    Downloading COHDA Firmware
    dfu-util 0.5
    
    (C) 2005-2008 by Weston Schmidt, Harald Welte and OpenMoko Inc.
    (C) 2010-2011 Tormod Volden (DfuSe support)
    This program is Free Software and has ABSOLUTELY NO WARRANTY
    
    dfu-util does currently only support DFU version 1.0
    
    Filter on vendor = 0x1fc9 product = 0x0102
    No DFU capable USB device found
    Installing llc ko
    Installing cw-llc kernel module 
    [   75.260000] LLC_USBOutReq: USB device not present
    [   75.260000] LLC_USBOutReq: USB device not present
    [   75.360000] usbcore: registered new interface driver cw-llc
    
    Debian GNU/Linux 7 OpenXC-VI-V2X-9327 ttyS0
    
    OpenXC-VI-V2X-9327 login: RomBOOT
    
    
    AT91Bootstrap 3.6.1-00078-g5415d4e (Tue Feb  4 15:36:46 CET 2014)
    
    NAND: ONFI flash detected
    NAND: Manufacturer ID: 0x2c Chip ID: 0x34
    NAND: Disable On-Die ECC
    NAND: Initialize PMECC params, cap: 0x4, sector: 0x200
    NAND: Image: Copy 0x80000 bytes from 0x40000 to 0x26f00000
    NAND: Done to load image
    
    
    U-Boot 2013.07 (Feb 04 2014 - 15:36:32)
    
    CPU: SAMA5D31
    Crystal frequency:       12 MHz
    CPU clock        :      528 MHz
    Master clock     :      132 MHz
    DRAM:  256 MiB
    NAND:  512 MiB
    MMC:   mci: 0, mci: 1
    In:    serial
    Out:   serial
    Err:   serial
    Net:   miiphy_register: non unique device name 'macb0'
    macb0
    Warning: failed to set MAC address
    , macb0
    Warning: failed to set MAC address
    
    Hit any key to stop autoboot:  1  0 
    
    NAND read: device 0 offset 0x180000, size 0x8672
     34418 bytes read: OK
    
    NAND read: device 0 offset 0x200000, size 0x355df8
     3497464 bytes read: OK
    Kernel image @ 0x22000000 [ 0x000000 - 0x355df8 ]
    ## Flattened Device Tree blob at 21000000
       Booting using the fdt blob at 0x21000000
       Loading Device Tree to 2bb0f000, end 2bb1a671 ... OK
    
    Starting kernel ...
    
    Uncompressing Linux... done, booting the kernel.
    [    0.000000] Booting Linux on physical CPU 0x0
    [    0.000000] Linux version 3.16.5-sama5-armv7-r8 (root@john-VirtualBox) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #28 Wed Oct 12 10:53:08 PDT 2016
    [    0.000000] CPU: ARMv7 Processor [410fc051] revision 1 (ARMv7), cr=50c53c7d
    [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [    0.000000] Machine model: SAMA5D3 Xplained
    [    0.000000] Memory policy: Data cache writeback
    [    0.000000] AT91: Detected soc type: sama5d3
    [    0.000000] AT91: Detected soc subtype: sama5d31
    [    0.000000] AT91: sram at 0x300000 of 0x20000 mapped at 0xfef58000
    [    0.000000] CPU: All CPU(s) started in SVC mode.
    [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 65024
    [    0.000000] Kernel command line: console=ttyS0,115200 mem=256M mmcrootfstype=ext4 root=/dev/mmcblk0p1 r rootwait
    [    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
    [    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
    [    0.000000] Memory: 254388K/262144K available (3315K kernel code, 202K rwdata, 1460K rodata, 149K init, 159K bss, 7756K reserved)
    [    0.000000] Virtual kernel memory layout:
    [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    [    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 kB)
    [    0.000000]     vmalloc : 0xd0800000 - 0xff000000   ( 744 MB)
    [    0.000000]     lowmem  : 0xc0000000 - 0xd0000000   ( 256 MB)
    [    0.000000]     modules : 0xbf800000 - 0xc0000000   (   8 MB)
    [    0.000000]       .text : 0xc0008000 - 0xc04b1f64   (4776 kB)
    [    0.000000]       .init : 0xc04b2000 - 0xc04d7424   ( 150 kB)
    [    0.000000]       .data : 0xc04d8000 - 0xc050a820   ( 203 kB)
    [    0.000000]        .bss : 0xc050a820 - 0xc0532710   ( 160 kB)
    [    0.000000] NR_IRQS:16 nr_irqs:16 16
    [    0.000000] sched_clock: 32 bits at 100 Hz, resolution 10000000ns, wraps every 21474836480000000ns
    [    0.000000] Console: colour dummy device 80x30
    [    0.050000] Calibrating delay loop... 351.43 BogoMIPS (lpj=1757184)
    [    0.060000] pid_max: default: 32768 minimum: 301
    [    0.060000] Security Framework initialized
    [    0.060000] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] CPU: Testing write buffer coherency: ok
    [    0.060000] Setting up static identity map for 0x2031e508 - 0x2031e554
    [    0.060000] devtmpfs: initialized
    [    0.060000] VFP support v0.3: implementor 41 architecture 2 part 30 variant 5 rev 1
    [    0.060000] pinctrl core: initialized pinctrl subsystem
    [    0.060000] regulator-dummy: no parameters
    [    0.080000] NET: Registered protocol family 16
    [    0.080000] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [    0.090000] No ATAGs?
    [    0.090000] AT91: Power Management
    [    0.100000] gpio-at91 fffff200.gpio: at address fefff200
    [    0.100000] gpio-at91 fffff400.gpio: at address fefff400
    [    0.100000] gpio-at91 fffff600.gpio: at address fefff600
    [    0.100000] gpio-at91 fffff800.gpio: at address fefff800
    [    0.100000] gpio-at91 fffffa00.gpio: at address fefffa00
    [    0.100000] pinctrl-at91 ahb:apb:pinctrl@fffff200: initialized AT91 pinctrl driver
    [    0.150000] at_hdmac ffffe600.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] at_hdmac ffffe800.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] wlan-en-regulator: 1800 mV 
    [    0.150000] SCSI subsystem initialized
    [    0.150000] usbcore: registered new interface driver usbfs
    [    0.150000] usbcore: registered new interface driver hub
    [    0.160000] usbcore: registered new device driver usb
    [    0.160000] at91_i2c f0014000.i2c: using dma0chan0 (tx) and dma0chan1 (rx) for DMA transfers
    [    0.160000] at91_i2c f0014000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f0018000.i2c: using dma0chan2 (tx) and dma0chan3 (rx) for DMA transfers
    [    0.160000] at91_i2c f0018000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f801c000.i2c: can't get a DMA channel for tx
    [    0.160000] at91_i2c f801c000.i2c: can't use DMA
    [    0.160000] at91_i2c f801c000.i2c: AT91 i2c bus driver.
    [    0.160000] pps_core: LinuxPPS API ver. 1 registered
    [    0.160000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.160000] PTP clock support registered
    [    0.170000] Bluetooth: Core ver 2.19
    [    0.170000] NET: Registered protocol family 31
    [    0.170000] Bluetooth: HCI device and connection manager initialized
    [    0.170000] Bluetooth: HCI socket layer initialized
    [    0.170000] Bluetooth: L2CAP socket layer initialized
    [    0.170000] Bluetooth: SCO socket layer initialized
    [    0.170000] Switched to clocksource tcb_clksrc
    [    0.210000] NET: Registered protocol family 2
    [    0.210000] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.210000] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.210000] TCP: Hash tables configured (established 2048 bind 2048)
    [    0.210000] TCP: reno registered
    [    0.210000] UDP hash table entries: 256 (order: 0, 4096 bytes)
    [    0.210000] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
    [    0.210000] NET: Registered protocol family 1
    [    0.210000] futex hash table entries: 256 (order: -1, 3072 bytes)
    [    0.210000] msgmni has been set to 496
    [    0.220000] NET: Registered protocol family 38
    [    0.220000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
    [    0.220000] io scheduler noop registered (default)
    [    0.220000] f001c000.serial: ttyS1 at MMIO 0xf001c000 (irq = 30, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.220000] f0020000.serial: ttyS2 at MMIO 0xf0020000 (irq = 31, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.230000] f8020000.serial: ttyS3 at MMIO 0xf8020000 (irq = 38, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.240000] ffffee00.serial: ttyS0 at MMIO 0xffffee00 (irq = 44, base_baud = 8250000) is a ATMEL_SERIAL
    [    0.720000] console [ttyS0] enabled
    [    0.730000] f0024000.serial: ttyS5 at MMIO 0xf0024000 (irq = 54, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.740000] [drm] Initialized drm 1.1.0 20060810
    [    0.750000] brd: module loaded
    [    0.760000] loop: module loaded
    [    0.770000] zram: Created 1 device(s) ...
    [    0.780000] atmel_nand_nfc 70000000.nfc: NFC is probed.
    [    0.780000] atmel_nand 60000000.nand: Use On Flash BBT
    [    0.790000] atmel_nand 60000000.nand: Using dma0chan4 for DMA transfers.
    [    0.790000] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xdc
    [    0.800000] nand: Micron MT29F4G08ABADAWP
    [    0.800000] nand: 512MiB, SLC, page size: 2048, OOB size: 64
    [    0.810000] atmel_nand 60000000.nand: minimum ECC: 4 bits in 512 bytes
    [    0.820000] atmel_nand 60000000.nand: Initialize PMECC params, cap: 4, sector: 512
    [    0.820000] atmel_nand 60000000.nand: Using NFC Sram read 
    [    0.830000] nand: WARNING: MT29F4G08ABADAWP: the ECC used on your system is too weak compared to the one required by the NAND chip
    [    0.840000] Bad block table found at page 262080, version 0x01
    [    0.850000] Bad block table found at page 262016, version 0x01
    [    0.860000] 6 ofpart partitions found on MTD device atmel_nand
    [    0.860000] Creating 6 MTD partitions on "atmel_nand":
    [    0.870000] 0x000000000000-0x000000040000 : "at91bootstrap"
    [    0.870000] 0x000000040000-0x0000000c0000 : "bootloader"
    [    0.880000] 0x0000000c0000-0x000000180000 : "bootloader env"
    [    0.890000] 0x000000180000-0x000000200000 : "device tree"
    [    0.900000] 0x000000200000-0x000000800000 : "kernel"
    [    0.910000] 0x000000800000-0x000010000000 : "rootfs"
    [    0.910000] atmel_spi f0004000.spi: version: 0x213
    [    0.920000] atmel_spi f0004000.spi: Using dma0chan5 (tx) and dma0chan6 (rx) for DMA transfers
    [    0.930000] atmel_spi f0004000.spi: Atmel SPI Controller at 0xf0004000 (irq 26)
    [    0.940000] atmel_spi f8008000.spi: version: 0x213
    [    0.940000] atmel_spi f8008000.spi: Using dma1chan0 (tx) and dma1chan1 (rx) for DMA transfers
    [    0.950000] atmel_spi f8008000.spi: Atmel SPI Controller at 0xf8008000 (irq 35)
    [    0.960000] PPP generic driver version 2.4.2
    [    0.970000] PPP BSD Compression module registered
    [    0.970000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [    0.980000] ehci-atmel: EHCI Atmel driver
    [    0.980000] atmel-ehci 700000.ehci: EHCI Host Controller
    [    0.990000] atmel-ehci 700000.ehci: new USB bus registered, assigned bus number 1
    [    1.000000] atmel-ehci 700000.ehci: irq 56, io mem 0x00700000
    [    1.020000] atmel-ehci 700000.ehci: USB 2.0 started, EHCI 1.00
    [    1.020000] hub 1-0:1.0: USB hub found
    [    1.030000] hub 1-0:1.0: 3 ports detected
    [    1.030000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [    1.040000] ohci-atmel: OHCI Atmel driver
    [    1.040000] at91_ohci 600000.ohci: OHCI Host Controller
    [    1.050000] at91_ohci 600000.ohci: new USB bus registered, assigned bus number 2
    [    1.060000] at91_ohci 600000.ohci: irq 56, io mem 0x00600000
    [    1.120000] hub 2-0:1.0: USB hub found
    [    1.120000] hub 2-0:1.0: 3 ports detected
    [    1.130000] usbcore: registered new interface driver cdc_acm
    [    1.140000] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
    [    1.140000] usbcore: registered new interface driver usb-storage
    [    1.150000] usbcore: registered new interface driver usbserial
    [    1.160000] usbcore: registered new interface driver usbserial_generic
    [    1.160000] usbserial: USB Serial support registered for generic
    [    1.170000] usbcore: registered new interface driver ftdi_sio
    [    1.170000] usbserial: USB Serial support registered for FTDI USB Serial Device
    [    1.180000] usbcore: registered new interface driver pl2303
    [    1.190000] usbserial: USB Serial support registered for pl2303
    [    1.190000] atmel_usba_udc 500000.gadget: MMIO registers at 0xf8030000 mapped at d08c8000
    [    1.200000] atmel_usba_udc 500000.gadget: FIFO at 0x00500000 mapped at d2200000
    [    1.210000] g_serial gadget: Gadget Serial v2.4
    [    1.220000] g_serial gadget: g_serial ready
    [    1.220000] rtc (null): invalid alarm value: 1900-1-2 17:30:32
    [    1.230000] at91_rtc fffffeb0.rtc: rtc core: registered fffffeb0.rtc as rtc0
    [    1.240000] at91_rtc fffffeb0.rtc: AT91 Real Time Clock driver.
    [    1.240000] i2c /dev entries driver
    [    1.250000] Bluetooth: HCI UART driver ver 2.2
    [    1.250000] Bluetooth: HCI H4 protocol initialized
    [    1.260000] usbcore: registered new interface driver btusb
    [    1.260000] atmel_aes f8038000.aes: version: 0x135
    [    1.270000] atmel_aes f8038000.aes: Atmel AES - Using dma1chan2, dma1chan3 for DMA transfers
    [    1.280000] atmel_sha f8034000.sha: version: 0x410
    [    1.290000] atmel_sha f8034000.sha: using dma1chan4 for DMA transfers
    [    1.290000] atmel_sha f8034000.sha: Atmel SHA1/SHA256/SHA224/SHA384/SHA512
    [    1.300000] atmel_tdes f803c000.tdes: version: 0x701
    [    1.310000] atmel_tdes f803c000.tdes: using dma1chan5, dma1chan6 for DMA transfers
    [    1.320000] atmel_tdes f803c000.tdes: Atmel DES/TDES
    [    1.320000] usbcore: registered new interface driver usbhid
    [    1.330000] usbhid: USB HID core driver
    [    1.330000] iio iio:device0: Resolution used: 12 bits
    [    1.340000] iio iio:device0: ADC Touch screen is disabled.
    [    1.340000] nf_conntrack version 0.5.0 (3974 buckets, 15896 max)
    [    1.350000] ip_tables: (C) 2000-2006 Netfilter Core Team
    [    1.360000] TCP: cubic registered
    [    1.360000] NET: Registered protocol family 10
    [    1.370000] sit: IPv6 over IPv4 tunneling driver
    [    1.370000] NET: Registered protocol family 17
    [    1.380000] Bridge firewalling registered
    [    1.380000] Bluetooth: RFCOMM TTY layer initialized
    [    1.390000] Bluetooth: RFCOMM socket layer initialized
    [    1.390000] Bluetooth: RFCOMM ver 1.11
    [    1.400000] registered taskstats version 1
    [    1.400000] input: gpio_keys as /devices/gpio_keys/input/input0
    [    1.410000] at91_rtc fffffeb0.rtc: setting system clock to 2007-01-02 17:31:07 UTC (1167759067)
    [    1.420000] atmel_mci f0000000.mmc: version: 0x505
    [    1.430000] atmel_mci f0000000.mmc: using dma0chan7 for DMA transfers
    [    1.430000] atmel_mci f0000000.mmc: No vmmc regulator found
    [    1.440000] atmel_mci f0000000.mmc: No vqmmc regulator found
    [    1.480000] atmel_mci f0000000.mmc: Atmel MCI controller at 0xf0000000 irq 25, 1 slots
    [    1.480000] atmel_mci f8000000.mmc: version: 0x505
    [    1.490000] atmel_mci f8000000.mmc: using dma1chan7 for DMA transfers
    [    1.500000] atmel_mci f8000000.mmc: No vmmc regulator found
    [    1.500000] atmel_mci f8000000.mmc: No vqmmc regulator found
    [    1.510000] mmc0: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.520000] mmc0: mmc_rescan_try_freq: trying to init card at 300000 Hz
    [    1.550000] atmel_mci f8000000.mmc: Atmel MCI controller at 0xf8000000 irq 33, 1 slots
    [    1.550000] atmel_mci f8004000.mmc: version: 0x505
    [    1.560000] atmel_mci f8004000.mmc: no DMA channel available
    [    1.560000] atmel_mci f8004000.mmc: using PIO
    [    1.570000] atmel_mci f8004000.mmc: No vqmmc regulator found
    [    1.610000] atmel_mci f8004000.mmc: Atmel MCI controller at 0xf8004000 irq 34, 1 slots
    [    1.620000] Waiting for root device /dev/mmcblk0p1...
    [    1.620000] mmc0: mmc_rescan_try_freq: trying to init card at 257813 Hz
    [    1.670000] mmc1: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.880000] mmc1: host does not support reading read-only switch. assuming write-enable.
    [    1.890000] mmc1: new high speed SDXC card at address aaaa
    [    1.900000] mmcblk0: mmc1:aaaa SE64G 59.4 GiB 
    [    1.920000]  mmcblk0: p1 p2
    [    1.930000] mmc2: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.940000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [    1.950000] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
    [    1.960000] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
    [    1.990000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [    2.000000] usb 2-3: new full-speed USB device number 2 using at91_ohci
    [    2.020000] mmc2: new high speed SDIO card at address 0001
    [    2.030000] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
    [    2.030000] VFS: Mounted root (ext4 filesystem) readonly on device 179:1.
    [    2.050000] devtmpfs: mounted
    [    2.050000] Freeing unused kernel memory: 148K (c04b2000 - c04d7000)
    [    2.250000] ftdi_sio 2-3:1.0: FTDI USB Serial Device converter detected
    [    2.260000] usb 2-3: Detected FT232RL
    [    2.260000] usb 2-3: Number of endpoints 2
    [    2.270000] usb 2-3: Endpoint 1 MaxPacketSize 64
    [    2.270000] usb 2-3: Endpoint 2 MaxPacketSize 64
    [    2.280000] usb 2-3: Setting MaxPacketSize 64
    [    2.290000] usb 2-3: FTDI USB Serial Device converter now attached to ttyUSB0
    INIT: version 2.88 booting
    [info] Using makefile-style concurrent boot in runlevel S.
    [....] Starting the hotplug events dispatcher: udevd[    3.600000] udevd[711]: starting version 175
    [ ok .
    [....] Synthesizing the initial hotplug events...[    5.120000] VCC_1V8: 1800 mV 
    [    5.130000] VCC_1V2: 1200 mV 
    [    5.130000] VCC_3V3: 3300 mV 
    [    5.150000] FUSE_2V5: 2500 mV 
    [    5.160000] VDDANA: 3300 mV 
    [    5.160000] LDO_REG3: at 600 mV 
    [    5.170000] LDO_REG4: at 600 mV 
    [    5.330000] Loading modules backported from Linux version R8.6-0-g3f5b34f
    [    5.330000] Backport generated by backports.git R8.6SP1-0-g4677dc3
    [ ok done.
    [    6.250000] cfg80211: Calling CRDA to update world regulatory domain
    [    6.350000] random: nonblocking pool is initialized
    [....] Waiting for /dev to be fully populated...[    6.560000] wlcore: Time Sync: gpio requested
    [    6.600000] wlcore: ERROR could not get configuration binary ti-connectivity/wl18xx-conf.bin: -2
    [    6.610000] wlcore: WARNING falling back to default config
    [    6.640000] mmc2: mmc_power_restore_host: powering up
    [    6.750000] cfg80211: World regulatory domain updated:
    [    6.750000] cfg80211:  DFS Master region: unset
    [    6.760000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [    6.770000] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.770000] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.780000] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.790000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [    6.800000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [    6.810000] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [    6.820000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.830000] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    [    6.870000] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
    [    6.900000] mmc2: mmc_power_save_host: powering down
    [    6.910000] wlcore: loaded
    [    6.910000] wlcore: driver version: R8.6-dirty
    [    6.910000] wlcore: compilation time: Thu Oct 13 09:53:22 2016
    [ ok done.
    [....] Activating swap...[ ok done.
    [    8.460000] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
    [....] Cleaning up temporary files...[ ok .
    [info] Loading kernel module g_serial.
    [....] Activating lvm and md swap...[ ok done.
    [....] Checking file systems...fsck from util-linux 2.20.1
    [ ok done.
    [....] Mounting local filesystems...[ ok done.
    [....] Activating swapfile swap...[ ok done.
    [....] Cleaning up temporary files...[ ok .
    [....] Setting kernel variables ...[ ok done.
    [....] Configuring network interfaces...[ ok done.
    [....] Cleaning up temporary files...[ ok .
    UIM SYSFS Node Not Found
    INIT: Entering runlevel: 2
    [info] Using makefile-style concurrent boot in runlevel 2.
    [....] Starting enhanced syslogd: rsyslogd[ ok .
    [....] Starting periodic command scheduler: cron[ ok .
    [....] Starting system message bus: dbus[ ok .
    [....] Starting bluetooth: bluetoothd[ ok .
    [....] Starting NTP server: ntpd[ ok .
    [....] Starting OpenBSD Secure Shell server: sshd[ ok .
    Starting very small Busybox based DHCP server: Starting /usr/sbin/udhcpd...
    udhcpd.
    BT Enabled
    Charger Config
    Enabling TI Chip (/dev/ttyUSB0)
    Found a Texas Instruments' chip!
    Firmware file : /lib/firmware/ti-connectivity/TIInit_11.8.32.bts
    Loaded BTS script version 1
    Can't set device: Protocol not supported
    Can't initialize device: Protocol not supported
    Device setup complete
    Successfully initialized wpa_supplicant
    [   49.890000] mmc2: mmc_power_restore_host: powering up
    [   50.280000] wlcore: using inverted interrupt logic: 8
    [   50.450000] wlcore: PHY firmware version: Rev 8.2.0.0.232
    [   50.660000] wlcore: firmware booted (Rev 8.9.0.0.48)
    [   50.800000] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
    [   50.830000] cfg80211: Calling CRDA for country: US
    [   51.170000] cfg80211: Regulatory domain changed to country: US
    [   51.170000] cfg80211:  DFS Master region: FCC
    [   51.180000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [   51.190000] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm), (N/A)
    [   51.190000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 1700 mBm), (N/A)
    [   51.200000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s)
    [   51.210000] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2300 mBm), (0 s)
    [   51.220000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A)
    [   51.230000] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
    Could not read interface p2p-dev-wlan0 flags: No such device
    [   54.440000] wlan0: authenticate with b4:75:0e:40:f8:b3
    [   54.470000] wlan0: send auth to b4:75:0e:40:f8:b3 (try 1/3)
    [   54.500000] wlan0: authenticated
    [   54.510000] wlan0: associate with b4:75:0e:40:f8:b3 (try 1/3)
    [   54.520000] wlan0: RX AssocResp from b4:75:0e:40:f8:b3 (capab=0x1411 status=0 aid=7)
    [   54.610000] wlan0: associated
    [   54.620000] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
    [   55.820000] wlcore: Association completed.
    Starting COHDA
    enabling COHDA module
    Downloading COHDA FW
    Downloading COHDA Firmware
    dfu-util 0.5
    
    (C) 2005-2008 by Weston Schmidt, Harald Welte and OpenMoko Inc.
    (C) 2010-2011 Tormod Volden (DfuSe support)
    This program is Free Software and has ABSOLUTELY NO WARRANTY
    
    dfu-util does currently only support DFU version 1.0
    
    Filter on vendor = 0x1fc9 product = 0x0102
    No DFU capable USB device found
    Installing llc ko
    Installing cw-llc kernel module 
    [   83.890000] LLC_USBOutReq: USB device not present
    [   83.900000] LLC_USBOutReq: USB device not present
    [   83.990000] usbcore: registered new interface driver cw-llc
    
    Debian GNU/Linux 7 OpenXC-VI-V2X-9327 ttyS0
    
    OpenXC-VI-V2X-9327 login: root
    rPassword: 
    
    Login incorrect
    OpenXC-VI-V2X-9327 login: 

    AT91Bootstrap 3.6.1-00078-g5415d4e (Tue Feb  4 15:36:46 CET 2014)
    
    NAND: ONFI flash detected
    NAND: Manufacturer ID: 0x2c Chip ID: 0x34
    NAND: Disable On-Die ECC
    NAND: Initialize PMECC params, cap: 0x4, sector: 0x200
    NAND: Image: Copy 0x80000 bytes from 0x40000 to 0x26f00000
    NAND: Done to load image
    
    
    U-Boot 2013.07 (Feb 04 2014 - 15:36:32)
    
    CPU: SAMA5D31
    Crystal frequency:       12 MHz
    CPU clock        :      528 MHz
    Master clock     :      132 MHz
    DRAM:  256 MiB
    NAND:  512 MiB
    MMC:   mci: 0, mci: 1
    In:    serial
    Out:   serial
    Err:   serial
    Net:   miiphy_register: non unique device name 'macb0'
    macb0
    Warning: failed to set MAC address
    , macb0
    Warning: failed to set MAC address
    
    Hit any key to stop autoboot:  0
    
    NAND read: device 0 offset 0x180000, size 0x8672
     34418 bytes read: OK
    
    NAND read: device 0 offset 0x200000, size 0x355df8
     3497464 bytes read: OK
    Kernel image @ 0x22000000 [ 0x000000 - 0x355df8 ]
    ## Flattened Device Tree blob at 21000000
       Booting using the fdt blob at 0x21000000
       Loading Device Tree to 2bb0f000, end 2bb1a671 ... OK
    
    Starting kernel ...
    
    Uncompressing Linux... done, booting the kernel.
    [    0.000000] Booting Linux on physical CPU 0x0
    [    0.000000] Linux version 3.16.5-sama5-armv7-r8 (root@john-VirtualBox) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #28 Wed Oct 12 10:53:08 PDT 2016
    [    0.000000] CPU: ARMv7 Processor [410fc051] revision 1 (ARMv7), cr=50c53c7d
    [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    [    0.000000] Machine model: SAMA5D3 Xplained
    [    0.000000] Memory policy: Data cache writeback
    [    0.000000] AT91: Detected soc type: sama5d3
    [    0.000000] AT91: Detected soc subtype: sama5d31
    [    0.000000] AT91: sram at 0x300000 of 0x20000 mapped at 0xfef58000
    [    0.000000] CPU: All CPU(s) started in SVC mode.
    [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 65024
    [    0.000000] Kernel command line: console=ttyS0,115200 mem=256M mmcrootfstype=ext4 root=/dev/mmcblk0p1 r rootwait
    [    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
    [    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
    [    0.000000] Memory: 254388K/262144K available (3315K kernel code, 202K rwdata, 1460K rodata, 149K init, 159K bss, 7756K reserved)
    [    0.000000] Virtual kernel memory layout:
    [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    [    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 kB)
    [    0.000000]     vmalloc : 0xd0800000 - 0xff000000   ( 744 MB)
    [    0.000000]     lowmem  : 0xc0000000 - 0xd0000000   ( 256 MB)
    [    0.000000]     modules : 0xbf800000 - 0xc0000000   (   8 MB)
    [    0.000000]       .text : 0xc0008000 - 0xc04b1f64   (4776 kB)
    [    0.000000]       .init : 0xc04b2000 - 0xc04d7424   ( 150 kB)
    [    0.000000]       .data : 0xc04d8000 - 0xc050a820   ( 203 kB)
    [    0.000000]        .bss : 0xc050a820 - 0xc0532710   ( 160 kB)
    [    0.000000] NR_IRQS:16 nr_irqs:16 16
    [    0.000000] sched_clock: 32 bits at 100 Hz, resolution 10000000ns, wraps every 21474836480000000ns
    [    0.000000] Console: colour dummy device 80x30
    [    0.050000] Calibrating delay loop... 351.43 BogoMIPS (lpj=1757184)
    [    0.060000] pid_max: default: 32768 minimum: 301
    [    0.060000] Security Framework initialized
    [    0.060000] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
    [    0.060000] CPU: Testing write buffer coherency: ok
    [    0.060000] Setting up static identity map for 0x2031e508 - 0x2031e554
    [    0.060000] devtmpfs: initialized
    [    0.060000] VFP support v0.3: implementor 41 architecture 2 part 30 variant 5 rev 1
    [    0.060000] pinctrl core: initialized pinctrl subsystem
    [    0.060000] regulator-dummy: no parameters
    [    0.080000] NET: Registered protocol family 16
    [    0.080000] DMA: preallocated 256 KiB pool for atomic coherent allocations
    [    0.090000] No ATAGs?
    [    0.090000] AT91: Power Management
    [    0.100000] gpio-at91 fffff200.gpio: at address fefff200
    [    0.100000] gpio-at91 fffff400.gpio: at address fefff400
    [    0.100000] gpio-at91 fffff600.gpio: at address fefff600
    [    0.100000] gpio-at91 fffff800.gpio: at address fefff800
    [    0.100000] gpio-at91 fffffa00.gpio: at address fefffa00
    [    0.100000] pinctrl-at91 ahb:apb:pinctrl@fffff200: initialized AT91 pinctrl driver
    [    0.150000] at_hdmac ffffe600.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] at_hdmac ffffe800.dma-controller: Atmel AHB DMA Controller ( cpy slave ), 8 channels
    [    0.150000] wlan-en-regulator: 1800 mV
    [    0.150000] SCSI subsystem initialized
    [    0.150000] usbcore: registered new interface driver usbfs
    [    0.150000] usbcore: registered new interface driver hub
    [    0.160000] usbcore: registered new device driver usb
    [    0.160000] at91_i2c f0014000.i2c: using dma0chan0 (tx) and dma0chan1 (rx) for DMA transfers
    [    0.160000] at91_i2c f0014000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f0018000.i2c: using dma0chan2 (tx) and dma0chan3 (rx) for DMA transfers
    [    0.160000] at91_i2c f0018000.i2c: AT91 i2c bus driver.
    [    0.160000] at91_i2c f801c000.i2c: can't get a DMA channel for tx
    [    0.160000] at91_i2c f801c000.i2c: can't use DMA
    [    0.160000] at91_i2c f801c000.i2c: AT91 i2c bus driver.
    [    0.160000] pps_core: LinuxPPS API ver. 1 registered
    [    0.160000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    [    0.160000] PTP clock support registered
    [    0.170000] Bluetooth: Core ver 2.19
    [    0.170000] NET: Registered protocol family 31
    [    0.170000] Bluetooth: HCI device and connection manager initialized
    [    0.170000] Bluetooth: HCI socket layer initialized
    [    0.170000] Bluetooth: L2CAP socket layer initialized
    [    0.170000] Bluetooth: SCO socket layer initialized
    [    0.170000] Switched to clocksource tcb_clksrc
    [    0.210000] NET: Registered protocol family 2
    [    0.210000] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.210000] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
    [    0.210000] TCP: Hash tables configured (established 2048 bind 2048)
    [    0.210000] TCP: reno registered
    [    0.210000] UDP hash table entries: 256 (order: 0, 4096 bytes)
    [    0.210000] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
    [    0.210000] NET: Registered protocol family 1
    [    0.220000] futex hash table entries: 256 (order: -1, 3072 bytes)
    [    0.220000] msgmni has been set to 496
    [    0.220000] NET: Registered protocol family 38
    [    0.220000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
    [    0.220000] io scheduler noop registered (default)
    [    0.230000] f001c000.serial: ttyS1 at MMIO 0xf001c000 (irq = 30, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.230000] f0020000.serial: ttyS2 at MMIO 0xf0020000 (irq = 31, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.240000] f8020000.serial: ttyS3 at MMIO 0xf8020000 (irq = 38, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.240000] ffffee00.serial: ttyS0 at MMIO 0xffffee00 (irq = 44, base_baud = 8250000) is a ATMEL_SERIAL
    [    0.720000] console [ttyS0] enabled
    [    0.730000] f0024000.serial: ttyS5 at MMIO 0xf0024000 (irq = 54, base_baud = 4125000) is a ATMEL_SERIAL
    [    0.740000] [drm] Initialized drm 1.1.0 20060810
    [    0.750000] brd: module loaded
    [    0.760000] loop: module loaded
    [    0.770000] zram: Created 1 device(s) ...
    [    0.780000] atmel_nand_nfc 70000000.nfc: NFC is probed.
    [    0.780000] atmel_nand 60000000.nand: Use On Flash BBT
    [    0.790000] atmel_nand 60000000.nand: Using dma0chan4 for DMA transfers.
    [    0.790000] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xdc
    [    0.800000] nand: Micron MT29F4G08ABADAWP
    [    0.800000] nand: 512MiB, SLC, page size: 2048, OOB size: 64
    [    0.810000] atmel_nand 60000000.nand: minimum ECC: 4 bits in 512 bytes
    [    0.820000] atmel_nand 60000000.nand: Initialize PMECC params, cap: 4, sector: 512
    [    0.820000] atmel_nand 60000000.nand: Using NFC Sram read
    [    0.830000] nand: WARNING: MT29F4G08ABADAWP: the ECC used on your system is too weak compared to the one required by the NAND chip
    [    0.840000] Bad block table found at page 262080, version 0x01
    [    0.850000] Bad block table found at page 262016, version 0x01
    [    0.860000] 6 ofpart partitions found on MTD device atmel_nand
    [    0.860000] Creating 6 MTD partitions on "atmel_nand":
    [    0.870000] 0x000000000000-0x000000040000 : "at91bootstrap"
    [    0.870000] 0x000000040000-0x0000000c0000 : "bootloader"
    [    0.880000] 0x0000000c0000-0x000000180000 : "bootloader env"
    [    0.890000] 0x000000180000-0x000000200000 : "device tree"
    [    0.900000] 0x000000200000-0x000000800000 : "kernel"
    [    0.910000] 0x000000800000-0x000010000000 : "rootfs"
    [    0.910000] atmel_spi f0004000.spi: version: 0x213
    [    0.920000] atmel_spi f0004000.spi: Using dma0chan5 (tx) and dma0chan6 (rx) for DMA transfers
    [    0.930000] atmel_spi f0004000.spi: Atmel SPI Controller at 0xf0004000 (irq 26)
    [    0.940000] atmel_spi f8008000.spi: version: 0x213
    [    0.940000] atmel_spi f8008000.spi: Using dma1chan0 (tx) and dma1chan1 (rx) for DMA transfers
    [    0.950000] atmel_spi f8008000.spi: Atmel SPI Controller at 0xf8008000 (irq 35)
    [    0.960000] PPP generic driver version 2.4.2
    [    0.970000] PPP BSD Compression module registered
    [    0.970000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    [    0.980000] ehci-atmel: EHCI Atmel driver
    [    0.980000] atmel-ehci 700000.ehci: EHCI Host Controller
    [    0.990000] atmel-ehci 700000.ehci: new USB bus registered, assigned bus number 1
    [    1.000000] atmel-ehci 700000.ehci: irq 56, io mem 0x00700000
    [    1.020000] atmel-ehci 700000.ehci: USB 2.0 started, EHCI 1.00
    [    1.020000] hub 1-0:1.0: USB hub found
    [    1.030000] hub 1-0:1.0: 3 ports detected
    [    1.030000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
    [    1.040000] ohci-atmel: OHCI Atmel driver
    [    1.040000] at91_ohci 600000.ohci: OHCI Host Controller
    [    1.050000] at91_ohci 600000.ohci: new USB bus registered, assigned bus number 2
    [    1.060000] at91_ohci 600000.ohci: irq 56, io mem 0x00600000
    [    1.120000] hub 2-0:1.0: USB hub found
    [    1.120000] hub 2-0:1.0: 3 ports detected
    [    1.130000] usbcore: registered new interface driver cdc_acm
    [    1.140000] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
    [    1.140000] usbcore: registered new interface driver usb-storage
    [    1.150000] usbcore: registered new interface driver usbserial
    [    1.160000] usbcore: registered new interface driver usbserial_generic
    [    1.160000] usbserial: USB Serial support registered for generic
    [    1.170000] usbcore: registered new interface driver ftdi_sio
    [    1.180000] usbserial: USB Serial support registered for FTDI USB Serial Device
    [    1.180000] usbcore: registered new interface driver pl2303
    [    1.190000] usbserial: USB Serial support registered for pl2303
    [    1.190000] atmel_usba_udc 500000.gadget: MMIO registers at 0xf8030000 mapped at d08c8000
    [    1.200000] atmel_usba_udc 500000.gadget: FIFO at 0x00500000 mapped at d2200000
    [    1.210000] g_serial gadget: Gadget Serial v2.4
    [    1.220000] g_serial gadget: g_serial ready
    [    1.220000] rtc (null): invalid alarm value: 1900-1-2 18:46:32
    [    1.230000] at91_rtc fffffeb0.rtc: rtc core: registered fffffeb0.rtc as rtc0
    [    1.240000] at91_rtc fffffeb0.rtc: AT91 Real Time Clock driver.
    [    1.240000] i2c /dev entries driver
    [    1.250000] Bluetooth: HCI UART driver ver 2.2
    [    1.250000] Bluetooth: HCI H4 protocol initialized
    [    1.260000] usbcore: registered new interface driver btusb
    [    1.260000] atmel_aes f8038000.aes: version: 0x135
    [    1.270000] atmel_aes f8038000.aes: Atmel AES - Using dma1chan2, dma1chan3 for DMA transfers
    [    1.280000] atmel_sha f8034000.sha: version: 0x410
    [    1.290000] atmel_sha f8034000.sha: using dma1chan4 for DMA transfers
    [    1.290000] atmel_sha f8034000.sha: Atmel SHA1/SHA256/SHA224/SHA384/SHA512
    [    1.300000] atmel_tdes f803c000.tdes: version: 0x701
    [    1.310000] atmel_tdes f803c000.tdes: using dma1chan5, dma1chan6 for DMA transfers
    [    1.320000] atmel_tdes f803c000.tdes: Atmel DES/TDES
    [    1.320000] usbcore: registered new interface driver usbhid
    [    1.330000] usbhid: USB HID core driver
    [    1.330000] iio iio:device0: Resolution used: 12 bits
    [    1.340000] iio iio:device0: ADC Touch screen is disabled.
    [    1.340000] nf_conntrack version 0.5.0 (3974 buckets, 15896 max)
    [    1.350000] ip_tables: (C) 2000-2006 Netfilter Core Team
    [    1.360000] TCP: cubic registered
    [    1.360000] NET: Registered protocol family 10
    [    1.370000] sit: IPv6 over IPv4 tunneling driver
    [    1.370000] NET: Registered protocol family 17
    [    1.380000] Bridge firewalling registered
    [    1.380000] Bluetooth: RFCOMM TTY layer initialized
    [    1.390000] Bluetooth: RFCOMM socket layer initialized
    [    1.390000] Bluetooth: RFCOMM ver 1.11
    [    1.400000] registered taskstats version 1
    [    1.400000] input: gpio_keys as /devices/gpio_keys/input/input0
    [    1.420000] at91_rtc fffffeb0.rtc: setting system clock to 2007-01-02 18:46:41 UTC (1167763601)
    [    1.430000] atmel_mci f0000000.mmc: version: 0x505
    [    1.440000] atmel_mci f0000000.mmc: using dma0chan7 for DMA transfers
    [    1.440000] atmel_mci f0000000.mmc: No vmmc regulator found
    [    1.450000] atmel_mci f0000000.mmc: No vqmmc regulator found
    [    1.490000] atmel_mci f0000000.mmc: Atmel MCI controller at 0xf0000000 irq 25, 1 slots
    [    1.490000] atmel_mci f8000000.mmc: version: 0x505
    [    1.500000] atmel_mci f8000000.mmc: using dma1chan7 for DMA transfers
    [    1.510000] atmel_mci f8000000.mmc: No vmmc regulator found
    [    1.510000] atmel_mci f8000000.mmc: No vqmmc regulator found
    [    1.520000] mmc0: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.530000] mmc0: mmc_rescan_try_freq: trying to init card at 300000 Hz
    [    1.560000] atmel_mci f8000000.mmc: Atmel MCI controller at 0xf8000000 irq 33, 1 slots
    [    1.560000] atmel_mci f8004000.mmc: version: 0x505
    [    1.570000] atmel_mci f8004000.mmc: no DMA channel available
    [    1.570000] atmel_mci f8004000.mmc: using PIO
    [    1.580000] atmel_mci f8004000.mmc: No vqmmc regulator found
    [    1.600000] mmc0: mmc_rescan_try_freq: trying to init card at 257813 Hz
    [    1.620000] atmel_mci f8004000.mmc: Atmel MCI controller at 0xf8004000 irq 34, 1 slots
    [    1.630000] Waiting for root device /dev/mmcblk0p1...
    [    1.640000] mmc1: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.710000] mmc1: host does not support reading read-only switch. assuming write-enable.
    [    1.720000] mmc1: new high speed SDXC card at address aaaa
    [    1.730000] mmcblk0: mmc1:aaaa SE64G 59.4 GiB
    [    1.730000]  mmcblk0: p1 p2
    [    1.740000] mmc2: mmc_rescan_try_freq: trying to init card at 400000 Hz
    [    1.750000] atmel_mci f8004000.mmc: card claims to support voltages below defined range
    [    1.790000] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    [    1.800000] mmc2: new high speed SDIO card at address 0001
    [    1.850000] EXT4-fs (mmcblk0p1): couldn't mount as ext3 due to feature incompatibilities
    [    1.860000] EXT4-fs (mmcblk0p1): couldn't mount as ext2 due to feature incompatibilities
    [    1.880000] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
    [    1.890000] VFS: Mounted root (ext4 filesystem) readonly on device 179:1.
    [    1.900000] devtmpfs: mounted
    [    1.910000] Freeing unused kernel memory: 148K (c04b2000 - c04d7000)
    [    2.000000] usb 2-3: new full-speed USB device number 2 using at91_ohci
    INIT: version 2.88 booting
    [    2.230000] ftdi_sio 2-3:1.0: FTDI USB Serial Device converter detected
    [    2.240000] usb 2-3: Detected FT232RL
    [    2.240000] usb 2-3: Number of endpoints 2
    [    2.250000] usb 2-3: Endpoint 1 MaxPacketSize 64
    [    2.250000] usb 2-3: Endpoint 2 MaxPacketSize 64
    [    2.260000] usb 2-3: Setting MaxPacketSize 64
    [    2.270000] usb 2-3: FTDI USB Serial Device converter now attached to ttyUSB0
    [info] Using makefile-style concurrent boot in runlevel S.
    [....] Starting the hotplug events dispatcher: udevd[    3.440000] udevd[711]: starting version 175
    . ok
    [....] Synthesizing the initial hotplug events...[    5.700000] VCC_1V8: 1800 mV
    [    5.700000] VCC_1V2: 1200 mV
    [    5.820000] VCC_3V3: 3300 mV
    [    5.820000] FUSE_2V5: 2500 mV
    [    5.900000] VDDANA: 3300 mV
    [    5.910000] LDO_REG3: at 600 mV
    [    5.910000] LDO_REG4: at 600 mV
    [    5.920000] Loading modules backported from Linux version R8.6-0-g3f5b34f
    [    5.930000] Backport generated by backports.git R8.6SP1-0-g4677dc3
    [ ok                                             [    6.090000] random: nonblocking pool is initialized
    done.
    [    6.220000] cfg80211: Calling CRDA to update world regulatory domain
    [....] [    6.390000] wlcore: Time Sync: gpio requested
    [    6.400000] wlcore: ERROR could not get configuration binary ti-connectivity/wl18xx-conf.bin: -2
    [    6.410000] wlcore: WARNING falling back to default config
    [    6.450000] mmc2: mmc_power_restore_host: powering up
    Waiting for /dev to be fully populated...[    6.660000] cfg80211: World regulatory domain updated:
    [    6.670000] cfg80211:  DFS Master region: unset
    [    6.670000] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [    6.680000] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.690000] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.700000] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.710000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [    6.720000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [    6.730000] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [    6.730000] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [    6.740000] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    done.
    [ ok ] Activating swap...done.
    [    8.070000] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
    [ ok ] Cleaning up temporary files....
    [info] Loading kernel module g_serial.
    [ ok ] Activating lvm and md swap...done.
    [....] Checking file systems...fsck from util-linux 2.20.1
    done.
    [ ok ] Mounting local filesystems...done.
    [ ok ] Activating swapfile swap...done.
    [ ok ] Cleaning up temporary files....
    [ ok ] Setting kernel variables ...done.
    [ ok ] Configuring network interfaces...done.
    [ ok ] Cleaning up temporary files....
    UIM SYSFS Node Not Found
    INIT: Entering runlevel: 2
    [info] Using makefile-style concurrent boot in runlevel 2.
    [ ok ] Starting enhanced syslogd: rsyslogd.
    [ ok ] Starting periodic command scheduler: cron.
    [ ok ] Starting system message bus: dbus.
    [ ok ] Starting bluetooth: bluetoothd.
    [ ok ] Starting NTP server: ntpd.
    [ ok ] Starting OpenBSD Secure Shell server: sshd.
    Starting very small Busybox based DHCP server: Starting /usr/sbin/udhcpd...
    udhcpd.
    BT Enabled
    Charger Config
    Enabling TI Chip (/dev/ttyUSB0)
    Found a Texas Instruments' chip!
    Firmware file : /lib/firmware/ti-connectivity/TIInit_11.8.32.bts
    Loaded BTS script version 1
    Can't set device: Protocol not supported
    Can't initialize device: Protocol not supported
    Device setup complete
    Starting COHDA
    enabling COHDA module
    Downloading COHDA FW
    Downloading COHDA Firmware
    dfu-util 0.5
    
    (C) 2005-2008 by Weston Schmidt, Harald Welte and OpenMoko Inc.
    (C) 2010-2011 Tormod Volden (DfuSe support)
    This program is Free Software and has ABSOLUTELY NO WARRANTY
    
    dfu-util does currently only support DFU version 1.0
    
    Filter on vendor = 0x1fc9 product = 0x0102
    No DFU capable USB device found
    Installing llc ko
    Installing cw-llc kernel module
    [   69.650000] LLC_USBOutReq: USB device not present
    [   69.660000] LLC_USBOutReq: USB device not present
    [   69.750000] usbcore: registered new interface driver cw-llc
    
    Debian GNU/Linux 7 OpenXC-VI-V2X-9327 ttyS0
    
    OpenXC-VI-V2X-9327 login: root
    Password:
    Last login: Tue Jan  2 19:46:07 CET 2007 on ttyS0
    Linux OpenXC-VI-V2X-9327 3.16.5-sama5-armv7-r8 #28 Wed Oct 12 10:53:08 PDT 2016 armv7l
    
    The programs included with the Debian GNU/Linux system are free software;
    the exact distribution terms for each program are described in the
    individual files in /usr/share/doc/*/copyright.
    
    Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
    permitted by applicable law.
    ===>>> Missing WLAN0 interface.
    ===>>> Please restart your system !

    [   17.340000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.340000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.340000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.340000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.340000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.340000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.340000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.340000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.340000] atmel_mci f8000000.mmc: command with data transfer
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.340000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.340000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.340000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.340000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.340000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.340000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.340000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.340000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.340000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.340000] atmel_mci f8000000.mmc: set completed not busy
    [   17.340000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.340000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.340000] atmel_mci f8000000.mmc: send stop command
    [   17.340000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.340000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.340000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.340000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.340000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.340000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.340000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.340000] atmel_mci f8000000.mmc: set completed not busy
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.340000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.340000] mmc1:     4096 bytes transferred: 0
    [   17.340000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.340000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.350000] mmc1: starting CMD18 arg 000426b0 flags 000000b5
    [   17.350000] mmc1:     blksz 512 blocks 32 flags 00000200 tsac 100 ms nsac 0
    [   17.350000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.350000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.350000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.350000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.350000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.350000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.350000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.350000] atmel_mci f8000000.mmc: command with data transfer
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.350000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.350000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.350000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.350000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.350000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.350000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.350000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.350000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.350000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.350000] atmel_mci f8000000.mmc: set completed not busy
    [   17.350000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.350000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.350000] atmel_mci f8000000.mmc: send stop command
    [   17.350000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.350000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.350000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.350000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.350000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.350000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.350000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.350000] atmel_mci f8000000.mmc: set completed not busy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.350000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.350000] mmc1:     16384 bytes transferred: 0
    [   17.350000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.350000] mmc1: starting CMD18 arg 000426d0 flags 000000b5
    [   17.350000] mmc1:     blksz 512 blocks 24 flags 00000200 tsac 100 ms nsac 0
    [   17.350000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.350000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.350000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.350000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.350000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.350000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.350000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.350000] atmel_mci f8000000.mmc: command with data transfer
    [   17.350000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.350000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: send stop command
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.360000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.360000] mmc1:     12288 bytes transferred: 0
    [   17.360000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] mmc1: starting CMD18 arg 00048380 flags 000000b5
    [   17.360000] mmc1:     blksz 512 blocks 32 flags 00000200 tsac 100 ms nsac 0
    [   17.360000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.360000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.360000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.360000] atmel_mci f8000000.mmc: command with data transfer
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: send stop command
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.360000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.360000] mmc1:     16384 bytes transferred: 0
    [   17.360000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] mmc1: starting CMD18 arg 000483f8 flags 000000b5
    [   17.360000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.360000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.360000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.360000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.360000] atmel_mci f8000000.mmc: command with data transfer
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: send stop command
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.360000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.360000] mmc1:     4096 bytes transferred: 0
    [   17.360000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] mmc1: starting CMD18 arg 000483a0 flags 000000b5
    [   17.360000] mmc1:     blksz 512 blocks 88 flags 00000200 tsac 100 ms nsac 0
    [   17.360000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.360000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.360000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.360000] atmel_mci f8000000.mmc: command with data transfer
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.360000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.360000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: send stop command
    [   17.360000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.360000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.360000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.360000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.360000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.360000] atmel_mci f8000000.mmc: set completed not busy
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.360000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.360000] mmc1:     45056 bytes transferred: 0
    [   17.360000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.360000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.380000] mmc1: starting CMD18 arg 0004cdb0 flags 000000b5
    [   17.380000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.380000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.380000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.380000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.380000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.380000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.380000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.380000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.380000] atmel_mci f8000000.mmc: command with data transfer
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.380000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.380000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.380000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.380000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.380000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.380000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.380000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.380000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.380000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.380000] atmel_mci f8000000.mmc: set completed not busy
    [   17.380000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.380000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.380000] atmel_mci f8000000.mmc: send stop command
    [   17.380000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.380000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.380000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.380000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.380000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.380000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.380000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.380000] atmel_mci f8000000.mmc: set completed not busy
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.380000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.380000] mmc1:     4096 bytes transferred: 0
    [   17.380000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.380000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.890000] mmc1: starting CMD18 arg 0004cdc8 flags 000000b5
    [   17.890000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.890000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.890000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.890000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.890000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.890000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.890000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.890000] atmel_mci f8000000.mmc: command with data transfer
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.890000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.890000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.890000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.890000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.890000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.890000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.890000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.890000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.890000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.890000] atmel_mci f8000000.mmc: set completed not busy
    [   17.890000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.890000] atmel_mci f8000000.mmc: send stop command
    [   17.890000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.890000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.890000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.890000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.890000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.890000] atmel_mci f8000000.mmc: set completed not busy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.890000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.890000] mmc1:     4096 bytes transferred: 0
    [   17.890000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.890000] mmc1: starting CMD18 arg 00008cb8 flags 000000b5
    [   17.890000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.890000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.890000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.890000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.890000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.890000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.890000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.890000] atmel_mci f8000000.mmc: command with data transfer
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.890000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.890000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.890000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.890000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.890000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.890000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.890000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.890000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.890000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.890000] atmel_mci f8000000.mmc: set completed not busy
    [   17.890000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.890000] atmel_mci f8000000.mmc: send stop command
    [   17.890000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.890000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.890000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.890000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.890000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.890000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.890000] atmel_mci f8000000.mmc: set completed not busy
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.890000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.890000] mmc1:     4096 bytes transferred: 0
    [   17.890000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.890000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] mmc1: starting CMD18 arg 0004bc10 flags 000000b5
    [   17.900000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.900000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.900000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.900000] atmel_mci f8000000.mmc: command with data transfer
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: send stop command
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.900000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.900000] mmc1:     4096 bytes transferred: 0
    [   17.900000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] mmc1: starting CMD18 arg 0004d388 flags 000000b5
    [   17.900000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.900000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.900000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.900000] atmel_mci f8000000.mmc: command with data transfer
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: send stop command
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.900000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.900000] mmc1:     4096 bytes transferred: 0
    [   17.900000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] mmc1: starting CMD18 arg 0004e5d0 flags 000000b5
    [   17.900000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.900000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.900000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.900000] atmel_mci f8000000.mmc: command with data transfer
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: send stop command
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.900000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.900000] mmc1:     4096 bytes transferred: 0
    [   17.900000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.910000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.930000] mmc1: starting CMD18 arg 000432f8 flags 000000b5
    [   17.930000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.930000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.930000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.930000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.930000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.930000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.930000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.930000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.930000] atmel_mci f8000000.mmc: command with data transfer
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.930000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.930000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.930000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.930000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.930000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.930000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.930000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.930000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.930000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.930000] atmel_mci f8000000.mmc: set completed not busy
    [   17.930000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.930000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.930000] atmel_mci f8000000.mmc: send stop command
    [   17.930000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.930000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.930000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.930000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.930000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.930000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.930000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.930000] atmel_mci f8000000.mmc: set completed not busy
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.930000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.930000] mmc1:     4096 bytes transferred: 0
    [   17.930000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.930000] atmel_mci f8000000.mmc: FSM: state=0
    [   18.000000] mmc1: starting CMD18 arg 00041860 flags 000000b5
    [   18.000000] mmc1:     blksz 512 blocks 32 flags 00000200 tsac 100 ms nsac 0
    [   18.000000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   18.000000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   18.000000] atmel_mci f8000000.mmc: start request: cmd 18
    [   18.000000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=1
    [   18.000000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   18.000000] atmel_mci f8000000.mmc: set completed cmd ready
    [   18.000000] atmel_mci f8000000.mmc: command with data transfer
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=2
    [   18.000000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   18.000000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   18.000000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   18.000000] atmel_mci f8000000.mmc: set pending notbusy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=2
    [   18.000000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   18.000000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   18.000000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   18.000000] atmel_mci f8000000.mmc: set pending notbusy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=3
    [   18.000000] atmel_mci f8000000.mmc: FSM: not busy?
    [   18.000000] atmel_mci f8000000.mmc: set completed not busy
    [   18.000000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   18.000000] atmel_mci f8000000.mmc: send stop command
    [   18.000000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=4
    [   18.000000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   18.000000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   18.000000] atmel_mci f8000000.mmc: set pending notbusy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=3
    [   18.000000] atmel_mci f8000000.mmc: FSM: not busy?
    [   18.000000] atmel_mci f8000000.mmc: set completed not busy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=5
    [   18.000000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   18.000000] mmc1:     16384 bytes transferred: 0
    [   18.000000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=0
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=0
    [   18.000000] mmc1: starting CMD18 arg 00041880 flags 000000b5
    [   18.000000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   18.000000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   18.000000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   18.000000] atmel_mci f8000000.mmc: start request: cmd 18
    [   18.000000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=1
    [   18.000000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   18.000000] atmel_mci f8000000.mmc: set completed cmd ready
    [   18.000000] atmel_mci f8000000.mmc: command with data transfer
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=2
    [   18.000000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   18.000000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   18.000000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   18.000000] atmel_mci f8000000.mmc: set pending notbusy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=2
    [   18.000000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   18.000000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   18.000000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   18.000000] atmel_mci f8000000.mmc: set pending notbusy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=3
    [   18.000000] atmel_mci f8000000.mmc: FSM: not busy?
    [   18.000000] atmel_mci f8000000.mmc: set completed not busy
    [   18.000000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   18.000000] atmel_mci f8000000.mmc: send stop command
    [   18.000000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=4
    [   18.000000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   18.000000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   18.000000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   18.000000] atmel_mci f8000000.mmc: set pending notbusy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=3
    [   18.000000] atmel_mci f8000000.mmc: FSM: not busy?
    [   18.000000] atmel_mci f8000000.mmc: set completed not busy
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=5
    [   18.000000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   18.000000] mmc1:     4096 bytes transferred: 0
    [   18.000000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=0
    [   18.000000] atmel_mci f8000000.mmc: FSM: state=0
    root@OpenXC-VI-V2X-9327:/var/log# 

    [   17.760000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.770000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.770000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.770000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.770000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.770000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.770000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.770000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.770000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.770000] atmel_mci f8000000.mmc: set completed not busy
    [   17.770000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.770000] atmel_mci f8000000.mmc: send stop command
    [   17.770000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.770000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.770000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.770000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.770000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.770000] atmel_mci f8000000.mmc: set completed not busy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.770000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.770000] mmc1:     126976 bytes transferred: 0
    [   17.770000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.770000] mmc1: starting CMD18 arg 00090f38 flags 000000b5
    [   17.770000] mmc1:     blksz 512 blocks 32 flags 00000200 tsac 100 ms nsac 0
    [   17.770000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.770000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.770000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.770000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.770000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.770000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.770000] atmel_mci f8000000.mmc: command with data transfer
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.770000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.770000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.770000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.770000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.770000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.770000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.770000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.770000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.770000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.770000] atmel_mci f8000000.mmc: set completed not busy
    [   17.770000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.770000] atmel_mci f8000000.mmc: send stop command
    [   17.770000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.770000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.770000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.770000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.770000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.770000] atmel_mci f8000000.mmc: set completed not busy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.770000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.770000] mmc1:     16384 bytes transferred: 0
    [   17.770000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.770000] mmc1: starting CMD18 arg 00090f58 flags 000000b5
    [   17.770000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.770000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.770000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.770000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.770000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.770000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.770000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.770000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.770000] atmel_mci f8000000.mmc: command with data transfer
    [   17.770000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.770000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.780000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.780000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.780000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.780000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.780000] atmel_mci f8000000.mmc: set completed not busy
    [   17.780000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.780000] atmel_mci f8000000.mmc: send stop command
    [   17.780000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.780000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.780000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.780000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.780000] atmel_mci f8000000.mmc: set completed not busy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.780000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.780000] mmc1:     4096 bytes transferred: 0
    [   17.780000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.780000] mmc1: starting CMD18 arg 0000caf0 flags 000000b5
    [   17.780000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.780000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.780000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.780000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.780000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.780000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.780000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.780000] atmel_mci f8000000.mmc: command with data transfer
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.780000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.780000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.780000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.780000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.780000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.780000] atmel_mci f8000000.mmc: set completed not busy
    [   17.780000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.780000] atmel_mci f8000000.mmc: send stop command
    [   17.780000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.780000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.780000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.780000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.780000] atmel_mci f8000000.mmc: set completed not busy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.780000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.780000] mmc1:     4096 bytes transferred: 0
    [   17.780000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.780000] mmc1: starting CMD18 arg 00008ce8 flags 000000b5
    [   17.780000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.780000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.780000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.780000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.780000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.780000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.780000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.780000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.780000] atmel_mci f8000000.mmc: command with data transfer
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.780000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.780000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.780000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.780000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.780000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.780000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.780000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.790000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.790000] atmel_mci f8000000.mmc: set completed not busy
    [   17.790000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.790000] atmel_mci f8000000.mmc: send stop command
    [   17.790000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.790000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.790000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.790000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.790000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.790000] atmel_mci f8000000.mmc: set completed not busy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.790000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.790000] mmc1:     4096 bytes transferred: 0
    [   17.790000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.790000] mmc1: starting CMD18 arg 0000cce8 flags 000000b5
    [   17.790000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.790000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.790000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.790000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.790000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.790000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.790000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.790000] atmel_mci f8000000.mmc: command with data transfer
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.790000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.790000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.790000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.790000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.790000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.790000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.790000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.790000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.790000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.790000] atmel_mci f8000000.mmc: set completed not busy
    [   17.790000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.790000] atmel_mci f8000000.mmc: send stop command
    [   17.790000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.790000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.790000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.790000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.790000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.790000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.790000] atmel_mci f8000000.mmc: set completed not busy
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.790000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.790000] mmc1:     4096 bytes transferred: 0
    [   17.790000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.790000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] mmc2: starting CMD7 arg 00010000 flags 00000015
    [   17.810000] atmel_mci f8004000.mmc: MRQ: cmd 7
    [   17.810000] atmel_mci f8004000.mmc: start request: cmd 7
    [   17.810000] atmel_mci f8004000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8004000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8004000.mmc: FSM: state=1
    [   17.810000] atmel_mci f8004000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8004000.mmc: set completed cmd ready
    [   17.810000] atmel_mci f8004000.mmc: FSM: state=5
    [   17.810000] mmc2: req done (CMD7): 0: 00001ec7 00001ec7 00001ec7 00001ec7
    [   17.810000] atmel_mci f8004000.mmc: FSM: state=0
    [   17.810000] mmc1: starting CMD18 arg 000446f8 flags 000000b5
    [   17.810000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.810000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.810000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.810000] atmel_mci f8000000.mmc: command with data transfer
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: send stop command
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.810000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.810000] mmc1:     4096 bytes transferred: 0
    [   17.810000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] mmc1: starting CMD18 arg 001ea518 flags 000000b5
    [   17.810000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.810000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.810000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.810000] atmel_mci f8000000.mmc: command with data transfer
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: send stop command
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.810000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.810000] mmc1:     4096 bytes transferred: 0
    [   17.810000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] mmc1: starting CMD18 arg 00043390 flags 000000b5
    [   17.810000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.810000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.810000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.810000] atmel_mci f8000000.mmc: command with data transfer
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: send stop command
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.810000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.810000] mmc1:     4096 bytes transferred: 0
    [   17.810000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] mmc1: starting CMD18 arg 001ee500 flags 000000b5
    [   17.810000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.810000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.810000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.810000] atmel_mci f8000000.mmc: command with data transfer
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.810000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.810000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: send stop command
    [   17.810000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.810000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.810000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.810000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.810000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.810000] atmel_mci f8000000.mmc: set completed not busy
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.810000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.810000] mmc1:     4096 bytes transferred: 0
    [   17.810000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.810000] mmc1: starting CMD18 arg 000434f8 flags 000000b5
    [   17.820000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.820000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.820000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.820000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.820000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.820000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.820000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.820000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.820000] atmel_mci f8000000.mmc: command with data transfer
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.820000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.820000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.820000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.820000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.820000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.820000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.820000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.820000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.820000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.820000] atmel_mci f8000000.mmc: set completed not busy
    [   17.820000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.820000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.820000] atmel_mci f8000000.mmc: send stop command
    [   17.820000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.820000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.820000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.820000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.820000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.820000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.820000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.820000] atmel_mci f8000000.mmc: set completed not busy
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.820000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.820000] mmc1:     4096 bytes transferred: 0
    [   17.820000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.820000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.850000] mmc1: starting CMD18 arg 001f24e8 flags 000000b5
    [   17.850000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.850000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.850000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.850000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.850000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.850000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.850000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.850000] atmel_mci f8000000.mmc: command with data transfer
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.850000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.850000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.850000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.850000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.850000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.850000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.850000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.850000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.850000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.850000] atmel_mci f8000000.mmc: set completed not busy
    [   17.850000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.850000] atmel_mci f8000000.mmc: send stop command
    [   17.850000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.850000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.850000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.850000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.850000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.850000] atmel_mci f8000000.mmc: set completed not busy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.850000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.850000] mmc1:     4096 bytes transferred: 0
    [   17.850000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.850000] mmc1: starting CMD18 arg 001118f0 flags 000000b5
    [   17.850000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.850000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.850000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.850000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.850000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.850000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.850000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.850000] atmel_mci f8000000.mmc: command with data transfer
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.850000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.850000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.850000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.850000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.850000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.850000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.850000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.850000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.850000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.850000] atmel_mci f8000000.mmc: set completed not busy
    [   17.850000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.850000] atmel_mci f8000000.mmc: send stop command
    [   17.850000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.850000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.850000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.850000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.850000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.850000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.850000] atmel_mci f8000000.mmc: set completed not busy
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.850000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.850000] mmc1:     4096 bytes transferred: 0
    [   17.850000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.850000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] mmc1: starting CMD18 arg 00041860 flags 000000b5
    [   17.900000] mmc1:     blksz 512 blocks 32 flags 00000200 tsac 100 ms nsac 0
    [   17.900000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.900000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.900000] atmel_mci f8000000.mmc: command with data transfer
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: send stop command
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.900000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.900000] mmc1:     16384 bytes transferred: 0
    [   17.900000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] mmc1: starting CMD18 arg 00041880 flags 000000b5
    [   17.900000] mmc1:     blksz 512 blocks 8 flags 00000200 tsac 100 ms nsac 0
    [   17.900000] mmc1:     CMD12 arg 00000000 flags 00000095
    [   17.900000] atmel_mci f8000000.mmc: MRQ: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: start request: cmd 18
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=1
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: set completed cmd ready
    [   17.900000] atmel_mci f8000000.mmc: command with data transfer
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_dma_complete) set pending xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=2
    [   17.900000] atmel_mci f8000000.mmc: FSM: xfer complete?
    [   17.900000] atmel_mci f8000000.mmc: (atmci_tasklet_func) set completed xfer complete
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: send stop command
    [   17.900000] atmel_mci f8000000.mmc: IRQ: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: set pending cmd rdy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=4
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready?
    [   17.900000] atmel_mci f8000000.mmc: FSM: cmd ready
    [   17.900000] atmel_mci f8000000.mmc: IRQ: not_busy
    [   17.900000] atmel_mci f8000000.mmc: set pending notbusy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=3
    [   17.900000] atmel_mci f8000000.mmc: FSM: not busy?
    [   17.900000] atmel_mci f8000000.mmc: set completed not busy
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=5
    [   17.900000] mmc1: req done (CMD18): 0: 00000900 00000900 00000900 00000900
    [   17.900000] mmc1:     4096 bytes transferred: 0
    [   17.900000] mmc1:     (CMD12): 0: 00000b00 00000b00 00000b00 00000b00
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0
    [   17.900000] atmel_mci f8000000.mmc: FSM: state=0

  • hi , can you pls explain the difference b/w the 2 scenarios when it works and when it doesn't ? what is different - software, hardware, kernel etc. ?
    Saurabh
  • Hi Saurabh, 

    Both scenarios are the same with same environment. Same kernel, same filesystems, same power supplies, same boards. 

    I was able to traceback some functions and added some debug lines. Here is a new kernel log snippet with the wlan0 working and not working: 

    WORKING

    [ 6.520000] wlcore: inside wlcore_probe!
    [ 6.550000] wlcore: ERROR could not get configuration binary ti-connectivity/wl18xx-conf.bin: -2
    [ 6.560000] wlcore: WARNING falling back to default config
    [ 6.560000] wlcore: inside wl12xx_set_power_on!
    [ 6.600000] inside wl12xx_sdio_power_on!
    [ 6.600000] mmc2: mmc_power_restore_host: powering up
    [ 6.720000] cfg80211: World regulatory domain updated:
    [ 6.720000] cfg80211: DFS Master region: unset
    [ 6.730000] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [ 6.740000] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.740000] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.750000] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.760000] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [ 6.770000] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [ 6.780000] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [ 6.790000] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.790000] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    [ 6.830000] wlcore: inside wl12xx_get_hw_info!
    [ 6.830000] wlcore: inside main.c : wl18xx_get_pg_ver
    [ 6.840000] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
    [ 6.860000] inside wl12xx_sdio_power_off!
    [ 6.870000] mmc2: mmc_power_save_host: powering down
    [ 6.880000] wlcore: loaded
    [ 6.880000] wlcore: driver version: R8.6-dirty
    [ 6.880000] wlcore: compilation time: Thu Oct 13 17:43:30 2016
    done.

    NOT WORKING


    [ 6.550000] wlcore: inside wlcore_probe!
    [ 6.570000] wlcore: ERROR could not get configuration binary ti-connectivity/wl18xx-conf.bin: -2
    [ 6.570000] wlcore: WARNING falling back to default config
    [ 6.580000] wlcore: inside wl12xx_set_power_on!
    [ 6.610000] inside wl12xx_sdio_power_on!
    [ 6.610000] mmc2: mmc_power_restore_host: powering up
    [ 6.690000] wlcore: wl1271_power_on< 0 !
    [ 6.850000] cfg80211: World regulatory domain updated:
    [ 6.860000] cfg80211: DFS Master region: unset
    [ 6.860000] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
    [ 6.870000] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.880000] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.890000] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.900000] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
    [ 6.910000] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
    [ 6.920000] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
    [ 6.920000] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
    [ 6.930000] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
    done.


    As you can see, when wlan0 does not work wl12xx_set_power_on (in wlcore/main.c) calls ret=wl1271_power_on(wl), which returns a value less than 0. 

    wl1271_power_on is defined in wlcore/io.h, which calls the "power" function in line int ret = wl->if_ops->power(wl->dev, true);

    power is defined under a /include/c++ library. 

     

    static inline int wl1271_power_on(struct wl1271 *wl) {
                int ret = wl->if_ops->power(wl->dev, true);
                printk(KERN_INFO "Powering on WL1271(=WL1835) ret = %d", ret);
                if (ret == 0)
                      set_bit(WL1271_FLAG_GPIO_POWER, &wl->flags);

                return ret;
    }

    Do you know why ret would be receiving a value less than 0? Do you think it would be ok to comment out the if statement and force wl1271 to always set the bit to turn on the wlan0? I added the printk line to look through the kernel bootup if it get's called in occasions where the if statement comes in handy. 

    Best, 

    Bruno

  • when wlan0 fails, ret has a value of -84
  • hi , wl8 is powered up/down by mmc/sdio controller . wl8 driver calls sdio fn to claim bus / power up wlan fn etc. I see you have commented the startup delay in wlan_en_reg ( dts file ). Is there a reason for that ?
    Saurabh
  • closing the thread since there has been no reply for almost 2 weeks
    Saurabh