eMMC module not working

To: tech-kern%NetBSD.org@localhost
Subject: eMMC module not working
From: Martin Husemann <martin%duskware.de@localhost>
Date: Thu, 16 Jul 2020 11:19:33 +0200
Hey folks,

I have two eMMC modules that with recentish -current do not work in my
Odroid C2 board (both used to work in older versions, but I don't know
when exactly it did break).

I enabled mmc debug and got the dump below.

Jared has one very similar module and it works for him (he also has another
different one that works).

This is with an image from very recentish -current, only bootaa64.efi replaced
with a working (newer) one, as the image yesterday still included a broken
version. Plus /netbsd replaced with a version with enabled mmc debug output
(but overall behaviour is the same with and w/o debug output).

Any hints?

Martin

--

chipLoad bl33 from eMMC, src: 0x00034200, des: 0x01000000, size: 0x00075f50
id: ef be ad de d f0 ad ba ef be ad de not ES chip

[0.385870 Inits done]

secure task start!
high task start!
low task start!
NOTICE:  BL3-1: v1.0(debug):4d2e34d
NOTICE:  BL3-1: Built : 17:08:35, Oct 29 2015
INFO:    BL3-1: Initializing runtime services
INFO:    BL3-1: Preparing for EL3 exit to normal world
INFO:    BL3-1: Next image address = 0x1000000
INFO:    BL3-1: Next image spsr = 0x3c9


U-Boot 2019.04-rc1-00141-g63f7e3fca3 (Feb 15 2019 - 20:11:48 -0400) odroid-c2

