Nouveau - Sep 2020 - pcieport 0000:00:01.0: PME: Spurious native interrupt (nvidia with nouveau and thunderbolt on thinkpad P73)

On Mon, Sep 07, 2020 at 09:14:03PM +0200, Karol Herbst
wrote:
> > - changes in the nouveau driver. Mika told me the PCIe regression
> >   "pcieport 0000:00:01.0: PME: Spurious native interrupt!"
is supposed
> >   to be fixed in 5.8, but I still get a 4mn hang or so during boot and
> >   with 5.8, removing the USB key, didn't help make the boot faster
> 
> that's the root port the GPU is attached to, no? I saw that message on
> the Thinkpad P1G2 when runtime resuming the Nvidia GPU, but it does
> seem to come from the root port.
Hi Karol, thanks for your answer.
 
00:01.0 PCI bridge: Intel Corporation Xeon E3-1200 v5/E3-1500 v5/6th Gen Core
Processor PCIe Controller (x16) (rev 0d)
01:00.0 VGA compatible controller: NVIDIA Corporation TU104GLM [Quadro RTX 4000
Mobile / Max-Q] (rev a1)
> Well, you'd also need it when attaching external displays.
 
Indeed. I just don't need that on this laptop, but familiar with the not
so seemless procedure to turn on both GPUs, and mirror the intel one into
the nvidia one for external output. 
> > [   11.262985] nvidia-gpu 0000:01:00.3: PME# enabled
> > [   11.303060] nvidia-gpu 0000:01:00.3: PME# disabled
> 
> mhh, interesting. I heard some random comments that the Nvidia
> USB-C/UCSI driver is a bit broken and can cause various issues. Mind
> blacklisting i2c-nvidia-gpu and typec_nvidia (and verify they don't
> get loaded) and see if that helps?
Right, this one:
01:00.3 Serial bus controller [0c80]: NVIDIA Corporation TU104 USB Type-C UCSI
Controller (rev a1)
Sure, I'll blacklist it. Ok, just did that, removed from initrd,
rebooted, and it was no better.
>From initrd (before root gets mounted), I have this:
nouveau              1961984  0
mxm_wmi                16384  1 nouveau
hwmon                  32768  1 nouveau
ttm                   102400  1 nouveau
wmi                    32768  2 nouveau,mxm_wmi

I still got a 2mn hang. and a nouveau probe error
[  189.124530] nouveau: probe of 0000:01:00.0 failed with error -12


