nouveau on NV04 calling illegal method 02fc under fbcon

Sun Nov 24 17:15:03 UTC 2019

Hi,

Trying a new kernel on old [NV04] system I get tons of 
  nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040
    [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0
    [DRM] subc 3 class 004a mthd 02fc data 00000003
errors when operating on console.

As I updated from 4.3 kernel, a bisect does not feel like the best start.

What is that 02fc method which fbcon is probably triggering as
hardware-acceleration on nouveau side.

Thanks,
Bruno

Below, a grep for nouveau on kernel log:

Nov 24 18:27:27 zeus kernel: Kernel command line: BOOT_IMAGE=5.3.12 ro root=802 slub_debug=FZP nouveau.runpm=1 nouveau.debug=debug console=ttyS0,115200 nouveau.agpmode=0
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: NVIDIA NV04 (20044001)
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: trying PRAMIN...
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: 00000260: NPDE signature (9b030041) unknown
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: 00000000: type 00, 32768 bytes
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: scored 4
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: trying PROM...
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: 00000000: ROM signature (0000) unknown
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: image 0 invalid
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: scored 0
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: trying ACPI...
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: using image from PRAMIN
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: 00000260: NPDE signature (9b030041) unknown
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: 00000260: NPDE signature (9b030041) unknown
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: BMP version 1.1
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: version 02.04.19.00.00
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: DCB table not found
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: i2c: ccb 00: type 00 drive 3f sense 3e share ff auxch cb
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: DCB table not found
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: i2c: ccb 01: type 00 drive 37 sense 36 share ff auxch cb
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: DCB table not found
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: bios: DCB table not found
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: disp: head-0: ctor
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: disp: head-1: ctor
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:00000080: init running...
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: putting AGP V2 device into 0x mode
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: unknown input clock freq
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: input frequency : 0Hz
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: numerator       : 00000001
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: denominator     : 00000001
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: timer frequency : 0Hz
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: time low        : 87dbe4df
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: tmr: time high       : 00000000
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: fb: 16 MiB SDRAM
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: clk: --:   
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:00000080: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:00000080: init completed in 80915us
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:80000009: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:80000009: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:80000009: init completed in 6315us
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:8000000d: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:8000000d: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:8000000d: init completed in 6319us
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:00000000: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:00000000: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM-master:00000000:00000000: init completed in 6317us
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000080: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000080: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000080: init completed in 5713us
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:80000009: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:80000009: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:80000009: init completed in 5664us
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:8000000d: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:8000000d: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:8000000d: init completed in 5663us
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: DRM: VRAM: 15 MiB
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: DRM: GART: 64 MiB
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: DRM: BMP version 1.1
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: DRM: No DCB data found in VBIOS
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: i2c: bus 0000: probing TV encoders
Nov 24 18:27:27 zeus kernel: nouveau 0000:01:00.0: i2c: bus 0000: no devices found.
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: init children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: init completed in 5751us
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: fini children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: fini running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: fini completed in 5622us
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: destroy children...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: destroy running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: destroy completed in 5892us...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: init running...
Nov 24 18:27:27 zeus kernel: nouveau: DRM:00000000:00000002: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000002: init completed in 5709us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:0000006b: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:0000006b: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:0000006b: init completed in 5665us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000002:0000003d: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000002:0000003d: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000002:0000003d: init completed in 5666us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000003:0000003d: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000003:0000003d: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000003:0000003d: init completed in 5712us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000006e:fffffffc: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000000: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000000: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000000: init completed in 5710us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000006e:fffffffc: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000006e:fffffffc: init completed in 23391us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:55550000:fffffffc: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:55550000:fffffffc: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:55550000:fffffffc: init completed in 5714us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000006:0000003d: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000006:0000003d: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:80000006:0000003d: init completed in 5665us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000039:00000039: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000000: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000000: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000000: init completed in 5705us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000039:00000039: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000039:00000039: init completed in 23339us
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: DRM: MM: using M2MF for buffer copies
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: bios: DCB table not found
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000046: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000046: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:00000046: init completed in 5664us
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: DRM: Saving VGA fonts
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: DRM: No DCB data found in VBIOS
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:ffffffff: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:ffffffff: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000000:ffffffff: init completed in 5711us
Nov 24 18:27:28 zeus kernel: nouveau: DRM-master:00000000:00000000: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM-master:00000000:00000000: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM-master:00000000:00000000: init completed in 6320us
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:00000080: init running...
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:00000080: init children...
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:00000080: init completed in 6320us
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:80000009: init running...
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:80000009: init children...
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:80000009: init completed in 6320us
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:8000000d: init running...
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:8000000d: init children...
Nov 24 18:27:28 zeus kernel: nouveau: swapper[1]:00000000:8000000d: init completed in 6317us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000062:00000042: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000062:00000042: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000062:00000042: init completed in 5719us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000019:00000019: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000019:00000019: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000019:00000019: init completed in 5712us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000043:00000043: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000043:00000043: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000043:00000043: init completed in 5667us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000044:00000044: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000044:00000044: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:00000044:00000044: init completed in 5667us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000004a:0000004a: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000004a:0000004a: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000004a:0000004a: init completed in 5712us
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000005f:0000005f: init running...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000005f:0000005f: init children...
Nov 24 18:27:28 zeus kernel: nouveau: DRM:0000005f:0000005f: init completed in 5712us
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 2 class 005f mthd 019c data 000018a6
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 2 class 005f mthd 02fc data 00000003
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 0198 data 000018a6
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 0188 data 000018a9
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 018c data 000018a8
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: DRM: allocated 1280x1024 fb: 0x4000, bo (ptrval)
Nov 24 18:27:28 zeus kernel: fbcon: nouveaudrmfb (fb0) is primary device
Nov 24 18:27:28 zeus kernel: nouveau 0000:01:00.0: fb0: nouveaudrmfb frame buffer device
Nov 24 18:27:28 zeus kernel: [drm] Initialized nouveau 1.3.1 20120801 for 0000:01:00.0 on minor 0
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
Nov 24 18:28:10 zeus kernel: nouveau 0000:01:00.0: gr: intr 00000001 [NOTIFY] nsource 00000040 [ILLEGAL_MTHD] nstatus 00004000 [PROTECTION_FAULT] ch 0 [DRM] subc 3 class 004a mthd 02fc data 00000003
...