AM5728: MMC issue with WiFi module

Bob Engineer 2

Part Number: AM5728
Other Parts Discussed in Thread: DRA752, PMP

Trying to get am5728 mmc3 to talk to a u-blox lily WiFi module. The am5728 identifies the wifi module, loads up the drivers, and then programs the wifi module with its firmware. Lily firmware is started.

So far so good. Next a command is issued from the micro to the wifi module, and this command times out. And then the driver unregisters the device and it's all over.

However, it clear that people have previously been able to make am57xx parts work with u-blox lily, e.g. http://e2e.ti.com/support/processors/f/791/t/639301?Linux-AM5708-MMC-throughput-with-WiFi-module

I am using TI SDK 5, linux kernel 4.14.40.

I am interested in any advice in how to get this going.

over 6 years ago

0 Andreas Dannenberg over 6 years ago

TI__Guru 70602 points

Hi,

Bob Engineer 2 said:
The am5728 identifies the wifi module, loads up the drivers, and then programs the wifi module with its firmware. Lily firmware is started.

If that's the case then it sounds like you are pretty close to getting it working.

Can you share a full(!) boot log and a log of what happens when you are trying to access the WiFi module and how then everything shuts down. We need to identify where and how to dig deeper.

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

Here's the boot log. I've made a couple of minor edits to make it slightly more anonymous, which is why there are a few blank lines..

The key moment seems to be: [ 24.794450] mwifiex_sdio mmc2:0001:1: mwifiex_cmd_timeout_func: Timeout cmd id = 0xa9, act = 0x0

Best regards,

Bob.

root@am57xx-evm:~# dmesg
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.14.40-g4796173fc5 (gcc version 7.2.1 20171011 (Linaro GCC 7.2-2017.11)) #5 SMP PREEMPT Wed Nov 20 11:18:34 AWST 2019
[ 0.000000] CPU: ARMv7 Processor [412fc0f2] revision 2 (ARMv7), cr=30c5387d
[ 0.000000] CPU: div instructions available: patching division code
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache

