On Sat, Jan 29, 2022 at 1:50 PM Felipe Contreras <felipe.contreras@xxxxxxxxx> wrote: > > On Sat, Jan 29, 2022 at 1:12 PM James <bjlockie@xxxxxxxxx> wrote: > > > > Does dmesg show anything? > > It's hard to tell because it seems there are multiple conflating > issues. I booted into 5.16.3 again, and this time I experienced a > different problem, so far I've seen these two: > > 1. The device appears, but I'm unable to bring it up > 2. The device doesn't even appear I removed the nvidia driver and I was still able to reproduce issue #1. Here are the interesting bits: [ 2.295614] mt7921e 0000:02:00.0: enabling device (0000 -> 0002) [ 2.295810] mt7921e 0000:02:00.0: ASIC revision: 79610010 [ 2.377578] mt7921e 0000:02:00.0: HW/SW Version: 0x8a108a10, Build Time: 20220110230855a [ 2.846987] mt7921e 0000:02:00.0: WM Firmware Version: ____010000, Build Time: 20220110230951 [ 2.874395] mt7921e 0000:02:00.0: Firmware init done [ 7.374118] mt7921e 0000:02:00.0: Message 00020001 (seq 4) timeout [ 7.374180] mt7921e 0000:02:00.0: chip reset [ 13.773763] mt7921e 0000:02:00.0: Message 000046ed (seq 5) timeout [ 13.887279] mt7921e 0000:02:00.0: HW/SW Version: 0x8a108a10, Build Time: 20220110230855a [ 13.958763] mt7921e 0000:02:00.0: WM Firmware Version: ____010000, Build Time: 20220110230951 [ 13.989292] mt7921e 0000:02:00.0: Firmware init done [ 54.093979] mt7921e 0000:02:00.0: Message 00020001 (seq 10) timeout [ 54.094010] mt7921e 0000:02:00.0: chip reset [ 60.493981] mt7921e 0000:02:00.0: Message 000046ed (seq 11) timeout [ 60.600757] mt7921e 0000:02:00.0: HW/SW Version: 0x8a108a10, Build Time: 20220110230855a [ 60.672805] mt7921e 0000:02:00.0: WM Firmware Version: ____010000, Build Time: 20220110230951 [ 60.704784] mt7921e 0000:02:00.0: Firmware init done The last "Firmware init done" happened after I did "ip link set wlan0 up" which failed. Here's the full dmesg: https://dpaste.org/PVTE Yet another issue (#3) is that the kernel sometimes crashes when starting up the system. I've mostly ignored this issue, but looking at the log when that happens, it seems to be related to the mt7921 driver: Jan 29 14:21:58 chronos kernel: mt7921e 0000:02:00.0: Timeout for driver own Jan 29 14:21:58 chronos kernel: BUG: Bad page state in process systemd-udevd pfn:103328 Jan 29 14:21:58 chronos kernel: page:00000000128101f9 refcount:-1 mapcount:0 mapping:0000000000000000 index:0x0 pfn:0x103328 Jan 29 14:21:58 chronos kernel: flags: 0x2ffff0000000000(node=0|zone=2|lastcpupid=0xffff) Jan 29 14:21:58 chronos kernel: raw: 02ffff0000000000 dead000000000100 dead000000000122 0000000000000000 Jan 29 14:21:58 chronos kernel: raw: 0000000000000000 0000000000000000 ffffffffffffffff 0000000000000000 Jan 29 14:21:58 chronos kernel: page dumped because: nonzero _refcount Jan 29 14:21:58 chronos kernel: Modules linked in: bnep btusb btrtl btbcm ccm algif_aead cbc btintel des_generic libdes ecb bluetooth iptable_nat ecdh_generic hid_asus nf_nat algif_skcipher nf_conntrack cmac nf_defrag_ipv6 nf_defrag_ipv4 libcrc32c md4 algif_hash iptable_mangle iptable_filter af_alg intel_rapl_msr intel_rapl_common joydev mousedev mt7921e(+) mt7921_common snd_hda_codec_realtek mt76_connac_lib snd_hda_codec_generic edac_mce_amd ledtrig_audio mt76 snd_hda_codec_hdmi hid_multitouch snd_hda_intel mac80211 kvm_amd snd_intel_dspcfg vfat asus_nb_wmi snd_intel_sdw_acpi libarc4 fat amdgpu kvm irqbypass snd_hda_codec asus_wmi snd_pci_acp6x crct10dif_pclmul cfg80211 snd_hda_core sparse_keymap crc32_pclmul snd_hwdep ghash_clmulni_intel platform_profile snd_pcm aesni_intel i8042 snd_timer crypto_simd gpu_sched snd_pci_acp5x cryptd serio ucsi_acpi sp5100_tco snd drm_ttm_helper snd_rn_pci_acp3x rapl typec_ucsi pcspkr wmi_bmof rfkill ttm soundcore ccp snd_pci_acp3x i2c_piix4 k10temp tpm_crb typec tpm_tis Jan 29 14:21:58 chronos kernel: roles mac_hid tpm_tis_core i2c_hid_acpi tpm i2c_hid amd_pmc rng_core acpi_cpufreq asus_wireless pinctrl_amd pkcs8_key_parser crypto_user fuse bpf_preload ip_tables x_tables usbhid ext4 crc32c_generic crc16 mbcache jbd2 xhci_pci crc32c_intel xhci_pci_renesas wmi video Jan 29 14:21:58 chronos kernel: CPU: 12 PID: 396 Comm: systemd-udevd Tainted: G W 5.16.3-arch1-1 #1 ca51a3fe35922d501638d513dc9548a2c4fed987 Jan 29 14:21:58 chronos kernel: Hardware name: ASUSTeK COMPUTER INC. ROG Zephyrus G14 GA401QM_GA401QM/GA401QM, BIOS GA401QM.410 12/13/2021 Jan 29 14:21:58 chronos kernel: Call Trace: Jan 29 14:21:58 chronos kernel: <TASK> Jan 29 14:21:58 chronos kernel: dump_stack_lvl+0x48/0x66 Jan 29 14:21:58 chronos kernel: bad_page.cold+0x63/0x94 Jan 29 14:21:58 chronos kernel: free_pcppages_bulk+0x1f2/0x380 Jan 29 14:21:58 chronos kernel: free_unref_page+0xbd/0x140 Jan 29 14:21:58 chronos kernel: mt76_dma_rx_cleanup+0x94/0x120 [mt76 d94b4c9690089b7441d9b3262ec58606565d1b82] Jan 29 14:21:58 chronos kernel: mt7921_wpdma_reset+0xbc/0x1c0 [mt7921e 7e95012acfae7cc199e541d3b3dbe15de0128110] Jan 29 14:21:58 chronos kernel: mt7921_register_device+0x32b/0x5e0 [mt7921_common 19fe4291bf468cdc820d57b91bfc4be907d53377] Jan 29 14:21:58 chronos kernel: mt7921_pci_probe+0x1f1/0x230 [mt7921e 7e95012acfae7cc199e541d3b3dbe15de0128110] Jan 29 14:21:58 chronos kernel: ? __pm_runtime_resume+0x58/0x80 Jan 29 14:21:58 chronos kernel: local_pci_probe+0x45/0x90 Jan 29 14:21:58 chronos kernel: ? pci_match_device+0xdf/0x140 Jan 29 14:21:58 chronos kernel: pci_device_probe+0xcf/0x1c0 Jan 29 14:21:58 chronos kernel: really_probe+0x203/0x400 Jan 29 14:21:58 chronos kernel: __driver_probe_device+0x112/0x190 Jan 29 14:21:58 chronos kernel: driver_probe_device+0x1e/0x90 Jan 29 14:21:58 chronos kernel: __driver_attach+0xc8/0x1e0 Jan 29 14:21:58 chronos kernel: ? __device_attach_driver+0xf0/0xf0 Jan 29 14:21:58 chronos kernel: ? __device_attach_driver+0xf0/0xf0 Jan 29 14:21:58 chronos kernel: bus_for_each_dev+0x8d/0xe0 Jan 29 14:21:58 chronos kernel: bus_add_driver+0x154/0x200 Jan 29 14:21:58 chronos kernel: driver_register+0x8f/0xf0 Jan 29 14:21:58 chronos kernel: ? 0xffffffffc0753000 Jan 29 14:21:58 chronos kernel: do_one_initcall+0x57/0x220 Jan 29 14:21:58 chronos kernel: do_init_module+0x5c/0x270 Jan 29 14:21:58 chronos kernel: load_module+0x25d7/0x27a0 Jan 29 14:21:58 chronos kernel: ? __alloc_pages_bulk+0x5e7/0x740 Jan 29 14:21:58 chronos kernel: ? __do_sys_init_module+0x12e/0x1b0 Jan 29 14:21:58 chronos kernel: __do_sys_init_module+0x12e/0x1b0 Jan 29 14:21:58 chronos kernel: do_syscall_64+0x5c/0x90 Jan 29 14:21:58 chronos kernel: ? ksys_read+0x67/0xf0 Jan 29 14:21:58 chronos kernel: ? exc_page_fault+0x72/0x180 Jan 29 14:21:58 chronos kernel: entry_SYSCALL_64_after_hwframe+0x44/0xae Jan 29 14:21:58 chronos kernel: RIP: 0033:0x7f261332632e Jan 29 14:21:58 chronos kernel: Code: 48 8b 0d 45 0b 0c 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 49 89 ca b8 af 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 12 0b 0c 00 f7 d8 64 89 01 48 Jan 29 14:21:58 chronos kernel: RSP: 002b:00007ffd2b6d7fd8 EFLAGS: 00000246 ORIG_RAX: 00000000000000af Jan 29 14:21:58 chronos kernel: RAX: ffffffffffffffda RBX: 000056487d08e8b0 RCX: 00007f261332632e Jan 29 14:21:58 chronos kernel: RDX: 00007f261347aa9d RSI: 000000000002b3af RDI: 000056487d408720 Jan 29 14:21:58 chronos kernel: RBP: 000056487d408720 R08: 27d4eb2f165667c5 R09: 0000000000000000 Jan 29 14:21:58 chronos kernel: R10: 000056487d0c3830 R11: 0000000000000246 R12: 00007f261347aa9d Jan 29 14:21:58 chronos kernel: R13: 0000000000000001 R14: 000056487d0e5bd0 R15: 000056487d08e8b0 Jan 29 14:21:58 chronos kernel: </TASK> Jan 29 14:21:58 chronos kernel: Disabling lock debugging due to kernel taint This is not a regression though, as it happens in 5.16.2 too. Here's a full dmesg of the crash: http://dpaste.org/xtt5 -- Felipe Contreras