DRAM:  2 GiB
MMC:   mmc@72000: 0, mmc@74000: 1
In:    serial
Out:   serial
Err:   serial
Net:   eth0: ethernet@c9410000
Hit any key to stop autoboot:  2  1  0 
Card did not respond to voltage select!
switch to partitions #0, OK
mmc1(part 0) is current device
Scanning mmc 1:1...
36543 bytes read in 2 ms (17.4 MiB/s)
Found EFI removable media binary efi/boot/bootaa64.efi
7[r[999;999H[6n8Card did not respond to voltage select!
Scanning disk mmc%72000.blk@localhost...
Disk mmc%72000.blk@localhost not ready
Scanning disk mmc%74000.blk@localhost...
Found 3 disks
182712 bytes read in 5 ms (34.8 MiB/s)
## Starting EFI application at 08080000 ...
[2J[0;37;40m[?25h


>> NetBSD/evbarm efiboot (arm64), Revision 2.2 (Wed Jul 15 08:25:56 UTC 2020)

Press return to boot now, any other key for boot prompt

booting netbsd - starting in 5 seconds. 4 seconds. 3 seconds. 2 seconds. 1 seconds. 0 seconds.     

8208656+3608328+3675352+1532912 [559761+934968+683973]=0x130c168

[   1.0000000] NetBSD/evbarm (fdt) booting ...
[   1.0000000] pool redzone disabled for 'kmem-04096'
[   1.0000000] Copyright (c) 1996, 1997, 1998, 1999, 2000, 2001, 2002, 2003, 2004, 2005,
[   1.0000000]     2006, 2007, 2008, 2009, 2010, 2011, 2012, 2013, 2014, 2015, 2016, 2017,
[   1.0000000]     2018, 2019, 2020 The NetBSD Foundation, Inc.  All rights reserved.
[   1.0000000] Copyright (c) 1982, 1986, 1989, 1991, 1993
[   1.0000000]     The Regents of the University of California.  All rights reserved.

[   1.0000000] NetBSD 9.99.69 (GENERIC64) #150: Thu Jul 16 10:48:33 CEST 2020
[   1.0000000] 	martin%seven-days-to-the-wolves.aprisoft.de@localhost:/work/src/sys/arch/evbarm/compile/GENERIC64
[   1.0000000] total memory = 2012 MB
[   1.0000000] avail memory = 1951 MB
[   1.0000000] pool redzone disabled for 'buf4k'
[   1.0000000] pool redzone disabled for 'buf64k'
[   1.0000000] entropy: no seed from bootloader
[   1.0000000] armfdt0 (root)
[   1.0000000] simplebus0 at armfdt0: Hardkernel ODROID-C2
[   1.0000000] simplebus1 at simplebus0
[   1.0000000] cpus0 at simplebus0
[   1.0000000] simplebus2 at simplebus0
[   1.0000000] psci0 at simplebus0: PSCI 0.2
[   1.0000000] cpu0 at cpus0: Arm Cortex-A53 r0p4 (v8-A), id 0x0
[   1.0000000] cpu1 at cpus0: Arm Cortex-A53 r0p4 (v8-A), id 0x1
[   1.0000000] cpu2 at cpus0: Arm Cortex-A53 r0p4 (v8-A), id 0x2
[   1.0000000] cpu3 at cpus0: Arm Cortex-A53 r0p4 (v8-A), id 0x3
[   1.0000000] simplebus3 at simplebus1
[   1.0000000] simplebus4 at simplebus1
[   1.0000000] simplebus5 at simplebus1
[   1.0000000] simplebus6 at simplebus1
[   1.0000000] simplebus7 at simplebus1
[   1.0000000] simplebus8 at simplebus1
[   1.0000000] gic0 at simplebus1: GIC
[   1.0000000] armgic0 at gic0: Generic Interrupt Controller, 256 sources (238 valid)
[   1.0000000] armgic0: 16 Priorities, 224 SPIs, 6 PPIs, 8 SGIs
[   1.0000000] syscon0 at simplebus3: System Controller Registers
[   1.0000000] syscon1 at simplebus4: System Controller Registers
[   1.0000000] fclock0 at simplebus0: 24000000 Hz fixed clock (xtal)
[   1.0000000] syscon2 at simplebus3: System Controller Registers
[   1.0000000] gtmr0 at simplebus0: Generic Timer
[   1.0000000] gtmr0: interrupting on GIC irq 27
[   1.0000000] armgtmr0 at gtmr0: Generic Timer (24000 kHz, virtual)
[   1.0000030] gxbbclkc0 at syscon1: Meson GXBB clock controller
[   1.0000030] mesonpinctrl0 at simplebus5: Meson GXBB periphs GPIO
[   1.0000030] gpio0 at mesonpinctrl0: 119 pins
[   1.0000030] mesonresets0 at simplebus6
[   1.0000030] gxbbaoclkc0 at syscon0: Meson GX AO clock controller
[   1.0000030] mesonpinctrl1 at simplebus3: Meson GXBB AO GPIO
[   1.0000030] mesonpinctrl1: usb-hub-reset GPIOAO_4 set to output (high)
[   1.0000030] gpio1 at mesonpinctrl1: 14 pins
[   1.0000030] fregulator0 at simplebus0: VCC1V8
[   1.0000030] fregulator1 at simplebus0: TFLASH_VDD
[   1.0000030] gregulator0 at simplebus0: TF_IO
[   1.0000030] fregulator2 at simplebus0: VCC3V3
[   1.0000030] fregulator3 at simplebus0: HDMI_P5V0
[   1.0000030] fregulator4 at simplebus0: USB_OTG_PWR
[   1.0000030] fregulator5 at simplebus0: P5V0
[   1.0000030] fregulator6 at simplebus0: VDDIO_AO3V3
[   1.0000030] mesonuart0 at simplebus3: console
[   1.0000030] mesonuart0: interrupting on GIC irq 225
[   1.0000030] fregulator7 at simplebus0: VDDIO_AO1V8
[   1.0000030] fregulator8 at simplebus0: DDR3_1V5
[   1.0000030] mmcpwrseq0 at simplebus0: eMMC hardware reset provider
[   1.0000030] mesonusbphy0 at simplebus1: USB2 PHY (host)
[   1.0000030] /soc/bus@c8100000/sys-ctrl@0/power-controller-vpu at syscon0 not configured
[   1.0000030] /scpi at simplebus0 not configured
[   1.0000030] /soc/bus@c883c000/mailbox@404 at simplebus4 not configured
[   1.0000030] /soc/sram@c8000000 at simplebus1 not configured
[   1.0000030] /soc/hdmi-tx@c883a000 at simplebus1 not configured
[   1.0000030] /soc/bus@c8838000/video-lut@48 at simplebus7 not configured
[   1.0000030] awge0 at simplebus1: Gigabit Ethernet Controller
[   1.0000030] awge0: interrupting on GIC irq 40
[   1.0000030] awge0: Core version: 00001137
[   1.0000030] awge0: Ethernet address 00:1e:06:33:12:a6
[   1.0000030] awge0: HW feature mask: 100d4f37
[   1.0000030] rgephy0 at awge0 phy 0: RTL8211F 1000BASE-T media interface
[   1.0000030] rgephy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT-FDX, auto
[   1.0000030] rgephy1 at awge0 phy 7: RTL8211F 1000BASE-T media interface
[   1.0000030] rgephy1: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT-FDX, auto
[   1.0000030] /soc/bus@c1100000/interrupt-controller@9880 at simplebus6 not configured
[   1.0000030] /soc/vpu@d0100000 at simplebus1 not configured
[   1.0000030] dispcon0 at simplebus0: HDMI connector
[   1.0000030] /efuse at simplebus0 not configured
[   1.0000030] /soc/bus@c1100000/i2c@8500 at simplebus6 not configured
[   1.0000030] /soc/bus@c1100000/adc@8680 at simplebus6 not configured
[   1.0000030] /soc/bus@c8100000/cec@100 at simplebus3 not configured
[   1.0000030] /soc/bus@c8100000/ir@580 at simplebus3 not configured
[   1.0000030] /soc/video-codec@c8820000 at simplebus1 not configured
[   1.0000030] mesonrng0 at simplebus5: Hardware RNG
[   1.0000030] entropy: ready
[   1.0000030] mesongxmmc0 at simplebus8: eMMC/SD/SDIO controller
[   1.0000030] mesongxmmc0: interrupting on GIC irq 249
[   1.0000030] mesongxmmc1 at simplebus8: eMMC/SD/SDIO controller
[   1.0000030] mesongxmmc1: interrupting on GIC irq 250
[   1.0000030] /soc/apb@d0000000/gpu@c0000 at simplebus8 not configured
[   1.0000030] dwctwo0 at simplebus1: DesignWare USB2 OTG
[   1.0000030] dwctwo0: interrupting on GIC irq 63
[   1.0000030] armpmu0 at simplebus0: Performance Monitor Unit
[   1.0000030] gpioleds0 at simplebus0: c2:blue:alive
[   1.0000030] /soc/bus@c1100000/clock-measure@8758 at simplebus6 not configured
[   1.0000030] /soc/bus@c1100000/watchdog@98d0 at simplebus6 not configured
[   1.5705756] sdmmc0 at mesongxmmc0
[   1.5705756] sdmmc1 at mesongxmmc1
[   1.5705756] usb0 at dwctwo0: USB revision 2.0
[   1.5705756] sdmmc1: attach card
[   1.5805782] armpmu0: interrupting on GIC irq 169
[   1.5805782] armpmu0: interrupting on GIC irq 170
[   1.5805782] armpmu0: interrupting on GIC irq 185
[   1.5905759] armpmu0: interrupting on GIC irq 186
[   1.5905759] uhub0 at usb0: NetBSD (0x0000) DWC2 root hub (0x0000), class 9/0, rev 2.00/1.00, addr 1
[   1.6105768] aes: ARM NEON vpaes
[   1.6705777] sdmmc_mmc_command: cmd=52, arg=0x80000c08, flags=0x4032
[   1.6705777] sdmmc1: cmd 52 arg=0x80000c08 data=0x0 dlen=0 flags=0x4032 (error 60)
[   1.6805785] sdmmc_mmc_command: error=60
[   1.6805785] sdmmc_mmc_command: cmd=5, arg=0, flags=0x4302
[   1.6905781] sdmmc1: cmd 5 arg=0 data=0x0 dlen=0 flags=0x4302 (error 60)
[   1.6905781] sdmmc_mmc_command: error=60
[   1.7005784] sdmmc_go_idle_state
[   1.7005784] sdmmc_mmc_command: cmd=0, arg=0, flags=0x600
[   1.7105785] sdmmc1: cmd 0 arg=0 data=0x0 dlen=0 flags=0x601 (error 0)
[   1.7105785] sdmmc1: resp=none
[   1.7105785] sdmmc_mmc_command: error=0
[   1.7205789] sdmmc1: sdmmc_mem_send_op_cond: ocr=0
[   1.7205789] sdmmc_app_command: start
[   1.7305788] sdmmc_mmc_command: cmd=55, arg=0, flags=0x4432
[   1.7305788] sdmmc1: cmd 55 arg=0 data=0x0 dlen=0 flags=0x4432 (error 60)
[   1.7405792] sdmmc_mmc_command: error=60
[   1.7405792] sdmmc_app_command: done (error=60)
[   1.7505792] sdmmc1: sdmmc_mem_send_op_cond: error=60, ocr=0
[   1.7505792] sdmmc1: switch to MMC mode
[   1.7605797] sdmmc1: sdmmc_mem_send_op_cond: ocr=0
[   1.7605797] sdmmc_mmc_command: cmd=1, arg=0, flags=0x4702
[   1.7705797] sdmmc1: cmd 1 arg=0 data=0x0 dlen=0 flags=0x4703 (error 0)
[   1.7705797] sdmmc1: resp=80 80 ff 40 
[   1.7805804] sdmmc_mmc_command: error=0
[   1.7805804] sdmmc1: sdmmc_mem_send_op_cond: error=0, ocr=0x40ff8080
[   1.7905800] sdmmc1: host_ocr=300080 card_ocr=40ff8080 new_ocr=80
[   1.7905800] sdmmc1: host_ocr 0x00300080
[   1.8005805] sdmmc1: card_ocr 0x40ff8080
[   1.8005805] sdmmc1: sdmmc_mem_send_op_cond: ocr=0x40300080
[   1.8105805] sdmmc_mmc_command: cmd=1, arg=0x40300080, flags=0x4702
[   1.8105805] sdmmc1: cmd 1 arg=0x40300080 data=0x0 dlen=0 flags=0x4703 (error 0)
[   1.8205811] sdmmc1: resp=80 80 ff 40 
[   1.8205811] sdmmc_mmc_command: error=0
[   1.8305808] sdmmc_mmc_command: cmd=1, arg=0x40300080, flags=0x4702
[   1.8305808] sdmmc1: cmd 1 arg=0x40300080 data=0x0 dlen=0 flags=0x4703 (error 0)
[   1.8405813] sdmmc1: resp=80 80 ff 40 
[   1.8405813] sdmmc_mmc_command: error=0
[   1.8505813] sdmmc_mmc_command: cmd=1, arg=0x40300080, flags=0x4702
[   1.8505813] sdmmc1: cmd 1 arg=0x40300080 data=0x0 dlen=0 flags=0x4703 (error 0)
[   1.8605817] sdmmc1: resp=80 80 ff c0 
[   1.8705817] sdmmc_mmc_command: error=0
[   1.8705817] sdmmc1: sdmmc_mem_send_op_cond: error=0, ocr=0xc0ff8080
[   1.8805826] sdmmc_mmc_command: cmd=2, arg=0, flags=0x431a
[   1.8805826] sdmmc1: cmd 2 arg=0 data=0x0 dlen=0 flags=0x431b (error 0)
[   1.8905822] sdmmc1: resp=a3 60 47 64 0c 43 20 64 72 61 43 4e 03 01 88 00 
[   1.8905822] sdmmc_mmc_command: error=0
[   1.9005826] sdmmc_dump_data: CID
[   1.9005826] --------+--------------------------------------------------+------------------+
[   1.9105826] offset  | +0 +1 +2 +3 +4 +5 +6 +7  +8 +9 +a +b +c +d +e +f | data             |
[   1.9205830] --------+--------------------------------------------------+------------------+
[   1.9305830] 00000000| a3 60 47 64 0c 43 20 64  72 61 43 4e 03 01 88 00 | .`Gd.C draCN.... |
[   1.9305830] --------+--------------------------------------------------+------------------+
[   1.9405834] sdmmc_mmc_command: cmd=3, arg=0x10000, flags=0x32
[   1.9505835] sdmmc1: cmd 3 arg=0x10000 data=0x0 dlen=0 flags=0x33 (error 0)
[   1.9605838] sdmmc1: resp=00 05 40 00 
[   1.9605838] sdmmc_mmc_command: error=0
[   1.9605838] sdmmc_mmc_command: cmd=2, arg=0, flags=0x431a
[   1.9705839] sdmmc1: cmd 2 arg=0 data=0x0 dlen=0 flags=0x431a (error 60)
[   1.9805845] sdmmc_mmc_command: error=60
[   1.9805845] sdmmc_mmc_command: cmd=9, arg=0x10000, flags=0x1a
[   1.9905842] sdmmc1: cmd 9 arg=0x10000 data=0x0 dlen=0 flags=0x1b (error 0)
[   1.9905842] sdmmc1: resp=00 40 96 e7 ff ff ff ff 03 59 0f 32 ff ff d0 00 
[   2.0005847] sdmmc_mmc_command: error=0
[   2.0005847] sdmmc_dump_data: CSD
[   2.0105847] --------+--------------------------------------------------+------------------+
[   2.0105847] offset  | +0 +1 +2 +3 +4 +5 +6 +7  +8 +9 +a +b +c +d +e +f | data             |
[   2.0205851] --------+--------------------------------------------------+------------------+
[   2.0305851] 00000000| 00 40 96 e7 ff ff ff ff  03 59 0f 32 ff ff d0 00 | .@.......Y.2.... |
[   2.0405855] --------+--------------------------------------------------+------------------+
[   2.0505856] sdmmc1: CID: mid=0x88 oid=0x0103 pnm="NCard " rev=0x00 psn=0x0c644760 mdt=000
[   2.0605859] sdmmc_mmc_command: cmd=7, arg=0x10000, flags=0x32
[   2.0605859] sdmmc1: cmd 7 arg=0x10000 data=0x0 dlen=0 flags=0x33 (error 0)
[   2.0705860] sdmmc1: resp=00 07 00 00 
[   2.0705860] sdmmc_mmc_command: error=0
[   2.0805866] sdmmc_mmc_command: cmd=16, arg=0x200, flags=0x432
[   2.0805866] sdmmc1: cmd 16 arg=0x200 data=0x0 dlen=0 flags=0x433 (error 0)
[   2.0905865] sdmmc1: resp=00 09 00 00 
[   2.0905865] sdmmc_mmc_command: error=0
[   2.1005867] sdmmc1: sdmmc_mem_set_blocklen: read_bl_len=512 sector_size=512
[   2.1005867] sdmmc_mmc_command: cmd=8, arg=0, flags=0x572
[   2.1105868] sdmmc1: cmd 8 arg=0 data=0xffff000004fb8000 dlen=512 flags=0x572 (error 5)
[   2.1205871] sdmmc_mmc_command: error=5
[   2.1205871] sdmmc1: can't read EXT_CSD (error=5)
[   2.1205871] sdmmc1: mem init failed
[   2.1305872] sdmmc1: init failed
[   2.1305872] sdmmc1: detach card
[   2.1305872] sdmmc_mmc_command: cmd=7, arg=0, flags=0
[   2.1405876] sdmmc1: cmd 7 arg=0 data=0x0 dlen=0 flags=0x1 (error 0)
[   2.1505876] sdmmc1: resp=none
[   2.1505876] sdmmc_mmc_command: error=0
[   3.4506120] uhub1 at uhub0 port 1: vendor 05e3 (0x05e3) USB2.0 Hub (0x0610), class 9/0, rev 2.00/32.98, addr 2
[   3.4506120] uhub1: multiple transaction translators
[   3.8006192] uhub0: illegal enable change, port 1
[   3.8006192] WARNING: 4 errors while detecting hardware; check system log.
[   3.8106202] boot device:
Follow-Ups:
- Re: eMMC module not working
  - From: Michael van Elst
Prev by Date: Re: style change: explicitly permit braces for single statements
Next by Date: Re: kernel stack usage
Previous by Thread: Re: style change: explicitly permit braces for single statements
Next by Thread: Re: eMMC module not working
Indexes:
Home | Main Index | Thread Index | Old Index