[ 0.000000] OF: fdt: Ignoring memory range 0x40000000 - 0x80000000
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] efi: Getting EFI parameters from FDT:
[ 0.000000] efi: UEFI not found.
[ 0.000000] Reserved memory: created CMA memory pool at 0x0000000095800000, size 56 MiB
[ 0.000000] OF: reserved mem: initialized node ipu2-memory@95800000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x0000000099000000, size 64 MiB
[ 0.000000] OF: reserved mem: initialized node dsp1-memory@99000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x000000009d000000, size 32 MiB
[ 0.000000] OF: reserved mem: initialized node ipu1-memory@9d000000, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created CMA memory pool at 0x000000009f000000, size 8 MiB
[ 0.000000] OF: reserved mem: initialized node dsp2-memory@9f000000, compatible id shared-dma-pool
[ 0.000000] cma: Reserved 24 MiB at 0x00000000fe400000
[ 0.000000] OMAP4: Map 0x00000000ffd00000 to fe600000 for dram barrier
[ 0.000000] On node 0 totalpages: 474368
[ 0.000000] free_area_init_node: node 0, pgdat c1053c40, node_mem_map eeda2000
[ 0.000000] DMA zone: 1728 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 147456 pages, LIFO batch:31
[ 0.000000] HighMem zone: 326912 pages, LIFO batch:31
[ 0.000000] DRA752 ES2.0
[ 0.000000] percpu: Embedded 15 pages/cpu @eed35000 s31308 r8192 d21940 u61440
[ 0.000000] pcpu-alloc: s31308 r8192 d21940 u61440 alloc=15*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 472640
[ 0.000000] Kernel command line: console=ttyO2,115200n8 root=PARTUUID=000c322d-02 rw rootfstype=ext4 rootwait
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Memory: 1675648K/1897472K available (8192K kernel code, 347K rwdata, 2540K rodata, 2048K init, 300K bss, 33408K reserved, 188416K cma-reserved, 1283072K highmem)
[ 0.000000] Virtual kernel memory layout:
vector : 0xffff0000 - 0xffff1000 ( 4 kB)
fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
vmalloc : 0xf0800000 - 0xff800000 ( 240 MB)
lowmem : 0xc0000000 - 0xf0000000 ( 768 MB)
pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
.text : 0xc0008000 - 0xc0a00000 (10208 kB)
.init : 0xc0e00000 - 0xc1000000 (2048 kB)
.data : 0xc1000000 - 0xc1056d68 ( 348 kB)
.bss : 0xc1058000 - 0xc10a3084 ( 301 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] Tasks RCU enabled.
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000000] GIC: Using split EOI/Deactivate mode
[ 0.000000] OMAP clockevent source: timer1 at 32786 Hz
[ 0.000000] arch_timer: cp15 timer(s) running at 6.14MHz (phys).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x16af5adb9, max_idle_ns: 440795202250 ns
[ 0.000005] sched_clock: 56 bits at 6MHz, resolution 162ns, wraps every 4398046511023ns
[ 0.000017] Switching to timer-based delay loop, resolution 162ns
[ 0.000354] clocksource: 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns
[ 0.000363] OMAP clocksource: 32k_counter at 32768 Hz
[ 0.000792] Console: colour dummy device 80x30
[ 0.000810] WARNING: Your 'console=ttyO2' has been replaced by 'ttyS2'
[ 0.000818] This ensures that you still see kernel messages. Please
[ 0.000825] update your kernel commandline.
[ 0.000846] Calibrating delay loop (skipped), value calculated using timer frequency.. 12.29 BogoMIPS (lpj=61475)
[ 0.000861] pid_max: default: 32768 minimum: 301
[ 0.000980] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000994] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.001509] CPU: Testing write buffer coherency: ok
[ 0.001722] /cpus/cpu@0 missing clock-frequency property
[ 0.001741] /cpus/cpu@1 missing clock-frequency property
[ 0.001752] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.039879] Setting up static identity map for 0x80200000 - 0x80200060
[ 0.059887] Hierarchical SRCU implementation.
[ 0.080081] EFI services will not be available.
[ 0.099954] smp: Bringing up secondary CPUs ...
[ 0.170262] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.170356] smp: Brought up 1 node, 2 CPUs
[ 0.170369] SMP: Total of 2 processors activated (24.59 BogoMIPS).
[ 0.170377] CPU: All CPU(s) started in HYP mode.
[ 0.170384] CPU: Virtualization extensions available.
[ 0.170888] devtmpfs: initialized
[ 0.188171] random: get_random_u32 called from bucket_table_alloc+0x108/0x230 with crng_init=0
[ 0.188423] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0
[ 0.188615] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.188632] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.192470] pinctrl core: initialized pinctrl subsystem
[ 0.192916] DMI not present or invalid.
[ 0.193160] NET: Registered protocol family 16
[ 0.194184] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.195137] omap_hwmod: l3_main_2 using broken dt data from ocp
[ 0.399687] cpuidle: using governor ladder
[ 0.399720] cpuidle: using governor menu
[ 0.407242] gpio gpiochip0: (gpio): added GPIO chardev (254:0)
[ 0.407310] gpiochip_setup_dev: registered GPIOs 0 to 31 on device: gpiochip0 (gpio)
[ 0.407370] OMAP GPIO hardware version 0.1
[ 0.408008] gpio gpiochip1: (gpio): added GPIO chardev (254:1)
[ 0.408073] gpiochip_setup_dev: registered GPIOs 32 to 63 on device: gpiochip1 (gpio)
[ 0.408742] gpio gpiochip2: (gpio): added GPIO chardev (254:2)
[ 0.408807] gpiochip_setup_dev: registered GPIOs 64 to 95 on device: gpiochip2 (gpio)
[ 0.409462] gpio gpiochip3: (gpio): added GPIO chardev (254:3)
[ 0.409526] gpiochip_setup_dev: registered GPIOs 96 to 127 on device: gpiochip3 (gpio)
[ 0.410191] gpio gpiochip4: (gpio): added GPIO chardev (254:4)
[ 0.410260] gpiochip_setup_dev: registered GPIOs 128 to 159 on device: gpiochip4 (gpio)
[ 0.410949] gpio gpiochip5: (gpio): added GPIO chardev (254:5)
[ 0.411018] gpiochip_setup_dev: registered GPIOs 160 to 191 on device: gpiochip5 (gpio)
[ 0.411687] gpio gpiochip6: (gpio): added GPIO chardev (254:6)
[ 0.411751] gpiochip_setup_dev: registered GPIOs 192 to 223 on device: gpiochip6 (gpio)
[ 0.412415] gpio gpiochip7: (gpio): added GPIO chardev (254:7)
[ 0.412479] gpiochip_setup_dev: registered GPIOs 224 to 255 on device: gpiochip7 (gpio)
[ 0.434310] No ATAGs?
[ 0.434380] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.434394] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.434747] omap4_sram_init:Unable to allocate sram needed to handle errata I688
[ 0.434757] omap4_sram_init:Unable to get sram pool needed to handle errata I688
[ 0.435266] OMAP DMA hardware revision 0.0
[ 0.450060] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver (LinkedList1/2/3 supported)
[ 0.451338] edma 43300000.edma: memcpy is disabled
[ 0.454478] edma 43300000.edma: TI EDMA DMA engine driver
[ 0.454831] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/fixedregulator-vdd_3v3[0]'
[ 0.455095] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/fixedregulator-aic_dvdd[0]'
[ 0.455446] of_get_named_gpiod_flags: parsed 'gpio' property of node '/fixedregulator-vtt[0]' - status (0)
[ 0.457706] omap-iommu 40d01000.mmu: 40d01000.mmu registered
[ 0.457908] omap-iommu 40d02000.mmu: 40d02000.mmu registered
[ 0.458149] omap-iommu 58882000.mmu: 58882000.mmu registered
[ 0.458386] omap-iommu 55082000.mmu: 55082000.mmu registered
[ 0.458727] omap-iommu 41501000.mmu: 41501000.mmu registered
[ 0.458937] omap-iommu 41502000.mmu: 41502000.mmu registered
[ 0.459155] iommu: Adding device 58820000.ipu to group 1
[ 0.459233] iommu: Adding device 55020000.ipu to group 2
[ 0.459376] iommu: Adding device 40800000.dsp to group 0
[ 0.459613] iommu: Adding device 41000000.dsp to group 3
[ 0.461014] omap_i2c 48070000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@2000/pinmux@1400/i2c1_pins_default, deferring probe
[ 0.461516] omap_i2c 4807a000.i2c: bus 3 rev0.12 at 400 kHz
[ 0.461987] omap_i2c 4807c000.i2c: bus 4 rev0.12 at 400 kHz
[ 0.462139] media: Linux media interface: v0.10
[ 0.462175] Linux video capture interface: v2.00
[ 0.462249] pps_core: LinuxPPS API ver. 1 registered
[ 0.462257] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[ 0.462276] PTP clock support registered
[ 0.462302] EDAC MC: Ver: 3.0.0
[ 0.462539] dmi: Firmware registration failed.
[ 0.462904] omap-mailbox 48840000.mailbox: omap mailbox rev 0x400
[ 0.463191] omap-mailbox 48842000.mailbox: omap mailbox rev 0x400
[ 0.463473] Advanced Linux Sound Architecture Driver Initialized.
[ 0.464438] clocksource: Switched to clocksource arch_sys_counter
[ 0.472001] NET: Registered protocol family 2
[ 0.472519] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.472583] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.472709] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.472776] UDP hash table entries: 512 (order: 2, 16384 bytes)
[ 0.472809] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[ 0.472931] NET: Registered protocol family 1
[ 0.473243] RPC: Registered named UNIX socket transport module.
[ 0.473253] RPC: Registered udp transport module.
[ 0.473261] RPC: Registered tcp transport module.
[ 0.473269] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.473279] PCI: CLS 0 bytes, default 64
[ 0.474123] hw perfevents: no interrupt-affinity property for /pmu, guessing.
[ 0.474298] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
[ 0.475289] workingset: timestamp_bits=14 max_order=19 bucket_order=5
[ 0.479274] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.479762] NFS: Registering the id_resolver key type
[ 0.479784] Key type id_resolver registered
[ 0.479793] Key type id_legacy registered
[ 0.479831] ntfs: driver 2.1.32 [Flags: R/O].
[ 0.481089] bounce: pool size: 64 pages
[ 0.481134] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[ 0.481146] io scheduler noop registered
[ 0.481155] io scheduler deadline registered
[ 0.481303] io scheduler cfq registered (default)
[ 0.481312] io scheduler mq-deadline registered
[ 0.481321] io scheduler kyber registered
[ 0.485916] pinctrl-single 4a003400.pinmux: 282 pins at pa fc003400 size 1128
[ 0.532831] Serial: 8250/16550 driver, 10 ports, IRQ sharing disabled
[ 0.535399] 48020000.serial: ttyS2 at MMIO 0x48020000 (irq = 43, base_baud = 3000000) is a 8250
[ 1.608929] console [ttyS2] enabled
[ 1.613210] 48066000.serial: ttyS4 at MMIO 0x48066000 (irq = 44, base_baud = 3000000) is a 8250
[ 1.623673] omap_rng 48090000.rng: Random Number Generator ver. 20
[ 1.630785] omapdss_dss 58000000.dss: master bind failed: -517
[ 1.645639] brd: module loaded
[ 1.654038] loop: module loaded
[ 1.660130] mdio_bus fixed-0: GPIO lookup for consumer reset
[ 1.665847] mdio_bus fixed-0: using lookup tables for GPIO lookup
[ 1.671971] mdio_bus fixed-0: lookup for GPIO reset failed
[ 1.677519] libphy: Fixed MDIO Bus: probed
[ 1.683969] mdio_bus 48485000.mdio: GPIO lookup for consumer reset
[ 1.690219] mdio_bus 48485000.mdio: using device tree for GPIO lookup
[ 1.696713] of_get_named_gpiod_flags: can't parse 'reset-gpios' property of node '/ocp/ethernet@48484000/mdio@48485000[0]'
[ 1.707827] of_get_named_gpiod_flags: can't parse 'reset-gpio' property of node '/ocp/ethernet@48484000/mdio@48485000[0]'
[ 1.718847] mdio_bus 48485000.mdio: using lookup tables for GPIO lookup
[ 1.725507] mdio_bus 48485000.mdio: lookup for GPIO reset failed
[ 1.784468] davinci_mdio 48485000.mdio: davinci mdio revision 1.6, bus freq 1000000
[ 1.792162] libphy: 48485000.mdio: probed
[ 1.798423] davinci_mdio 48485000.mdio: phy[1]: device 48485000.mdio:01, driver Micrel KSZ9031 Gigabit PHY
[ 1.808645] cpsw 48484000.ethernet: Detected MACID = a8:10:87:78:56:76
[ 1.815282] cpsw 48484000.ethernet: initialized cpsw ale version 1.4
[ 1.821666] cpsw 48484000.ethernet: ALE Table size 1024
[ 1.826944] cpsw 48484000.ethernet: device node lookup for pps timer failed
[ 1.833974] cpsw 48484000.ethernet: cpts: overflow check period 500 (jiffies)
[ 1.842348] i2c /dev entries driver
[ 1.846577] IR NEC protocol handler initialized
[ 1.851126] IR RC5(x/sz) protocol handler initialized
[ 1.856221] IR RC6 protocol handler initialized
[ 1.860772] IR JVC protocol handler initialized
[ 1.865340] IR Sony protocol handler initialized
[ 1.869978] IR SANYO protocol handler initialized
[ 1.874721] IR Sharp protocol handler initialized
[ 1.879446] IR MCE Keyboard/mouse protocol handler initialized
[ 1.885320] IR XMP protocol handler initialized
[ 1.893631] sdhci: Secure Digital Host Controller Interface driver
[ 1.900287] sdhci: Copyright(c) Pierre Ossman
[ 1.905134] sdhci-pltfm: SDHCI platform and OF driver helper
[ 1.911473] sdhci-omap 4809c000.mmc: GPIO lookup for consumer cd
[ 1.917533] sdhci-omap 4809c000.mmc: using device tree for GPIO lookup
[ 1.924096] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]'
[ 1.933285] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]'
[ 1.942386] sdhci-omap 4809c000.mmc: using lookup tables for GPIO lookup
[ 1.949132] sdhci-omap 4809c000.mmc: lookup for GPIO cd failed
[ 1.955007] sdhci-omap 4809c000.mmc: GPIO lookup for consumer wp
[ 1.961041] sdhci-omap 4809c000.mmc: using device tree for GPIO lookup
[ 1.967614] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]'
[ 1.976803] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]'
[ 1.985901] sdhci-omap 4809c000.mmc: using lookup tables for GPIO lookup
[ 1.992632] sdhci-omap 4809c000.mmc: lookup for GPIO wp failed
[ 1.998650] sdhci-omap 4809c000.mmc: 4809c000.mmc supply vqmmc not found, using dummy regulator
[ 2.007983] sdhci-omap 480b4000.mmc: GPIO lookup for consumer cd
[ 2.014017] sdhci-omap 480b4000.mmc: using device tree for GPIO lookup
[ 2.020602] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]'
[ 2.029794] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@480b4000[0]'
[ 2.038899] sdhci-omap 480b4000.mmc: using lookup tables for GPIO lookup
[ 2.045661] sdhci-omap 480b4000.mmc: lookup for GPIO cd failed
[ 2.051524] sdhci-omap 480b4000.mmc: GPIO lookup for consumer wp
[ 2.057574] sdhci-omap 480b4000.mmc: using device tree for GPIO lookup
[ 2.064132] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]'
[ 2.073324] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480b4000[0]'
[ 2.082486] sdhci-omap 480b4000.mmc: using lookup tables for GPIO lookup
[ 2.089235] sdhci-omap 480b4000.mmc: lookup for GPIO wp failed
[ 2.095201] sdhci-omap 480b4000.mmc: 480b4000.mmc supply vqmmc not found, using dummy regulator
[ 2.104358] sdhci-omap 480ad000.mmc: GPIO lookup for consumer wp
[ 2.110417] sdhci-omap 480ad000.mmc: using device tree for GPIO lookup
[ 2.116996] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480ad000[0]'
[ 2.126190] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480ad000[0]'
[ 2.135297] sdhci-omap 480ad000.mmc: using lookup tables for GPIO lookup
[ 2.142029] sdhci-omap 480ad000.mmc: lookup for GPIO wp failed
[ 2.147997] sdhci-omap 480ad000.mmc: 480ad000.mmc supply vqmmc not found, using dummy regulator
[ 2.157310] of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/led@0[0]' - status (0)
[ 2.166427] no flags found for gpios
[ 2.170125] of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/led@1[0]' - status (0)
[ 2.179236] no flags found for gpios
[ 2.183241] ledtrig-cpu: registered to indicate activity on CPUs
[ 2.192945] NET: Registered protocol family 10
[ 2.198220] Segment Routing with IPv6
[ 2.201950] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 2.208343] NET: Registered protocol family 17
[ 2.212962] Key type dns_resolver registered
[ 2.217387] omap_voltage_late_init: Voltage driver support not added
[ 2.223768] Power Management for TI OMAP4+ devices.
[ 2.228933] Registering SWP/SWPB emulation handler
[ 2.245727] dmm 4e000000.dmm: workaround for errata i878 in use
[ 2.253291] dmm 4e000000.dmm: initialized all PAT entries
[ 2.260018] palmas 0-0058: Irq flag is 0x00000008
[ 2.296016] palmas 0-0058: Muxing GPIO 2d, PWM 0, LED 0
[ 2.302885] SMPS12: supplied by regulator-dummy
[ 2.309301] SMPS3: supplied by regulator-dummy
[ 2.315612] SMPS45: supplied by regulator-dummy
[ 2.322139] SMPS6: supplied by regulator-dummy
[ 2.327000] smps6: Bringing 1060000uV into 1030000-1030000uV
[ 2.334610] SMPS7: supplied by regulator-dummy
[ 2.340620] SMPS8: supplied by regulator-dummy
[ 2.346466] SMPS9: supplied by regulator-dummy
[ 2.351369] random: fast init done
[ 2.355101] LDO1: supplied by regulator-dummy
[ 2.361468] LDO2: supplied by regulator-dummy
[ 2.367681] LDO3: supplied by regulator-dummy
[ 2.373902] LDO4: supplied by regulator-dummy
[ 2.380122] LDO5: supplied by regulator-dummy
[ 2.385270] LDO6: supplied by regulator-dummy
[ 2.390377] LDO7: supplied by regulator-dummy
[ 2.396432] LDO8: supplied by regulator-dummy
[ 2.401583] LDO9: supplied by regulator-dummy
[ 2.407954] LDOLN: supplied by regulator-dummy
[ 2.414247] LDOUSB: supplied by regulator-dummy
[ 2.423511] at24 0-0050: 4096 byte 24c32 EEPROM, writable, 32 bytes/write
[ 2.430557] omap_i2c 48070000.i2c: bus 0 rev0.12 at 400 kHz
[ 2.437583] DSS: OMAP DSS rev 6.1
[ 2.441327] omapdss_dss 58000000.dss: bound 58001000.dispc (ops dispc_component_ops)
[ 2.451122] sdhci-omap 4809c000.mmc: GPIO lookup for consumer cd
[ 2.457189] sdhci-omap 4809c000.mmc: using device tree for GPIO lookup
[ 2.463752] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]'
[ 2.472947] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]'
[ 2.482051] sdhci-omap 4809c000.mmc: using lookup tables for GPIO lookup
[ 2.488800] sdhci-omap 4809c000.mmc: lookup for GPIO cd failed
[ 2.494679] sdhci-omap 4809c000.mmc: GPIO lookup for consumer wp
[ 2.500714] sdhci-omap 4809c000.mmc: using device tree for GPIO lookup
[ 2.507293] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]'
[ 2.516486] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]'
[ 2.525587] sdhci-omap 4809c000.mmc: using lookup tables for GPIO lookup
[ 2.532318] sdhci-omap 4809c000.mmc: lookup for GPIO wp failed
[ 2.538362] sdhci-omap 4809c000.mmc: 4809c000.mmc supply vqmmc not found, using dummy regulator
[ 2.548621] sdhci-omap 4809c000.mmc: no pinctrl state for sdr104 mode
[ 2.555126] sdhci-omap 4809c000.mmc: no pinctrl state for ddr50 mode
[ 2.561514] sdhci-omap 4809c000.mmc: no pinctrl state for sdr50 mode
[ 2.567916] sdhci-omap 4809c000.mmc: no pinctrl state for sdr25 mode
[ 2.574302] sdhci-omap 4809c000.mmc: no pinctrl state for sdr12 mode
[ 2.580706] sdhci-omap 4809c000.mmc: no pinctrl state for ddr_1_8v mode
[ 2.587375] sdhci-omap 4809c000.mmc: no pinctrl state for hs mode
[ 2.593500] sdhci-omap 4809c000.mmc: no pinctrl state for hs mode
[ 2.599641] sdhci-omap 4809c000.mmc: no pinctrl state for hs200_1_8v mode
[ 2.664471] mmc0: SDHCI controller on 4809c000.mmc [4809c000.mmc] using ADMA
[ 2.672047] sdhci-omap 480b4000.mmc: GPIO lookup for consumer cd
[ 2.678104] sdhci-omap 480b4000.mmc: using device tree for GPIO lookup
[ 2.684681] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]'
[ 2.693856] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@480b4000[0]'
[ 2.702956] sdhci-omap 480b4000.mmc: using lookup tables for GPIO lookup
[ 2.709701] sdhci-omap 480b4000.mmc: lookup for GPIO cd failed
[ 2.715577] sdhci-omap 480b4000.mmc: GPIO lookup for consumer wp
[ 2.721612] sdhci-omap 480b4000.mmc: using device tree for GPIO lookup
[ 2.728184] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]'
[ 2.737374] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480b4000[0]'
[ 2.746472] sdhci-omap 480b4000.mmc: using lookup tables for GPIO lookup
[ 2.753204] sdhci-omap 480b4000.mmc: lookup for GPIO wp failed
[ 2.759207] sdhci-omap 480b4000.mmc: 480b4000.mmc supply vqmmc not found, using dummy regulator
[ 2.768192] vdd_3v3: supplied by regen1
[ 2.824465] mmc1: SDHCI controller on 480b4000.mmc [480b4000.mmc] using ADMA
[ 2.831929] sdhci-omap 480ad000.mmc: GPIO lookup for consumer wp
[ 2.837989] sdhci-omap 480ad000.mmc: using device tree for GPIO lookup
[ 2.844590] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480ad000[0]'
[ 2.853797] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480ad000[0]'
[ 2.862930] sdhci-omap 480ad000.mmc: using lookup tables for GPIO lookup
[ 2.869710] sdhci-omap 480ad000.mmc: lookup for GPIO wp failed
[ 2.875747] sdhci-omap 480ad000.mmc: 480ad000.mmc supply vqmmc not found, using dummy regulator
[ 2.892629] mmc0: host does not support reading read-only switch, assuming write-enable
[ 2.903956] mmc0: new SDHC card at address aaaa
[ 2.908726] mmcblk0: mmc0:aaaa SC16G 14.8 GiB
[ 2.917272] mmcblk0: p1 p2
[ 2.942121] mmc1: new DDR MMC card at address 0001
[ 2.946962] mmc2: SDHCI controller on 480ad000.mmc [480ad000.mmc] using PIO
[ 2.947552] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 2.947555] [drm] No driver support for vblank timestamp query.
[ 2.948081] [drm] Initialized omapdrm 1.0.0 20110917 for omapdrm.0 on minor 0
[ 2.948438] hctosys: unable to open rtc device (rtc0)
[ 2.948979] aic_dvdd_fixed: supplied by vdd_3v3
[ 2.949044] vtt_fixed: supplied by smps3
[ 2.968791] aic_dvdd_fixed: disabling
[ 2.985593] ldousb: disabling
[ 2.996322] ALSA device list:
[ 2.999318] No soundcards found.
[ 3.003237] mmcblk1: mmc1:0001 Q2J55L 7.09 GiB
[ 3.007984] mmcblk1boot0: mmc1:0001 Q2J55L partition 1 16.0 MiB
[ 3.014178] mmcblk1boot1: mmc1:0001 Q2J55L partition 2 16.0 MiB
[ 3.020273] mmcblk1rpmb: mmc1:0001 Q2J55L partition 3 4.00 MiB
[ 3.029013] mmcblk1: p1 p2
[ 3.053346] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 3.061543] VFS: Mounted root (ext4 filesystem) on device 179:2.
[ 3.070572] mmc2: new high speed SDIO card at address 0001
[ 3.077388] devtmpfs: mounted
[ 3.081442] Freeing unused kernel memory: 2048K
[ 3.677191] systemd[1]: System time before build time, advancing clock.
[ 3.757810] systemd[1]: systemd 234 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN2 -IDN default-hierarchy=hybrid)
[ 3.779240] systemd[1]: Detected architecture arm.
[ 3.817423] systemd[1]: Set hostname to <am57xx-evm>.
[ 4.256292] random: systemd: uninitialized urandom read (16 bytes read)
[ 4.263101] systemd[1]: Listening on Journal Socket.
[ 4.294905] random: systemd: uninitialized urandom read (16 bytes read)
[ 4.301613] systemd[1]: Reached target Swap.
[ 4.334666] random: systemd: uninitialized urandom read (16 bytes read)
[ 4.341378] systemd[1]: Listening on Network Service Netlink Socket.
[ 4.374772] systemd[1]: Reached target Remote File Systems.
[ 4.404649] systemd[1]: Listening on udev Control Socket.
[ 4.436837] systemd[1]: Created slice System Slice.
[ 4.485046] systemd[1]: Starting Load Kernel Modules...
[ 4.544212] cmemk: loading out-of-tree module taints kernel.
[ 4.551063] CMEMK module: reference Linux version 4.14.40
[ 4.557244] allocated heap buffer 0x40500000 of size 0x100000
[ 4.563052] cmemk initialized
[ 4.588272] cryptodev: disagrees about version of symbol crypto_alloc_aead
[ 4.595248] cryptodev: Unknown symbol crypto_alloc_aead (err -22)
[ 4.601384] cryptodev: disagrees about version of symbol crypto_aead_setauthsize
[ 4.608849] cryptodev: Unknown symbol crypto_aead_setauthsize (err -22)
[ 4.615637] cryptodev: disagrees about version of symbol crypto_aead_setkey
[ 4.622647] cryptodev: Unknown symbol crypto_aead_setkey (err -22)
[ 4.629054] cryptodev: disagrees about version of symbol crypto_alloc_skcipher
[ 4.636354] cryptodev: Unknown symbol crypto_alloc_skcipher (err -22)
[ 4.718724] usbcore: registered new interface driver usbfs
[ 4.726187] usbcore: registered new interface driver hub
[ 4.731581] usbcore: registered new device driver usb
[ 4.745704] usbcore: registered new interface driver usbserial
[ 4.771870] usbcore: registered new interface driver ftdi_sio
[ 4.777746] usbserial: USB Serial support registered for FTDI USB Serial Device
[ 4.802700] uio_module_drv: disagrees about version of symbol _dev_info
[ 4.809374] uio_module_drv: Unknown symbol _dev_info (err -22)
[ 4.815264] uio_module_drv: disagrees about version of symbol dev_err
[ 4.821733] uio_module_drv: Unknown symbol dev_err (err -22)
[ 4.827484] uio_module_drv: disagrees about version of symbol kobject_uevent
[ 4.834585] uio_module_drv: Unknown symbol kobject_uevent (err -22)
[ 5.014302] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 5.947654] systemd-journald[92]: Received request to flush runtime journal from PID 1
[ 6.271476] omap-rproc 58820000.ipu: assigned reserved memory node ipu1-memory@9d000000
[ 6.320189] remoteproc remoteproc0: 58820000.ipu is available
[ 6.371578] omap-rproc 55020000.ipu: assigned reserved memory node ipu2-memory@95800000
[ 6.403953] remoteproc remoteproc1: 55020000.ipu is available
[ 6.415945] omap-rproc 40800000.dsp: assigned reserved memory node dsp1-memory@99000000
[ 6.452120] remoteproc remoteproc2: 40800000.dsp is available
[ 6.515906] omap-rproc 41000000.dsp: assigned reserved memory node dsp2-memory@9f000000
[ 6.540479] remoteproc remoteproc3: 41000000.dsp is available
[ 6.665816] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: GPIO lookup for consumer id
[ 6.674232] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: using device tree for GPIO lookup
[ 6.684511] of_get_named_gpiod_flags: can't parse 'id-gpios' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]'
[ 6.696243] of_get_named_gpiod_flags: can't parse 'id-gpio' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]'
[ 6.707947] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: using lookup tables for GPIO lookup

