USB devices / hubs 'stuck' on resume after suspend while removing USB-C cable (using DSC) Ryzen 7 PRO 4750U
Brief summary of the problem:
A use case for my Lenovo Thinkpad P14s AMD Gen1 is using this device in multiple locations, equipped with docking stations (ThinkPad USB-C Dock Gen 2) or 'on the road' without a docking station. Depending on the sequence of suspending and removing the USB-C docking cable as well as the hardware combination in use (resulting in DSC being active or not) resuming the laptop renders it pretty much unusable.
Hardware description:
- Lenovo P14s AMD Gen1
- ThinkPad USB-C Dock Gen 2
- amd_s2idle report: <TODO: When debugging a s2idle issue, please capture a log using amd_s2idle.py > (will report later!)
System information:
- Distro name and Version:
Fedora 38
(up to date) - Kernel version:
6.4.14-200.fc38.x86_64
How to reproduce the issue:
There are generally four scenarios:
-
When using the laptop solely on docking stations and manually suspending the laptop without disconnecting it, everything works as expected and after wake up all devices are working (regardless of DSC being active or not).
-
When using the laptop on a docking station with 2x"sub 4k monitors" (no DSC), manually suspending the laptop and disconnecting it after suspending. After disconnecting the laptop and opening it (without any docking station attached) everything is working as expected, the laptop resumes and all devices are working.
-
When using the laptop on a docking station with 2x4k@60Hz displays (DSC active), manually suspending the laptop and disconnecting it after suspending. After disconnecting the laptop and opening it (without any docking station attached) some devices are broken, especially the touchscreen (ELAN Touchscreen) and
lsusb
is stuck indefinitely, seeing previous non existent devices. Additionally using some of the USB ports does not work anymore. Rebooting the laptop ends in being stuck on shutdown, only a hard reboot works. -
When using the laptop on a docking station with 2x4k@60Hz displays (DSC active), instead of manually suspending just disconnecting the USB-C cable and waiting for the laptop to automatically suspend. After the laptop suspends opening it (without any docking station attached) everything is working as expected, the laptop resumes and all devices are working.
This can easily be reproduced with the hardware configuration above as described. It seems to break the laptops internal USB hubs / hosts which the system can't recover from. Additionally scenario 4 shows this only occurs when DSC and a 'unexpected change of hardware' after suspend occurs at the same time.
Attached files:
Laptop suspended:
journalctl -b0 --no-pager
[...]
Sep 12 00:03:59 fedora systemd-logind[1498]: The system will suspend now!
Sep 12 00:03:59 fedora ModemManager[1586]: <info> [sleep-monitor-systemd] system is about to suspend
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.3435] manager: sleep: sleep requested (sleeping: no enabled: yes)
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.3442] device (enp2s0f0): state change: unavailable -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.3560] device (enp5s0): state change: unavailable -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.3675] device (p2p-dev-wlp3s0): state change: disconnected -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.3686] manager: NetworkManager state is now ASLEEP
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.3693] device (wlp3s0): state change: activated -> deactivating (reason 'sleeping', sys-iface-state: 'managed')
Sep 12 00:03:59 fedora systemd[1]: Starting NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service...
Sep 12 00:03:59 fedora systemd[1]: Started NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service.
Sep 12 00:03:59 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 00:03:59 fedora kernel: wlp3s0: deauthenticating from c4:ad:34:2d:a1:d5 by local choice (Reason: 3=DEAUTH_LEAVING)
Sep 12 00:03:59 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-DISCONNECTED bssid=c4:ad:34:2d:a1:d5 reason=3 locally_generated=1
Sep 12 00:03:59 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-DSCP-POLICY clear_all
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.4971] device (wlp3s0): supplicant interface state: completed -> disconnected
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.4974] device (wlp3s0): state change: deactivating -> disconnected (reason 'sleeping', sys-iface-state: 'managed')
Sep 12 00:03:59 fedora audit[1587]: NETFILTER_CFG table=firewalld:66 family=1 entries=5 op=nft_unregister_rule pid=1587 subj=system_u:system_r:firewalld_t:s0 comm="firewalld"
Sep 12 00:03:59 fedora avahi-daemon[1478]: Interface wlp3s0.IPv4 no longer relevant for mDNS.
Sep 12 00:03:59 fedora avahi-daemon[1478]: Leaving mDNS multicast group on interface wlp3s0.IPv4 with address <someip>.
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.5134] device (wlp3s0): set-hw-addr: set MAC address to <somemac> (scanning)
Sep 12 00:03:59 fedora avahi-daemon[1478]: Withdrawing address record for <someip> on wlp3s0.
Sep 12 00:03:59 fedora avahi-daemon[1478]: Joining mDNS multicast group on interface wlp3s0.IPv4 with address <someip>.
Sep 12 00:03:59 fedora avahi-daemon[1478]: New relevant interface wlp3s0.IPv4 for mDNS.
Sep 12 00:03:59 fedora avahi-daemon[1478]: Registering new address record for <someip> on wlp3s0.IPv4.
Sep 12 00:03:59 fedora avahi-daemon[1478]: Withdrawing address record for <someip> on wlp3s0.
Sep 12 00:03:59 fedora avahi-daemon[1478]: Leaving mDNS multicast group on interface wlp3s0.IPv4 with address <someip>.
Sep 12 00:03:59 fedora avahi-daemon[1478]: Interface wlp3s0.IPv4 no longer relevant for mDNS.
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.5355] device (wlp3s0): supplicant interface state: disconnected -> interface_disabled
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.5356] device (wlp3s0): supplicant interface state: interface_disabled -> disconnected
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.5358] device (wlp3s0): state change: disconnected -> unmanaged (reason 'sleeping', sys-iface-state: 'managed')
Sep 12 00:03:59 fedora NetworkManager[1609]: <info> [1694469839.6687] device (wlp3s0): set-hw-addr: reset MAC address to <somemac> (unmanage)
Sep 12 00:03:59 fedora wpa_supplicant[1782]: p2p-dev-wlp3s0: CTRL-EVENT-DSCP-POLICY clear_all
Sep 12 00:03:59 fedora wpa_supplicant[1782]: p2p-dev-wlp3s0: CTRL-EVENT-DSCP-POLICY clear_all
Sep 12 00:03:59 fedora wpa_supplicant[1782]: nl80211: deinit ifname=p2p-dev-wlp3s0 disabled_11b_rates=0
Sep 12 00:03:59 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-DSCP-POLICY clear_all
Sep 12 00:03:59 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-DSCP-POLICY clear_all
Sep 12 00:03:59 fedora wpa_supplicant[1782]: nl80211: deinit ifname=wlp3s0 disabled_11b_rates=0
Sep 12 00:03:59 fedora kernel: [drm] Send DSC disable to synaptics
[...]
Sep 12 00:04:00 fedora solaar[3498]: gtk_widget_get_scale_factor: assertion 'GTK_IS_WIDGET (widget)' failed
Sep 12 00:04:01 fedora systemd[1]: Reached target sleep.target - Sleep.
Sep 12 00:04:01 fedora systemd[1]: Starting systemd-suspend.service - System Suspend...
Sep 12 00:04:01 fedora systemd-sleep[39572]: Currently on mains.
Sep 12 00:04:01 fedora systemd-sleep[39572]: Saving time and battery energy before sleeping (suspend).
Sep 12 00:04:01 fedora systemd-sleep[39570]: Entering sleep state 'suspend'...
Sep 12 00:04:01 fedora kernel: PM: suspend entry (s2idle)
Sep 12 00:04:01 fedora kernel: Filesystems sync: 0.007 seconds
Laptop woken up (lid opened, no docking station attached):
journalctl -b0 --no-pager
Sep 12 05:47:28 fedora kernel: Freezing user space processes
Sep 12 05:47:28 fedora kernel: Freezing user space processes completed (elapsed 0.004 seconds)
Sep 12 05:47:28 fedora kernel: OOM killer disabled.
Sep 12 05:47:28 fedora kernel: Freezing remaining freezable tasks
Sep 12 05:47:28 fedora kernel: Freezing remaining freezable tasks completed (elapsed 6.388 seconds)
Sep 12 05:47:28 fedora kernel: printk: Suspending console(s) (use no_console_suspend to debug)
Sep 12 05:47:28 fedora kernel: PM: suspend devices took 1.052 seconds
Sep 12 05:47:28 fedora kernel: ACPI: EC: interrupt blocked
Sep 12 05:47:28 fedora kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PCI0.LPC0.EC0.HKEY.MSCB], AE_NOT_FOUND (20230331/psargs-330)
Sep 12 05:47:28 fedora kernel: ACPI Error: Aborting method \_SB.PEP._DSM due to previous error (AE_NOT_FOUND) (20230331/psparse-529)
Sep 12 05:47:28 fedora kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PCI0.LPC0.EC0.HKEY.MSCB], AE_NOT_FOUND (20230331/psargs-330)
Sep 12 05:47:28 fedora kernel: ACPI Error: Aborting method \_SB.PEP._DSM due to previous error (AE_NOT_FOUND) (20230331/psparse-529)
Sep 12 05:47:28 fedora kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PCI0.LPC0.EC0.HKEY.MSCB], AE_NOT_FOUND (20230331/psargs-330)
Sep 12 05:47:28 fedora kernel: ACPI Error: Aborting method \_SB.PEP._DSM due to previous error (AE_NOT_FOUND) (20230331/psparse-529)
Sep 12 05:47:28 fedora kernel: ACPI BIOS Error (bug): Could not resolve symbol [\_SB.PCI0.LPC0.EC0.HKEY.MSCB], AE_NOT_FOUND (20230331/psargs-330)
Sep 12 05:47:28 fedora kernel: ACPI Error: Aborting method \_SB.PEP._DSM due to previous error (AE_NOT_FOUND) (20230331/psparse-529)
Sep 12 05:47:28 fedora kernel: ACPI: EC: interrupt unblocked
Sep 12 05:47:28 fedora kernel: pci 0000:00:00.2: can't derive routing for PCI INT A
Sep 12 05:47:28 fedora kernel: pci 0000:00:00.2: PCI INT A: no GSI
Sep 12 05:47:28 fedora kernel: usb usb1: root hub lost power or was reset
Sep 12 05:47:28 fedora kernel: usb usb2: root hub lost power or was reset
Sep 12 05:47:28 fedora kernel: usb usb3: root hub lost power or was reset
Sep 12 05:47:28 fedora kernel: xhci_hcd 0000:06:00.0: Zeroing 64bit base registers, expecting fault
Sep 12 05:47:28 fedora kernel: [drm] PCIE GART of 1024M enabled.
Sep 12 05:47:28 fedora kernel: [drm] PTB located at 0x000000F47FC00000
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: SMU is resuming...
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: dpm has been disabled
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: SMU is resumed successfully!
Sep 12 05:47:28 fedora kernel: iwlwifi 0000:03:00.0: WRT: Invalid buffer destination
Sep 12 05:47:28 fedora kernel: [drm] DM_MST: stopping TM on aconnector: 0000000091ecea95 [id: 89]
Sep 12 05:47:28 fedora kernel: nvme nvme0: Shutdown timeout set to 8 seconds
Sep 12 05:47:28 fedora kernel: [drm] DM_MST: stopping TM on aconnector: 0000000091ecea95 [id: 89]
Sep 12 05:47:28 fedora kernel: [drm] VCN decode and encode initialized successfully(under DPG Mode).
Sep 12 05:47:28 fedora kernel: [drm] JPEG decode initialized successfully.
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring gfx uses VM inv eng 0 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring gfx_low uses VM inv eng 1 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring gfx_high uses VM inv eng 4 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.0.0 uses VM inv eng 5 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.1.0 uses VM inv eng 6 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.2.0 uses VM inv eng 7 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.3.0 uses VM inv eng 8 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.0.1 uses VM inv eng 9 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.1.1 uses VM inv eng 10 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.2.1 uses VM inv eng 11 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring comp_1.3.1 uses VM inv eng 12 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring kiq_2.1.0 uses VM inv eng 13 on hub 0
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring sdma0 uses VM inv eng 0 on hub 1
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring vcn_dec uses VM inv eng 1 on hub 1
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring vcn_enc0 uses VM inv eng 4 on hub 1
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring vcn_enc1 uses VM inv eng 5 on hub 1
Sep 12 05:47:28 fedora kernel: amdgpu 0000:07:00.0: amdgpu: ring jpeg_dec uses VM inv eng 6 on hub 1
Sep 12 05:47:28 fedora kernel: nvme nvme0: 16/0/0 default/read/poll queues
Sep 12 05:47:28 fedora kernel: iwlwifi 0000:03:00.0: WFPM_UMAC_PD_NOTIFICATION: 0x1f
Sep 12 05:47:28 fedora kernel: iwlwifi 0000:03:00.0: WFPM_LMAC2_PD_NOTIFICATION: 0x1f
Sep 12 05:47:28 fedora kernel: iwlwifi 0000:03:00.0: WFPM_AUTH_KEY_0: 0x90
Sep 12 05:47:28 fedora kernel: iwlwifi 0000:03:00.0: CNVI_SCU_SEQ_DATA_DW9: 0x0
Sep 12 05:47:28 fedora kernel: usb 4-4: reset full-speed USB device number 3 using xhci_hcd
Sep 12 05:47:28 fedora kernel: usb 2-2: reset high-speed USB device number 2 using xhci_hcd
Sep 12 05:47:29 fedora kernel: psmouse serio1: synaptics: queried max coordinates: x [..5678], y [..4694]
Sep 12 05:47:29 fedora kernel: psmouse serio1: synaptics: queried min coordinates: x [1266..], y [1162..]
Sep 12 05:47:29 fedora kernel: PM: resume devices took 2.346 seconds
Sep 12 05:47:29 fedora kernel: OOM killer enabled.
Sep 12 05:47:29 fedora kernel: Restarting tasks ...
Sep 12 05:47:29 fedora kernel: r8152-cfgselector 5-1.1: USB disconnect, device number 17
Sep 12 05:47:29 fedora kernel: usb 5-1: USB disconnect, device number 16
Sep 12 05:47:29 fedora kernel: usb 4-1: USB disconnect, device number 21
Sep 12 05:47:29 fedora kernel: usb 4-1.2: USB disconnect, device number 33
Sep 12 05:47:29 fedora kernel: done.
Sep 12 05:47:29 fedora kernel: random: crng reseeded on system resumption
Sep 12 05:47:29 fedora kernel: usb 5-1.3.4: USB disconnect, device number 19
Sep 12 05:47:29 fedora kernel: usb 5-1.3: USB disconnect, device number 18
Sep 12 05:47:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:28 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sssd-kcm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:28 fedora systemd-resolved[1449]: Clock change detected. Flushing caches.
Sep 12 05:47:29 fedora code.desktop[12997]: [0912/054728.907079:ERROR:file_io_posix.cc(152)] open /home/<someuser>/.config/Code/Crashpad/pending/d19c63ee-b1ad-4438-8778-fc7745da9b7e.lock: File exists (17)
Sep 12 05:47:28 fedora rtkit-daemon[1493]: The canary thread is apparently starving. Taking action.
Sep 12 05:47:28 fedora systemd-logind[1498]: Lid opened.
Sep 12 05:47:28 fedora rtkit-daemon[1493]: Demoting known real-time threads.
Sep 12 05:47:28 fedora NetworkManager[1609]: <info> [1694490448.8960] dhcp4 (enp7s0f3u1u1): activation: beginning transaction (timeout in 45 seconds)
Sep 12 05:47:28 fedora rtkit-daemon[1493]: Successfully demoted thread 18289 of process 17088 (/usr/lib64/firefox/firefox).
Sep 12 05:47:28 fedora NetworkManager[1609]: <info> [1694490448.8961] dhcp4 (enp7s0f3u1u1): state changed no lease
Sep 12 05:47:28 fedora rtkit-daemon[1493]: Demoted 1 threads.
Sep 12 05:47:28 fedora sssd_kcm[16059]: Shutting down (status = 0)
Sep 12 05:47:28 fedora avahi-daemon[1478]: Interface enp7s0f3u1u1.IPv4 no longer relevant for mDNS.
Sep 12 05:47:28 fedora systemd[1]: plocate-updatedb.service - Update the plocate database was skipped because of an unmet condition check (ConditionACPower=true).
Sep 12 05:47:28 fedora avahi-daemon[1478]: Leaving mDNS multicast group on interface enp7s0f3u1u1.IPv4 with address <someip>.
Sep 12 05:47:28 fedora gsd-media-keys[3471]: Unable to get default source
Sep 12 05:47:28 fedora avahi-daemon[1478]: Withdrawing address record for <someip> on enp7s0f3u1u1.
Sep 12 05:47:28 fedora gsd-media-keys[3471]: Unable to get default sink
Sep 12 05:47:28 fedora systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Sep 12 05:47:28 fedora NetworkManager[1609]: <info> [1694490448.9396] device (enp7s0f3u1u1): state change: activated -> unmanaged (reason 'removed', sys-iface-state: 'removed')
Sep 12 05:47:28 fedora NetworkManager[1609]: <info> [1694490448.9557] dhcp4 (enp7s0f3u1u1): canceled DHCP transaction
Sep 12 05:47:28 fedora NetworkManager[1609]: <info> [1694490448.9558] dhcp4 (enp7s0f3u1u1): state changed no lease
Sep 12 05:47:28 fedora systemd[1]: sssd-kcm.service: Deactivated successfully.
Sep 12 05:47:28 fedora NetworkManager[1609]: <warn> [1694490448.9802] dns-sd-resolved[4b8b24cc9a7d0496]: send-updates SetLinkDomains@12 failed: GDBus.Error:org.freedesktop.resolve1.NoSuchLink: Link 12 not known
Sep 12 05:47:28 fedora systemd[1]: sssd-kcm.service: Consumed 5.091s CPU time.
Sep 12 05:47:29 fedora systemd[1]: Starting sssd-kcm.service - SSSD Kerberos Cache Manager...
Sep 12 05:47:29 fedora kernel: PM: suspend exit
Sep 12 05:47:29 fedora systemd-sleep[39570]: System returned from sleep state.
Sep 12 05:47:29 fedora bluetoothd[1479]: Controller resume with wake event 0x0
Sep 12 05:47:29 fedora systemd[1]: Starting NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service...
Sep 12 05:47:29 fedora systemd-sleep[39737]: Currently on battery.
Sep 12 05:47:29 fedora solaar[3498]: gtk_widget_get_scale_factor: assertion 'GTK_IS_WIDGET (widget)' failed
Sep 12 05:47:29 fedora systemd-sleep[39737]: Duration of 0 days 5 hours 43 minutes sleeping (suspend).
Sep 12 05:47:29 fedora systemd-sleep[39737]: Battery energy change of -.6 % (-330 mWh) at an average rate of -.11 %/h (-57 mW).
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_monitor_manager_get_logical_monitor_from_number: assertion '(unsigned int) number < g_list_length (manager->logical_monitors)' failed
Sep 12 05:47:29 fedora kernel: usb 4-1.3: USB disconnect, device number 23
Sep 12 05:47:29 fedora kernel: usb 4-1.3.3: USB disconnect, device number 24
Sep 12 05:47:29 fedora kernel: usb 4-1.3.3.1: USB disconnect, device number 32
Sep 12 05:47:29 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sssd-kcm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_workspace_get_work_area_for_monitor: assertion 'logical_monitor != NULL' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_monitor_manager_get_logical_monitor_from_number: assertion '(unsigned int) number < g_list_length (manager->logical_monitors)' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_workspace_get_work_area_for_monitor: assertion 'logical_monitor != NULL' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_monitor_manager_get_logical_monitor_from_number: assertion '(unsigned int) number < g_list_length (manager->logical_monitors)' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_workspace_get_work_area_for_monitor: assertion 'logical_monitor != NULL' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_monitor_manager_get_logical_monitor_from_number: assertion '(unsigned int) number < g_list_length (manager->logical_monitors)' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_workspace_get_work_area_for_monitor: assertion 'logical_monitor != NULL' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_monitor_manager_get_logical_monitor_from_number: assertion '(unsigned int) number < g_list_length (manager->logical_monitors)' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_workspace_get_work_area_for_monitor: assertion 'logical_monitor != NULL' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_monitor_manager_get_logical_monitor_from_number: assertion '(unsigned int) number < g_list_length (manager->logical_monitors)' failed
Sep 12 05:47:29 fedora gnome-shell[3075]: meta_workspace_get_work_area_for_monitor: assertion 'logical_monitor != NULL' failed
Sep 12 05:47:29 fedora systemd[1]: Started sssd-kcm.service - SSSD Kerberos Cache Manager.
Sep 12 05:47:29 fedora systemd[1]: systemd-suspend.service: Deactivated successfully.
Sep 12 05:47:29 fedora kernel: usb 4-1.3.3.2: USB disconnect, device number 27
Sep 12 05:47:29 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:29 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=systemd-suspend comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:29 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:29 fedora systemd[1]: Finished systemd-suspend.service - System Suspend.
Sep 12 05:47:29 fedora ModemManager[1586]: <info> [sleep-monitor-systemd] system is resuming
Sep 12 05:47:29 fedora systemd[1]: Started NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service.
Sep 12 05:47:29 fedora systemd[1]: Stopped target sleep.target - Sleep.
Sep 12 05:47:29 fedora systemd[1]: Reached target suspend.target - Suspend.
Sep 12 05:47:29 fedora systemd-logind[1498]: Operation 'sleep' finished.
Sep 12 05:47:29 fedora systemd[1]: Stopped target suspend.target - Suspend.
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.1541] manager: sleep: wake requested (sleeping: yes enabled: yes)
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.1552] device (enp2s0f0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 12 05:47:29 fedora sssd_kcm[39758]: Starting up
Sep 12 05:47:29 fedora chronyd[1548]: Forward time jump detected!
Sep 12 05:47:29 fedora kernel: Generic FE-GE Realtek PHY r8169-0-200:00: attached PHY driver (mii_bus:phy_addr=r8169-0-200:00, irq=MAC)
Sep 12 05:47:29 fedora chronyd[1548]: Can't synchronise: no selectable sources
Sep 12 05:47:29 fedora chronyd[1548]: Source <someip> offline
Sep 12 05:47:29 fedora chronyd[1548]: Source <someip> offline
Sep 12 05:47:29 fedora chronyd[1548]: Source <someip> offline
Sep 12 05:47:29 fedora chronyd[1548]: Source <someip> offline
Sep 12 05:47:29 fedora kernel: r8169 0000:02:00.0 enp2s0f0: Link is Down
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.2940] device (enp5s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 12 05:47:29 fedora kernel: Generic FE-GE Realtek PHY r8169-0-500:00: attached PHY driver (mii_bus:phy_addr=r8169-0-500:00, irq=MAC)
Sep 12 05:47:29 fedora telegram-desktop[3584]: qt.qpa.wayland: Creating a fake screen in order for Qt not to crash
Sep 12 05:47:29 fedora keepassxc[13344]: qt.qpa.wayland: Creating a fake screen in order for Qt not to crash
Sep 12 05:47:29 fedora kernel: r8169 0000:05:00.0 enp5s0: Link is Down
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.4878] device (wlp3s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.5201] device (wlp3s0): set-hw-addr: set MAC address to <somemac> (scanning)
Sep 12 05:47:29 fedora kernel: iwlwifi 0000:03:00.0: WRT: Invalid buffer destination
Sep 12 05:47:29 fedora kernel: iwlwifi 0000:03:00.0: WFPM_UMAC_PD_NOTIFICATION: 0x1f
Sep 12 05:47:29 fedora kernel: iwlwifi 0000:03:00.0: WFPM_LMAC2_PD_NOTIFICATION: 0x1f
Sep 12 05:47:29 fedora kernel: iwlwifi 0000:03:00.0: WFPM_AUTH_KEY_0: 0x90
Sep 12 05:47:29 fedora kernel: iwlwifi 0000:03:00.0: CNVI_SCU_SEQ_DATA_DW9: 0x0
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.7928] device (p2p-dev-wlp3s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.7939] manager: NetworkManager state is now CONNECTED_LOCAL
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8460] device (wlp3s0): supplicant interface state: internal-starting -> disconnected
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8462] device (p2p-dev-wlp3s0): state change: unavailable -> unmanaged (reason 'removed', sys-iface-state: 'removed')
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8472] Wi-Fi P2P device controlled by interface wlp3s0 created
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8478] manager: (p2p-dev-wlp3s0): new 802.11 Wi-Fi P2P device (/org/freedesktop/NetworkManager/Devices/17)
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8482] device (p2p-dev-wlp3s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8490] device (wlp3s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
Sep 12 05:47:29 fedora NetworkManager[1609]: <info> [1694490449.8510] device (p2p-dev-wlp3s0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:31 fedora ModemManager[1586]: <info> [base-manager] couldn't check support for device '/sys/devices/pci0000:00/0000:00:02.2/0000:02:00.0': not supported by any plugin
Sep 12 05:47:31 fedora ModemManager[1586]: <info> [base-manager] couldn't check support for device '/sys/devices/pci0000:00/0000:00:02.3/0000:03:00.0': not supported by any plugin
Sep 12 05:47:31 fedora ModemManager[1586]: <info> [base-manager] couldn't check support for device '/sys/devices/pci0000:00/0000:00:02.6/0000:05:00.0': not supported by any plugin
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=FR
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4064] policy: auto-activating connection '<somessid>' (8a6f4d72-d6aa-4e68-b061-7866089e55ad)
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4069] device (wlp3s0): Activation: starting connection '<somessid>' (8a6f4d72-d6aa-4e68-b061-7866089e55ad)
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4070] device (wlp3s0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4072] manager: NetworkManager state is now CONNECTING
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4276] device (wlp3s0): set-hw-addr: set-cloned MAC address to 92:83:C4:32:2F:90 (92:83:C4:32:2F:90)
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4292] device (wlp3s0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4295] device (wlp3s0): Activation: (wifi) connection '<somessid>' requires no security. No secrets needed.
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4296] Config: added 'ssid' value '<somessid>'
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4296] Config: added 'scan_ssid' value '1'
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4296] Config: added 'bgscan' value 'simple:30:-65:300'
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4296] Config: added 'key_mgmt' value 'NONE'
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4383] device (wlp3s0): supplicant interface state: disconnected -> inactive
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4383] device (p2p-dev-wlp3s0): supplicant management interface state: disconnected -> inactive
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: SME: Trying to authenticate with <somemac> (SSID='<somessid>' freq=5180 MHz)
Sep 12 05:47:33 fedora kernel: wlp3s0: authenticate with <somemac>
Sep 12 05:47:33 fedora kernel: wlp3s0: send auth to <somemac> (try 1/3)
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4447] device (wlp3s0): supplicant interface state: inactive -> authenticating
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4448] device (p2p-dev-wlp3s0): supplicant management interface state: inactive -> authenticating
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: Trying to associate with <somemac> (SSID='<somessid>' freq=5180 MHz)
Sep 12 05:47:33 fedora kernel: wlp3s0: authenticated
Sep 12 05:47:33 fedora kernel: wlp3s0: associate with <somemac> (try 1/3)
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4969] device (wlp3s0): supplicant interface state: authenticating -> associating
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.4969] device (p2p-dev-wlp3s0): supplicant management interface state: authenticating -> associating
Sep 12 05:47:33 fedora kernel: wlp3s0: RX AssocResp from <somemac> (capab=0x101 status=0 aid=6)
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: Associated with <somemac>
Sep 12 05:47:33 fedora kernel: wlp3s0: associated
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-CONNECTED - Connection to <somemac> completed [id=0 id_str=]
Sep 12 05:47:33 fedora kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp3s0: link becomes ready
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.5136] device (wlp3s0): supplicant interface state: associating -> completed
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.5137] device (wlp3s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful. Connected to wireless network "<somessid>"
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.5137] device (p2p-dev-wlp3s0): supplicant management interface state: associating -> completed
Sep 12 05:47:33 fedora audit[1587]: NETFILTER_CFG table=firewalld:67 family=1 entries=5 op=nft_register_rule pid=1587 subj=system_u:system_r:firewalld_t:s0 comm="firewalld"
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.5431] device (wlp3s0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.5437] dhcp4 (wlp3s0): activation: beginning transaction (timeout in 45 seconds)
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6010] dhcp4 (wlp3s0): state changed new lease, address=<someip>
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6017] policy: set '<somessid>' (wlp3s0) as default for IPv4 routing and DNS
Sep 12 05:47:33 fedora avahi-daemon[1478]: Joining mDNS multicast group on interface wlp3s0.IPv4 with address<someip>.
Sep 12 05:47:33 fedora systemd-resolved[1449]: wlp3s0: Bus client set default route setting: yes
Sep 12 05:47:33 fedora avahi-daemon[1478]: New relevant interface wlp3s0.IPv4 for mDNS.
Sep 12 05:47:33 fedora avahi-daemon[1478]: Registering new address record for<someip> on wlp3s0.IPv4.
Sep 12 05:47:33 fedora dnsmasq[6934]: reading /etc/resolv.conf
Sep 12 05:47:33 fedora dnsmasq[6934]: using nameserver 127.0.0.53#53
Sep 12 05:47:33 fedora systemd-resolved[1449]: wlp3s0: Bus client set DNS server list to: <someip>
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6160] device (wlp3s0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6206] device (wlp3s0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6209] device (wlp3s0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6215] manager: NetworkManager state is now CONNECTED_SITE
Sep 12 05:47:33 fedora NetworkManager[1609]: <info> [1694490453.6227] device (wlp3s0): Activation: successful, device activated.
Sep 12 05:47:33 fedora wpa_supplicant[1782]: wlp3s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-47 noise=9999 txrate=108000
Sep 12 05:47:33 fedora chronyd[1548]: Source <someip> online
Sep 12 05:47:33 fedora chronyd[1548]: Source <someip> online
Sep 12 05:47:33 fedora chronyd[1548]: Source <someip> online
Sep 12 05:47:33 fedora chronyd[1548]: Source <someip> online
Sep 12 05:47:33 fedora systemd[1]: iscsi.service: Unit cannot be reloaded because it is inactive.
Sep 12 05:47:33 fedora systemd[2817]: Started dbus-:1.2-org.gnome.Shell.PortalHelper@3.service.
Sep 12 05:47:34 fedora xdg-desktop-por[3691]: Realtime error: Could not map pid: Could not determine pid namespace: Could not find instance-id in process's /.flatpak-info
Sep 12 05:47:35 fedora audit: BPF prog-id=117 op=LOAD
Sep 12 05:47:35 fedora systemd[1]: Starting fprintd.service - Fingerprint Authentication Daemon...
Sep 12 05:47:35 fedora systemd[1]: Started fprintd.service - Fingerprint Authentication Daemon.
Sep 12 05:47:35 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=fprintd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:43 fedora gdm-password][40008]: gkr-pam: unlocked login keyring
Sep 12 05:47:43 fedora audit[40008]: USER_AUTH pid=40008 uid=0 auid=1000 ses=2 subj=system_u:system_r:xdm_t:s0-s0:c0.c1023 msg='op=PAM:authentication grantors=pam_usertype,pam_localuser,pam_unix,pam_gnome_keyring acct="<someuser>" exe="/usr/libexec/gdm-session-worker" hostname=fedora addr=? terminal=/dev/tty1 res=success'
Sep 12 05:47:43 fedora audit[40008]: USER_ACCT pid=40008 uid=0 auid=1000 ses=2 subj=system_u:system_r:xdm_t:s0-s0:c0.c1023 msg='op=PAM:accounting grantors=pam_unix,pam_localuser acct="<someuser>" exe="/usr/libexec/gdm-session-worker" hostname=fedora addr=? terminal=/dev/tty1 res=success'
Sep 12 05:47:43 fedora audit[40008]: CRED_REFR pid=40008 uid=0 auid=1000 ses=2 subj=system_u:system_r:xdm_t:s0-s0:c0.c1023 msg='op=PAM:setcred grantors=pam_localuser,pam_unix,pam_gnome_keyring acct="<someuser>" exe="/usr/libexec/gdm-session-worker" hostname=fedora addr=? terminal=/dev/tty1 res=success'
Sep 12 05:47:43 fedora systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Sep 12 05:47:43 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:47:44 fedora NetworkManager[1609]: <info> [1694490464.1596] agent-manager: agent[a3e232219ea395fe,:1.94/org.gnome.Shell.NetworkAgent/1000]: agent registered
Sep 12 05:47:44 fedora appindicatorsupport@rgcjonas.gmail.com[3075]: Using Brute-force mode for StatusNotifierItem :1.111@/StatusNotifierItem
Sep 12 05:47:44 fedora gnome-shell[3075]: Received property WindowId with type u does not match expected type i in the expected interface
Sep 12 05:47:44 fedora gnome-shell[3075]: Received property Menu with type s does not match expected type o in the expected interface
Sep 12 05:47:46 fedora gnome-shell[3075]: Trying to set property Menu of type s but according to the expected interface the type is o
Sep 12 05:47:47 fedora gnome-shell[3075]: Trying to set property Menu of type s but according to the expected interface the type is o
Sep 12 05:47:48 fedora gnome-shell[3075]: Trying to set property Menu of type s but according to the expected interface the type is o
Sep 12 05:47:48 fedora chronyd[1548]: Source <someip> replaced with 91.107.199.28 (2.fedora.pool.ntp.org)
Sep 12 05:47:50 fedora gnome-shell-portal-helper[39944]: (WebKitWebProcess:2): GStreamer-WARNING **: 05:47:50.333: External plugin loader failed. This most likely means that the plugin loader helper binary was not found or could not be run. You might need to set the GST_PLUGIN_SCANNER environment variable if your setup is unusual. This should normally not be required though.
Sep 12 05:48:04 fedora NetworkManager[1609]: <info> [1694490484.9276] manager: NetworkManager state is now CONNECTED_GLOBAL
Sep 12 05:48:04 fedora systemd[1]: Starting NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service...
Sep 12 05:48:04 fedora systemd[1]: Started NetworkManager-dispatcher.service - Network Manager Script Dispatcher Service.
Sep 12 05:48:04 fedora audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:48:06 fedora systemd[1]: fprintd.service: Deactivated successfully.
Sep 12 05:48:06 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=fprintd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:48:06 fedora audit: BPF prog-id=117 op=UNLOAD
Sep 12 05:48:15 fedora systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Sep 12 05:48:15 fedora audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=NetworkManager-dispatcher comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Sep 12 05:48:20 fedora xdg-desktop-por[3691]: Realtime error: Could not map pid: Could not determine pid namespace: Could not find instance-id in process's /.flatpak-info
Sep 12 05:48:29 fedora systemd-udevd[1189]: 4-4: Worker [39713] processing SEQNUM=6514 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: pcmC4D0p: Worker [39765] processing SEQNUM=6565 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: controlC4: Worker [39707] processing SEQNUM=6564 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: 4-1.3.3.1:1.1: Worker [39735] processing SEQNUM=6561 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: controlC0: Worker [39715] processing SEQNUM=6516 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: 4-1.3.3.1:1.0: Worker [39721] processing SEQNUM=6560 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: hidraw1: Worker [39748] processing SEQNUM=6553 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: hiddev1: Worker [39745] processing SEQNUM=6551 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: event13: Worker [39724] processing SEQNUM=6546 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: pcmC0D0c: Worker [39705] processing SEQNUM=6518 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: event11: Worker [39711] processing SEQNUM=6538 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: 4-1.2:1.2: Worker [39712] processing SEQNUM=6524 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: 4-1.2:1.1: Worker [39717] processing SEQNUM=6522 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: event12: Worker [39725] processing SEQNUM=6540 is taking a long time
Sep 12 05:48:29 fedora systemd-udevd[1189]: pcmC0D0p: Worker [39709] processing SEQNUM=6517 is taking a long time
Sep 12 05:48:58 fedora virtqemud[6677]: internal error: connection closed due to keepalive timeout
Sep 12 05:49:47 fedora kernel: usb 6-2: new full-speed USB device number 3 using xhci_hcd
Sep 12 05:49:48 fedora kernel: usb 6-2: New USB device found, idVendor=1050, idProduct=0407, bcdDevice= 5.24
Sep 12 05:49:48 fedora kernel: usb 6-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 12 05:49:48 fedora kernel: usb 6-2: Product: YubiKey OTP+FIDO+CCID
Sep 12 05:49:48 fedora kernel: usb 6-2: Manufacturer: Yubico
Sep 12 05:49:48 fedora kernel: input: Yubico YubiKey OTP+FIDO+CCID as /devices/pci0000:00/0000:00:08.1/0000:07:00.4/usb6/6-2/6-2:1.0/0003:1050:0407.0016/input/input49
Sep 12 05:49:48 fedora kernel: hid-generic 0003:1050:0407.0016: input,hidraw1: USB HID v1.10 Keyboard [Yubico YubiKey OTP+FIDO+CCID] on usb-0000:07:00.4-2/input0
Sep 12 05:49:48 fedora kernel: hid-generic 0003:1050:0407.0017: hiddev97,hidraw3: USB HID v1.10 Device [Yubico YubiKey OTP+FIDO+CCID] on usb-0000:07:00.4-2/input1
Sep 12 05:49:48 fedora mtp-probe[41331]: checking bus 6, device 3: "/sys/devices/pci0000:00/0000:00:08.1/0000:07:00.4/usb6/6-2"
Sep 12 05:49:48 fedora mtp-probe[41331]: bus: 6, device: 3 was not an MTP device
Sep 12 05:49:48 fedora systemd[1]: Reached target smartcard.target - Smart Card.
Sep 12 05:49:48 fedora systemd[2817]: Reached target smartcard.target - Smart Card.
Sep 12 05:49:52 fedora kernel: CIFS: VFS: \\<someip> has not responded in 180 seconds. Reconnecting...
Sep 12 05:49:57 fedora kernel: usb 6-2: USB disconnect, device number 3
Sep 12 05:49:57 fedora pcscd[2066]: 00000000 ccid_usb.c:899:WriteUSB() write failed (6/3): LIBUSB_ERROR_NO_DEVICE
Sep 12 05:49:57 fedora pcscd[2066]: 00000178 ccid_usb.c:1501:InterruptRead() libusb_submit_transfer failed: LIBUSB_ERROR_NO_DEVICE
Sep 12 05:49:58 fedora pcscd[2066]: 00400119 ccid_usb.c:899:WriteUSB() write failed (6/3): LIBUSB_ERROR_NO_DEVICE
Sep 12 05:49:58 fedora pcscd[2066]: 00000049 ccid_usb.c:1501:InterruptRead() libusb_submit_transfer failed: LIBUSB_ERROR_NO_DEVICE
Sep 12 05:49:58 fedora pcscd[2066]: 00400113 ccid_usb.c:899:WriteUSB() write failed (6/3): LIBUSB_ERROR_NO_DEVICE
Sep 12 05:49:58 fedora pcscd[2066]: 00000022 ccid_usb.c:899:WriteUSB() write failed (6/3): LIBUSB_ERROR_NO_DEVICE
[...]
[...]