On 22/10/18 12:14 PM, Anisse Astier wrote:
> 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: ============================================
Could be a BIOS issue. Do you have the most up to date BIOS?