[ 6.833614] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: lookup for GPIO id failed
[ 6.842491] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: GPIO lookup for consumer vbus
[ 6.851627] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: using device tree for GPIO lookup
[ 6.861113] of_get_named_gpiod_flags: can't parse 'vbus-gpios' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]'
[ 6.873077] of_get_named_gpiod_flags: parsed 'vbus-gpio' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]' - status (0)

[ 7.148359] omap_rtc 48838000.rtc: char device (253:0)
[ 7.154286] omap_rtc 48838000.rtc: registered as rtc0
[ 7.165314] rtc rtc1: 48070000.i2c:tps659038@58:tps659038_rtc: dev (253:1)
[ 7.174466] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659038@58:tps659038_rtc as rtc1
[ 7.856339] remoteproc remoteproc1: powering up 55020000.ipu
[ 7.862032] remoteproc remoteproc1: Booting fw image dra7-ipu2-fw.xem4, size 3743076
[ 7.869966] omap-iommu 55082000.mmu: 55082000.mmu: version 2.1
[ 7.923276] virtio_rpmsg_bus virtio0: rpmsg host is online
[ 7.928867] remoteproc remoteproc1: registered virtio0 (type 7)
[ 7.931423] virtio_rpmsg_bus virtio0: creating channel rpmsg-rpc addr 0x65
[ 7.932302] virtio_rpmsg_bus virtio0: creating channel rpmsg-rpc addr 0x66
[ 7.950049] remoteproc remoteproc1: remote processor 55020000.ipu is now up
[ 8.230044] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[ 8.431539] omap-aes 4b500000.aes: OMAP AES hw accel rev: 3.3
[ 8.437523] omap-aes 4b500000.aes: will run requests pump with realtime priority
[ 8.447940] omap-aes 4b700000.aes: OMAP AES hw accel rev: 3.3
[ 8.453871] omap-aes 4b700000.aes: will run requests pump with realtime priority
[ 8.924351] remoteproc remoteproc0: powering up 58820000.ipu
[ 8.930077] remoteproc remoteproc0: Booting fw image dra7-ipu1-fw.xem4, size 6636332
[ 8.938334] omap-iommu 58882000.mmu: 58882000.mmu: version 2.1
[ 8.962788] virtio_rpmsg_bus virtio1: rpmsg host is online
[ 8.969418] remoteproc remoteproc0: registered virtio1 (type 7)
[ 8.979634] remoteproc remoteproc0: remote processor 58820000.ipu is now up
[ 9.059982] omap-des 480a5000.des: OMAP DES hw accel rev: 2.2
[ 9.066019] omap-des 480a5000.des: will run requests pump with realtime priority
[ 9.080758] omap-sham 4b101000.sham: hw accel on OMAP rev 4.3
[ 9.088673] vpe 489d0000.vpe: loading firmware vpdma-1b8.bin
[ 9.091206] virtio_rpmsg_bus virtio1: creating channel rpmsg-proto addr 0x3d
[ 9.224634] vpe 489d0000.vpe: Device registered as /dev/video0
[ 10.705903] SCSI subsystem initialized
[ 11.437295] remoteproc remoteproc3: powering up 41000000.dsp
[ 11.443172] remoteproc remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 20323956
[ 11.458010] omap_hwmod: mmu0_dsp2: _wait_target_disable failed
[ 11.463903] omap-iommu 41501000.mmu: 41501000.mmu: version 3.0
[ 11.469829] omap-iommu 41502000.mmu: 41502000.mmu: version 3.0
[ 11.486465] virtio_rpmsg_bus virtio2: rpmsg host is online
[ 11.489287] virtio_rpmsg_bus virtio2: creating channel rpmsg-proto addr 0x3d
[ 11.499931] remoteproc remoteproc3: registered virtio2 (type 7)
[ 11.506023] remoteproc remoteproc3: remote processor 41000000.dsp is now up
[ 11.876210] remoteproc remoteproc2: powering up 40800000.dsp
[ 11.882409] udc-core: couldn't find an available UDC - added [g_ether] to list of pending drivers
[ 11.892081] remoteproc remoteproc2: Booting fw image dra7-dsp1-fw.xe66, size 20323956
[ 11.906982] omap_hwmod: mmu0_dsp1: _wait_target_disable failed
[ 11.912872] omap-iommu 40d01000.mmu: 40d01000.mmu: version 3.0
[ 11.918784] omap-iommu 40d02000.mmu: 40d02000.mmu: version 3.0
[ 11.937423] virtio_rpmsg_bus virtio3: rpmsg host is online
[ 11.940180] virtio_rpmsg_bus virtio3: creating channel rpmsg-proto addr 0x3d
[ 11.950326] remoteproc remoteproc2: registered virtio3 (type 7)
[ 11.959250] remoteproc remoteproc2: remote processor 40800000.dsp is now up
[ 12.035271] libata version 3.00 loaded.
[ 12.044153] vip 48990000.vip: loading firmware vpdma-1b8.bin
[ 12.074506] vip 48990000.vip: VPDMA firmware loaded
[ 12.079588] vip2-s0: Port A: Using subdev ar0135 4-0010 for capture
[ 12.107265] vip2-s0: device registered as video1
[ 12.121079] vip2-s1: Port A: Using subdev ar0135 3-0010 for capture
[ 12.132825] ahci 4a140000.sata: SSS flag set, parallel bus scan disabled
[ 12.132847] ahci 4a140000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode
[ 12.132855] ahci 4a140000.sata: flags: 64bit ncq sntf stag pm led clo only pmp pio slum part ccc apst
[ 12.224350] vip2-s1: device registered as video2
[ 12.239744] scsi host0: ahci
[ 12.243150] ata1: SATA max UDMA/133 mmio [mem 0x4a140000-0x4a1410ff] port 0x100 irq 81
[ 12.476061] net eth0: initializing cpsw version 1.15 (0)
[ 12.587315] random: crng init done
[ 12.591173] random: 7 urandom warning(s) missed due to ratelimiting
[ 12.594597] ata1: SATA link down (SStatus 0 SControl 300)
[ 12.659715] Micrel KSZ9031 Gigabit PHY 48485000.mdio:01: attached PHY driver [Micrel KSZ9031 Gigabit PHY] (mii_bus:phy_addr=48485000.mdio:01, irq=POLL)
[ 12.665923] cpts ptp bc clkid 0
[ 12.670598] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 13.108106] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
[ 13.744101] pvrsrvkm: disagrees about version of symbol dev_err
[ 13.757205] pvrsrvkm: Unknown symbol dev_err (err -22)
[ 13.979036] mwifiex_sdio mmc2:0001:1: info: FW download over, size 256188 bytes
[ 13.996842] pruss 4b200000.pruss: creating PRU cores and other child platform devices
[ 13.998928] pruss 4b280000.pruss: creating PRU cores and other child platform devices
[ 14.041774] rpmsg_rpc virtio0.rpmsg-rpc.-1.101: probing service dce-callback with src 1024 dst 101
[ 14.042283] rpmsg_rpc virtio0.rpmsg-rpc.-1.102: probing service rpmsg-dce with src 1025 dst 102
[ 14.096476] NET: Registered protocol family 44
[ 14.098534] remoteproc remoteproc4: 4b234000.pru is available
[ 14.098579] pru-rproc 4b234000.pru: PRU rproc node /ocp/pruss_soc_bus@4b226004/pruss@0/pru@34000 probed successfully
[ 14.098839] remoteproc remoteproc5: 4b238000.pru is available
[ 14.098875] pru-rproc 4b238000.pru: PRU rproc node /ocp/pruss_soc_bus@4b226004/pruss@0/pru@38000 probed successfully
[ 14.099139] remoteproc remoteproc6: 4b2b4000.pru is available
[ 14.099184] pru-rproc 4b2b4000.pru: PRU rproc node /ocp/pruss_soc_bus@4b2a6004/pruss@0/pru@34000 probed successfully
[ 14.099432] remoteproc remoteproc7: 4b2b8000.pru is available
[ 14.099468] pru-rproc 4b2b8000.pru: PRU rproc node /ocp/pruss_soc_bus@4b2a6004/pruss@0/pru@38000 probed successfully
[ 14.232243] rpmsg_rpc virtio0.rpmsg-rpc.-1.101: published functions = 4
[ 14.247386] rpmsg_rpc virtio0.rpmsg-rpc.-1.102: published functions = 9
[ 14.255708] mwifiex_sdio mmc2:0001:1: WLAN FW is active
[ 14.273762] dwc3 488d0000.usb: changing max_speed on rev 5533202a
[ 14.332180] using random self ethernet address
[ 14.337112] using random host ethernet address
[ 14.343533] usb0: HOST MAC 8e:5d:c7:b4:56:a7
[ 14.350273] usb0: MAC 52:01:ba:b6:1b:17
[ 14.355915] using random self ethernet address
[ 14.363014] using random host ethernet address
[ 14.368531] g_ether gadget: Ethernet Gadget, version: Memorial Day 2008
[ 14.376397] g_ether gadget: g_ether ready
[ 14.425176] IPv6: ADDRCONF(NETDEV_UP): usb0: link is not ready
[ 14.488882] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[ 14.494413] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
[ 14.505374] xhci-hcd xhci-hcd.0.auto: hcc params 0x0220f04c hci version 0x100 quirks 0x02010010
[ 14.514405] xhci-hcd xhci-hcd.0.auto: irq 171, io mem 0x48890000
[ 14.523098] hub 1-0:1.0: USB hub found
[ 14.529623] hub 1-0:1.0: 1 port detected
[ 14.534069] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[ 14.541670] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
[ 14.550658] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[ 14.560202] hub 2-0:1.0: USB hub found
[ 14.564202] hub 2-0:1.0: 1 port detected
[ 16.209579] pvrsrvkm: disagrees about version of symbol dev_err
[ 16.215786] pvrsrvkm: Unknown symbol dev_err (err -22)
[ 22.241820] omap_hwmod: mmu0_dsp2: _wait_target_disable failed
[ 22.255903] omap_hwmod: mmu0_dsp1: _wait_target_disable failed
[ 24.794450] mwifiex_sdio mmc2:0001:1: mwifiex_cmd_timeout_func: Timeout cmd id = 0xa9, act = 0x0
[ 24.803292] mwifiex_sdio mmc2:0001:1: num_data_h2c_failure = 0
[ 24.809168] mwifiex_sdio mmc2:0001:1: num_cmd_h2c_failure = 0
[ 24.814947] mwifiex_sdio mmc2:0001:1: is_cmd_timedout = 1
[ 24.820376] mwifiex_sdio mmc2:0001:1: num_tx_timeout = 0
[ 24.825718] mwifiex_sdio mmc2:0001:1: last_cmd_index = 1
[ 24.831071] mwifiex_sdio mmc2:0001:1: last_cmd_id: 00 00 a9 00 00 00 00 00 00 00
[ 24.838513] mwifiex_sdio mmc2:0001:1: last_cmd_act: 00 00 00 00 00 00 00 00 00 00
[ 24.846040] mwifiex_sdio mmc2:0001:1: last_cmd_resp_index = 0
[ 24.851824] mwifiex_sdio mmc2:0001:1: last_cmd_resp_id: 00 00 00 00 00 00 00 00 00 00
[ 24.859700] mwifiex_sdio mmc2:0001:1: last_event_index = 0
[ 24.865222] mwifiex_sdio mmc2:0001:1: last_event: 00 00 00 00 00 00 00 00 00 00
[ 24.872575] mwifiex_sdio mmc2:0001:1: data_sent=1 cmd_sent=1
[ 24.878272] mwifiex_sdio mmc2:0001:1: ps_mode=0 ps_state=0

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

