Hi,
On Mon, Oct 22, 2018 at 11:47:30AM +0300, Adrian Hunter wrote:
> On 19/10/18 4:42 PM, Anisse Astier wrote:
> > On Fri, Oct 19, 2018 at 04:19:39PM +0300, Adrian Hunter wrote:
> >> On 19/10/18 12:26 PM, Anisse Astier wrote:
> >>> Hi Adrian,
> >>>
> >>> On Fri, Oct 19, 2018 at 10:07:38AM +0300, Adrian Hunter wrote:
> >>>> On 18/10/18 1:21 PM, Anisse Astier wrote:
> >>>>> If we don't have the voltage switch DSM methods available, there's no
> >>>>> point in advertising to the rest of the kernel that we support 1.8V, or
> >>>>> support voltage switch at all.
> >>>>>
> >>>>> This fixes an issue on a Gemini Lake (GLK) laptop : eMMC driver will
> >>>>> timeout on boot (from 60seconds to 10minutes ) as the cqhci attempts CQE
> >>>>> recovery after a failed voltage switch. In earlier kernels, the problem
> >>>>> existed, but only delayed boot for about 10 seconds after an I/O error,
> >>>>> allowing booting on the eMMC (almost) unnoticed.
> >>>>
> >>>> Can you send the kernel messages? Which kernel is it? Which laptop? An
> >>>> acpidump might help too.
> >>>
> >>> You're right, I should have started with this. I have attached various
> >>> dmesg traces:
> >>> - dmesg-4.18.3-CQE-traces.txt : the original issue that was
> >>> encountered, it shows the multiple CQE recovery timeouts, each taking
> >>> about 60s
> >>> - dmesg-4.19-rc8.noquirk.txt : a boot where the CQE recovery works, and
> >>> only an I/O error is shown. I've reduced it to the mmc/sdhci traces.
> >>> - dmesg-4.19-rc8.noquirk-with-error.txt : a boot where it fails, this
> >>> is similar to the first one, but with a more recent kernel
> >>> - dmesg-4.19-rc8.withquirk.txt : a boot with sdhci.debug_quirks2=0x90c
> >>> on the command line. I've added the SDHCI_QUIRK2_NO_1_8_V quirk to
> >>> the other ones present in the driver. You can see there's no CQE
> >>> recovery or mmc I/O errors.
> >>>
> >>>
> >>> I've reproduced the issue with linux 4.17, 4.18 and 4.19-rc8. The laptop
> >>> is a noname laptop with an Insyde EFI firmware (Manufacturer: Notebook,
> >>> Product Name: N75_77GU).
> >>>
> >>> You'll find the acpidump in the attachment. I've looked into another GLK
> >>> laptop's tables, and the implemented acpi methods seem to only do a
> >>> sleep(), which isn't really helpful. I've tried to add a similmar msleep
> >>> in the voltage_switch function, but it didn't seem to help.
> >>
> >> Please try disabling CQE i.e.
> >>
> >> diff --git a/drivers/mmc/host/sdhci-pci-core.c b/drivers/mmc/host/sdhci-pci-core.c
> >> index e53333c695b3..c0f8348f75f7 100644
> >> --- a/drivers/mmc/host/sdhci-pci-core.c
> >> +++ b/drivers/mmc/host/sdhci-pci-core.c
> >> @@ -732,7 +732,7 @@ static int glk_emmc_probe_slot(struct sdhci_pci_slot *slot)
> >> {
> >> int ret = byt_emmc_probe_slot(slot);
> >>
> >> - slot->host->mmc->caps2 |= MMC_CAP2_CQE;
> >> + //slot->host->mmc->caps2 |= MMC_CAP2_CQE;
> >>
> >> if (slot->chip->pdev->device != PCI_DEVICE_ID_INTEL_GLK_EMMC) {
> >> slot->host->mmc->caps2 |= MMC_CAP2_HS400_ES,
> >>
> >
> > I did that, and while we don't have the long CQE timeouts, we still have
> > an I/O error:
> >
> > [ 0.468934] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000)
> > [ 0.468934] PCI: MMCONFIG at [mem 0xe0000000-0xe3ffffff] reserved in E820
> > [ 0.621318] acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge
> > [ 3.727365] sdhci: Secure Digital Host Controller Interface driver
> > [ 3.727365] sdhci: Copyright(c) Pierre Ossman
> > [ 3.729638] sdhci-pci 0000:00:1c.0: SDHCI controller found [8086:31cc] (rev 3)
> > [ 3.731801] mmc0: no DSM function for 1.8 voltage switch
> > [ 3.731802] mmc0: Voltage switching unsupported
> > [ 3.731872] mmc0: CQHCI version 5.10
> > [ 3.735646] mmc0: SDHCI controller on PCI [0000:00:1c.0] using ADMA 64-bit
> > [ 3.816485] mmc0: new HS400 MMC card at address 0001
> > [ 3.819219] mmcblk0: mmc0:0001 M52532 29.1 GiB
> > [ 3.819635] mmcblk0boot0: mmc0:0001 M52532 partition 1 4.00 MiB
> > [ 3.820056] mmcblk0boot1: mmc0:0001 M52532 partition 2 4.00 MiB
> > [ 3.820225] mmcblk0rpmb: mmc0:0001 M52532 partition 3 4.00 MiB, chardev (247:0)
> > [ 3.823106] mmcblk0: p1 p2 p3 p4 p5 p6
> > [ 4.135118] bcache: register_cache() registered cache device mmcblk0p6
> > [ 5.627275] sr 1:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
> > [ 16.251559] mmc0: Timeout waiting for hardware interrupt.
> > [ 16.251572] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
> > [ 16.251581] mmc0: sdhci: Sys addr: 0x00000020 | Version: 0x00001002
> > [ 16.251589] mmc0: sdhci: Blk size: 0x00007200 | Blk cnt: 0x00000020
> > [ 16.251596] mmc0: sdhci: Argument: 0x000f4000 | Trn mode: 0x0000003b
> > [ 16.251603] mmc0: sdhci: Present: 0x1fff0206 | Host ctl: 0x0000003d
> > [ 16.251609] mmc0: sdhci: Power: 0x0000000b | Blk gap: 0x00000080
> > [ 16.251616] mmc0: sdhci: Wake-up: 0x00000000 | Clock: 0x00000007
> > [ 16.251623] mmc0: sdhci: Timeout: 0x00000006 | Int stat: 0x00000000
> > [ 16.251630] mmc0: sdhci: Int enab: 0x02ff000b | Sig enab: 0x02ff000b
> > [ 16.251637] mmc0: sdhci: AC12 err: 0x00000000 | Slot int: 0x00000000
> > [ 16.251644] mmc0: sdhci: Caps: 0x546ec881 | Caps_1: 0x80000807
> > [ 16.251651] mmc0: sdhci: Cmd: 0x0000123a | Max curr: 0x00000000
> > [ 16.251658] mmc0: sdhci: Resp[0]: 0x00000800 | Resp[1]: 0x00000000
> > [ 16.251665] mmc0: sdhci: Resp[2]: 0x00000000 | Resp[3]: 0x00000900
> > [ 16.251671] mmc0: sdhci: Host ctl2: 0x0000000d
> > [ 16.251679] mmc0: sdhci: ADMA Err: 0x00000000 | ADMA Ptr: 0x0000000173126200
> > [ 16.251682] mmc0: sdhci: ============================================
> > [ 16.252462] mmc0: mmc_hs400_to_hs200 failed, error -84
> > [ 16.253487] mmcblk0: error -84 requesting status
> > [ 16.253856] mmc0: mmc_hs400_to_hs200 failed, error -84
> > [ 16.254111] mmc0: cache flush error -84
> > [ 16.370768] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
> > [ 17.310793] EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro
> > [ 17.632001] bcache: register_bcache() error /dev/mmcblk0p6: device already registered
> > [ 18.135208] Adding 524284k swap on /dev/mmcblk0p3. Priority:-2 extents:1 across:524284k SSFS
> > [ 18.818304] EXT4-fs (mmcblk0p4): mounted filesystem with ordered data mode. Opts: errors=remount-ro
> > [ 18.818848] EXT4-fs (mmcblk0p5): mounted filesystem with ordered data mode. Opts: (null)
>
> Let's get some more debugging messages. If you configure dynamic debug then
> add kernel command line parameter:
>
> dyndbg="file drivers/mmc/core/* +p;file drivers/mmc/host/* +p"
>
> with a recent kernel, still with CQE disabled, but no quirks or other
> workarounds, then it will produce a large number of mmc messages.
>
You'll find the full dmesg here:
https://anisse.astier.eu/static/dmesg-4.19-rc8.nocqe-verbose.xz
I don't expect it to live very long, so I've tried quoting something
useful before the first register dump, below:
[ 4.471082] <mmc0: starting CMD23 arg 80000004 flags 00000015>
[ 4.471084] mmc0: starting CMD25 arg 01237156 flags 000000b5
[ 4.471086] mmc0: blksz 512 blocks 4 flags 00001100 tsac 1600 ms nsac 4000
[ 4.471087] mmc0: CMD12 arg 00000000 flags 0000049d
[ 4.472140] mmc0: req done <CMD23>: 0: 00000000 00000000 00000000 00000000
[ 4.472142] mmc0: req done (CMD25): 0: 00000900 00000000 00000000 00000000
[ 4.472143] mmc0: 2048 bytes transferred: 0
[ 4.472145] mmc0: (CMD12): 0: 00000000 00000000 00000000 00000000
[ 4.472184] mmc0: starting CMD13 arg 00010000 flags 00000195
[ 4.472236] mmc0: req done (CMD13): 0: 00000900 00000000 00000000 00000000
[ 4.472284] mmc0: starting CMD6 arg 03200101 flags 0000049d
[ 4.472339] mmc0: req done (CMD6): 0: 00000800 00000000 00000000 00000000
[ 4.472381] mmc0: starting CMD13 arg 00010000 flags 00000195
[ 4.472433] mmc0: req done (CMD13): 0: 00000900 00000000 00000000 00000000
[ 4.472480] <mmc0: starting CMD23 arg 80000001 flags 00000015>
[ 4.472482] mmc0: starting CMD25 arg 01218c00 flags 000000b5
[ 4.472483] mmc0: blksz 512 blocks 1 flags 00001100 tsac 1600 ms nsac 4000
[ 4.472485] mmc0: CMD12 arg 00000000 flags 0000049d
[ 4.473056] mmc0: req done <CMD23>: 0: 00000000 00000000 00000000 00000000
[ 4.473058] mmc0: req done (CMD25): 0: 00000900 00000000 00000000 00000000
[ 4.473059] mmc0: 512 bytes transferred: 0
[ 4.473060] mmc0: (CMD12): 0: 00000000 00000000 00000000 00000000
[ 4.473069] mmc0: starting CMD13 arg 00010000 flags 00000195
[ 4.473100] mmc0: req done (CMD13): 0: 00000900 00000000 00000000 00000000
[ 4.487852] mmc1: req done (CMD52): -110: 00000000 00000000 00000000 00000000
[ 4.487864] mmc1: clock 400000Hz busmode 2 powermode 2 cs 1 Vdd 21 width 1 timing 0
[ 4.489242] mmc1: starting CMD0 arg 00000000 flags 000000c0
[ 4.489630] mmc1: req done (CMD0): 0: 00000000 00000000 00000000 00000000
[ 4.490924] mmc1: clock 400000Hz busmode 2 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 4.492295] mmc1: starting CMD8 arg 000001aa flags 000002f5
[ 4.503980] usb 1-6: new high-speed USB device number 2 using xhci_hcd
[ 4.595865] mmc1: req done (CMD8): -110: 00000000 00000000 00000000 00000000
[ 4.595879] mmc1: starting CMD5 arg 00000000 flags 000002e1
[ 4.648038] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 4.655909] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 4.658638] ata2.00: ATAPI: HL-DT-ST DVDRAM GUD0N, 1.00, max UDMA/133
[ 4.663327] ata2.00: configured for UDMA/133
[ 4.686681] ata1.00: ATA-10: ST1000LM048-2E7172, SDM1, max UDMA/133
[ 4.686683] ata1.00: 1953525168 sectors, multi 16: LBA48 NCQ (depth 32), AA
[ 4.699867] mmc1: req failed (CMD5): -110, retrying...
[ 4.743663] usb 1-6: New USB device found, idVendor=04f2, idProduct=b59e, bcdDevice=10.19
[ 4.743666] usb 1-6: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 4.743668] usb 1-6: Product: Chicony USB2.0 Camera
[ 4.743670] usb 1-6: Manufacturer: Chicony Electronics Co.,Ltd.
[ 4.743672] usb 1-6: SerialNumber: 200901010001
[ 4.803875] mmc1: req failed (CMD5): -110, retrying...
[ 4.823978] ata1.00: configured for UDMA/133
[ 4.824317] scsi 0:0:0:0: Direct-Access ATA ST1000LM048-2E71 SDM1 PQ: 0 ANSI: 5
[ 4.827949] scsi 1:0:0:0: CD-ROM HL-DT-ST DVDRAM GUD0N 1.00 PQ: 0 ANSI: 5
[ 4.871980] usb 1-9: new full-speed USB device number 3 using xhci_hcd
[ 4.907876] mmc1: req failed (CMD5): -110, retrying...
[ 5.011958] mmc1: req done (CMD5): -110: 00000000 00000000 00000000 00000000
[ 5.011978] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 5.098795] usb 1-9: New USB device found, idVendor=8087, idProduct=0aaa, bcdDevice= 0.02
[ 5.098798] usb 1-9: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 5.115993] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 5.116009] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 5.219941] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 5.219957] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 5.323853] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 5.323865] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 5.377294] psmouse serio2: synaptics: queried max coordinates: x [..5674], y [..4764]
[ 5.427864] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 5.427880] mmc1: clock 400000Hz busmode 1 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 5.427992] mmc1: starting CMD1 arg 00000000 flags 000000e1
[ 5.504366] psmouse serio2: synaptics: queried min coordinates: x [1266..], y [1086..]
[ 5.504374] psmouse serio2: synaptics: The touchpad can support a better bus than the too old PS/2 protocol. Make sure MOUSE_PS2_SYNAPTICS_SMBUS and RMI4_SMB are enabled to get a better touchpad experience.
[ 5.531859] mmc1: req done (CMD1): -110: 00000000 00000000 00000000 00000000
[ 5.531875] mmc1: clock 0Hz busmode 2 powermode 0 cs 0 Vdd 0 width 1 timing 0
[ 5.533420] mmc1: mmc_rescan_try_freq: trying to init card at 300000 Hz
[ 5.533423] mmc1: clock 0Hz busmode 2 powermode 1 cs 0 Vdd 21 width 1 timing 0
[ 5.534192] rtsx_pci_sdmmc rtsx_pci_sdmmc.0: Initial signal voltage of 3.3v
[ 5.546735] mmc1: clock 300000Hz busmode 2 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 5.559367] mmc1: starting CMD52 arg 00000c00 flags 00000195
[ 5.657443] psmouse serio2: synaptics: Touchpad model: 1, fw: 8.2, id: 0x1e2b1, caps: 0xf00223/0x840300/0x26800/0x0, board id: 3189, fw id: 2302754
[ 5.659997] mmc1: req done (CMD52): -110: 00000000 00000000 00000000 00000000
[ 5.660015] mmc1: starting CMD52 arg 80000c08 flags 00000195
[ 5.710015] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio2/input/input13
[ 5.763975] mmc1: req done (CMD52): -110: 00000000 00000000 00000000 00000000
[ 5.763992] mmc1: clock 300000Hz busmode 2 powermode 2 cs 1 Vdd 21 width 1 timing 0
[ 5.765430] mmc1: starting CMD0 arg 00000000 flags 000000c0
[ 5.765962] mmc1: req done (CMD0): 0: 00000000 00000000 00000000 00000000
[ 5.767388] mmc1: clock 300000Hz busmode 2 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 5.768902] mmc1: starting CMD8 arg 000001aa flags 000002f5
[ 5.871989] mmc1: req done (CMD8): -110: 00000000 00000000 00000000 00000000
[ 5.872007] mmc1: starting CMD5 arg 00000000 flags 000002e1
[ 5.976016] mmc1: req failed (CMD5): -110, retrying...
[ 6.046317] Console: switching to colour frame buffer device 200x56
[ 6.069187] i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
[ 6.079995] mmc1: req failed (CMD5): -110, retrying...
[ 6.093063] sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB)
[ 6.093068] sd 0:0:0:0: [sda] 4096-byte physical blocks
[ 6.093083] sd 0:0:0:0: [sda] Write Protect is off
[ 6.093087] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 6.093106] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 6.127609] sr 1:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
[ 6.127614] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 6.128132] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 6.183982] mmc1: req failed (CMD5): -110, retrying...
[ 6.186423] sd 0:0:0:0: [sda] Attached SCSI disk
[ 6.287847] mmc1: req done (CMD5): -110: 00000000 00000000 00000000 00000000
[ 6.287869] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 6.299035] bcache: register_bdev() registered backing device sda
[ 6.395876] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 6.395890] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 6.499984] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 6.500005] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 6.603976] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 6.603999] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 6.620171] <mmc0: starting CMD23 arg 00000020 flags 00000015>
[ 6.620177] mmc0: starting CMD18 arg 000f4000 flags 000000b5
[ 6.620181] mmc0: blksz 512 blocks 32 flags 00000200 tsac 400 ms nsac 1000
[ 6.620183] mmc0: CMD12 arg 00000000 flags 00000095
[ 6.622351] mmc0: req done <CMD23>: 0: 00000000 00000000 00000000 00000000
[ 6.622357] mmc0: req done (CMD18): 0: 00000900 00000000 00000000 00000000
[ 6.622359] mmc0: 16384 bytes transferred: 0
[ 6.622362] mmc0: (CMD12): 0: 00000000 00000000 00000000 00000000
[ 6.629789] <mmc0: starting CMD23 arg 00000020 flags 00000015>
[ 6.629794] mmc0: starting CMD18 arg 000f4000 flags 000000b5
[ 6.629798] mmc0: blksz 512 blocks 32 flags 00000200 tsac 400 ms nsac 1000
[ 6.629801] mmc0: CMD12 arg 00000000 flags 00000095
[ 6.630279] mmc0: req done <CMD23>: 0: 00000000 00000000 00000000 00000000
[ 6.630283] mmc0: req done (CMD18): 0: 00000900 00000000 00000000 00000000
[ 6.630286] mmc0: 16384 bytes transferred: 0
[ 6.630289] mmc0: (CMD12): 0: 00000000 00000000 00000000 00000000
[ 6.634284] <mmc0: starting CMD23 arg 00000020 flags 00000015>
[ 6.634288] mmc0: starting CMD18 arg 000f4000 flags 000000b5
[ 6.634292] mmc0: blksz 512 blocks 32 flags 00000200 tsac 400 ms nsac 1000
[ 6.634295] mmc0: CMD12 arg 00000000 flags 00000095
[ 6.634771] mmc0: req done <CMD23>: 0: 00000000 00000000 00000000 00000000
[ 6.634775] mmc0: req done (CMD18): 0: 00000900 00000000 00000000 00000000
[ 6.634778] mmc0: 16384 bytes transferred: 0
[ 6.634781] mmc0: (CMD12): 0: 00000000 00000000 00000000 00000000
[ 6.641766] <mmc0: starting CMD23 arg 00000008 flags 00000015>
[ 6.641768] mmc0: starting CMD18 arg 00cf3f80 flags 000000b5
[ 6.641770] mmc0: blksz 512 blocks 8 flags 00000200 tsac 400 ms nsac 1000
[ 6.641771] mmc0: CMD12 arg 00000000 flags 00000095
[ 6.641972] mmc0: req done <CMD23>: 0: 00000000 00000000 00000000 00000000
[ 6.641974] mmc0: req done (CMD18): 0: 00000900 00000000 00000000 00000000
[ 6.641975] mmc0: 4096 bytes transferred: 0
[ 6.641977] mmc0: (CMD12): 0: 00000000 00000000 00000000 00000000
[ 6.642048] <mmc0: starting CMD23 arg 00000008 flags 00000015>
[ 6.642050] mmc0: starting CMD18 arg 00cf3ff0 flags 000000b5
[ 6.642052] mmc0: blksz 512 blocks 8 flags 00000200 tsac 400 ms nsac 1000
[ 6.642053] mmc0: CMD12 arg 00000000 flags 00000095
[ 6.707986] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 6.708008] mmc1: clock 300000Hz busmode 1 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 6.708117] mmc1: starting CMD1 arg 00000000 flags 000000e1
[ 6.811990] mmc1: req done (CMD1): -110: 00000000 00000000 00000000 00000000
[ 6.812013] mmc1: clock 0Hz busmode 2 powermode 0 cs 0 Vdd 0 width 1 timing 0
[ 6.813513] mmc1: mmc_rescan_try_freq: trying to init card at 250000 Hz
[ 6.813517] mmc1: clock 0Hz busmode 2 powermode 1 cs 0 Vdd 21 width 1 timing 0
[ 6.814257] rtsx_pci_sdmmc rtsx_pci_sdmmc.0: Initial signal voltage of 3.3v
[ 6.826921] mmc1: clock 250000Hz busmode 2 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 6.839686] mmc1: starting CMD52 arg 00000c00 flags 00000195
[ 6.939992] mmc1: req done (CMD52): -110: 00000000 00000000 00000000 00000000
[ 6.940015] mmc1: starting CMD52 arg 80000c08 flags 00000195
[ 7.043873] mmc1: req done (CMD52): -110: 00000000 00000000 00000000 00000000
[ 7.043893] mmc1: clock 250000Hz busmode 2 powermode 2 cs 1 Vdd 21 width 1 timing 0
[ 7.045248] mmc1: starting CMD0 arg 00000000 flags 000000c0
[ 7.045747] mmc1: req done (CMD0): 0: 00000000 00000000 00000000 00000000
[ 7.047033] mmc1: clock 250000Hz busmode 2 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 7.048383] mmc1: starting CMD8 arg 000001aa flags 000002f5
[ 7.151991] mmc1: req done (CMD8): -110: 00000000 00000000 00000000 00000000
[ 7.152014] mmc1: starting CMD5 arg 00000000 flags 000002e1
[ 7.256004] mmc1: req failed (CMD5): -110, retrying...
[ 7.359998] mmc1: req failed (CMD5): -110, retrying...
[ 7.463892] mmc1: req failed (CMD5): -110, retrying...
[ 7.567993] mmc1: req done (CMD5): -110: 00000000 00000000 00000000 00000000
[ 7.568017] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 7.671992] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 7.672014] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 7.775984] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 7.776008] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 7.879993] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 7.880015] mmc1: starting CMD55 arg 00000000 flags 000000f5
[ 7.983992] mmc1: req done (CMD55): -110: 00000000 00000000 00000000 00000000
[ 7.984014] mmc1: clock 250000Hz busmode 1 powermode 2 cs 0 Vdd 21 width 1 timing 0
[ 7.984112] mmc1: starting CMD1 arg 00000000 flags 000000e1
[ 8.087987] mmc1: req done (CMD1): -110: 00000000 00000000 00000000 00000000
[ 8.088009] mmc1: clock 0Hz busmode 2 powermode 0 cs 0 Vdd 0 width 1 timing 0
[ 16.823934] mmc0: Timeout waiting for hardware interrupt.
[ 16.823947] mmc0: sdhci: ============ SDHCI REGISTER DUMP ===========
[ 16.823956] mmc0: sdhci: Sys addr: 0x00000008 | Version: 0x00001002
[ 16.823964] mmc0: sdhci: Blk size: 0x00007200 | Blk cnt: 0x00000008
[ 16.823971] mmc0: sdhci: Argument: 0x00cf3ff0 | Trn mode: 0x0000003b
[ 16.823978] mmc0: sdhci: Present: 0x1fff0001 | Host ctl: 0x0000003d
[ 16.823985] mmc0: sdhci: Power: 0x0000000b | Blk gap: 0x00000080
[ 16.823992] mmc0: sdhci: Wake-up: 0x00000000 | Clock: 0x00000007
[ 16.823999] mmc0: sdhci: Timeout: 0x00000006 | Int stat: 0x00000000
[ 16.824006] mmc0: sdhci: Int enab: 0x02ff000b | Sig enab: 0x02ff000b
[ 16.824013] mmc0: sdhci: AC12 err: 0x00000000 | Slot int: 0x00000000
[ 16.824020] mmc0: sdhci: Caps: 0x546ec881 | Caps_1: 0x80000807
[ 16.824027] mmc0: sdhci: Cmd: 0x0000123a | Max curr: 0x00000000
[ 16.824034] mmc0: sdhci: Resp[0]: 0x00000900 | Resp[1]: 0x00000000
[ 16.824041] mmc0: sdhci: Resp[2]: 0x00000000 | Resp[3]: 0x00000900
[ 16.824047] mmc0: sdhci: Host ctl2: 0x0000000d
[ 16.824055] mmc0: sdhci: ADMA Err: 0x00000000 | ADMA Ptr: 0x000000016bbf5200
[ 16.824058] mmc0: sdhci: ============================================
Regards,
Anisse
