Sure thing! Tracing it out, it seems to happen after the function psp_v11_0_ring_set_wptr is called, but I'm having trouble figuring out *why* the timing is messing it up. It also runs fine if any print statements are called before amdgpu_device_ip_init, however DRMDEBUG has to be disabled. It doesn't have issues with drm_msleep being called in place of kernel print statements either. The timeout error about the IB test only shows up about half the time. I've also tried increasing the timeout limit to see if that aided anything, but it still had the same error.
This is the output using a vanilla, precompiled kernel: Dec 3 12:24:08 tabr /bsd: amdgpu0: VEGA20 60 CU rev 0x01 Dec 3 12:24:08 tabr /bsd: amdgpu0: 2560x1440, 32bpp Dec 3 12:24:08 tabr /bsd: wsdisplay0 at amdgpu0 mux 1: console (std, vt100 emulation), using wskbd0 Dec 3 12:24:08 tabr /bsd: wskbd1: connecting to wsdisplay0 Dec 3 12:24:08 tabr /bsd: wskbd2: connecting to wsdisplay0 Dec 3 12:24:08 tabr /bsd: wskbd3: connecting to wsdisplay0 Dec 3 12:24:08 tabr /bsd: wskbd4: connecting to wsdisplay0 Dec 3 12:24:08 tabr /bsd: wsdisplay0: screen 1-5 added (std, vt100 emulation) Dec 3 12:24:08 tabr /bsd: iwm0: hw rev 0x310, fw ver 34.3125811985.0, address 38:00:25:26:6d:f3 Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* [gfxhub0] no-retry page fault (src_id:0 ring:222 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000066d000 from client 27 Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x000009BC Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x6 Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0xb Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x1 Dec 3 12:24:08 tabr /bsd: drm:pid38002:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 3 12:24:08 tabr /bsd: [drm] *ERROR* IB test failed on gfx (-60). Dec 3 12:24:08 tabr /bsd: [drm] *ERROR* ib ring test failed (-60). If DRMDEBUG is set, this mess pops out: Dec 1 11:39:01 tabr /bsd: [drm] initializing kernel modesetting (VEGA20 0x1002:0x66AF 0x1002:0x081E 0xC1). Dec 1 11:39:01 tabr /bsd: [drm] register mmio base: 0x9A200000 Dec 1 11:39:01 tabr /bsd: [drm] register mmio size: 524288 Dec 1 11:39:01 tabr /bsd: [drm] probing pcie caps for device 2:0:0 0x1002:0x14a1 = 3/e Dec 1 11:39:01 tabr /bsd: [drm] probing pcie width for device 2:0:0 0x1002:0x14a1 = 700d03 Dec 1 11:39:01 tabr /bsd: [drm] probing pcie caps for device 3:0:0 0x1002:0x66af = 3/e Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 0 <soc15_common> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 1 <gmc_v9_0> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 2 <vega10_ih> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 3 <psp> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 4 <gfx_v9_0> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 5 <sdma_v4_0> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 6 <powerplay> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 7 <dm> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 8 <uvd_v7_0> Dec 1 11:39:01 tabr /bsd: [drm] add ip block number 9 <vce_v4_0> Dec 1 11:39:01 tabr /bsd: [drm] ATOMBIOS detected Dec 1 11:39:01 tabr /bsd: ATOM BIOS: 113-D3600200-106 Dec 1 11:39:01 tabr /bsd: [drm] atom firmware requested 00000000 0kb fw 0kb drv Dec 1 11:39:01 tabr /bsd: [drm] Dec 1 11:39:01 tabr /bsd: [drm] psp_load == 'true' Dec 1 11:39:01 tabr /bsd: [drm] UVD(0) is enabled in VM mode Dec 1 11:39:01 tabr /bsd: [drm] UVD(1) is enabled in VM mode Dec 1 11:39:01 tabr /bsd: [drm] UVD(0) ENC is enabled in VM mode Dec 1 11:39:01 tabr /bsd: [drm] UVD(1) ENC is enabled in VM mode Dec 1 11:39:01 tabr /bsd: [drm] VCE enabled in VM mode Dec 1 11:39:01 tabr /bsd: [drm] HBM ECC is not presented. Dec 1 11:39:01 tabr /bsd: [drm] SRAM ECC is not presented. Dec 1 11:39:01 tabr /bsd: [drm] vm size is 262144 GB, 4 levels, block size is 9-bit, fragment size is 9-bit Dec 1 11:39:01 tabr /bsd: drm: VRAM: 16368M 0x0000008000000000 - 0x00000083FEFFFFFF (16368M used) Dec 1 11:39:01 tabr /bsd: drm: GART: 512M 0x0000000000000000 - 0x000000001FFFFFFF Dec 1 11:39:01 tabr /bsd: drm: AGP: 267894784M 0x0000008400000000 - 0x0000FFFFFFFFFFFF Dec 1 11:39:01 tabr /bsd: [drm] Detected VRAM RAM=16368M, BAR=256M Dec 1 11:39:01 tabr /bsd: [drm] RAM width 4096bits HBM Dec 1 11:39:01 tabr /bsd: [TTM] Zone kernel: Available graphics memory: 33512110 KiB Dec 1 11:39:01 tabr /bsd: [TTM] Zone dma32: Available graphics memory: 2097152 KiB Dec 1 11:39:01 tabr /bsd: [TTM] Initializing pool allocator Dec 1 11:39:01 tabr /bsd: [drm] memory training does not support! Dec 1 11:39:01 tabr /bsd: [drm] amdgpu: 16368M of VRAM memory ready Dec 1 11:39:01 tabr /bsd: [drm] amdgpu: 16368M of GTT memory ready. Dec 1 11:39:01 tabr /bsd: [drm] GART: num cpu pages 131072, num gpu pages 131072 Dec 1 11:39:01 tabr /bsd: [drm] PCIE GART of 512M enabled (table at 0x00000080012E6000). Dec 1 11:39:01 tabr /bsd: [drm] irq=-1 Dec 1 11:39:01 tabr /bsd: [drm] amdgpu: irq initialized. Dec 1 11:39:01 tabr /bsd: [drm] Dec 1 11:39:01 tabr /bsd: [drm] PSP Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 174992 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 44 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 11 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x00080b67 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 174736 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x04d34038 Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 0 Dec 1 11:39:01 tabr /bsd: [drm] sos_offset_bytes: 112528 Dec 1 11:39:01 tabr /bsd: [drm] sos_size_bytes: 62208 Dec 1 11:39:01 tabr /bsd: [drm] memory training is not supported! Dec 1 11:39:01 tabr /bsd: [drm] Memory training is not supported. Dec 1 11:39:01 tabr /bsd: [drm] Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring gfx use gpu addr 0x0000000000400040, cpu addr 0x0xfffffd904c2df040 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.0.0 use gpu addr 0x00000000004000e0, cpu addr 0x0xfffffd904c2df0e0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.1.0 use gpu addr 0x0000000000400180, cpu addr 0x0xfffffd904c2df180 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.2.0 use gpu addr 0x0000000000400220, cpu addr 0x0xfffffd904c2df220 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.3.0 use gpu addr 0x00000000004002c0, cpu addr 0x0xfffffd904c2df2c0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.0.1 use gpu addr 0x0000000000400360, cpu addr 0x0xfffffd904c2df360 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.1.1 use gpu addr 0x0000000000400400, cpu addr 0x0xfffffd904c2df400 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.2.1 use gpu addr 0x00000000004004a0, cpu addr 0x0xfffffd904c2df4a0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring comp_1.3.1 use gpu addr 0x0000000000400540, cpu addr 0x0xfffffd904c2df540 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring kiq_2.1.0 use gpu addr 0x0000000000400600, cpu addr 0x0xfffffd904c2df600 Dec 1 11:39:01 tabr /bsd: [drm] use_doorbell being set to: [true] Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring sdma0 use gpu addr 0x00000000004006a0, cpu addr 0x0xfffffd904c2df6a0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring page0 use gpu addr 0x0000000000400740, cpu addr 0x0xfffffd904c2df740 Dec 1 11:39:01 tabr /bsd: [drm] use_doorbell being set to: [true] Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring sdma1 use gpu addr 0x00000000004007e0, cpu addr 0x0xfffffd904c2df7e0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring page1 use gpu addr 0x0000000000400880, cpu addr 0x0xfffffd904c2df880 Dec 1 11:39:01 tabr /bsd: amdgpu: [powerplay] hwmgr_sw_init smu backed is vega20_smu Dec 1 11:39:01 tabr /bsd: [drm] SMC Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 262912 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 36 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x00283900 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 262656 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x807ed725 Dec 1 11:39:01 tabr /bsd: [drm] ucode_start_addr: 131072 Dec 1 11:39:01 tabr /bsd: amdgpu: [powerplay] powerplay sw init successfully Dec 1 11:39:01 tabr /bsd: [drm] Found UVD firmware ENC: 1.2 DEC: .43 Family ID: 19 Dec 1 11:39:01 tabr /bsd: [drm] PSP loading UVD firmware Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring uvd_0 use gpu addr 0x000000800146ca20, cpu addr 0x0xffff800017f49a20 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring uvd_enc_0.0 use gpu addr 0x00000000004009c0, cpu addr 0x0xfffffd904c2df9c0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring uvd_enc_0.1 use gpu addr 0x0000000000400a60, cpu addr 0x0xfffffd904c2dfa60 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring uvd_1 use gpu addr 0x00000080016d2a20, cpu addr 0x0xffff8000181afa20 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring uvd_enc_1.0 use gpu addr 0x0000000000400ba0, cpu addr 0x0xfffffd904c2dfba0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring uvd_enc_1.1 use gpu addr 0x0000000000400c40, cpu addr 0x0xfffffd904c2dfc40 Dec 1 11:39:01 tabr /bsd: [drm] Found VCE firmware Version: 57.6 Binary ID: 4 Dec 1 11:39:01 tabr /bsd: [drm] PSP loading VCE firmware Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring vce0 use gpu addr 0x0000000000400ce0, cpu addr 0x0xfffffd904c2dfce0 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring vce1 use gpu addr 0x0000000000400d80, cpu addr 0x0xfffffd904c2dfd80 Dec 1 11:39:01 tabr /bsd: [drm] fence driver on ring vce2 use gpu addr 0x0000000000400e20, cpu addr 0x0xfffffd904c2dfe20 Dec 1 11:39:01 tabr /bsd: [drm] reserve 0x400000 from 0x83fe800000 for PSP TMR Dec 1 11:39:01 tabr /bsd: [drm] SDMA Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 17408 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 48 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 4 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 2 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x00000090 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 17152 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0xa767b209 Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 42 Dec 1 11:39:01 tabr /bsd: [drm] ucode_change_version: 0 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 4096 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 64 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (0) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] SDMA Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 17408 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 48 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 4 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 2 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x00000090 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 17152 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0xa1b1cd3a Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 42 Dec 1 11:39:01 tabr /bsd: [drm] ucode_change_version: 0 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 4096 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 64 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (1) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] GFX Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 9344 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 44 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x0000004f Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 9088 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x53e6fcd0 Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 51 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 2048 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 96 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (8) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] GFX Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 21632 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 44 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x000000bb Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 21376 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x39e8455e Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 51 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 5120 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 96 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (9) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] GFX Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 17536 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 44 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x000000a4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 17280 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0xc7772444 Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 51 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 4096 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 96 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (10) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] GFX Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 268048 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 44 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x000001b8 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 267792 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x95f1964c Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 51 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 66724 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 224 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (11) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (12) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (13) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (14) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (17) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (18) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (19) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] RLC Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 49436 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 104 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 2 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 1 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x00000032 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 16896 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x629eddfb Dec 1 11:39:01 tabr /bsd: [drm] ucode_feature_version: 1 Dec 1 11:39:01 tabr /bsd: [drm] jt_offset: 0 Dec 1 11:39:01 tabr /bsd: [drm] jt_size: 0 Dec 1 11:39:01 tabr /bsd: [drm] save_and_restore_offset: 0 Dec 1 11:39:01 tabr /bsd: [drm] clear_state_descriptor_offset: 0 Dec 1 11:39:01 tabr /bsd: [drm] avail_scratch_ram_locations: 0 Dec 1 11:39:01 tabr /bsd: [drm] reg_restore_list_size: 95 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_start: 96 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_separate_start: 176 Dec 1 11:39:01 tabr /bsd: [drm] starting_offsets_start: 186 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_size_bytes: 268 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_array_offset_bytes: 17152 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_size_bytes: 14680 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_array_offset_bytes: 17420 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_separate_size_bytes: 0 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_separate_array_offset_bytes: 0 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_separate_size_bytes: 0 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_separate_array_offset_bytes: 0 Dec 1 11:39:01 tabr /bsd: [drm] reg_list_format_direct_reg_list_length: 36 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_cntl_ucode_ver: 1 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_cntl_feature_ver: 1 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_cntl_size_bytes 608 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_cntl_offset_bytes: 32100 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_gpm_ucode_ver: 1 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_gpm_feature_ver: 1 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_gpm_size_bytes 1536 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_gpm_offset_bytes: 32708 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_srm_ucode_ver: 1 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_srm_feature_ver: 1 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_srm_size_bytes 15192 Dec 1 11:39:01 tabr /bsd: [drm] save_restore_list_srm_offset_bytes: 34244 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (20) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] SMC Dec 1 11:39:01 tabr /bsd: [drm] size_bytes: 262912 Dec 1 11:39:01 tabr /bsd: [drm] header_size_bytes: 36 Dec 1 11:39:01 tabr /bsd: [drm] header_version_major: 1 Dec 1 11:39:01 tabr /bsd: [drm] header_version_minor: 0 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_major: 9 Dec 1 11:39:01 tabr /bsd: [drm] ip_version_minor: 4 Dec 1 11:39:01 tabr /bsd: [drm] ucode_version: 0x00283900 Dec 1 11:39:01 tabr /bsd: [drm] ucode_size_bytes: 262656 Dec 1 11:39:01 tabr /bsd: [drm] ucode_array_offset_bytes: 256 Dec 1 11:39:01 tabr /bsd: [drm] crc32: 0x807ed725 Dec 1 11:39:01 tabr /bsd: [drm] ucode_start_addr: 131072 Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (22) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (23) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (24) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: [drm] failed to load ucode id (25) [drm] psp command (0x6) failed and response status is (0xF) Dec 1 11:39:01 tabr /bsd: drm: HDCP: optional hdcp ta ucode is not available Dec 1 11:39:01 tabr /bsd: drm: DTM: optional dtm ta ucode is not available Dec 1 11:39:01 tabr /bsd: amdgpu: [powerplay] [Vega20StartSmu] SMC is not running! Dec 1 11:39:01 tabr /bsd: amdgpu: [powerplay] fw load failed Dec 1 11:39:01 tabr /bsd: smu firmware loading failed Dec 1 11:39:01 tabr /bsd: drm:pid0:amdgpu_device_init *ERROR* amdgpu_device_ip_init failed Dec 1 11:39:01 tabr /bsd: drm:pid0:amdgpu_attachhook *ERROR* Fatal error during GPU init Dec 1 11:39:01 tabr /bsd: efifb0 at mainbus0: 3440x1440, 32bpp Dec 1 11:39:01 tabr /bsd: wsdisplay0 at efifb0 mux 1: console (std, vt100 emulation), using wskbd0 Dec 1 11:39:01 tabr /bsd: [drm] amdgpu_ih_process: rptr 0, wptr 544 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000076d000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x0000473D Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x1 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x6 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x3 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x1 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000772000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000777000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000077a000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000780000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000785000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x00000000007c7000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x00000000007c8000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000080a000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000080b000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000080c000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x000000000080d000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000811000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000816000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000857000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x00000000008b5000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* [mmhub0] no-retry page fault (src_id:0 ring:158 vmid:0 pasid:0, for process pid 0 thread pid 0) Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* in page starting at address 0x0000000000913000 from client 18 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* VM_L2_PROTECTION_FAULT_STATUS:0x00000000 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MORE_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* WALKER_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* PERMISSION_FAULTS: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* MAPPING_ERROR: 0x0 Dec 1 11:39:01 tabr /bsd: drm:pid26158:gmc_v9_0_process_interrupt *ERROR* RW: 0x0 And lastly, if I put a printf statement anywhere within amdgpu_device_ip_init in an attempt to figure it out, I get the following message instead of the usual: Dec 3 14:45:59 tabr /bsd: [drm] *ERROR* ring kiq_2.1.0 test failed (-60) Dec 3 14:45:59 tabr /bsd: [drm] *ERROR* KCQ enable failed Dec 3 14:45:59 tabr /bsd: [drm] *ERROR* hw_init of IP block <gfx_v9_0> failed -60 Dec 3 14:45:59 tabr /bsd: drm:pid0:amdgpu_device_init *ERROR* amdgpu_device_ip_init failed Dec 3 14:45:59 tabr /bsd: drm:pid0:amdgpu_attachhook *ERROR* Fatal error during GPU init On Mon, Nov 30, 2020 at 2:24 AM Jonathan Gray <j...@jsg.id.au> wrote: > On Mon, Nov 30, 2020 at 12:02:15AM -0600, Charlie Burnett wrote: > > Doesn’t DRM_INFO output even if DRMDEBUG is enabled? I thought DRM_DEBUG > > only output when debug’s enabled while DRM_INFO is pretty much just a > > wrapper for printk? > > Currently DRM_INFO will call into printk which returns early for > KERN_INFO messages if DRMDEBUG is not set, see printk in drm_linux.c. > > > > > Either way, I found the call writing to the GPU register it doesn’t like > > earlier this weekend, but haven’t figured out what exactly it’s having > > issues with. Have a busy week or two but I’ll try to come back to it > then! > > Just wanted to send something in case anyone else had a similar issue. > > Including the error message you saw would be helpful. > > > > > On Sun, Nov 29, 2020 at 11:25 PM Jonathan Gray <j...@jsg.id.au> wrote: > > > > > On Sun, Nov 29, 2020 at 10:17:22PM -0600, Charlie Burnett wrote: > > > > Howdy all, > > > > For reasons that are beyond me, when printf is called in > amdgpu_device.c > > > to > > > > print the CU info, it gives me a psp firmware load failure on a > Radeon > > > VII > > > > (Vega 20) gpu. Switching the printf statement to a DRM_INFO > statement as > > > > used in the rest of amdgpu seems to fix it though. > > > > > > Find what is sensitive to the delay. > > > > > > Hiding this printf under DRMDEBUG makes no sense. You should be able > to > > > load kernels with and without DRMDEBUG. > > > > > > > > > > > ok? > > > > > > > > diff --git sys/dev/pci/drm/amd/amdgpu/amdgpu_device.c > > > > sys/dev/pci/drm/amd/amdgpu/amdgpu_device.c > > > > index 45eff483e86..fba5a7caf23 100644 > > > > --- sys/dev/pci/drm/amd/amdgpu/amdgpu_device.c > > > > +++ sys/dev/pci/drm/amd/amdgpu/amdgpu_device.c > > > > @@ -3210,7 +3210,7 @@ fence_driver_init: > > > > default: > > > > chip_name = amdgpu_asic_name[adev->asic_type]; > > > > } > > > > - printf("%s: %s %d CU rev 0x%02x\n", adev->self.dv_xname, > > > > + DRM_INFO( "%s: %s %d CU rev 0x%02x\n", adev->self.dv_xname, > > > > chip_name, adev->gfx.cu_info.number, adev->rev_id); > > > > } > > > > #endif > > > > > > > > > > > > >