dmesg - *ERROR* (gt|render|vdbox0|vdbox2|vebox0|vebox1): timed out waiting for forcewake ack to clear
I am using an Intel Arc A380 on a freshly installed NixOS system in a Proxmox VM. The VM uses the card via PCI Passthrough.
I basically had the same issues as in #8328 (closed) and multiple closed issues. The Firmware not loading could be solved by installing the Firmware, but I still get the timed out errors:
EFI stub: Loaded initrd from command line option
<<< NixOS Stage 1 >>>
loading module virtio_balloon...
loading module virtio_console...
loading module virtio_rng...
loading module i915...
[ 1.385264] i915 0000:06:10.0: [drm] *ERROR* gt: timed out waiting for forcewake ack to clear.
[ 1.486764] i915 0000:06:10.0: [drm] *ERROR* render: timed out waiting for forcewake ack to clear.
[ 1.588163] i915 0000:06:10.0: [drm] *ERROR* vdbox0: timed out waiting for forcewake ack to clear.
[ 1.689506] i915 0000:06:10.0: [drm] *ERROR* vdbox2: timed out waiting for forcewake ack to clear.
[ 1.790845] i915 0000:06:10.0: [drm] *ERROR* vebox0: timed out waiting for forcewake ack to clear.
[ 1.892198] i915 0000:06:10.0: [drm] *ERROR* vebox1: timed out waiting for forcewake ack to clear.
loading module dm_mod...
running udev...
Starting version 251.15
kbd_mode: KDSKBMODE: Inappropriate ioctl for device
starting device mapper and LVM...
checking /dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e...
fsck (busybox 1.35.0)
[fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e
/dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e: clean, 583462/2064384 files, 3668023/8256354 blocks
mounting /dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e on /...
<<< NixOS Stage 2 >>>
running activation script...
setting up /etc...
starting systemd...
Welcome to NixOS 22.11 (Raccoon)!
[ OK ] Created slice Slice /system/getty.
[ OK ] Created slice Slice /system/modprobe.
[ OK ] Created slice Slice /system/serial-getty.
[ OK ] Created slice Slice /system/systemd-fsck.
[ OK ] Created slice User and Session Slice.
[ OK ] Started Dispatch Password …ts to Console Directory Watch.
[ OK ] Started Forward Password Ruests to Wall Directory Watch.
[ OK ] Reached target Local Encrypted Volumes.
[ OK ] Reached target Containers.
[ OK ] Reached target Path Units.
[ OK ] Reached target Remote File Systems.
[ OK ] Reached target Slice Units.
[ OK ] Reached target Swaps.
[ OK ] Listening on Process Core Dump Socket.
[ OK ] Listening on Journal Audit Socket.
[ OK ] Listening on Journal Socket (/dev/log).
[ OK ] Listening on Journal Socket.
[ OK ] Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
[ OK ] Listening on udev Control Socket.
[ OK ] Listening on udev Kernel Socket.
Mounting Huge Pages File System...
Mounting POSIX Message Queue File System...
Mounting Kernel Debug File System...
Starting Create List of Static Device Nodes...
Starting Load Kernel Module configfs...
Starting Load Kernel Module drm...
Starting Load Kernel Module fuse...
Starting mount-pstore.service...
Starting Journal Service...
Starting Load Kernel Modules...
Starting Remount Root and Kernel File Systems...
Starting Coldplug All udev Devices...
[ OK ] Mounted Huge Pages File System.
[ OK ] Mounted POSIX Message Queue File System.
[ OK ] Mounted Kernel Debug File System.
[ OK ] Finished Create List of Static Device Nodes.
[ OK ] Finished Load Kernel Module configfs.
[ OK ] Finished Load Kernel Module drm.
[ OK ] Finished Load Kernel Module fuse.
[ OK ] Started Journal Service.
[ OK ] Finished Load Kernel Modules.
[ OK ] Finished Remount Root and Kernel File Systems.
Mounting FUSE Control File System...
Mounting Kernel Configuration File System...
Starting Flush Journal to Persistent Storage...
Starting Load/Save Random Seed...
Starting Apply Kernel Variables...
Starting Create Static Device Nodes in /dev...
[ OK ] Mounted FUSE Control File System.
[ OK ] Mounted Kernel Configuration File System.
[ OK ] Finished Load/Save Random Seed.
[ OK ] Finished Coldplug All udev Devices.
[ OK ] Finished Apply Kernel Variables.
[ OK ] Finished Create Static Device Nodes in /dev.
[ OK ] Reached target Preparation for Local File Systems.
Starting Rule-based Manage…for Device Events and Files...
[ OK ] Finished Flush Journal to Persistent Storage.
[ OK ] Started Rule-based Manager for Device Events and Files.
[ OK ] Found device /dev/ttyS0.
[ OK ] Found device QEMU_HARDDISK 1.
Starting File System Check…/dev/disk/by-uuid/B4C3-F67E...
[ OK ] Found device Virtio network device.
[ OK ] Finished File System Check…n /dev/disk/by-uuid/B4C3-F67E.
Mounting /boot/efi...
[ OK ] Mounted /boot/efi.
[ OK ] Reached target Local File Systems.
Starting Create Volatile Files and Directories...
[ 4.366733] [drm:vmw_probe [vmwgfx]] *ERROR* Hardware has no pitchlock
[ OK ] Finished Create Volatile Files and Directories.
Starting Userspace Out-Of-Memory (OOM) Killer...
Starting Network Time Synchronization...
Starting Record System Boot/Shutdown in UTMP...
[ OK ] Finished mount-pstore.service.
[ OK ] Finished Record System Boot/Shutdown in UTMP.
[ OK ] Started Userspace Out-Of-Memory (OOM) Killer.
[ OK ] Started Network Time Synchronization.
[ OK ] Reached target System Initialization.
[ OK ] Started logrotate.timer.
[ OK ] Started Daily Cleanup of Temporary Directories.
[ OK ] Reached target Timer Units.
[ OK ] Listening on D-Bus System Message Bus Socket.
[ OK ] Listening on Nix Daemon Socket.
[ OK ] Reached target Socket Units.
[ OK ] Reached target Basic System.
Starting Network Manager Script Dispatcher Service...
Starting Kernel Auditing...
Starting Logrotate configuration check...
Starting Name Service Cache Daemon...
[ OK ] Started Run the QEMU Guest Agent.
[ OK ] Started Reset console on configuration changes.
Starting resolvconf update...
[ 4.584375] snd_hda_intel 0000:00:1b.0: no codecs found!
[ OK ] Finished Kernel Auditing.
[ OK ] Finished Logrotate configuration check.
[ OK ] Reached target Sound Card.
Starting D-Bus System Message Bus...
[ OK ] Started Name Service Cache Daemon.
[ OK ] Reached target Host and Network Name Lookups.
[ OK ] Reached target User and Group Name Lookups.
Starting User Login Management...
[ OK ] Finished resolvconf update.
[ OK ] Reached target Preparation for Network.
[ OK ] Reached target All Network Interfaces (deprecated).
Starting Address configuration of enp6s18...
[ OK ] Finished Address configuration of enp6s18.
Starting Networking Setup...
[ OK ] Started D-Bus System Message Bus.
Starting Network Manager...
[ OK ] Started User Login Management.
[ OK ] Started Network Manager Script Dispatcher Service.
[ OK ] Started Network Manager.
Starting Network Manager Wait Online...
Starting Hostname Service...
[ OK ] Stopped target Host and Network Name Lookups.
Stopping Host and Network Name Lookups...
[ OK ] Stopped target User and Group Name Lookups.
Stopping User and Group Name Lookups...
Stopping Name Service Cache Daemon...
[ OK ] Stopped Name Service Cache Daemon.
[ OK ] Finished Networking Setup.
[ OK ] Started Hostname Service.
[ OK ] Listening on Load/Save RF …itch Status /dev/rfkill Watch.
Starting Extra networking commands....
Starting Name Service Cache Daemon...
[ OK ] Finished Extra networking commands..
[ OK ] Reached target Network.
[ OK ] Started Jellyfin Media Server.
Starting SSH Daemon...
[ OK ] Finished Network Manager Wait Online.
[ OK ] Started SSH Daemon.
[ OK ] Reached target Network is Online.
Mounting /mnt/media...
[ OK ] Started Name Service Cache Daemon.
[ OK ] Reached target Host and Network Name Lookups.
[ OK ] Reached target User and Group Name Lookups.
Starting Permit User Sessions...
[ OK ] Finished Permit User Sessions.
[ OK ] Started Getty on tty1.
[ OK ] Started Serial Getty on ttyS0.
[ OK ] Reached target Login Prompts.
[ OK ] Reached target Multi-User System.
[ OK ] Mounted /mnt/media.
<<< Welcome to NixOS 22.11.4037.cc45a3f8c98 (x86_64) - ttyS0 >>>
I am on Kernel 6.3.1, same behaviour on Kernel 6.2.
When not loading the i915 module in initramfs but only in the later stage, there are a few more error messages. Also, in that case the Login takes forever (>1min) and systemd things in general are timing out. So even things like 'shutdown' do not work.
EFI stub: Loaded initrd from command line option
<<< NixOS Stage 1 >>>
loading module virtio_balloon...
loading module virtio_console...
loading module virtio_rng...
loading module dm_mod...
running udev...
Starting version 251.15
kbd_mode: KDSKBMODE: Inappropriate ioctl for device
starting device mapper and LVM...
checking /dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e...
fsck (busybox 1.35.0)
[fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e
/dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e: recovering journal
/dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e: clean, 583742/2064384 files, 3674658/8256354 blocks
mounting /dev/disk/by-uuid/a205fc61-6565-491f-8ec3-ffd9a2e3e70e on /...
<<< NixOS Stage 2 >>>
running activation script...
setting up /etc...
starting systemd...
Welcome to NixOS 22.11 (Raccoon)!
[ OK ] Created slice Slice /system/getty.
[ OK ] Created slice Slice /system/modprobe.
[ OK ] Created slice Slice /system/serial-getty.
[ OK ] Created slice Slice /system/systemd-fsck.
[ OK ] Created slice User and Session Slice.
[ OK ] Started Dispatch Password …ts to Console Directory Watch.
[ OK ] Started Forward Password R…uests to Wall Directory Watch.
[ OK ] Reached target Local Encrypted Volumes.
[ OK ] Reached target Containers.
[ OK ] Reached target Path Units.
[ OK ] Reached target Remote File Systems.
[ OK ] Reached target Slice Units.
[ OK ] Reached target Swaps.
[ OK ] Listening on Process Core Dump Socket.
[ OK ] Listening on Journal Audit Socket.
[ OK ] Listening on Journal Socket (/dev/log).
[ OK ] Listening on Journal Socket.
[ OK ] Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
[ OK ] Listening on udev Control Socket.
[ OK ] Listening on udev Kernel Socket.
Mounting Huge Pages File System...
Mounting POSIX Message Queue File System...
Mounting Kernel Debug File System...
Starting Create List of Static Device Nodes...
Starting Load Kernel Module configfs...
Starting Load Kernel Module drm...
Starting Load Kernel Module fuse...
Starting mount-pstore.service...
Starting Journal Service...
Starting Load Kernel Modules...
Starting Remount Root and Kernel File Systems...
Starting Coldplug All udev Devices...
[ OK ] Mounted Huge Pages File System.
[ OK ] Mounted POSIX Message Queue File System.
[ OK ] Mounted Kernel Debug File System.
[ OK ] Finished Create List of Static Device Nodes.
[ OK ] Finished Load Kernel Module configfs.
[ OK ] Finished Load Kernel Module fuse.
[ OK ] Finished Load Kernel Module drm.
[ OK ] Started Journal Service.
[ OK ] Finished Load Kernel Modules.
[ OK ] Finished Remount Root and Kernel File Systems.
Mounting FUSE Control File System...
Mounting Kernel Configuration File System...
Starting Flush Journal to Persistent Storage...
Starting Load/Save Random Seed...
Starting Apply Kernel Variables...
Starting Create Static Device Nodes in /dev...
[ OK ] Finished Coldplug All udev Devices.
[ OK ] Mounted FUSE Control File System.
[ OK ] Mounted Kernel Configuration File System.
[ OK ] Finished Load/Save Random Seed.
[ OK ] Finished Apply Kernel Variables.
[ OK ] Finished Create Static Device Nodes in /dev.
[ OK ] Reached target Preparation for Local File Systems.
Starting Rule-based Manage…for Device Events and Files...
[ OK ] Started Rule-based Manager for Device Events and Files.
[ OK ] Finished Flush Journal to Persistent Storage.
[ OK ] Found device /dev/ttyS0.
[ OK ] Found device Virtio network device.
[ OK ] Found device QEMU_HARDDISK 1.
Starting File System Check…/dev/disk/by-uuid/B4C3-F67E...
[ OK ] Finished File System Check…n /dev/disk/by-uuid/B4C3-F67E.
Mounting /boot/efi...
[ OK ] Mounted /boot/efi.
[ OK ] Reached target Local File Systems.
Starting Create Volatile Files and Directories...
[ OK ] Finished mount-pstore.service.
[ OK ] Finished Create Volatile Files and Directories.
[ 3.425610] snd_hda_intel 0000:00:1b.0: no codecs found!
Starting Userspace Out-Of-Memory (OOM) Killer...
Starting Network Time Synchronization...
Starting Record System Boot/Shutdown in UTMP...
[ OK ] Reached target Sound Card.
[ OK ] Finished Record System Boot/Shutdown in UTMP.
[ OK ] Started Userspace Out-Of-Memory (OOM) Killer.
[ OK ] Started Network Time Synchronization.
[ OK ] Reached target System Initialization.
[ OK ] Started logrotate.timer.
[ OK ] Started Daily Cleanup of Temporary Directories.
[ OK ] Reached target Timer Units.
[ OK ] Listening on D-Bus System Message Bus Socket.
[ OK ] Listening on Nix Daemon Socket.
[ OK ] Reached target Socket Units.
[ OK ] Reached target Basic System.
Starting Network Manager Script Dispatcher Service...
Starting Kernel Auditing...
Starting Logrotate configuration check...
Starting Name Service Cache Daemon...
[ OK ] Started Run the QEMU Guest Agent.
[ OK ] Started Reset console on configuration changes.
Starting resolvconf update...
[ OK ] Finished Kernel Auditing.
[ OK ] Finished Logrotate configuration check.
Starting D-Bus System Message Bus...
[ OK ] Started Name Service Cache Daemon.
[ OK ] Reached target Host and Network Name Lookups.
[ OK ] Reached target User and Group Name Lookups.
Starting User Login Management...
[ OK ] Stopped target Host and Network Name Lookups.
Stopping Host and Network Name Lookups...
[ OK ] Stopped target User and Group Name Lookups.
Stopping User and Group Name Lookups...
Stopping Name Service Cache Daemon...
[ OK ] Stopped Name Service Cache Daemon.
[ OK ] Finished resolvconf update.
[ OK ] Reached target Preparation for Network.
[ OK ] Reached target All Network Interfaces (deprecated).
Starting Address configuration of enp6s18...
Starting Name Service Cache Daemon...
[ OK ] Started D-Bus System Message Bus.
[ OK ] Finished Address configuration of enp6s18.
[ OK ] Started Name Service Cache Daemon.
[ OK ] Started User Login Management.
[ OK ] Started Network Manager Script Dispatcher Service.
[ OK ] Reached target Host and Network Name Lookups.
[ OK ] Reached target User and Group Name Lookups.
Starting Network Manager...
Starting Networking Setup...
[ OK ] Started Network Manager.
[ 4.155823] i915 0000:06:10.0: [drm] *ERROR* gt: timed out waiting for forcewake ack to clear.
Starting Network Manager Wait Online...
Starting Hostname Service...
[ OK ] Stopped target Host and Network Name Lookups.
Stopping Host and Network Name Lookups...
[ OK ] Stopped target User and Group Name Lookups.
Stopping User and Group Name Lookups...
Stopping Name Service Cache Daemon...
[ 4.261000] i915 0000:06:10.0: [drm] *ERROR* render: timed out waiting for forcewake ack to clear.
[ 4.362522] i915 0000:06:10.0: [drm] *ERROR* vdbox0: timed out waiting for forcewake ack to clear.
[ 4.463917] i915 0000:06:10.0: [drm] *ERROR* vdbox2: timed out waiting for forcewake ack to clear.
[ 4.565221] i915 0000:06:10.0: [drm] *ERROR* vebox0: timed out waiting for forcewake ack to clear.
[ 4.666556] i915 0000:06:10.0: [drm] *ERROR* vebox1: timed out waiting for forcewake ack to clear.
[ OK ] Finished Networking Setup.
[ OK ] Stopped Name Service Cache Daemon.
Starting Extra networking commands....
Starting Name Service Cache Daemon...
[ OK ] Finished Extra networking commands..
[ OK ] Started Hostname Service.
[ OK ] Reached target Network.
[ OK ] Started Jellyfin Media Server.
Starting SSH Daemon...
[ OK ] Started SSH Daemon.
[ OK ] Listening on Load/Save RF …itch Status /dev/rfkill Watch.
[ OK ] Started Name Service Cache Daemon.
[ OK ] Reached target Host and Network Name Lookups.
[ OK ] Reached target User and Group Name Lookups.
Starting Permit User Sessions...
[ OK ] Finished Permit User Sessions.
[ OK 4.801030] mei i915.mei-gscfi.1664-e2c2afa2-3817-4d19-9d95-06b16b588a5d: cannot connect
0m] Started Getty on tty1.
[ OK ] Started Serial Getty on ttyS0.
[ OK ] Reached target Login Prompts.
[ OK ] Finished Network Manager Wait Online.
[ OK ] Reached target Network is Online.
[ OK ] Reached target Multi-User System.
Mounting /mnt/media...
[ OK ] Mounted /mnt/media.
<<< Welcome to NixOS 22.11.4037.cc45a3f8c98 (x86_64) - ttyS0 >>>
Kernel Options:
boot.kernelParams = [ "console=tty0" "console=ttyS0,115200" "i915.enable_guc=3" ];
boot.initrd.kernelModules = [ "i915" ];
lshw output on VM:
[nix-shell:~]# lshw -C display
*-display UNCLAIMED
physical id: 1
bus info: pci@0000:00:01.0
version: 00
width: 32 bits
clock: 33MHz
configuration: latency=64
resources: ioport:a120(size=16) memory:c0000000-c0ffffff memory:c2c00000-c2c0ffff memory:c0000-dffff
*-display
physical id: 10
bus info: pci@0000:06:10.0
version: 05
width: 64 bits
clock: 33MHz
capabilities: msi pm bus_master cap_list rom
configuration: driver=i915 latency=0
resources: iomemory:80-7f irq:28 memory:c1000000-c1ffffff memory:800000000-80fffffff
lshw output on Host:
root@pve:~# lshw -C display
*-display
description: VGA compatible controller
product: ASPEED Graphics Family
vendor: ASPEED Technology, Inc.
physical id: 0
bus info: pci@0000:88:00.0
version: 41
width: 32 bits
clock: 33MHz
capabilities: pm msi vga_controller bus_master cap_list
configuration: driver=ast latency=0
resources: irq:306 memory:f5000000-f5ffffff memory:f6000000-f601ffff ioport:9000(size=128) memory:c0000-dffff
*-display
description: VGA compatible controller
product: Intel Corporation
vendor: Intel Corporation
physical id: 0
bus info: pci@0000:c3:00.0
version: 05
width: 64 bits
clock: 33MHz
capabilities: pciexpress msi pm vga_controller bus_master cap_list rom
configuration: driver=vfio-pci latency=0
resources: iomemory:1800-17ff irq:307 memory:b7000000-b7ffffff memory:18000000000-1800fffffff memory:b8000000-b81fffff