Here's what it looks like:
[    9.693230] hid: raw HID events driver (C) Jiri Kosina
[    9.694988] usbcore: registered new interface driver usbhid
[    9.694989] usbhid: USB HID core driver
[    9.696700] hid-generic 0003:1050:0200.0001: hiddev0,hidraw0: USB HID v1.00
Device [Yubico Yubico Gnubby (gnubby1)] on usb-0000:00:14.0-2/input0
[    9.784456] Console: switching to colour frame buffer device 240x67
[    9.816297] i915 0000:00:02.0: fb0: i915drmfb frame buffer device
[   25.087400] thunderbolt 0000:06:00.0: saving config space at offset 0x0
(reading 0x15eb8086)
[   25.087414] thunderbolt 0000:06:00.0: saving config space at offset 0x4
(reading 0x100406)
[   25.087419] thunderbolt 0000:06:00.0: saving config space at offset 0x8
(reading 0x8800006)
[   25.087424] thunderbolt 0000:06:00.0: saving config space at offset 0xc
(reading 0x20)
[   25.087430] thunderbolt 0000:06:00.0: saving config space at offset 0x10
(reading 0xcc100000)
[   25.087435] thunderbolt 0000:06:00.0: saving config space at offset 0x14
(reading 0xcc140000)
[   25.087440] thunderbolt 0000:06:00.0: saving config space at offset 0x18
(reading 0x0)
[   25.087445] thunderbolt 0000:06:00.0: saving config space at offset 0x1c
(reading 0x0)
[   25.087450] thunderbolt 0000:06:00.0: saving config space at offset 0x20
(reading 0x0)
[   25.087455] thunderbolt 0000:06:00.0: saving config space at offset 0x24
(reading 0x0)
[   25.087460] thunderbolt 0000:06:00.0: saving config space at offset 0x28
(reading 0x0)
[   25.087466] thunderbolt 0000:06:00.0: saving config space at offset 0x2c
(reading 0x229b17aa)
[   25.087471] thunderbolt 0000:06:00.0: saving config space at offset 0x30
(reading 0x0)
[   25.087476] thunderbolt 0000:06:00.0: saving config space at offset 0x34
(reading 0x80)
[   25.087481] thunderbolt 0000:06:00.0: saving config space at offset 0x38
(reading 0x0)
[   25.087486] thunderbolt 0000:06:00.0: saving config space at offset 0x3c
(reading 0x1ff)
[   25.087571] thunderbolt 0000:06:00.0: PME# enabled
[   25.105353] pcieport 0000:05:00.0: saving config space at offset 0x0 (reading
0x15ea8086)
[   25.105364] pcieport 0000:05:00.0: saving config space at offset 0x4 (reading
0x100407)
[   25.105370] pcieport 0000:05:00.0: saving config space at offset 0x8 (reading
0x6040006)
[   25.105375] pcieport 0000:05:00.0: saving config space at offset 0xc (reading
0x10020)
[   25.105380] pcieport 0000:05:00.0: saving config space at offset 0x10
(reading 0x0)
[   25.105384] pcieport 0000:05:00.0: saving config space at offset 0x14
(reading 0x0)
[   25.105389] pcieport 0000:05:00.0: saving config space at offset 0x18
(reading 0x60605)
[   25.105394] pcieport 0000:05:00.0: saving config space at offset 0x1c
(reading 0x1f1)
[   25.105399] pcieport 0000:05:00.0: saving config space at offset 0x20
(reading 0xcc10cc10)
[   25.105404] pcieport 0000:05:00.0: saving config space at offset 0x24
(reading 0x1fff1)
[   25.105409] pcieport 0000:05:00.0: saving config space at offset 0x28
(reading 0x0)
[   25.105413] pcieport 0000:05:00.0: saving config space at offset 0x2c
(reading 0x0)
[   25.105418] pcieport 0000:05:00.0: saving config space at offset 0x30
(reading 0x0)
[   25.105423] pcieport 0000:05:00.0: saving config space at offset 0x34
(reading 0x80)
[   25.105428] pcieport 0000:05:00.0: saving config space at offset 0x38
(reading 0x0)
[   25.105432] pcieport 0000:05:00.0: saving config space at offset 0x3c
(reading 0x201ff)
[   25.105517] pcieport 0000:05:00.0: PME# enabled
[   25.125367] pcieport 0000:04:00.0: saving config space at offset 0x0 (reading
0x15ea8086)
[   25.125378] pcieport 0000:04:00.0: saving config space at offset 0x4 (reading
0x100007)
[   25.125383] pcieport 0000:04:00.0: saving config space at offset 0x8 (reading
0x6040006)
[   25.125388] pcieport 0000:04:00.0: saving config space at offset 0xc (reading
0x10020)
[   25.125393] pcieport 0000:04:00.0: saving config space at offset 0x10
(reading 0x0)
[   25.125398] pcieport 0000:04:00.0: saving config space at offset 0x14
(reading 0x0)
[   25.125403] pcieport 0000:04:00.0: saving config space at offset 0x18
(reading 0x510504)
[   25.125407] pcieport 0000:04:00.0: saving config space at offset 0x1c
(reading 0x5141)
[   25.125412] pcieport 0000:04:00.0: saving config space at offset 0x20
(reading 0xcc10b400)
[   25.125417] pcieport 0000:04:00.0: saving config space at offset 0x24
(reading 0x3ff10001)
[   25.125422] pcieport 0000:04:00.0: saving config space at offset 0x28
(reading 0x60)
[   25.125427] pcieport 0000:04:00.0: saving config space at offset 0x2c
(reading 0x60)
[   25.125431] pcieport 0000:04:00.0: saving config space at offset 0x30
(reading 0x0)
[   25.125436] pcieport 0000:04:00.0: saving config space at offset 0x34
(reading 0x80)
[   25.125441] pcieport 0000:04:00.0: saving config space at offset 0x38
(reading 0x0)
[   25.125446] pcieport 0000:04:00.0: saving config space at offset 0x3c
(reading 0x201ff)
[   25.125528] pcieport 0000:04:00.0: PME# enabled
[   25.145423] pcieport 0000:00:1c.0: saving config space at offset 0x0 (reading
0xa3388086)
[   25.145437] pcieport 0000:00:1c.0: saving config space at offset 0x4 (reading
0x100407)
[   25.145445] pcieport 0000:00:1c.0: saving config space at offset 0x8 (reading
0x60400f0)
[   25.145453] pcieport 0000:00:1c.0: saving config space at offset 0xc (reading
0x810000)
[   25.145460] pcieport 0000:00:1c.0: saving config space at offset 0x10
(reading 0x0)
[   25.145464] pcieport 0000:00:1c.0: saving config space at offset 0x14
(reading 0x0)
[   25.145469] pcieport 0000:00:1c.0: saving config space at offset 0x18
(reading 0x510400)
[   25.145476] pcieport 0000:00:1c.0: saving config space at offset 0x1c
(reading 0x20006040)
[   25.145484] pcieport 0000:00:1c.0: saving config space at offset 0x20
(reading 0xcc10b400)
[   25.145488] pcieport 0000:00:1c.0: saving config space at offset 0x24
(reading 0x3ff10001)
[   25.145493] pcieport 0000:00:1c.0: saving config space at offset 0x28
(reading 0x60)
[   25.145497] pcieport 0000:00:1c.0: saving config space at offset 0x2c
(reading 0x60)
[   25.145502] pcieport 0000:00:1c.0: saving config space at offset 0x30
(reading 0x0)
[   25.145506] pcieport 0000:00:1c.0: saving config space at offset 0x34
(reading 0x40)
[   25.145510] pcieport 0000:00:1c.0: saving config space at offset 0x38
(reading 0x0)
[   25.145515] pcieport 0000:00:1c.0: saving config space at offset 0x3c
(reading 0x201ff)
[   25.145604] pcieport 0000:00:1c.0: PME# enabled
[   26.265697] pcieport 0000:00:1c.0: power state changed by ACPI to D3cold
[   45.468365] random: crng init done
[  105.032727] usb 1-2: USB disconnect, device number 2  <= I removed a usb
key, didn't help
[  128.495144] async_tx: api initialized (async)
[  128.514820] device-mapper: uevent: version 1.0.3
[  128.518186] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised:
dm-devel at redhat.com
[  144.869445] e1000e 0000:00:1f.6 eth0: NIC Link is Down
[  172.851384] BTRFS: device label btrfs_pool4 devid 1 transid 78270 /dev/sdb4
scanned by btrfs (1293)
[  172.851648] BTRFS: device label btrfs_pool3 devid 1 transid 27410 /dev/sda5
scanned by btrfs (1293)
[  172.852030] BTRFS: device fsid de9694f8-9c0d-4e9d-bd12-57adc4381cd7 devid 1
transid 41 /dev/sda3 scanned by btrfs (1293)
[  172.852224] BTRFS: device fsid 23e1398d-e462-41aa-b85e-f574906ddc03 devid 1
transid 585 /dev/nvme0n1p4 scanned by btrfs (1293)
[  189.124291] nouveau 0000:01:00.0: disp ctor failed, -12
[  189.124530] nouveau: probe of 0000:01:00.0 failed with error -12