looks like the probe process of the Marvell mwifiex driver probe does not go through completely... After the "WLAN FW is active" message you should hit this section of code in drivers/net/wireless/marvell/mwifiex/main.c...

	mwifiex_drv_get_driver_version(adapter, fmt, sizeof(fmt) - 1);
	mwifiex_dbg(adapter, MSG, "driver_version = %s\n", fmt);

But there is no related print in the log you shared. So there could be either an issue with the firmware itself or with the communication with the firmware.

Can you see if using updated firmware available at https://git.kernel.org/pub/scm/linux/kernel/git/firmware/linux-firmware.git/tree/mrvl helps?

If not, can you see if you can narrow down where the problem occurs by adding extra prints to the _mwifiex_fw_dpc() function in the Kernel?

Regard, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

Thanks for your suggestions. I tried the updated firmware, and this made no difference.

I have also tried a couple of different SDK versions, and I have found that if I go back to SDK 03.02.00.05 (kernel 4.4.32 / November 2016), the WiFi module works. Unfortunately it doesn't work with SDK 5 or 6, and going back to SDK 3 isn't really an option for us. So it used to work, but something must have changed that has broken it.

In terms of adding extra print statements, what I have found is that it reaches this code in mwifiex_init_fw():

ret = mwifiex_sta_init_cmd(adapter->priv[i],
first_sta, true);

and the return value is -1.

This is caused by a failed call to mwifiex_send_cmd(). I haven't traced it further than that.

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

that's good detective work and also thanks for trying the other SDKs. There seems to be some fundamental issue possibly related to the new MMC host driver in the newer Kernels. There's actually a what looks like very related support thread here of a very early failure with mwifiex on an AM57x device on newer Kernels, can you please also have a look as well: https://e2e.ti.com/support/processors/f/791/t/861857

As for mwifiex_send_cmd(), can you trace a bit more to see which part fails?

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

mwifiex_send_cmd() runs all the way through to the call of mwifiex_wait_queue_complete() at the bottom of the function.

mwifiex_wait_queue_complete() calls wait_event_interruptible_timeout(), and then there's a time gap of about 10.5 seconds.

Then we get the error message:

mwifiex_cmd_timeout_func: Timeout cmd id = 0xa9, act = 0x0

The exit from mwifiex_wait_queue_complete() is the normal exit at the bottom of the function.

Hope this is helpful.

Regards Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

please keep tracking the other E2E thread for now referenced earlier, I believe this is all the same root cause, but do let me know if you feel your case is significantly different.

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

Given that it worked with a previous generation driver (omap_hsmmc), is it possible for me to use the older driver with this part, but using a newer kernel version, and keeping the newer driver for other peripherals (eMMC etc)? How would I set that up in the device tree?

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Bob,

Bob Engineer 2 said:
Given that it worked with a previous generation driver (omap_hsmmc), is it possible for me to use the older driver with this part, but using a newer kernel version, and keeping the newer driver for other peripherals (eMMC etc)

