Bug 219590
| Summary: | Linux 6.13 ucsi driver error: drivers/usb/typec/ucsi/ucsi.c:1374 ucsi_reset_ppm | ||
|---|---|---|---|
| Product: | Drivers | Reporter: | Guido (guido.iodice) |
| Component: | USB | Assignee: | Default virtual assignee for Drivers/USB (drivers_usb) |
| Status: | NEW --- | ||
| Severity: | normal | CC: | christian.rohmann, dion, dominik, guido.iodice, jacklivingood, pchelkin, tr.ml |
| Priority: | P3 | ||
| Hardware: | All | ||
| OS: | Linux | ||
| Kernel Version: | Subsystem: | ||
| Regression: | No | Bisected commit-id: | |
| Attachments: | [PATCH] usb: typec: ucsi: increase timeout for PPM reset operations | ||
|
Description
Guido
2024-12-11 13:23:00 UTC
It seems that it is not the only problematic module... 30.12.2024 21:54:45:030 kernel ------------[ cut here ]------------ 30.12.2024 21:54:45:030 kernel WARNING: CPU: 7 PID: 337 at kernel/trace/trace_events.c:577 trace_event_raw_init+0x159/0x660 30.12.2024 21:54:45:030 kernel Modules linked in: ee1004(+) intel_rapl_msr iTCO_vendor_support intel_ishtp_hid xe(+) snd_hda_codec mei_hdcp dell_pc aesni_intel mei_pxp ext4 platform_profile mac80211 processor_thermal_device_pci_legacy snd_hda_core gf128mul processor_thermal_device crypto_simd processor_thermal_wt_hint processor_thermal_rfim cryptd crc32c_generic snd_hwdep crc32c_intel rapl libarc4 crc16 snd_pcm processor_thermal_rapl drm_gpuvm intel_cstate dell_laptop mbcache drm_exec dell_wmi jbd2 cfg80211 intel_rapl_common intel_uncore dell_smbios snd_timer gpu_sched i2c_i801 processor_thermal_wt_req intel_lpss_pci snd spi_nor i2c_smbus intel_lpss dcdbas processor_thermal_power_floor drm_ttm_helper mousedev pcspkr psmouse dell_wmi_ddv dell_smm_hwmon dell_wmi_sysman ucsi_acpi firmware_attributes_class dell_wmi_descriptor wmi_bmof soundcore mtd rfkill i2c_mux mei_me intel_ish_ipc typec_ucsi thunderbolt processor_thermal_mbox drm_suballoc_helper mei intel_soc_dts_iosf typec idma64 intel_ishtp igen6_edac roles intel_pmc_core intel_vsec 30.12.2024 21:54:45:030 kernel intel_hid i2c_hid_acpi int3400_thermal pmt_telemetry acpi_pad sparse_keymap acpi_tad acpi_thermal_rel int3403_thermal i2c_hid pmt_class pinctrl_tigerlake int340x_thermal_zone mac_hid tcp_bbr sch_fq uhid i2c_dev sg crypto_user dm_mod loop nfnetlink zram 842_decompress 842_compress ip_tables x_tables ums_realtek uas hid_generic usb_storage usbhid f2fs crc32_generic lz4hc_compress lz4_compress intel_agp i915 nvme serio_raw atkbd libps2 vivaldi_fmap nvme_core spi_intel_pci crc32_pclmul spi_intel nvme_auth i8042 serio i2c_algo_bit drm_buddy video wmi ttm drm_display_helper cec intel_gtt 30.12.2024 21:54:45:030 kernel CPU: 7 UID: 0 PID: 337 Comm: (udev-worker) Tainted: G U 6.13.0-rc4-1-MANJARO #1 515edb1355c850f35d54202d85225258c9f8bcd2 30.12.2024 21:54:45:030 kernel Tainted: [U]=USER 30.12.2024 21:54:45:030 kernel Hardware name: Dell Inc. Inspiron 5502/0WNVYK, BIOS 1.33.1 11/15/2024 30.12.2024 21:54:45:030 kernel RIP: 0010:trace_event_raw_init+0x159/0x660 30.12.2024 21:54:45:030 kernel Code: 89 ea 0f 83 3b 04 00 00 e8 44 db ff ff 84 c0 74 10 8b 0c 24 48 c7 c0 fe ff ff ff 48 d3 c0 49 21 c6 4d 85 f6 0f 84 d6 fe ff ff <0f> 0b bb 01 00 00 00 41 f6 c6 01 0f 85 77 0c d5 ff 66 0f 1f 44 00 30.12.2024 21:54:45:031 kernel RSP: 0018:ffffa9c2c072fa80 EFLAGS: 00010206 30.12.2024 21:54:45:031 kernel RAX: ffffffffffffffdf RBX: ffffffffc18eabd1 RCX: 0000000000000005 30.12.2024 21:54:45:031 kernel RDX: 0000000000000002 RSI: 0000000000000001 RDI: ffffffffc18eabc7 30.12.2024 21:54:45:031 kernel RBP: ffffffffc18eaae0 R08: 0000000000000039 R09: 0000000000000000 30.12.2024 21:54:45:031 kernel R10: 0000000000000076 R11: 000000000000004e R12: 00000000000000f2 30.12.2024 21:54:45:031 kernel R13: ffffffffc18ebc00 R14: 0000000000000018 R15: 0000000000000000 30.12.2024 21:54:45:031 kernel FS: 000075edb2cda880(0000) GS:ffff9608ff780000(0000) knlGS:0000000000000000 30.12.2024 21:54:45:031 kernel CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 30.12.2024 21:54:45:031 kernel CR2: 00005cdbf6268648 CR3: 0000000160ec8004 CR4: 0000000000f70ef0 30.12.2024 21:54:45:031 kernel PKRU: 55555554 30.12.2024 21:54:45:031 kernel Call Trace: 30.12.2024 21:54:45:031 kernel <TASK> 30.12.2024 21:54:45:031 kernel ? trace_event_raw_init+0x159/0x660 30.12.2024 21:54:45:031 kernel ? __warn.cold+0x93/0xf6 30.12.2024 21:54:45:031 kernel ? trace_event_raw_init+0x159/0x660 30.12.2024 21:54:45:031 kernel ? report_bug+0xff/0x140 30.12.2024 21:54:45:031 kernel ? handle_bug+0x58/0x90 30.12.2024 21:54:45:031 kernel ? exc_invalid_op+0x17/0x70 30.12.2024 21:54:45:031 kernel ? asm_exc_invalid_op+0x1a/0x20 30.12.2024 21:54:45:031 kernel ? trace_event_raw_init+0x159/0x660 30.12.2024 21:54:45:031 kernel event_init+0x28/0x70 30.12.2024 21:54:45:031 kernel trace_module_notify+0x1a4/0x250 30.12.2024 21:54:45:031 kernel notifier_call_chain+0x5a/0xd0 30.12.2024 21:54:45:031 kernel blocking_notifier_call_chain_robust+0x65/0xc0 30.12.2024 21:54:45:031 kernel load_module+0x19e4/0x1e30 30.12.2024 21:54:45:031 kernel ? __slab_free+0xdf/0x2f0 30.12.2024 21:54:45:031 kernel ? init_module_from_file+0x89/0xe0 30.12.2024 21:54:45:031 kernel init_module_from_file+0x89/0xe0 30.12.2024 21:54:45:031 kernel idempotent_init_module+0x115/0x310 30.12.2024 21:54:45:031 kernel __x64_sys_finit_module+0x65/0xc0 30.12.2024 21:54:45:031 kernel do_syscall_64+0x82/0x190 30.12.2024 21:54:45:031 kernel ? f2fs_llseek+0x3c/0x5f0 [f2fs 701ad704d498108fbe86dd92c040b46ed718418e] 30.12.2024 21:54:45:031 kernel ? syscall_exit_to_user_mode+0x37/0x1c0 30.12.2024 21:54:45:031 kernel ? clear_bhb_loop+0x25/0x80 30.12.2024 21:54:45:031 kernel ? clear_bhb_loop+0x25/0x80 30.12.2024 21:54:45:031 kernel ? clear_bhb_loop+0x25/0x80 30.12.2024 21:54:45:031 kernel entry_SYSCALL_64_after_hwframe+0x76/0x7e 30.12.2024 21:54:45:031 kernel RIP: 0033:0x75edb34d11fd 30.12.2024 21:54:45:031 kernel Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d e3 fa 0c 00 f7 d8 64 89 01 48 30.12.2024 21:54:45:031 kernel RSP: 002b:00007ffccf7c1618 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 30.12.2024 21:54:45:031 kernel RAX: ffffffffffffffda RBX: 00005cdbf623fb40 RCX: 000075edb34d11fd 30.12.2024 21:54:45:031 kernel RDX: 0000000000000004 RSI: 00005cdbf623c040 RDI: 000000000000001e 30.12.2024 21:54:45:031 kernel RBP: 00007ffccf7c16d0 R08: 0000000000000001 R09: 00007ffccf7c1660 30.12.2024 21:54:45:031 kernel R10: 0000000000000040 R11: 0000000000000246 R12: 00005cdbf623c040 30.12.2024 21:54:45:031 kernel R13: 0000000000020000 R14: 00005cdbf6240510 R15: 00005cdbf6242ef0 30.12.2024 21:54:45:031 kernel </TASK> 30.12.2024 21:54:45:031 kernel ---[ end trace 0000000000000000 ]--- A similar issue is being tracked here: https://forum.ubuntu-it.org/viewtopic.php?t=656839 Please send your _first_ message to LKML and CC lucas.demarchi@intel.com and ukaszb@chromium.org Don't know how this is related 13.01.2025 10:51:35:637 kernel ------------[ cut here ]------------ 13.01.2025 10:51:35:637 kernel workqueue: work disable count underflowed 13.01.2025 10:51:35:637 kernel WARNING: CPU: 1 PID: 25 at kernel/workqueue.c:4317 enable_work+0xdc/0x100 13.01.2025 10:51:35:637 kernel Modules linked in: 13.01.2025 10:51:35:637 kernel CPU: 1 UID: 0 PID: 25 Comm: cpuhp/1 Not tainted 6.13.0-rc6-1-MANJARO #1 0ff203b605de2496cb4d97c5ea24b610f623d28d 13.01.2025 10:51:35:637 kernel Hardware name: Dell Inc. Inspiron 5502/0WNVYK, BIOS 1.33.1 11/15/2024 13.01.2025 10:51:35:637 kernel RIP: 0010:enable_work+0xdc/0x100 13.01.2025 10:51:35:637 kernel Code: de 2e 02 00 74 04 31 ed eb b3 48 c7 c7 60 9e 08 9a 48 89 54 24 10 89 44 24 0c 48 89 34 24 c6 05 45 de 2e 02 01 e8 64 5e fd ff <0f> 0b 31 ed 48 8b 34 24 8b 44 24 0c 48 8b 54 24 10 eb 80 e8 4c cc 13.01.2025 10:51:35:637 kernel RSP: 0000:ffff9aa8c01bfe10 EFLAGS: 00010086 13.01.2025 10:51:35:637 kernel RAX: 0000000000000000 RBX: ffff8f6cbf4b1a40 RCX: 0000000000000003 13.01.2025 10:51:35:637 kernel RDX: 0000000000000000 RSI: 0000000000000003 RDI: 0000000000000001 13.01.2025 10:51:35:637 kernel RBP: ffff9aa8c01bfe28 R08: 0000000000000000 R09: ffff9aa8c01bfc90 13.01.2025 10:51:35:637 kernel R10: ffffffff9aab5408 R11: 0000000000000003 R12: 00000000000000c4 13.01.2025 10:51:35:637 kernel R13: ffffffff98be3b30 R14: 0000000000000000 R15: ffff8f6cbf4a1408 13.01.2025 10:51:35:637 kernel FS: 0000000000000000(0000) GS:ffff8f6cbf480000(0000) knlGS:0000000000000000 13.01.2025 10:51:35:637 kernel CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 13.01.2025 10:51:35:637 kernel CR2: 0000000000000000 CR3: 0000000330e22001 CR4: 0000000000f70ef0 13.01.2025 10:51:35:637 kernel PKRU: 55555554 13.01.2025 10:51:35:637 kernel Call Trace: 13.01.2025 10:51:35:637 kernel <TASK> 13.01.2025 10:51:35:637 kernel ? enable_work+0xdc/0x100 13.01.2025 10:51:35:637 kernel ? __warn.cold+0x93/0xf6 13.01.2025 10:51:35:637 kernel ? enable_work+0xdc/0x100 13.01.2025 10:51:35:637 kernel ? report_bug+0xff/0x140 13.01.2025 10:51:35:637 kernel ? handle_bug+0x58/0x90 13.01.2025 10:51:35:637 kernel ? exc_invalid_op+0x17/0x70 13.01.2025 10:51:35:637 kernel ? asm_exc_invalid_op+0x1a/0x20 13.01.2025 10:51:35:637 kernel ? __pfx_vmstat_cpu_online+0x10/0x10 13.01.2025 10:51:35:637 kernel ? enable_work+0xdc/0x100 13.01.2025 10:51:35:637 kernel vmstat_cpu_online+0x61/0x70 13.01.2025 10:51:35:637 kernel cpuhp_invoke_callback+0x11f/0x420 13.01.2025 10:51:35:637 kernel ? __pfx_smpboot_thread_fn+0x10/0x10 13.01.2025 10:51:35:637 kernel cpuhp_thread_fun+0xa2/0x170 13.01.2025 10:51:35:637 kernel smpboot_thread_fn+0xda/0x1d0 13.01.2025 10:51:35:637 kernel kthread+0xcf/0x100 13.01.2025 10:51:35:637 kernel ? __pfx_kthread+0x10/0x10 13.01.2025 10:51:35:637 kernel ret_from_fork+0x31/0x50 13.01.2025 10:51:35:637 kernel ? __pfx_kthread+0x10/0x10 13.01.2025 10:51:35:637 kernel ret_from_fork_asm+0x1a/0x30 13.01.2025 10:51:35:637 kernel </TASK> 13.01.2025 10:51:35:637 kernel ---[ end trace 0000000000000000 ]--- mmm it seems that rc7 doesn't give any problems. However this is only the first boot, I will check in the next few days whether the problem still occurs or not. sadly the problem is still there: 13.01.2025 19:40:36:297 kernel ------------[ cut here ]------------ 13.01.2025 19:40:36:297 kernel WARNING: CPU: 2 PID: 229 at drivers/usb/typec/ucsi/ucsi.c:1377 ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi] 13.01.2025 19:40:36:297 kernel Modules linked in: cmac algif_hash algif_skcipher af_alg bnep snd_ctl_led snd_soc_skl_hda_dsp snd_soc_intel_sof_board_helpers snd_sof_probes snd_soc_intel_hda_dsp_common snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic snd_hda_scodec_component snd_soc_dmic vfat fat snd_sof_pci_intel_tgl snd_sof_pci_intel_cnl snd_sof_intel_hda_generic soundwire_intel soundwire_cadence snd_sof_intel_hda_common intel_uncore_frequency snd_soc_hdac_hda intel_uncore_frequency_common snd_sof_intel_hda_mlink snd_sof_intel_hda snd_sof_pci hid_sensor_custom snd_sof_xtensa_dsp uvcvideo snd_sof videobuf2_vmalloc hid_sensor_hub uvc snd_sof_utils videobuf2_memops snd_soc_acpi_intel_match videobuf2_v4l2 snd_soc_acpi_intel_sdca_quirks intel_ishtp_hid soundwire_generic_allocation btusb videobuf2_common x86_pkg_temp_thermal snd_soc_acpi btrtl intel_powerclamp btintel soundwire_bus videodev btbcm coretemp snd_soc_sdca btmtk mc snd_soc_avs bluetooth kvm_intel snd_soc_hda_codec cdc_ether snd_hda_ext_core ath10k_pci usbnet kvm 13.01.2025 19:40:36:297 kernel snd_soc_core crct10dif_pclmul ath10k_core polyval_clmulni snd_compress polyval_generic hid_multitouch ac97_bus ghash_clmulni_intel sha512_ssse3 snd_pcm_dmaengine ath sha256_ssse3 sha1_ssse3 snd_hda_intel ee1004 aesni_intel dell_pc snd_intel_dspcfg intel_pmc_bxt gf128mul platform_profile iTCO_vendor_support mei_hdcp mei_pxp intel_rapl_msr snd_intel_sdw_acpi dell_laptop ext4 crypto_simd snd_hda_codec mac80211 cryptd snd_hda_core crc32c_generic processor_thermal_device_pci_legacy rapl r8152 processor_thermal_device crc32c_intel processor_thermal_wt_hint crc16 intel_cstate processor_thermal_rfim mii snd_hwdep mbcache libarc4 mousedev libphy joydev jbd2 dell_smm_hwmon intel_uncore dell_wmi ucsi_acpi snd_pcm processor_thermal_rapl i2c_i801 dell_wmi_ddv cfg80211 snd_timer intel_rapl_common processor_thermal_wt_req spi_nor intel_lpss_pci psmouse typec_ucsi processor_thermal_power_floor dell_smbios pcspkr mei_me i2c_smbus i2c_hid_acpi snd intel_lpss intel_ish_ipc dell_wmi_sysman dcdbas processor_thermal_mbox typec 13.01.2025 19:40:36:297 kernel firmware_attributes_class dell_wmi_descriptor wmi_bmof intel_pmc_core mei soundcore mtd rfkill i2c_mux thunderbolt idma64 intel_ishtp roles igen6_edac intel_soc_dts_iosf i2c_hid intel_vsec int3400_thermal pmt_telemetry int3403_thermal intel_hid int340x_thermal_zone acpi_pad acpi_tad acpi_thermal_rel pmt_class pinctrl_tigerlake sparse_keymap mac_hid tcp_bbr sch_fq uhid i2c_dev sg crypto_user dm_mod loop nfnetlink zram 842_decompress 842_compress ip_tables x_tables hid_generic ums_realtek uas usbhid usb_storage f2fs crc32_generic lz4hc_compress lz4_compress intel_agp serio_raw atkbd nvme libps2 vivaldi_fmap nvme_core spi_intel_pci crc32_pclmul spi_intel nvme_auth i8042 serio i915 i2c_algo_bit drm_buddy video wmi ttm drm_display_helper cec intel_gtt 13.01.2025 19:40:36:297 kernel CPU: 2 UID: 0 PID: 229 Comm: kworker/2:2 Tainted: G U 6.13.0-rc7-1-MANJARO #1 56395ce4eea9ed2b7ba363d4072cdedaa9dbb7e4 13.01.2025 19:40:36:297 kernel Tainted: [U]=USER 13.01.2025 19:40:36:297 kernel Hardware name: Dell Inc. Inspiron 5502/0WNVYK, BIOS 1.33.1 11/15/2024 13.01.2025 19:40:36:297 kernel Workqueue: events_long ucsi_init_work [typec_ucsi] 13.01.2025 19:40:36:297 kernel RIP: 0010:ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi] 13.01.2025 19:40:36:297 kernel Code: 8b 44 24 04 a9 00 00 00 08 0f 85 36 ff ff ff 4c 89 74 24 10 48 8b 05 8b fe e0 f5 49 39 c5 79 8f bb 92 ff ff ff e9 1b ff ff ff <0f> 0b e9 50 ff ff ff e8 f0 5d ad f4 90 90 90 90 90 90 90 90 90 90 13.01.2025 19:40:36:297 kernel RSP: 0018:ffffb816c05d7db0 EFLAGS: 00010206 13.01.2025 19:40:36:297 kernel RAX: 0000000008000000 RBX: 0000000000000000 RCX: 0000000000000002 13.01.2025 19:40:36:297 kernel RDX: 00000000fffeab3c RSI: ffffb816c05d7db4 RDI: ffff8b72c0d00a00 13.01.2025 19:40:36:297 kernel RBP: ffff8b72c0d00a00 R08: 0000000000000000 R09: 0000000000000014 13.01.2025 19:40:36:297 kernel R10: 0000000000000001 R11: 0000000000000000 R12: ffffb816c05d7db4 13.01.2025 19:40:36:297 kernel R13: 00000000fffeab35 R14: ffff8b72c0d00a60 R15: ffff8b72c0d00ac0 13.01.2025 19:40:36:298 kernel FS: 0000000000000000(0000) GS:ffff8b763f500000(0000) knlGS:0000000000000000 13.01.2025 19:40:36:298 kernel CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 13.01.2025 19:40:36:298 kernel CR2: 00005ce06429a4a0 CR3: 00000002b7222004 CR4: 0000000000f72ef0 13.01.2025 19:40:36:298 kernel PKRU: 55555554 13.01.2025 19:40:36:298 kernel Call Trace: 13.01.2025 19:40:36:298 kernel <TASK> 13.01.2025 19:40:36:298 kernel ? ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi 6a404df311e90ab27e191f01403d346931166551] 13.01.2025 19:40:36:298 kernel ? __warn.cold+0x93/0xf6 13.01.2025 19:40:36:298 kernel ? ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi 6a404df311e90ab27e191f01403d346931166551] 13.01.2025 19:40:36:298 kernel ? report_bug+0xff/0x140 13.01.2025 19:40:36:298 kernel ? handle_bug+0x58/0x90 13.01.2025 19:40:36:298 kernel ? exc_invalid_op+0x17/0x70 13.01.2025 19:40:36:298 kernel ? asm_exc_invalid_op+0x1a/0x20 13.01.2025 19:40:36:298 kernel ? ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi 6a404df311e90ab27e191f01403d346931166551] 13.01.2025 19:40:36:298 kernel ucsi_init_work+0x3c/0x9c0 [typec_ucsi 6a404df311e90ab27e191f01403d346931166551] 13.01.2025 19:40:36:298 kernel process_one_work+0x17b/0x330 13.01.2025 19:40:36:298 kernel worker_thread+0x2ce/0x3f0 13.01.2025 19:40:36:298 kernel ? __pfx_worker_thread+0x10/0x10 13.01.2025 19:40:36:298 kernel kthread+0xcf/0x100 13.01.2025 19:40:36:298 kernel ? __pfx_kthread+0x10/0x10 13.01.2025 19:40:36:298 kernel ret_from_fork+0x31/0x50 13.01.2025 19:40:36:298 kernel ? __pfx_kthread+0x10/0x10 13.01.2025 19:40:36:298 kernel ret_from_fork_asm+0x1a/0x30 13.01.2025 19:40:36:298 kernel </TASK> 13.01.2025 19:40:36:298 kernel ---[ end trace 0000000000000000 ]--- This was reported downstream in Fedora as well: https://bugzilla.redhat.com/show_bug.cgi?id=2323584 . Hi, is this warning reproducible on your system only during the initial startup/booting the kernel? If you then manually load/unload 'ucsi_acpi' module, are there any errors observed in the log? Do you have something like the following in the kernel log (dmesg)? Does it happen when the WARNING occurs or when it does not occur? [ 6.482546] ucsi_acpi USBC000:00: failed to reset PPM! [ 6.482551] ucsi_acpi USBC000:00: error -ETIMEDOUT: PPM init failed I've also encountered these "failed to init PPM" errors and the WARNING. Looks like PPM is not quickly responsive at the kernel startup phase. That's strange but as a straightforward solution the attached patch helped me. It turns out that it takes around 8000ms for the PPM on my laptop to start responding during kernel startup when the selected timeout in the code is 5000ms. You can check the patch. If it still won't help, try increasing the timeout some more. Otherwise, the cause seems to be hidden in another place.. Also checked various kernels, and "failed to init PPM" errors go back to 5.12 kernel at least on my system so that's probably not a recent regression. I'm not talking about the WARNING - it appeared much-much later and probably just revealed the problem clearer. See https://lore.kernel.org/linux-usb/Z18hJM55ED2hYJ6D@lappy/t/#u Created attachment 307567 [details]
[PATCH] usb: typec: ucsi: increase timeout for PPM reset operations
(In reply to Fedor Pchelkin from comment #7) > See https://lore.kernel.org/linux-usb/Z18hJM55ED2hYJ6D@lappy/t/#u And this contains a patch proposed by Christian A. Ehrhardt. You can try this, too, of course. But in my case it unfortunately didn't help. (In reply to Fedor Pchelkin from comment #7) > Hi, > > is this warning reproducible on your system only during the initial > startup/booting the kernel? If you then manually load/unload 'ucsi_acpi' > module, are there any errors observed in the log? only during boot > > Do you have something like the following in the kernel log (dmesg)? Does it > happen when the WARNING occurs or when it does not occur? > > [ 6.482546] ucsi_acpi USBC000:00: failed to reset PPM! > [ 6.482551] ucsi_acpi USBC000:00: error -ETIMEDOUT: PPM init failed Yes, something similar but in the call trace 03.02.2025 18:12:39:741 WARNING CPU: 2 PID: 35 at drivers/usb/typec/ucsi/ucsi.c:1377 ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi] 03.02.2025 18:12:39:741 RIP 0010:ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi] 03.02.2025 18:12:39:741 ? ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi 231559ee5125add8a822ef3f41338af7860410e9] 03.02.2025 18:12:39:741 ? ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi 231559ee5125add8a822ef3f41338af7860410e9] 03.02.2025 18:12:39:741 ? ucsi_reset_ppm+0x1b4/0x1c0 [typec_ucsi 231559ee5125add8a822ef3f41338af7860410e9] Sorry for the stupid question, how do I recompile only the module and not the entire kernel after patching? (In reply to Guido from comment #11) > Sorry for the stupid question, how do I recompile only the module and not > the entire kernel after patching? Well, googling "compile a single kernel module" gives a lot of useful links. I think the top ones will contain the needed info.. E.g. https://yoursunny.com/t/2018/one-kernel-module/ Any success with that ..? The procedure is a bit outdated but I found an updated one specifically for Arch on their wiki. I'm testing it. So far it seems OK. Thank you! I see it in 6.14rc3: [ 11.560861] WARNING: CPU: 4 PID: 81 at drivers/usb/typec/ucsi/ucsi.c:1377 ucsi_reset_ppm+0x1ad/0x1c0 [typec_ucsi] [ 11.560897] Modules linked in: dm_crypt raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor async_tx xor raid6_pq raid1 raid0 linear dm_mirror dm_region_hash dm_log hid_logitech_hidpp hid_logitech_dj hid_generic usbhid hid polyval_clmulni rtsx_pci_sdmmc polyval_generic ghash_clmulni_intel nvme thinkpad_acpi ucsi_acpi sha256_ssse3 sha1_ssse3 e1000e psmouse nvram nvme_core rtsx_pci intel_lpss_pci typec_ucsi nvme_auth intel_lpss snd typec idma64 soundcore sparse_keymap video platform_profile wmi pinctrl_cannonlake aesni_intel crypto_simd cryptd [ 11.561052] CPU: 4 UID: 0 PID: 81 Comm: kworker/4:1 Not tainted 6.14.0-061400rc3-generic #202502181422 [ 11.561064] Hardware name: LENOVO 20Q5CTO1WW/20Q5CTO1WW, BIOS R0ZET58W (1.36 ) 02/22/2024 [ 11.561072] Workqueue: events_long ucsi_init_work [typec_ucsi] [ 11.561096] RIP: 0010:ucsi_reset_ppm+0x1ad/0x1c0 [typec_ucsi] [ 11.561115] Code: ff 8b 55 bc 81 e2 00 00 00 08 0f 85 33 ff ff ff 4c 89 75 c8 48 8b 05 52 9d 10 dc 49 39 c5 79 94 b8 92 ff ff ff e9 19 ff ff ff <0f> 0b e9 57 ff ff ff e8 e7 28 01 db 0f 1f 80 00 00 00 00 90 90 90 [ 11.561123] RSP: 0018:ffffad1600363d70 EFLAGS: 00010206 [ 11.561134] RAX: 0000000008000000 RBX: ffff9e340ec78000 RCX: 0000000000000000 [ 11.561141] RDX: 00000000fffb97aa RSI: 0000000000000000 RDI: 0000000000000000 [ 11.561146] RBP: ffffad1600363dc0 R08: 0000000000000000 R09: 0000000000000000 [ 11.561152] R10: 0000000000000000 R11: 0000000000000000 R12: ffffad1600363d7c [ 11.561157] R13: 00000000fffb9797 R14: ffff9e340ec78020 R15: ffff9e340ec780c0 [ 11.561164] FS: 0000000000000000(0000) GS:ffff9e3b5e600000(0000) knlGS:0000000000000000 [ 11.561172] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 11.561178] CR2: 00005bd21fb4c028 CR3: 0000000170240004 CR4: 00000000003706f0 [ 11.561186] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 11.561190] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 11.561196] Call Trace: [ 11.561202] <TASK> [ 11.561209] ? show_trace_log_lvl+0x1be/0x310 [ 11.561224] ? show_trace_log_lvl+0x1be/0x310 [ 11.561237] ? ucsi_init+0x2bc/0x310 [typec_ucsi] [ 11.561257] ? show_regs.part.0+0x22/0x30 [ 11.561267] ? show_regs.cold+0x8/0x10 [ 11.561277] ? ucsi_reset_ppm+0x1ad/0x1c0 [typec_ucsi] [ 11.561293] ? __warn.cold+0xac/0x10c [ 11.561304] ? ucsi_reset_ppm+0x1ad/0x1c0 [typec_ucsi] [ 11.561320] ? report_bug+0x114/0x160 [ 11.561332] ? handle_bug+0x6e/0xb0 [ 11.561343] ? exc_invalid_op+0x18/0x80 [ 11.561354] ? asm_exc_invalid_op+0x1b/0x20 [ 11.561369] ? ucsi_reset_ppm+0x1ad/0x1c0 [typec_ucsi] [ 11.561386] ? ucsi_send_command_common+0xa4/0x120 [typec_ucsi] [ 11.561404] ucsi_init+0x2bc/0x310 [typec_ucsi] [ 11.561422] ucsi_init_work+0x18/0x90 [typec_ucsi] [ 11.561439] process_one_work+0x174/0x350 [ 11.561456] worker_thread+0x34a/0x480 [ 11.561464] ? _raw_spin_lock_irqsave+0xe/0x20 [ 11.561478] ? __pfx_worker_thread+0x10/0x10 [ 11.561486] kthread+0xf9/0x230 [ 11.561497] ? __pfx_kthread+0x10/0x10 [ 11.561508] ret_from_fork+0x44/0x70 [ 11.561518] ? __pfx_kthread+0x10/0x10 [ 11.561527] ret_from_fork_asm+0x1a/0x30 [ 11.561545] </TASK> [ 11.561549] ---[ end trace 0000000000000000 ]--- [ 11.601285] ucsi_acpi USBC000:00: error -ETIMEDOUT: PPM init failed 6.14rc5 still the same error. |