The next boot looks similar:
[   25.161759] pcieport 0000:00:1c.0: PME# enabled
[   26.297810] pcieport 0000:00:1c.0: power state changed by ACPI to D3cold
[  128.427270] async_tx: api initialized (async)
[  128.446525] device-mapper: uevent: version 1.0.3
[  128.446691] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised:
dm-devel at redhat.com
[  128.458120] random: cryptsetup: uninitialized urandom read (4 bytes read)
[  138.507373] random: cryptsetup: uninitialized urandom read (4 bytes read)
[  144.793573] e1000e 0000:00:1f.6 eth0: NIC Link is Down
[  159.627780] random: crng init done
[  171.814064] process '/usr/bin/fstype' started with executable stack
[  181.949989] BTRFS: device label btrfs_boot devid 1 transid 394687
/dev/mapper/cryptroot scanned by btrfs (1063)
[  181.953437] BTRFS: device label btrfs_pool4 devid 1 transid 78270 /dev/sdb4
scanned by btrfs (1063)
[  181.956989] BTRFS: device label btrfs_pool3 devid 1 transid 27410 /dev/sda5
scanned by btrfs (1063)
[  181.960473] BTRFS: device fsid de9694f8-9c0d-4e9d-bd12-57adc4381cd7 devid 1
transid 41 /dev/sda3 scanned by btrfs (1063)
[  181.964097] BTRFS: device fsid 23e1398d-e462-41aa-b85e-f574906ddc03 devid 1
transid 585 /dev/nvme0n1p4 scanned by btrfs (1063)
[  188.733645] nouveau 0000:01:00.0: disp ctor failed, -12
[  188.740653] nouveau: probe of 0000:01:00.0 failed with error -12
[  188.901070] PM: Image not found (code -22)