Great idea and this is actually exactly what was attempted in the other related thread I referred to (https://e2e.ti.com/support/processors/f/791/t/861857) however this did not solve the probe issue. There may well be an issue with some other part of the framework, an interaction that is now different between the framework and the MMC driver, or some general (mis-) configuration issue I think. I'm going to dig into this some more to see if I find any specific aspects worth examining further but there are limits in terms of what I can do especially without hardware and the amount of time I can dedicate to this. One "easy" but labor-some way however would be to bi-sect the Kernel tree to see when things broke. I'd probably start around the Kernel commit when the MMC driver was switched to see if this specific event really broke it, or something else that happened in time before or after that.

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

I think the other thread is almost certainly the same issue, although the failures seem to happen at different points, which is a bit odd. I had a go at using the omap_hsmmc driver with my 4.19 build, as it seems this driver is still part of the kernel driver set. I haven't tried a back-port like the other thread did.

However in trying to use the omap_hsmmc driver, I wasn't convinced I had the device tree part of it right. Presumably I set the driver by using a "compatible" setting in the mmc part of the tree. What's the correct "compatible" string for this? Also what other settings do I need, e.g. DMA settings?

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

Bob Engineer 2 said:
I had a go at using the omap_hsmmc driver with my 4.19 build, as it seems this driver is still part of the kernel driver set. I haven't tried a back-port like the other thread did.

I also noticed the driver is still there...

Bob Engineer 2 said:
However in trying to use the omap_hsmmc driver, I wasn't convinced I had the device tree part of it right. Presumably I set the driver by using a "compatible" setting in the mmc part of the tree. What's the correct "compatible" string for this? Also what other settings do I need, e.g. DMA settings?

Please have another look at the other E2E thread, I just pointed out a specific commit there:

ARM: dts: dra7: Use sdhci-omap programming model
https://git.ti.com/cgit/processor-sdk/processor-sdk-linux/commit/?h=processor-sdk-linux-4.19.y&id=940293affa7ed7c0bdb1820ecf7a8f12e901d030

See if you can revert this commit, specifically what it does to arch/arm/boot/dts/dra7.dtsi. It shows you what the compatible string needs (ti,omap4-hsmmc) and what else to update (re-introduce the DMA setup, and remove the sdhci-caps-mask that was added). Then, double-check your generated .config contains CONFIG_MMC_OMAP_HS.

Also can you provide a working boot log from your experiments with Kernel 4.4.32?

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

Thanks for that. I have tried using the omap_hsmmc driver in kernel 4.19, with the device tree settings from the commit you suggested. I am sure you're not surprised to hear that this didn't work, but I think was worth a go anyway. For reference, here are the relevant failing lines from dmesg:

[ 12.429273] mwifiex_sdio mmc0:0001:1: poll card status failed, tries = 100
[ 12.429279] mwifiex_sdio mmc0:0001:1: FW download with helper: poll status timeout @ 0
[ 12.429285] mwifiex_sdio mmc0:0001:1: prog_fw failed ret=0xffffffff
[ 12.429295] mwifiex_sdio mmc0:0001:1: info: _mwifiex_fw_dpc: unregister device

You also asked for the boot log from kernel 4.4 (SDK 3). Here it is. You can see the wifi coming up between [ 12.661144] and [ 13.216495]

[ 0.000000] Booting Linux on physical CPU 0x0

[ 0.000000] Initializing cgroup subsys cpuset

[ 0.000000] Initializing cgroup subsys cpu

[ 0.000000] Initializing cgroup subsys cpuacct

[ 0.000000] Linux version 4.4.32-gadde2ca9f8 () (gcc version 5.3.1 20160113 (Linaro GCC 5.3-2016.02) ) #1 SMP PREEMPT Wed Dec 4 08:51:06 AWST 2019

[ 0.000000] CPU: ARMv7 Processor [412fc0f2] revision 2 (ARMv7), cr=30c5387d

[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache

[ 0.000000] Machine model: NTLX ROMI

[ 0.000000] Reserved memory: created CMA memory pool at 0x0000000095800000, size 56 MiB

[ 0.000000] Reserved memory: initialized node ipu2-memory@95800000, compatible id shared-dma-pool

[ 0.000000] Reserved memory: created CMA memory pool at 0x0000000099000000, size 64 MiB

[ 0.000000] Reserved memory: initialized node dsp1-memory@99000000, compatible id shared-dma-pool

[ 0.000000] Reserved memory: created CMA memory pool at 0x000000009d000000, size 32 MiB

[ 0.000000] Reserved memory: initialized node ipu1-memory@9d000000, compatible id shared-dma-pool

[ 0.000000] Reserved memory: created CMA memory pool at 0x000000009f000000, size 8 MiB

[ 0.000000] Reserved memory: initialized node dsp2-memory@9f000000, compatible id shared-dma-pool

[ 0.000000] cma: Reserved 24 MiB at 0x00000000fe400000

[ 0.000000] Forcing write-allocate cache policy for SMP

[ 0.000000] Memory policy: Data cache writealloc

[ 0.000000] OMAP4: Map 0x00000000ffd00000 to fe600000 for dram barrier

[ 0.000000] On node 0 totalpages: 474368

[ 0.000000] free_area_init_node: node 0, pgdat c0979800, node_mem_map eeda2000

[ 0.000000] DMA zone: 1728 pages used for memmap

[ 0.000000] DMA zone: 0 pages reserved

[ 0.000000] DMA zone: 147456 pages, LIFO batch:31

[ 0.000000] HighMem zone: 326912 pages, LIFO batch:31

[ 0.000000] DRA752 ES2.0

[ 0.000000] PERCPU: Embedded 11 pages/cpu @eed33000 s14848 r8192 d22016 u45056

[ 0.000000] pcpu-alloc: s14848 r8192 d22016 u45056 alloc=11*4096

[ 0.000000] pcpu-alloc: [0] 0 [0] 1

[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 472640

[ 0.000000] Kernel command line: console=ttyO2,115200n8 root=PARTUUID=0005d4f8-02 rw rootfstype=ext4 rootwait

[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)

[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)

[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)

[ 0.000000] Memory: 1680656K/1897472K available (6579K kernel code, 360K rwdata, 2404K rodata, 332K init, 289K bss, 28400K reserved, 188416K cma-reserved, 1283072K highmem)

[ 0.000000] Virtual kernel memory layout:

vector : 0xffff0000 - 0xffff1000 ( 4 kB)

fixmap : 0xffc00000 - 0xfff00000 (3072 kB)

vmalloc : 0xf0800000 - 0xff800000 ( 240 MB)

lowmem : 0xc0000000 - 0xf0000000 ( 768 MB)

pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)

modules : 0xbf000000 - 0xbfe00000 ( 14 MB)

.text : 0xc0008000 - 0xc08ce044 (8985 kB)

.init : 0xc08cf000 - 0xc0922000 ( 332 kB)

.data : 0xc0922000 - 0xc097c2f0 ( 361 kB)

.bss : 0xc097e000 - 0xc09c66c0 ( 290 kB)

[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1

[ 0.000000] Preemptible hierarchical RCU implementation.

[ 0.000000] Build-time adjustment of leaf fanout to 32.

[ 0.000000] NR_IRQS:16 nr_irqs:16 16

[ 0.000000] ti_dt_clocks_register: failed to lookup clock node gmac_gmii_ref_clk_div

[ 0.000000] OMAP clockevent source: timer1 at 32786 Hz

[ 0.000000] Architected cp15 timer(s) running at 6.14MHz (phys).

[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x16af5adb9, max_idle_ns: 440795202250 ns

[ 0.000005] sched_clock: 56 bits at 6MHz, resolution 162ns, wraps every 4398046511023ns

[ 0.000016] Switching to timer-based delay loop, resolution 162ns

[ 0.000336] clocksource: 32k_counter: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 58327039986419 ns

[ 0.000344] OMAP clocksource: 32k_counter at 32768 Hz

[ 0.000739] Console: colour dummy device 80x30

[ 0.000754] WARNING: Your 'console=ttyO2' has been replaced by 'ttyS2'

[ 0.000760] This ensures that you still see kernel messages. Please

[ 0.000766] update your kernel commandline.

[ 0.000779] Calibrating delay loop (skipped), value calculated using timer frequency.. 12.29 BogoMIPS (lpj=61475)

[ 0.000791] pid_max: default: 32768 minimum: 301

[ 0.000883] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)

[ 0.000892] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)

[ 0.001423] Initializing cgroup subsys io

[ 0.001440] Initializing cgroup subsys memory

[ 0.001463] Initializing cgroup subsys devices

[ 0.001475] Initializing cgroup subsys freezer

[ 0.001486] Initializing cgroup subsys perf_event

[ 0.001497] Initializing cgroup subsys pids

[ 0.001521] CPU: Testing write buffer coherency: ok

[ 0.001716] /cpus/cpu@0 missing clock-frequency property

[ 0.001733] /cpus/cpu@1 missing clock-frequency property

[ 0.001742] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000

[ 0.001777] Setting up static identity map for 0x800082c0 - 0x80008318

[ 0.080073] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001

[ 0.080136] Brought up 2 CPUs

[ 0.080149] SMP: Total of 2 processors activated (24.59 BogoMIPS).

[ 0.080156] CPU: All CPU(s) started in HYP mode.

[ 0.080161] CPU: Virtualization extensions available.

[ 0.080531] devtmpfs: initialized

[ 0.107161] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0

[ 0.108110] omap_hwmod: l3_main_2 using broken dt data from ocp

[ 0.310686] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns

[ 0.314595] pinctrl core: initialized pinctrl subsystem

[ 0.315426] NET: Registered protocol family 16

[ 0.316327] DMA: preallocated 256 KiB pool for atomic coherent allocations

[ 0.340306] cpuidle: using governor ladder

[ 0.370328] cpuidle: using governor menu

[ 0.377976] gpiochip_add: registered GPIOs 0 to 31 on device: gpio

[ 0.378526] OMAP GPIO hardware version 0.1

[ 0.379201] gpiochip_add: registered GPIOs 32 to 63 on device: gpio

[ 0.380107] gpiochip_add: registered GPIOs 64 to 95 on device: gpio

[ 0.380991] gpiochip_add: registered GPIOs 96 to 127 on device: gpio

[ 0.381868] gpiochip_add: registered GPIOs 128 to 159 on device: gpio

[ 0.382733] gpiochip_add: registered GPIOs 160 to 191 on device: gpio

[ 0.383604] gpiochip_add: registered GPIOs 192 to 223 on device: gpio

[ 0.384469] gpiochip_add: registered GPIOs 224 to 255 on device: gpio

[ 0.385095] irq: no irq domain found for /ocp/l4@4a000000/scm@2000/pinmux@1400 !

[ 0.385504] irq: no irq domain found for /ocp/l4@4a000000/scm@2000/pinmux@1400 !

[ 0.404412] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.

[ 0.404422] hw-breakpoint: maximum watchpoint size is 8 bytes.

[ 0.404876] omap4_sram_init:Unable to allocate sram needed to handle errata I688

[ 0.404885] omap4_sram_init:Unable to get sram pool needed to handle errata I688

[ 0.405441] OMAP DMA hardware revision 0.0

[ 0.451176] omap-dma-engine 4a056000.dma-controller: OMAP DMA engine driver (LinkedList1/2/3 supported)

[ 0.452213] edma 43300000.edma: memcpy is disabled

[ 0.456878] edma 43300000.edma: TI EDMA DMA engine driver

[ 0.457229] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/fixedregulator-vdd_3v3[0]'

[ 0.457447] of_get_named_gpiod_flags: can't parse 'gpio' property of node '/fixedregulator-aic_dvdd[0]'

[ 0.457684] of_get_named_gpiod_flags: parsed 'gpio' property of node '/fixedregulator-vtt[0]' - status (0)

[ 0.459714] ------------[ cut here ]------------

[ 0.459730] WARNING: CPU: 0 PID: 1 at drivers/iommu/omap-iommu.c:1634 omap_iommu_add_device+0xf8/0x148()

[ 0.459736] Modules linked in:

[ 0.459750] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.4.32-gadde2ca9f8 #1

[ 0.459757] Hardware name: Generic DRA74X (Flattened Device Tree)

[ 0.459763] Backtrace:

[ 0.459789] [<c00130e4>] (dump_backtrace) from [<c00132e0>] (show_stack+0x18/0x1c)

[ 0.459797] r7:c03821e4 r6:60000013 r5:00000000 r4:c094edcc

[ 0.459825] [<c00132c8>] (show_stack) from [<c02b420c>] (dump_stack+0x8c/0xa0)

[ 0.459841] [<c02b4180>] (dump_stack) from [<c00349c4>] (warn_slowpath_common+0x88/0xb8)

[ 0.459848] r7:c03821e4 r6:00000662 r5:00000009 r4:00000000

[ 0.459874] [<c003493c>] (warn_slowpath_common) from [<c0034a98>] (warn_slowpath_null+0x24/0x2c)

[ 0.459880] r8:c0849cdc r7:ffffffea r6:eed86320 r5:eeaf1240 r4:00000000

[ 0.459908] [<c0034a74>] (warn_slowpath_null) from [<c03821e4>] (omap_iommu_add_device+0xf8/0x148)

[ 0.459919] [<c03820ec>] (omap_iommu_add_device) from [<c03801cc>] (add_iommu_group+0x34/0x60)

[ 0.459925] r10:00000000 r9:c08cf600 r8:000000a8 r7:00000000 r6:c0380198 r5:c06c07ec

[ 0.459947] r4:eea48810

[ 0.459962] [<c0380198>] (add_iommu_group) from [<c03e97f8>] (bus_for_each_dev+0x70/0xa4)

[ 0.459967] r5:ee88de94 r4:00000000

[ 0.459983] [<c03e9788>] (bus_for_each_dev) from [<c0380940>] (bus_set_iommu+0xa4/0xe0)

[ 0.459989] r6:eeaf1200 r5:00000000 r4:c095f710

[ 0.460009] [<c038089c>] (bus_set_iommu) from [<c08f4b18>] (omap_iommu_init+0x7c/0xa0)

[ 0.460014] r7:eeaf1200 r6:c0927720 r5:c08f4a9c r4:c0927720

[ 0.460036] [<c08f4a9c>] (omap_iommu_init) from [<c000978c>] (do_one_initcall+0x98/0x1e4)

[ 0.460047] [<c00096f4>] (do_one_initcall) from [<c08cff68>] (kernel_init_freeable+0x1d4/0x268)

[ 0.460053] r10:00000005 r9:c08cf600 r8:000000a8 r7:c090f82c r6:c091d1ac r5:c097e000

[ 0.460073] r4:c097e000

[ 0.460089] [<c08cfd94>] (kernel_init_freeable) from [<c066deac>] (kernel_init+0x18/0xf4)

[ 0.460095] r10:00000000 r9:00000000 r8:00000000 r7:00000000 r6:00000000 r5:c066de94

[ 0.460115] r4:c097e000

[ 0.460129] [<c066de94>] (kernel_init) from [<c000fac8>] (ret_from_fork+0x14/0x2c)

[ 0.460135] r5:c066de94 r4:00000000

[ 0.460156] ---[ end trace 29519f68c65aeecf ]---

[ 0.462559] omap_i2c 48070000.i2c: could not find pctldev for node /ocp/l4@4a000000/scm@2000/pinmux@1400/i2c1_pins_default, deferring probe

[ 0.462951] omap_i2c 4807a000.i2c: bus 3 rev0.12 at 400 kHz

[ 0.463321] omap_i2c 4807c000.i2c: bus 4 rev0.12 at 400 kHz

[ 0.463468] media: Linux media interface: v0.10

[ 0.463524] Linux video capture interface: v2.00

[ 0.463565] pps_core: LinuxPPS API ver. 1 registered

[ 0.463596] PTP clock support registered

[ 0.463645] EDAC MC: Ver: 3.0.0

[ 0.464363] Advanced Linux Sound Architecture Driver Initialized.

[ 0.465162] clocksource: Switched to clocksource arch_sys_counter

[ 0.475526] NET: Registered protocol family 2

[ 0.476018] TCP established hash table entries: 8192 (order: 3, 32768 bytes)

[ 0.476087] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)

[ 0.476211] TCP: Hash tables configured (established 8192 bind 8192)

[ 0.476261] UDP hash table entries: 512 (order: 2, 16384 bytes)

[ 0.476291] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)

