re: kern/56245: NetBSD 9.2 amd64 with AMD FirePro W4100 throws constant kernel errors of 'Can't enable IRQ/MSI because no handler is installed'

["Andy Wallis" <rawallis%panix.com@localhost>]

> The following reply was made to PR kern/56245; it has been noted by GNATS.
>
> From: matthew green <mrg%eterna.com.au@localhost>
> To: gnats-bugs%netbsd.org@localhost
> Cc: kern-bug-people%netbsd.org@localhost, gnats-admin%netbsd.org@localhost,
>     netbsd-bugs%netbsd.org@localhost
> Subject: re: kern/56245: NetBSD 9.2 amd64 with AMD FirePro W4100 throws
> constant kernel errors of 'Can't enable IRQ/MSI because no handler is
> installed'
> Date: Mon, 14 Jun 2021 08:11:09 +1000
>
>  this is strange.
>
>  > Jun  4 18:33:45 vorlon /netbsd: [   8.6896180] radeon0: info: radeon:
> MS=
>  I limited to 32-bit
>  > Jun  4 18:33:45 vorlon /netbsd: [   8.6896180] radeon0: interrupting at
> =
>  ioapic0 pin 16 (radeon0)
>  > Jun  4 18:33:45 vorlon /netbsd: [   8.6896180] kern info: [drm] radeon:
> =
>  irq initialized.
>
>  so, MSI is not enabled, otherwise this message wuld appear:
>
>     dev_info(rdev->dev, "radeon: using MSI.\n");
>
>  > Jun  4 18:33:45 vorlon /netbsd: [   9.8597595] warning:
> /usr/src/sys/ext=
>  ernal/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't enable IRQ/MSI
> beca=
>  use no handler is installed
>
>  so, this seems impossible.  that message happens if
>  rdev->irq.installed is not set in si_irq_set().
>
>  si_startup() checks if it's not enabled, and then
>  calls radeon_irq_kms_init() to set it, which sets
>  installed =3D true, so the call a few lines later to
>  si_irq_set() should have it set, instead of the
>  error message it displays and doesn't setup.
>
>  i don't see a path that doesn't do this, but i guess
>  there's something i'm missing.
>
>  > spamming syslog messages.
>  > [ 428896.996373] kern error:
> [drm:(/usr/src/sys/external/bsd/drm2/dist/d=
>  rm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state] *ERROR*
> si_enable_s=
>  mc_cac fail ed
>
>  this happens on r600 as well, i never got around to look at why.
>
>
>  .mrg.
>
>
I did a clean boot on 9.2 and captured the following dmesg fragments
[     8.444818] radeon0: info: VRAM: 2048M 0x0000000000000000 -
0x000000007FFFFFFF (2048M used)
[     8.444818] radeon0: info: GTT: 2048M 0x0000000080000000 -
0x00000000FFFFFFFF
[     8.444818] kern info: [drm] Detected VRAM RAM=800M, BAR=256M
[     8.444818] kern info: [drm] RAM width 128bits DDR
[     8.444818] Zone  kernel: Available graphics memory: 11320412 kiB
[     8.444818] Zone   dma32: Available graphics memory: 2097152 kiB
[     8.444818] kern info: [drm] radeon: 2048M of VRAM memory ready
[     8.444818] kern info: [drm] radeon: 2048M of GTT memory ready.
[     8.444818] kern info: [drm] Loading verde Microcode
[     8.454748] kern info: [drm] radeon/VERDE_mc2.bin: 31500 bytes
[     8.454748] kern info: [drm] Internal thermal controller with fan control
[     8.464752] kern info: [drm] radeon: dpm initialized
[     8.464752] kern info: [drm] Found VCE firmware/feedback version
50.0.1 / 17!
[     8.464752] kern info: [drm] GART: num cpu pages 524288, num gpu pages
524288
[     8.534779] kern info: [drm] PCIE GART of 2048M enabled (table at
0x00000000002E8000).
[     8.534779] radeon0: info: WB enabled
[     8.534779] radeon0: info: fence driver on ring 0 use gpu addr
0x0000000080000c00 and cpu addr 0x0xffff818b45837c00
[     8.545446] radeon0: info: fence driver on ring 1 use gpu addr
0x0000000080000c04 and cpu addr 0x0xffff818b45837c04
[     8.545446] radeon0: info: fence driver on ring 2 use gpu addr
0x0000000080000c08 and cpu addr 0x0xffff818b45837c08
[     8.545446] radeon0: info: fence driver on ring 3 use gpu addr
0x0000000080000c0c and cpu addr 0x0xffff818b45837c0c
[     8.545446] radeon0: info: fence driver on ring 4 use gpu addr
0x0000000080000c10 and cpu addr 0x0xffff818b45837c10
[     8.545446] radeon0: info: fence driver on ring 5 use gpu addr
0x0000000000075a18 and cpu addr 0x0xffff98025a9c5a18
[     8.564790] radeon0: info: fence driver on ring 6 use gpu addr
0x0000000080000c18 and cpu addr 0x0xffff818b45837c18
[     8.564790] radeon0: info: fence driver on ring 7 use gpu addr
0x0000000080000c1c and cpu addr 0x0xffff818b45837c1c
[     8.564790] kern info: [drm] Supports vblank timestamp caching Rev 2
(21.10.2013).
[     8.564790] kern info: [drm] Driver supports precise vblank timestamp
query.
[     8.575482] radeon0: info: radeon: MSI limited to 32-bit
[     8.575482] radeon0: interrupting at ioapic0 pin 16 (radeon0)
[     8.575482] kern info: [drm] radeon: irq initialized.
[     9.285070] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_r600.c:2917)r600_ring_test]
*ERROR* radeon: ring 0 test failed (scratch(0x850C)=0xCAFEDEAD)
[     9.285070] radeon0: autoconfiguration error: error: disabling GPU
acceleration
[     9.465140] kern info: [drm] Radeon Display Connectors
[     9.465140] kern info: [drm] Connector 0:
[     9.465140] kern info: [drm]   DP-1
[     9.465140] kern info: [drm]   HPD4
[     9.475173] kern info: [drm]   DDC: 0x6540 0x6540 0x6544 0x6544 0x6548
0x6548 0x654c 0x654c
[     9.475173] kern info: [drm]   Encoders:
[     9.475173] kern info: [drm]     DFP1: INTERNAL_UNIPHY2
[     9.475173] kern info: [drm] Connector 1:
[     9.475173] kern info: [drm]   DP-2
[     9.475173] kern info: [drm]   HPD5
[     9.475173] kern info: [drm]   DDC: 0x6530 0x6530 0x6534 0x6534 0x6538
0x6538 0x653c 0x653c
[     9.475173] kern info: [drm]   Encoders:
[     9.475173] kern info: [drm]     DFP2: INTERNAL_UNIPHY1
[     9.475173] kern info: [drm] Connector 2:
[     9.475173] kern info: [drm]   DP-3
[     9.485572] kern info: [drm]   HPD1
[     9.485572] kern info: [drm]   DDC: 0x6560 0x6560 0x6564 0x6564 0x6568
0x6568 0x656c 0x656c
[     9.485572] kern info: [drm]   Encoders:
[     9.485572] kern info: [drm]     DFP3: INTERNAL_UNIPHY1
[     9.485572] kern info: [drm] Connector 3:
[     9.485572] kern info: [drm]   DP-4
[     9.485572] kern info: [drm]   HPD2
[     9.485572] kern info: [drm]   DDC: 0x6580 0x6580 0x6584 0x6584 0x6588
0x6588 0x658c 0x658c
[     9.485572] kern info: [drm]   Encoders:
[     9.485572] kern info: [drm]     DFP4: INTERNAL_UNIPHY
[     9.495151] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state]
*ERROR* si_enable_smc_cac failed
[     9.555175] radeondrmkmsfb0 at radeon0
[     9.555175] radeondrmkmsfb0: framebuffer at 0xffff98025abd3000, size
1920x1080, depth 32, stride 7680
[     9.735245] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state]
*ERROR* si_enable_smc_cac failed
[     9.745248] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.805272] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state]
*ERROR* si_enable_smc_cac failed
[     9.816040] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.845287] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.875299] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.925319] wsdisplay0 at radeondrmkmsfb0 kbdmux 1: console (default,
vt100 emulation), using wskbd0