Does that help?

Thanks,
Marc
-- 
"A mouse is a device used to point at the xterm you want to type in" -
A.S.R.
 
Home page: http://marc.merlins.org/                       | PGP 7F55D5F27AAF9D08

On Mon, Sep 7, 2020 at 10:58 PM Marc MERLIN <marc_nouveau at merlins.org>
wrote:
>
> On Mon, Sep 07, 2020 at 09:14:03PM +0200, Karol Herbst wrote:
> > > - changes in the nouveau driver. Mika told me the PCIe regression
> > >   "pcieport 0000:00:01.0: PME: Spurious native
interrupt!" is supposed
> > >   to be fixed in 5.8, but I still get a 4mn hang or so during
boot and
> > >   with 5.8, removing the USB key, didn't help make the boot
faster
> >
> > that's the root port the GPU is attached to, no? I saw that
message on
> > the Thinkpad P1G2 when runtime resuming the Nvidia GPU, but it does
> > seem to come from the root port.
>
> Hi Karol, thanks for your answer.
>
> 00:01.0 PCI bridge: Intel Corporation Xeon E3-1200 v5/E3-1500 v5/6th Gen
Core Processor PCIe Controller (x16) (rev 0d)
> 01:00.0 VGA compatible controller: NVIDIA Corporation TU104GLM [Quadro RTX
4000 Mobile / Max-Q] (rev a1)
>
> > Well, you'd also need it when attaching external displays.
>
> Indeed. I just don't need that on this laptop, but familiar with the
not
> so seemless procedure to turn on both GPUs, and mirror the intel one into
> the nvidia one for external output.
>
> > > [   11.262985] nvidia-gpu 0000:01:00.3: PME# enabled
> > > [   11.303060] nvidia-gpu 0000:01:00.3: PME# disabled
> >
> > mhh, interesting. I heard some random comments that the Nvidia
> > USB-C/UCSI driver is a bit broken and can cause various issues. Mind
> > blacklisting i2c-nvidia-gpu and typec_nvidia (and verify they
don't
> > get loaded) and see if that helps?
>
> Right, this one:
> 01:00.3 Serial bus controller [0c80]: NVIDIA Corporation TU104 USB Type-C
UCSI Controller (rev a1)
> Sure, I'll blacklist it. Ok, just did that, removed from initrd,
> rebooted, and it was no better.
>
> From initrd (before root gets mounted), I have this:
> nouveau              1961984  0
> mxm_wmi                16384  1 nouveau
> hwmon                  32768  1 nouveau
> ttm                   102400  1 nouveau
> wmi                    32768  2 nouveau,mxm_wmi
>
> I still got a 2mn hang. and a nouveau probe error
> [  189.124530] nouveau: probe of 0000:01:00.0 failed with error -12
>
>
> Here's what it looks like:
> [    9.693230] hid: raw HID events driver (C) Jiri Kosina
> [    9.694988] usbcore: registered new interface driver usbhid
> [    9.694989] usbhid: USB HID core driver
> [    9.696700] hid-generic 0003:1050:0200.0001: hiddev0,hidraw0: USB HID
v1.00 Device [Yubico Yubico Gnubby (gnubby1)] on usb-0000:00:14.0-2/input0
> [    9.784456] Console: switching to colour frame buffer device 240x67
> [    9.816297] i915 0000:00:02.0: fb0: i915drmfb frame buffer device
> [   25.087400] thunderbolt 0000:06:00.0: saving config space at offset 0x0
(reading 0x15eb8086)
> [   25.087414] thunderbolt 0000:06:00.0: saving config space at offset 0x4
(reading 0x100406)
> [   25.087419] thunderbolt 0000:06:00.0: saving config space at offset 0x8
(reading 0x8800006)
> [   25.087424] thunderbolt 0000:06:00.0: saving config space at offset 0xc
(reading 0x20)
> [   25.087430] thunderbolt 0000:06:00.0: saving config space at offset 0x10
(reading 0xcc100000)
> [   25.087435] thunderbolt 0000:06:00.0: saving config space at offset 0x14
(reading 0xcc140000)
> [   25.087440] thunderbolt 0000:06:00.0: saving config space at offset 0x18
(reading 0x0)
> [   25.087445] thunderbolt 0000:06:00.0: saving config space at offset 0x1c
(reading 0x0)
> [   25.087450] thunderbolt 0000:06:00.0: saving config space at offset 0x20
(reading 0x0)
> [   25.087455] thunderbolt 0000:06:00.0: saving config space at offset 0x24
(reading 0x0)
> [   25.087460] thunderbolt 0000:06:00.0: saving config space at offset 0x28
(reading 0x0)
> [   25.087466] thunderbolt 0000:06:00.0: saving config space at offset 0x2c
(reading 0x229b17aa)
> [   25.087471] thunderbolt 0000:06:00.0: saving config space at offset 0x30
(reading 0x0)
> [   25.087476] thunderbolt 0000:06:00.0: saving config space at offset 0x34
(reading 0x80)
> [   25.087481] thunderbolt 0000:06:00.0: saving config space at offset 0x38
(reading 0x0)
> [   25.087486] thunderbolt 0000:06:00.0: saving config space at offset 0x3c
(reading 0x1ff)
> [   25.087571] thunderbolt 0000:06:00.0: PME# enabled
> [   25.105353] pcieport 0000:05:00.0: saving config space at offset 0x0
(reading 0x15ea8086)
> [   25.105364] pcieport 0000:05:00.0: saving config space at offset 0x4
(reading 0x100407)
> [   25.105370] pcieport 0000:05:00.0: saving config space at offset 0x8
(reading 0x6040006)
> [   25.105375] pcieport 0000:05:00.0: saving config space at offset 0xc
(reading 0x10020)
> [   25.105380] pcieport 0000:05:00.0: saving config space at offset 0x10
(reading 0x0)
> [   25.105384] pcieport 0000:05:00.0: saving config space at offset 0x14
(reading 0x0)
> [   25.105389] pcieport 0000:05:00.0: saving config space at offset 0x18
(reading 0x60605)
> [   25.105394] pcieport 0000:05:00.0: saving config space at offset 0x1c
(reading 0x1f1)
> [   25.105399] pcieport 0000:05:00.0: saving config space at offset 0x20
(reading 0xcc10cc10)
> [   25.105404] pcieport 0000:05:00.0: saving config space at offset 0x24
(reading 0x1fff1)
> [   25.105409] pcieport 0000:05:00.0: saving config space at offset 0x28
(reading 0x0)
> [   25.105413] pcieport 0000:05:00.0: saving config space at offset 0x2c
(reading 0x0)
> [   25.105418] pcieport 0000:05:00.0: saving config space at offset 0x30
(reading 0x0)
> [   25.105423] pcieport 0000:05:00.0: saving config space at offset 0x34
(reading 0x80)
> [   25.105428] pcieport 0000:05:00.0: saving config space at offset 0x38
(reading 0x0)
> [   25.105432] pcieport 0000:05:00.0: saving config space at offset 0x3c
(reading 0x201ff)
> [   25.105517] pcieport 0000:05:00.0: PME# enabled
> [   25.125367] pcieport 0000:04:00.0: saving config space at offset 0x0
(reading 0x15ea8086)
> [   25.125378] pcieport 0000:04:00.0: saving config space at offset 0x4
(reading 0x100007)
> [   25.125383] pcieport 0000:04:00.0: saving config space at offset 0x8
(reading 0x6040006)
> [   25.125388] pcieport 0000:04:00.0: saving config space at offset 0xc
(reading 0x10020)
> [   25.125393] pcieport 0000:04:00.0: saving config space at offset 0x10
(reading 0x0)
> [   25.125398] pcieport 0000:04:00.0: saving config space at offset 0x14
(reading 0x0)
> [   25.125403] pcieport 0000:04:00.0: saving config space at offset 0x18
(reading 0x510504)
> [   25.125407] pcieport 0000:04:00.0: saving config space at offset 0x1c
(reading 0x5141)
> [   25.125412] pcieport 0000:04:00.0: saving config space at offset 0x20
(reading 0xcc10b400)
> [   25.125417] pcieport 0000:04:00.0: saving config space at offset 0x24
(reading 0x3ff10001)
> [   25.125422] pcieport 0000:04:00.0: saving config space at offset 0x28
(reading 0x60)
> [   25.125427] pcieport 0000:04:00.0: saving config space at offset 0x2c
(reading 0x60)
> [   25.125431] pcieport 0000:04:00.0: saving config space at offset 0x30
(reading 0x0)
> [   25.125436] pcieport 0000:04:00.0: saving config space at offset 0x34
(reading 0x80)
> [   25.125441] pcieport 0000:04:00.0: saving config space at offset 0x38
(reading 0x0)
> [   25.125446] pcieport 0000:04:00.0: saving config space at offset 0x3c
(reading 0x201ff)
> [   25.125528] pcieport 0000:04:00.0: PME# enabled
> [   25.145423] pcieport 0000:00:1c.0: saving config space at offset 0x0
(reading 0xa3388086)
> [   25.145437] pcieport 0000:00:1c.0: saving config space at offset 0x4
(reading 0x100407)
> [   25.145445] pcieport 0000:00:1c.0: saving config space at offset 0x8
(reading 0x60400f0)
> [   25.145453] pcieport 0000:00:1c.0: saving config space at offset 0xc
(reading 0x810000)
> [   25.145460] pcieport 0000:00:1c.0: saving config space at offset 0x10
(reading 0x0)
> [   25.145464] pcieport 0000:00:1c.0: saving config space at offset 0x14
(reading 0x0)
> [   25.145469] pcieport 0000:00:1c.0: saving config space at offset 0x18
(reading 0x510400)
> [   25.145476] pcieport 0000:00:1c.0: saving config space at offset 0x1c
(reading 0x20006040)
> [   25.145484] pcieport 0000:00:1c.0: saving config space at offset 0x20
(reading 0xcc10b400)
> [   25.145488] pcieport 0000:00:1c.0: saving config space at offset 0x24
(reading 0x3ff10001)
> [   25.145493] pcieport 0000:00:1c.0: saving config space at offset 0x28
(reading 0x60)
> [   25.145497] pcieport 0000:00:1c.0: saving config space at offset 0x2c
(reading 0x60)
> [   25.145502] pcieport 0000:00:1c.0: saving config space at offset 0x30
(reading 0x0)
> [   25.145506] pcieport 0000:00:1c.0: saving config space at offset 0x34
(reading 0x40)
> [   25.145510] pcieport 0000:00:1c.0: saving config space at offset 0x38
(reading 0x0)
> [   25.145515] pcieport 0000:00:1c.0: saving config space at offset 0x3c
(reading 0x201ff)
> [   25.145604] pcieport 0000:00:1c.0: PME# enabled
> [   26.265697] pcieport 0000:00:1c.0: power state changed by ACPI to D3cold
> [   45.468365] random: crng init done
> [  105.032727] usb 1-2: USB disconnect, device number 2  <= I removed a
usb key, didn't help
> [  128.495144] async_tx: api initialized (async)
> [  128.514820] device-mapper: uevent: version 1.0.3
> [  128.518186] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised:
dm-devel at redhat.com
> [  144.869445] e1000e 0000:00:1f.6 eth0: NIC Link is Down
> [  172.851384] BTRFS: device label btrfs_pool4 devid 1 transid 78270
/dev/sdb4 scanned by btrfs (1293)
> [  172.851648] BTRFS: device label btrfs_pool3 devid 1 transid 27410
/dev/sda5 scanned by btrfs (1293)
> [  172.852030] BTRFS: device fsid de9694f8-9c0d-4e9d-bd12-57adc4381cd7
devid 1 transid 41 /dev/sda3 scanned by btrfs (1293)
> [  172.852224] BTRFS: device fsid 23e1398d-e462-41aa-b85e-f574906ddc03
devid 1 transid 585 /dev/nvme0n1p4 scanned by btrfs (1293)
> [  189.124291] nouveau 0000:01:00.0: disp ctor failed, -12
> [  189.124530] nouveau: probe of 0000:01:00.0 failed with error -12
>
> The next boot looks similar:
> [   25.161759] pcieport 0000:00:1c.0: PME# enabled
> [   26.297810] pcieport 0000:00:1c.0: power state changed by ACPI to D3cold
> [  128.427270] async_tx: api initialized (async)
> [  128.446525] device-mapper: uevent: version 1.0.3
> [  128.446691] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised:
dm-devel at redhat.com
> [  128.458120] random: cryptsetup: uninitialized urandom read (4 bytes
read)
> [  138.507373] random: cryptsetup: uninitialized urandom read (4 bytes
read)
> [  144.793573] e1000e 0000:00:1f.6 eth0: NIC Link is Down
> [  159.627780] random: crng init done
> [  171.814064] process '/usr/bin/fstype' started with executable
stack
> [  181.949989] BTRFS: device label btrfs_boot devid 1 transid 394687
/dev/mapper/cryptroot scanned by btrfs (1063)
> [  181.953437] BTRFS: device label btrfs_pool4 devid 1 transid 78270
/dev/sdb4 scanned by btrfs (1063)
> [  181.956989] BTRFS: device label btrfs_pool3 devid 1 transid 27410
/dev/sda5 scanned by btrfs (1063)
> [  181.960473] BTRFS: device fsid de9694f8-9c0d-4e9d-bd12-57adc4381cd7
devid 1 transid 41 /dev/sda3 scanned by btrfs (1063)
> [  181.964097] BTRFS: device fsid 23e1398d-e462-41aa-b85e-f574906ddc03
devid 1 transid 585 /dev/nvme0n1p4 scanned by btrfs (1063)
> [  188.733645] nouveau 0000:01:00.0: disp ctor failed, -12
> [  188.740653] nouveau: probe of 0000:01:00.0 failed with error -12
oh, I somehow missed that "disp ctor failed" message. I think that
might explain why things are a bit hanging. From the top of my head I
am not sure if that's something known or something new. But just in
case I CCed Lyude and Ben. And I think booting with
nouveau.debug=disp=trace could already show something relevant.
> [  188.901070] PM: Image not found (code -22)
>
> Does that help?
>
> Thanks,
> Marc
> --
> "A mouse is a device used to point at the xterm you want to type
in" - A.S.R.
>
> Home page: http://marc.merlins.org/                       | PGP
7F55D5F27AAF9D08
>

On Tue, Sep 08, 2020 at 01:51:19AM +0200, Karol Herbst
wrote:
> oh, I somehow missed that "disp ctor failed" message. I think
that
> might explain why things are a bit hanging. From the top of my head I
> am not sure if that's something known or something new. But just in
> case I CCed Lyude and Ben. And I think booting with
> nouveau.debug=disp=trace could already show something relevant.
Thanks.
I've added that to my boot for next time I reboot.

I'm moving some folks to Bcc now, and let's remove the lists other than
nouveau on followups (lkml and pci). I'm just putting a warning here
so that it shows up in other list archives and anyone finding this
later knows that they should look in the nouveau archives for further
updates/resolution.

Thanks,
Marc
-- 
"A mouse is a device used to point at the xterm you want to type in" -
A.S.R.
 
Home page: http://marc.merlins.org/                       | PGP 7F55D5F27AAF9D08