[ 0.476499] NET: Registered protocol family 1

[ 0.476735] RPC: Registered named UNIX socket transport module.

[ 0.476743] RPC: Registered udp transport module.

[ 0.476750] RPC: Registered tcp transport module.

[ 0.476756] RPC: Registered tcp NFSv4.1 backchannel transport module.

[ 0.476770] PCI: CLS 0 bytes, default 64

[ 0.477647] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available

[ 0.479887] futex hash table entries: 512 (order: 3, 32768 bytes)

[ 0.487483] squashfs: version 4.0 (2009/01/31) Phillip Lougher

[ 0.488119] NFS: Registering the id_resolver key type

[ 0.488147] Key type id_resolver registered

[ 0.488155] Key type id_legacy registered

[ 0.488216] ntfs: driver 2.1.32 [Flags: R/O].

[ 0.490146] bounce: pool size: 64 pages

[ 0.490294] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)

[ 0.490310] io scheduler noop registered

[ 0.490324] io scheduler deadline registered

[ 0.490358] io scheduler cfq registered (default)

[ 0.494647] pinctrl-single 4a003400.pinmux: 282 pins at pa fc003400 size 1128

[ 0.554476] Serial: 8250/16550 driver, 10 ports, IRQ sharing disabled

[ 0.557849] 48020000.serial: ttyS2 at MMIO 0x48020000 (irq = 299, base_baud = 3000000) is a 8250

[ 1.577758] console [ttyS2] enabled

[ 1.582145] 48066000.serial: ttyS4 at MMIO 0x48066000 (irq = 300, base_baud = 3000000) is a 8250

[ 1.592010] [drm] Initialized drm 1.1.0 20060810

[ 1.597579] omapdss_dss 58000000.dss: master bind failed: -517

[ 1.610829] loop: module loaded

[ 1.616889] libphy: Fixed MDIO Bus: probed

[ 1.665197] davinci_mdio 48485000.mdio: davinci mdio revision 1.6

[ 1.671322] libphy: 48485000.mdio: probed

[ 1.677596] davinci_mdio 48485000.mdio: phy[1]: device 48485000.mdio:01, driver Micrel KSZ9031 Gigabit PHY

[ 1.687765] cpsw 48484000.ethernet: Detected MACID = a8:10:87:78:56:76

[ 1.694414] cpsw 48484000.ethernet: cpts: overflow check period 800

[ 1.702248] mousedev: PS/2 mouse device common for all mice

[ 1.708291] i2c /dev entries driver

[ 1.715747] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer cd

[ 1.715760] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup

[ 1.715771] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]'

[ 1.715780] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]'

[ 1.715789] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup

[ 1.715798] omap_hsmmc 4809c000.mmc: lookup for GPIO cd failed

[ 1.715809] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer wp

[ 1.715817] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup

[ 1.715826] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]'

[ 1.715834] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]'

[ 1.715842] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup

[ 1.715850] omap_hsmmc 4809c000.mmc: lookup for GPIO wp failed

[ 1.716024] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr104 mode

[ 1.722495] omap_hsmmc 4809c000.mmc: no pinctrl state for ddr50 mode

[ 1.728914] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr50 mode

[ 1.735314] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr25 mode

[ 1.741696] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr12 mode

[ 1.748091] omap_hsmmc 4809c000.mmc: no pinctrl state for hs mode

[ 1.775744] omap_hsmmc 480b4000.mmc: GPIO lookup for consumer cd

[ 1.775755] omap_hsmmc 480b4000.mmc: using device tree for GPIO lookup

[ 1.775765] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]'

[ 1.775774] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@480b4000[0]'

[ 1.775782] omap_hsmmc 480b4000.mmc: using lookup tables for GPIO lookup

[ 1.775791] omap_hsmmc 480b4000.mmc: lookup for GPIO cd failed

[ 1.775801] omap_hsmmc 480b4000.mmc: GPIO lookup for consumer wp

[ 1.775809] omap_hsmmc 480b4000.mmc: using device tree for GPIO lookup

[ 1.775818] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]'

[ 1.775826] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480b4000[0]'

[ 1.775833] omap_hsmmc 480b4000.mmc: using lookup tables for GPIO lookup

[ 1.775841] omap_hsmmc 480b4000.mmc: lookup for GPIO wp failed

[ 1.776007] omap_hsmmc 480b4000.mmc: no pinctrl state for sdr25 mode

[ 1.782392] omap_hsmmc 480b4000.mmc: no pinctrl state for sdr12 mode

[ 1.788815] omap_hsmmc 480b4000.mmc: no pinctrl state for ddr_1_8v mode

[ 1.825405] omap_hsmmc 480ad000.mmc: GPIO lookup for consumer wp

[ 1.825415] omap_hsmmc 480ad000.mmc: using device tree for GPIO lookup

[ 1.825425] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480ad000[0]'

[ 1.825434] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480ad000[0]'

[ 1.825441] omap_hsmmc 480ad000.mmc: using lookup tables for GPIO lookup

[ 1.825449] omap_hsmmc 480ad000.mmc: lookup for GPIO wp failed

[ 1.855634] of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/led@0[0]' - status (0)

[ 1.855767] of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/led@1[0]' - status (0)

[ 1.856188] ledtrig-cpu: registered to indicate activity on CPUs

[ 1.865136] NET: Registered protocol family 10

[ 1.870366] sit: IPv6 over IPv4 tunneling driver

[ 1.875577] NET: Registered protocol family 17

[ 1.880230] Key type dns_resolver registered

[ 1.884628] omap_voltage_late_init: Voltage driver support not added

[ 1.891568] Adding alias for supply vdd,cpu0 -> vdd,4a003b20.oppdm

[ 1.897797] Adding alias for supply vbb,cpu0 -> vbb,4a003b20.oppdm

[ 1.904015] cpu0 supply vdd not found, using dummy regulator

[ 1.909954] Adding alias for supply vdd,cpu0 -> vdd,4a003b20.oppdm

[ 1.916204] Adding alias for supply vbb,cpu0 -> vbb,4a003b20.oppdm

[ 1.922422] cpu0 supply vdd not found, using dummy regulator

[ 1.928645] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 1.939307] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 1.949892] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 1.957144] Power Management for TI OMAP4+ devices.

[ 1.962293] Registering SWP/SWPB emulation handler

[ 1.969760] dmm 4e000000.dmm: initialized all PAT entries

[ 1.976508] palmas 0-0058: Irq flag is 0x00000008

[ 1.996705] palmas 0-0058: Muxing GPIO 2d, PWM 0, LED 0

[ 2.028049] at24 0-0050: 4096 byte 24c32 EEPROM, writable, 32 bytes/write

[ 2.035035] omap_i2c 48070000.i2c: bus 0 rev0.12 at 400 kHz

[ 2.042284] OMAP DSS rev 6.1

[ 2.046064] omapdss_dss 58000000.dss: bound 58001000.dispc (ops dispc_component_ops)

[ 2.054235] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer cd

[ 2.054246] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup

[ 2.054257] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@4809c000[0]'

[ 2.054266] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@4809c000[0]'

[ 2.054274] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup

[ 2.054283] omap_hsmmc 4809c000.mmc: lookup for GPIO cd failed

[ 2.054293] omap_hsmmc 4809c000.mmc: GPIO lookup for consumer wp

[ 2.054301] omap_hsmmc 4809c000.mmc: using device tree for GPIO lookup

[ 2.054310] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@4809c000[0]'

[ 2.054318] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@4809c000[0]'

[ 2.054325] omap_hsmmc 4809c000.mmc: using lookup tables for GPIO lookup

[ 2.054333] omap_hsmmc 4809c000.mmc: lookup for GPIO wp failed

[ 2.054493] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr104 mode

[ 2.060984] omap_hsmmc 4809c000.mmc: no pinctrl state for ddr50 mode

[ 2.067380] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr50 mode

[ 2.073762] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr25 mode

[ 2.080156] omap_hsmmc 4809c000.mmc: no pinctrl state for sdr12 mode

[ 2.086550] omap_hsmmc 4809c000.mmc: no pinctrl state for hs mode

[ 2.125608] omap_hsmmc 480b4000.mmc: GPIO lookup for consumer cd

[ 2.125618] omap_hsmmc 480b4000.mmc: using device tree for GPIO lookup

[ 2.125629] of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/ocp/mmc@480b4000[0]'

[ 2.125638] of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/ocp/mmc@480b4000[0]'

[ 2.125646] omap_hsmmc 480b4000.mmc: using lookup tables for GPIO lookup

[ 2.125654] omap_hsmmc 480b4000.mmc: lookup for GPIO cd failed

[ 2.125664] omap_hsmmc 480b4000.mmc: GPIO lookup for consumer wp

[ 2.125671] omap_hsmmc 480b4000.mmc: using device tree for GPIO lookup

[ 2.125679] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480b4000[0]'

[ 2.125688] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480b4000[0]'

[ 2.125695] omap_hsmmc 480b4000.mmc: using lookup tables for GPIO lookup

[ 2.125703] omap_hsmmc 480b4000.mmc: lookup for GPIO wp failed

[ 2.125854] omap_hsmmc 480b4000.mmc: no pinctrl state for sdr25 mode