I installed -current (9.99.84  /pub/NetBSD-daily/HEAD/202106121740Z)
Here is the dmesg output from it

     8.444818] kern info: ATOM BIOS: C755
[     8.444818] radeon0: info: VRAM: 2048M 0x0000000000000000 -
0x000000007FFFFFFF (2048M used)
[     8.444818] radeon0: info: GTT: 2048M 0x0000000080000000 -
0x00000000FFFFFFFF
[     8.444818] kern info: [drm] Detected VRAM RAM=800M, BAR=256M
[     8.444818] kern info: [drm] RAM width 128bits DDR
[     8.444818] Zone  kernel: Available graphics memory: 11320412 kiB
[     8.444818] Zone   dma32: Available graphics memory: 2097152 kiB
[     8.444818] kern info: [drm] radeon: 2048M of VRAM memory ready
[     8.444818] kern info: [drm] radeon: 2048M of GTT memory ready.
[     8.444818] kern info: [drm] Loading verde Microcode
[     8.454748] kern info: [drm] radeon/VERDE_mc2.bin: 31500 bytes
[     8.454748] kern info: [drm] Internal thermal controller with fan control
[     8.464752] kern info: [drm] radeon: dpm initialized
[     8.464752] kern info: [drm] Found VCE firmware/feedback version
50.0.1 / 17!
[     8.464752] kern info: [drm] GART: num cpu pages 524288, num gpu pages
524288
[     8.534779] kern info: [drm] PCIE GART of 2048M enabled (table at
0x00000000002E8000).
[     8.534779] radeon0: info: WB enabled
[     8.534779] radeon0: info: fence driver on ring 0 use gpu addr
0x0000000080000c00 and cpu addr 0x0xffff818b45837c00
[     8.545446] radeon0: info: fence driver on ring 1 use gpu addr
0x0000000080000c04 and cpu addr 0x0xffff818b45837c04
[     8.545446] radeon0: info: fence driver on ring 2 use gpu addr
0x0000000080000c08 and cpu addr 0x0xffff818b45837c08
[     8.545446] radeon0: info: fence driver on ring 3 use gpu addr
0x0000000080000c0c and cpu addr 0x0xffff818b45837c0c
[     8.545446] radeon0: info: fence driver on ring 4 use gpu addr
0x0000000080000c10 and cpu addr 0x0xffff818b45837c10
[     8.545446] radeon0: info: fence driver on ring 5 use gpu addr
0x0000000000075a18 and cpu addr 0x0xffff98025a9c5a18
[     8.564790] radeon0: info: fence driver on ring 6 use gpu addr
0x0000000080000c18 and cpu addr 0x0xffff818b45837c18
[     8.564790] radeon0: info: fence driver on ring 7 use gpu addr
0x0000000080000c1c and cpu addr 0x0xffff818b45837c1c
[     8.564790] kern info: [drm] Supports vblank timestamp caching Rev 2
(21.10.2013).
[     8.564790] kern info: [drm] Driver supports precise vblank timestamp
query.
[     8.564790] kern info: [drm] Driver supports precise vblank timestamp
query.
[     8.575482] radeon0: info: radeon: MSI limited to 32-bit
[     8.575482] radeon0: interrupting at ioapic0 pin 16 (radeon0)
[     8.575482] kern info: [drm] radeon: irq initialized.
[     9.285070] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_r600.c:2917)r600_ring_test]
*ERROR* radeon: ring 0 test failed (scratch(0x850C)=0xCAFEDEAD)
[     9.285070] radeon0: autoconfiguration error: error: disabling GPU
acceleration
[     9.465140] kern info: [drm] Radeon Display Connectors
[     9.465140] kern info: [drm] Connector 0:
[     9.465140] kern info: [drm]   DP-1
[     9.465140] kern info: [drm]   HPD4
[     9.475173] kern info: [drm]   DDC: 0x6540 0x6540 0x6544 0x6544 0x6548
0x6548 0x654c 0x654c
[     9.475173] kern info: [drm]   Encoders:
[     9.475173] kern info: [drm]     DFP1: INTERNAL_UNIPHY2
[     9.475173] kern info: [drm] Connector 1:
[     9.475173] kern info: [drm]   DP-2
[     9.475173] kern info: [drm]   HPD5
[     9.475173] kern info: [drm]   DDC: 0x6530 0x6530 0x6534 0x6534 0x6538
0x6538 0x653c 0x653c
[     9.475173] kern info: [drm]   Encoders:
[     9.475173] kern info: [drm]     DFP2: INTERNAL_UNIPHY1
[     9.475173] kern info: [drm] Connector 2:
[     9.475173] kern info: [drm]   DP-3
[     9.485572] kern info: [drm]   HPD1
[     9.485572] kern info: [drm]   DDC: 0x6560 0x6560 0x6564 0x6564 0x6568
0x6568 0x656c 0x656c
[     9.485572] kern info: [drm]   Encoders:
[     9.485572] kern info: [drm]     DFP3: INTERNAL_UNIPHY1
[     9.485572] kern info: [drm] Connector 3:
[     9.485572] kern info: [drm]   DP-4
[     9.485572] kern info: [drm]   HPD2
[     9.485572] kern info: [drm]   DDC: 0x6580 0x6580 0x6584 0x6584 0x6588
0x6588 0x658c 0x658c
[     9.485572] kern info: [drm]   Encoders:
[     9.485572] kern info: [drm]     DFP4: INTERNAL_UNIPHY
[     9.495151] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state]
*ERROR* si_enable_smc_cac failed
[     9.555175] radeondrmkmsfb0 at radeon0
[     9.555175] radeondrmkmsfb0: framebuffer at 0xffff98025abd3000, size
1920x1080, depth 32, stride 7680
[     9.735245] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state]
*ERROR* si_enable_smc_cac failed
[     9.745248] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.805272] kern error:
[drm:(/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si_dpm.c:6697)si_dpm_set_power_state]
*ERROR* si_enable_smc_cac failed
[     9.816040] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.845287] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.875299] warning:
/usr/src/sys/external/bsd/drm2/dist/drm/radeon/radeon_si.c:6101: Can't
enable IRQ/MSI because no handler is installed
[     9.925319] wsdisplay0 at radeondrmkmsfb0 kbdmux 1: console (default,
vt100 emulation), using wskbd0
[     9.946331] wsmux1: connecting to wsdisplay0