[ 2.132237] omap_hsmmc 480b4000.mmc: no pinctrl state for sdr12 mode

[ 2.138632] omap_hsmmc 480b4000.mmc: no pinctrl state for ddr_1_8v mode

[ 2.145445] vdd_3v3: supplied by regen1

[ 2.155211] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 2.165816] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 2.178430] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 2.185591] omap_hsmmc 480ad000.mmc: GPIO lookup for consumer wp

[ 2.185601] omap_hsmmc 480ad000.mmc: using device tree for GPIO lookup

[ 2.185610] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/ocp/mmc@480ad000[0]'

[ 2.185620] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/ocp/mmc@480ad000[0]'

[ 2.185628] omap_hsmmc 480ad000.mmc: using lookup tables for GPIO lookup

[ 2.185636] omap_hsmmc 480ad000.mmc: lookup for GPIO wp failed

[ 2.227246] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).

[ 2.233892] [drm] No driver support for vblank timestamp query.

[ 2.240501] [drm] Initialized omapdrm 1.0.0 20110917 on minor 0

[ 2.246963] hctosys: unable to open rtc device (rtc0)

[ 2.261426] mmc0: host does not support reading read-only switch, assuming write-enable

[ 2.264565] aic_dvdd_fixed: disabling

[ 2.273293] mmc0: new SDHC card at address aaaa

[ 2.277892] ldousb: disabling

[ 2.281379] ALSA device list:

[ 2.284361] No soundcards found.

[ 2.288481] mmcblk0: mmc0:aaaa SC16G 14.8 GiB

[ 2.297354] mmcblk0: p1 p2

[ 2.333730] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)

[ 2.341903] mmc1: MAN_BKOPS_EN bit is not set

[ 2.341941] VFS: Mounted root (ext4 filesystem) on device 179:2.

[ 2.355198] mmc1: new high speed MMC card at address 0001

[ 2.363279] devtmpfs: mounted

[ 2.366470] Freeing unused kernel memory: 332K (c08cf000 - c0922000)

[ 2.372897] This architecture does not have kernel memory protection.

[ 2.372923] mmcblk1: mmc1:0001 Q2J55L 7.09 GiB

[ 2.383214] mmcblk1boot0: mmc1:0001 Q2J55L partition 1 16.0 MiB

[ 2.393464] mmcblk1boot1: mmc1:0001 Q2J55L partition 2 16.0 MiB

[ 2.402923] mmcblk1: p1 p2

[ 2.442033] mmc2: new high speed SDIO card at address 0001

[ 2.535221] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 2.546040] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 2.556762] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 2.887321] systemd[1]: System time before build time, advancing clock.

[ 2.960335] random: systemd: uninitialized urandom read (16 bytes read, 17 bits of entropy available)

[ 2.975525] random: systemd: uninitialized urandom read (16 bytes read, 17 bits of entropy available)

[ 2.987197] systemd[1]: systemd 229 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN)

[ 3.005717] systemd[1]: Detected architecture arm.

[ 3.048647] systemd[1]: Set hostname to <am57xx-evm>.

[ 3.135222] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 3.145841] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 3.145846] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 3.194266] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 19 bits of entropy available)

[ 3.204591] random: systemd-gpt-aut: uninitialized urandom read (16 bytes read, 19 bits of entropy available)

[ 3.215807] random: systemd-gpt-aut: uninitialized urandom read (16 bytes read, 19 bits of entropy available)

[ 3.234083] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 19 bits of entropy available)

[ 3.257669] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 20 bits of entropy available)

[ 3.375345] random: systemd: uninitialized urandom read (16 bytes read, 23 bits of entropy available)

[ 3.384846] random: systemd: uninitialized urandom read (16 bytes read, 23 bits of entropy available)

[ 3.394816] random: systemd: uninitialized urandom read (16 bytes read, 23 bits of entropy available)

[ 3.435229] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 3.445842] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 3.456426] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 3.933328] systemd[1]: alignment.service: Found ordering cycle on alignment.service/start

[ 3.941702] systemd[1]: alignment.service: Found dependency on sysinit.target/start

[ 3.949492] systemd[1]: alignment.service: Found dependency on alignment.service/start

[ 3.957762] systemd[1]: alignment.service: Breaking ordering cycle by deleting job alignment.service/start

[ 3.967486] systemd[1]: alignment.service: Job alignment.service/start deleted to break ordering cycle starting with alignment.service/start

[ 4.008046] systemd[1]: Reached target Remote File Systems.

[ 4.035224] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 4.045845] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 4.056385] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 4.056660] systemd[1]: Listening on Journal Socket.

[ 4.085595] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.

[ 4.115474] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.

[ 4.145368] systemd[1]: Reached target Swap.

[ 4.165491] systemd[1]: Listening on udev Control Socket.

[ 4.196833] systemd[1]: Created slice User and Session Slice.

[ 4.225465] systemd[1]: Listening on Syslog Socket.

[ 4.245425] systemd[1]: Listening on udev Kernel Socket.

[ 4.307695] systemd[1]: Listening on Network Service Netlink Socket.

[ 4.335218] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 4.345829] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 4.346146] systemd[1]: Listening on Journal Socket (/dev/log).

[ 4.362330] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 4.386096] systemd[1]: Created slice System Slice.

[ 4.455411] systemd[1]: Mounting Temporary Directory...

[ 4.507797] systemd[1]: Starting Load Kernel Modules...

[ 4.526364] CMEMK module: reference Linux version 4.4.32

[ 4.532350] allocated heap buffer 0x40500000 of size 0x100000

[ 4.539309] systemd[1]: Created slice system-getty.slice.

[ 4.545209] cmemk initialized

[ 4.570468] cryptodev: driver 1.8 loaded.

[ 4.595483] systemd[1]: Mounting Debug File System...

[ 4.617935] systemd[1]: Starting Remount Root and Kernel File Systems...

[ 4.635245] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 4.649608] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)

[ 4.651414] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 4.651419] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 4.673490] systemd[1]: Created slice system-serial\x2dgetty.slice.

[ 4.745649] systemd[1]: Starting Create list of required static device nodes for the current kernel...

[ 4.777839] systemd[1]: Starting Setup Virtual Console...

[ 4.805445] systemd[1]: Reached target Slices.

[ 4.827891] systemd[1]: Mounting POSIX Message Queue File System...

[ 4.857823] systemd[1]: Starting Journal Service...

[ 4.885639] systemd[1]: Started Forward Password Requests to Wall Directory Watch.

[ 4.915445] systemd[1]: Reached target Paths.

[ 4.935222] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 4.945827] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 4.956338] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 5.015464] systemd[1]: Mounted POSIX Message Queue File System.

[ 5.045510] systemd[1]: Mounted Debug File System.

[ 5.065534] systemd[1]: Mounted Temporary Directory.

[ 5.095655] systemd[1]: Started Journal Service.

[ 5.235226] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 5.245832] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 5.257537] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 5.535226] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 5.545929] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 5.558936] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 5.792406] systemd-journald[140]: Received request to flush runtime journal from PID 1

[ 5.835221] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 5.855558] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 5.874719] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 6.135267] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 6.155726] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 6.177899] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 6.407137] omap-rproc 58820000.ipu: assigned reserved memory node ipu1-memory@9d000000

[ 6.435245] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 6.470071] remoteproc0: 58820000.ipu is available

[ 6.478885] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 6.502571] remoteproc0: Note: remoteproc is still under development and considered experimental.

[ 6.514291] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 6.523424] remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.

[ 6.537273] omap-rproc 55020000.ipu: assigned reserved memory node ipu2-memory@95800000

[ 6.592595] remoteproc1: 55020000.ipu is available

[ 6.603651] remoteproc1: Note: remoteproc is still under development and considered experimental.

[ 6.661098] remoteproc1: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.

[ 6.696231] omap-rproc 40800000.dsp: assigned reserved memory node dsp1-memory@99000000

[ 6.724137] remoteproc2: 40800000.dsp is available

[ 6.735246] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 6.761742] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 6.777323] remoteproc2: Note: remoteproc is still under development and considered experimental.

[ 6.798566] rtc rtc1: 48070000.i2c:tps659: dev (254:1)

[ 6.798583] palmas-rtc 48070000.i2c:tps659038@58:tps659038_rtc: rtc core: registered 48070000.i2c:tps659 as rtc1

[ 6.806896] remoteproc2: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.

[ 6.807316] omap-rproc 41000000.dsp: assigned reserved memory node dsp2-memory@9f000000

[ 6.807371] remoteproc3: 41000000.dsp is available

[ 6.807375] remoteproc3: Note: remoteproc is still under development and considered experimental.

[ 6.807378] remoteproc3: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.

[ 6.811233] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 6.834206] omap_rng 48090000.rng: OMAP Random Number Generator ver. 20

[ 7.035246] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 7.046883] omap-des 480a5000.des: OMAP DES hw accel rev: 2.2

[ 7.053549] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: GPIO lookup for consumer id

[ 7.053562] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: using device tree for GPIO lookup

[ 7.053575] of_get_named_gpiod_flags: can't parse 'id-gpios' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]'

[ 7.053585] of_get_named_gpiod_flags: can't parse 'id-gpio' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]'

[ 7.053594] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: using lookup tables for GPIO lookup

[ 7.053604] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: lookup for GPIO id failed

[ 7.053614] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: GPIO lookup for consumer vbus

[ 7.053623] palmas-usb 48070000.i2c:tps659038@58:tps659038_usb: using device tree for GPIO lookup

[ 7.053632] of_get_named_gpiod_flags: can't parse 'vbus-gpios' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]'

[ 7.053703] of_get_named_gpiod_flags: parsed 'vbus-gpio' property of node '/ocp/i2c@48070000/tps659038@58/tps659038_usb[0]' - status (0)

[ 7.062476] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 7.073282] alg: skcipher: setkey failed on test 5 for ecb-des-omap: flags=100

[ 7.080428] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 7.093092] alg: skcipher-ddst: setkey failed on test 5 for ecb-des-omap: flags=100

[ 7.104398] alg: skcipher-ddst: setkey failed on test 5 for ecb-des-omap: flags=100

[ 7.121070] rtc rtc2: 48838000.rtc: dev (254:2)

[ 7.121087] omap_rtc 48838000.rtc: rtc core: registered 48838000.rtc as rtc2

[ 7.230730] remoteproc0: registered virtio0 (type 7)

[ 7.330246] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec

[ 7.335252] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 7.335267] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 7.335272] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 7.382346] omap-sham 4b101000.sham: hw accel on OMAP rev 4.3

[ 7.635217] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 7.655865] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 7.666466] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 7.771574] remoteproc1: registered virtio1 (type 7)

[ 7.861960] SCSI subsystem initialized

[ 7.935223] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 7.946045] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 7.957808] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 8.207014] libata version 3.00 loaded.

[ 8.235216] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 8.255206] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 8.265822] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 8.535240] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 8.555204] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 8.565796] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 8.835263] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 8.855848] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 8.866590] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 9.135229] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 9.155972] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 9.166590] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 9.435247] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 9.446116] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 9.462569] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 9.542903] mwifiex: rx work enabled, cpus 2

[ 9.735247] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 9.755237] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 9.782314] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 9.800155] omap-aes 4b500000.aes: OMAP AES hw accel rev: 3.3

[ 10.035244] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 10.055854] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 10.066458] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 10.335232] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 10.345839] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 10.363865] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 10.635249] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 10.648618] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 10.661659] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 10.935222] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 10.946006] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 10.956625] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 11.235299] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 11.252270] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 11.275424] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 11.528473] omap-aes 4b700000.aes: OMAP AES hw accel rev: 3.3

[ 11.535284] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 11.545398] vpe 489d0000.vpe: loading firmware vpdma-1b8.bin

[ 11.561232] [drm] Initialized pvr 1.14.3699939 20110701 on minor 1

[ 11.570958] ahci 4a140000.sata: SSS flag set, parallel bus scan disabled

[ 11.580079] ahci 4a140000.sata: AHCI 0001.0300 32 slots 1 ports 3 Gbps 0x1 impl platform mode

[ 11.595051] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 11.619417] ahci 4a140000.sata: flags: 64bit ncq sntf stag pm led clo only pmp pio slum part ccc apst

[ 11.632221] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 11.665582] scsi host0: ahci

[ 11.668933] ata1: SATA max UDMA/133 mmio [mem 0x4a140000-0x4a1410ff] port 0x100 irq 326

[ 11.835245] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 11.846368] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 11.865374] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 12.035239] ata1: SATA link down (SStatus 0 SControl 300)

[ 12.096009] random: nonblocking pool is initialized

[ 12.135220] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 12.145992] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 12.163120] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 12.196854] vpe 489d0000.vpe: Device registered as /dev/video0

[ 12.435250] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 12.452896] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 12.470309] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 12.661144] mwifiex_sdio mmc2:0001:1: info: FW download over, size 256188 bytes

[ 12.735226] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 12.746123] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 12.757019] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 12.885528] mwifiex_sdio mmc2:0001:1: WLAN FW is active

[ 12.911402] remoteproc2: registered virtio2 (type 7)

[ 12.916750] remoteproc3: registered virtio3 (type 7)

[ 12.937683] remoteproc0: powering up 58820000.ipu

[ 13.004238] remoteproc0: Booting fw image dra7-ipu1-fw.xem4, size 4890352

[ 13.014327] omap-rproc 58820000.ipu: can't alloc iommu domain

[ 13.020775] remoteproc0: can't enable iommu: -12

[ 13.025719] mwifiex_sdio mmc2:0001:1: info: MWIFIEX VERSION: mwifiex 1.0 (14.68.36.p139)

[ 13.027182] remoteproc0: rproc_boot() failed -12

[ 13.033973] virtio_rpmsg_bus: probe of virtio0 failed with error -12

[ 13.038811] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 13.038825] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 13.038829] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 13.066350] remoteproc1: powering up 55020000.ipu

[ 13.071275] remoteproc1: Booting fw image dra7-ipu2-fw.xem4, size 3743072

[ 13.071284] omap-rproc 55020000.ipu: can't alloc iommu domain

[ 13.071288] remoteproc1: can't enable iommu: -12

[ 13.085863] remoteproc1: rproc_boot() failed -12

[ 13.096614] virtio_rpmsg_bus: probe of virtio1 failed with error -12

[ 13.106827] remoteproc2: powering up 40800000.dsp

[ 13.140350] remoteproc2: Booting fw image dra7-dsp1-fw.xe66, size 21998880

[ 13.152004] omap-rproc 40800000.dsp: can't alloc iommu domain

[ 13.164829] remoteproc2: can't enable iommu: -12

[ 13.177385] remoteproc2: rproc_boot() failed -12

[ 13.184942] virtio_rpmsg_bus: probe of virtio2 failed with error -12

[ 13.200553] remoteproc3: powering up 41000000.dsp

[ 13.216495] mwifiex_sdio mmc2:0001:1: driver_version = mwifiex 1.0 (14.68.36.p139)

[ 13.250355] remoteproc3: Booting fw image dra7-dsp2-fw.xe66, size 21998880

[ 13.257438] omap-rproc 41000000.dsp: can't alloc iommu domain

[ 13.263311] remoteproc3: can't enable iommu: -12

[ 13.283587] remoteproc3: rproc_boot() failed -12

[ 13.299462] virtio_rpmsg_bus: probe of virtio3 failed with error -12

[ 13.324339] cfg80211: World regulatory domain updated:

[ 13.335261] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 13.346482] cfg80211: DFS Master region: unset

[ 13.350864] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)

[ 13.365142] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 13.405554] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)

[ 13.420456] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 13.441507] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)

[ 13.465602] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)

[ 13.473652] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)

[ 13.503226] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)

[ 13.515516] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)

[ 13.523649] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)

[ 13.551323] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)

[ 13.635236] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 13.654939] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 13.696530] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 13.787334] NET: Registered protocol family 15

[ 13.870304] net eth0: initializing cpsw version 1.15 (0)

[ 13.886820] net eth0: initialized cpsw ale version 1.4

[ 13.895071] net eth0: ALE Table size 1024

[ 13.907879] usbcore: registered new interface driver usbfs

[ 13.920719] usbcore: registered new interface driver hub

[ 13.935056] usbcore: registered new device driver usb

[ 13.936065] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 13.936080] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 13.936085] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 13.973130] Bluetooth: Core ver 2.21

[ 13.983371] NET: Registered protocol family 31

[ 13.994484] Bluetooth: HCI device and connection manager initialized

[ 14.008795] net eth0: phy found : id is : 0x221622

[ 14.009533] Bluetooth: HCI socket layer initialized

[ 14.009544] Bluetooth: L2CAP socket layer initialized

[ 14.009583] Bluetooth: SCO socket layer initialized

[ 14.069458] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller

[ 14.069754] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready

[ 14.092227] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1

[ 14.118667] Initializing XFRM netlink socket

[ 14.127125] xhci-hcd xhci-hcd.0.auto: hcc params 0x0220f04c hci version 0x100 quirks 0x00010010

[ 14.155288] xhci-hcd xhci-hcd.0.auto: irq 412, io mem 0x48890000

[ 14.184998] hub 1-0:1.0: USB hub found

[ 14.194980] hub 1-0:1.0: 1 port detected

[ 14.207395] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller

[ 14.224475] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2

[ 14.235227] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 14.251675] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 14.251893] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.

[ 14.257303] hub 2-0:1.0: USB hub found

[ 14.257342] hub 2-0:1.0: 1 port detected

[ 14.330219] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 14.535252] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 14.562037] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 14.592841] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 14.835255] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 14.835269] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 14.835274] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 15.135229] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 15.153918] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 15.176353] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 15.435234] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 15.453276] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 15.479229] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 15.663232] PVR_K: UM DDK-(3699939) and KM DDK-(3699939) match. [ OK ]

[ 15.735248] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 15.746459] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 15.757309] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 16.035233] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 16.045923] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 16.056818] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 16.335237] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 16.345975] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 16.356774] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 16.635222] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 16.645913] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 16.661989] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 16.935231] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 16.955275] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 16.976029] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 17.235237] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 17.255282] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 17.273744] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 17.535216] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 17.555271] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 17.565865] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 17.835216] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 17.845830] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 17.859251] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 18.135215] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 18.155192] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 18.165825] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 18.435210] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 18.446093] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 18.459642] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 18.735215] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 18.745830] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 18.758898] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 19.035226] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 19.045921] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 19.057171] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 19.345214] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 19.355820] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 19.368922] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 20.235234] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 20.245865] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 20.259163] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 23.835240] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1083000uV(ref=1160000uV)[min 885000uV max 1500000uV]:-22

[ 23.853080] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 23.867188] cpufreq: __target_index: Failed to change cpu frequency: -22

[ 24.135234] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1189000uV(ref=1210000uV)[min 950000uV max 1500000uV]:-22

[ 24.146811] ti_oppdm 4a003b20.oppdm: vdd failed for voltage 1070000uV(ref=1060000uV)[min 850000uV max 1500000uV]:-22

[ 24.160048] cpufreq: __target_index: Failed to change cpu frequency: -22

Best regards,

Bob.

0 Bob Engineer 2 over 6 years ago in reply to Bob Engineer 2

Intellectual 530 points

Hi Andreas,

Further update to the above - it looks like I am now having more success in getting the UBlox device running, using omap_hsmmc. I will get back to you in the next couple of day to confirm whether or not this is a solution, but it's looking possible at the moment. Fingers crossed.

Thanks for your support on this.

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

thanks for the updates and the signs of progress. When using omap_hsmmc, did you re-introduce DMA channel references into &mmc2 in the device tree as it was there with older Kernels? As per comment on the related thread DMA for MMC3/MMC4 HW modules (a.k.a. mmc2/mmc3 in Linux) using sdhci-omap is not supported in current Kernels, and although PIO mode should work there may still be something amiss related to that.

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

We are using mmc3, so your comment regarding DMA is applicable.

How do I cause the driver to use PIO mode? It's presumably not as simple as just taking the DMA channel references out, as this just leads to this error: "omap_hsmmc 480ad000.mmc: RX DMA channel request failed".

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

Bob Engineer 2 said:
How do I cause the driver to use PIO mode? It's presumably not as simple as just taking the DMA channel references out, as this just leads to this error: "omap_hsmmc 480ad000.mmc: RX DMA channel request failed".

I had not tried this but what you are reporting seems like a limitation of the driver that it requires to use DMA, so PIO mode won't work here.

Also you had suggested earlier that you had some success using omap_hsmmc in the current Kernel. Can you please advise the status of this? How much do you have working now talking with that module? Depending on where you are at maybe I can provide help getting this solution over the finish line?

Thanks and Regards,
Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

I've actually been on leave over the last week, so can't get back to you on this immediately. I'll do this as soon as I'm back in the office. Sorry for the delay.

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

I was since able to resolve the issue in the related support case where the customer confirmed that the his SDIO-based Marvell WiFi module is now working again using the 4.19 Kernel and the "new" sdhci-omap.c driver. I believe the solution should address your issues too.

Can you please review/try out that solution and report back here:
https://e2e.ti.com/support/processors/f/791/p/861857/3237209#3237209

Regards, Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

Thanks for all your efforts on this. Still working on this, but initial test shows my system producing this error:

[ 13.692543] mwifiex_sdio mmc1:0001:1: info: FW download over, size 256188 bytes
[ 13.950771] mwifiex_sdio mmc1:0001:1: WLAN FW is active
[ 13.994271] mwifiex_sdio mmc1:0001:1: CMD_RESP: cmd 0x242 error, result=0x2
[ 14.001853] mwifiex_sdio mmc1:0001:1: mwifiex_process_cmdresp: cmd 0x242 failed during initialization
[ 14.125407] mwifiex_sdio mmc1:0001:1: info: MWIFIEX VERSION: mwifiex 1.0 (14.68.36.p139)
[ 14.135786] mwifiex_sdio mmc1:0001:1: driver_version = mwifiex 1.0 (14.68.36.p139)

Best regards,

Bob.

0 Andreas Dannenberg over 6 years ago in reply to Bob Engineer 2

TI__Guru 70602 points

Hi Bob,

looks like you got it working as well, thanks for closing the loop.

Bob Engineer 2 said:
[ 14.001853] mwifiex_sdio mmc1:0001:1: mwifiex_process_cmdresp: cmd 0x242 failed during initialization

I have seen the same, and if I recall correctly this is something related to the regulatory setup or so. I have not seen this affecting my ability to do some basic things with the module such as bringing up the interface and scanning for STAs so I'm almost certain this has nothing to do with the SDHCI driver related issues you originally reported and that we fixed. Since this is something mwlwifi-specific I would suggest you start researching this angle to understand what this failure means in more detail by first looking at the code that causes it (I had tracked it down to a specific function call when I experimented with it, just go backwards from the CMD number in the error message over to the #define and then to the driver code - let me know if you have trouble finding it). Then you can try to backport the driver from the upstream 5.x Kernel to see if it fixes it. And/or search the mailing lists (simple Google should do). And/or reach out to Marvell/NXP(?) to ask for more details on this issue.

I'm going to close this thread for now but please feel free to re-open/amend or open a new one in case you identify any SDIO communication issues.

Thanks and Regards,
Andreas

0 Bob Engineer 2 over 6 years ago in reply to Andreas Dannenberg

Intellectual 530 points

Hi Andreas,

My WiFi is up and running! As you suggested, the mwifiex_sdio actually isn't critical, and is in any case not related to the SDHCI driver.

Once again, thanks again for all your support on this.

Best regards,

Bob.

Processors

Processors forum

AM5728: MMC issue with WiFi module