[SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

hey00 · 2024-03-21 11:03:01

Hello there,

I'm new to Arch, on a fresh install, and I'm faced with an issue I couldn't solve. I've seen plenty of other threads here and elsewhere with similar issues, but none of their solutions worked, so here I am. Any help will be appreciated.

So as I said, fresh Arch install, with 5 drives in my system. Two are nvme, three are good old 3.5" spinning rust hard drives.
I have data partitions on every drive, and a swap partition on one of the HDDs. They are all in my /etc/fstab to be mounted on boot (except one, which is in my fstab, but in noauto, because I don't want it mounted at all times), and on my previous systems (debian and ubuntu), I had no issues at all.

On this new Arch, though, the boot hangs, apparently trying to mount the HDD data and swap partitions (no visible problems with the NVME partitions), I have to wait 90 seconds until it times out, press ctrl-D to continue, and then reach my desktop, where my partitions are correctly mounted.

Here is the output of journalctl:

Mar 21 03:29:50 eyrya kernel: hid-generic 0003:1B1C:1B33.000D: input,hiddev99,hidraw10: USB HID v1.11 Keyboard [Corsair Corsair Gaming K70 LUX RGB Keyboard ] on usb-0000:13:00.0-3.4/input0
Mar 21 03:29:50 eyrya kernel: hid-generic 0003:1B1C:1B33.000E: hiddev102,hidraw11: USB HID v1.11 Device [Corsair Corsair Gaming K70 LUX RGB Keyboard ] on usb-0000:13:00.0-3.4/input1
Mar 21 03:30:47 eyrya (udev-worker)[483]: hiddev3: Spawned process '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev3 -v' [491] is taking longer than 59s to complete
Mar 21 03:30:47 eyrya (udev-worker)[487]: hiddev4: Spawned process '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev4 -v' [492] is taking longer than 59s to complete
Mar 21 03:30:47 eyrya systemd-udevd[477]: hiddev3: Worker [483] processing SEQNUM=3515 is taking a long time
Mar 21 03:30:47 eyrya systemd-udevd[477]: hiddev4: Worker [487] processing SEQNUM=3521 is taking a long time
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-a6e9e876\x2d114b\x2d433b\x2d8fe2\x2d0560179a29c3.device: Job dev-disk-by\x2duuid-a6e9e876\x2d114b\x2d433b\x2d8fe2\x2d0560179a29c3.device/start timed out.
Mar 21 03:31:16 eyrya systemd[1]: Timed out waiting for device /dev/disk/by-uuid/a6e9e876-114b-433b-8fe2-0560179a29c3.
Mar 21 03:31:16 eyrya systemd[1]: Dependency failed for /dev/disk/by-uuid/a6e9e876-114b-433b-8fe2-0560179a29c3.
Mar 21 03:31:16 eyrya systemd[1]: Dependency failed for Swaps.
Mar 21 03:31:16 eyrya systemd[1]: swap.target: Job swap.target/start failed with result 'dependency'.
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-a6e9e876\x2d114b\x2d433b\x2d8fe2\x2d0560179a29c3.swap: Job dev-disk-by\x2duuid-a6e9e876\x2d114b\x2d433b\x2d8fe2\x2d0560179a29c3.swap/start failed with result 'dependency'.
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-a6e9e876\x2d114b\x2d433b\x2d8fe2\x2d0560179a29c3.device: Job dev-disk-by\x2duuid-a6e9e876\x2d114b\x2d433b\x2d8fe2\x2d0560179a29c3.device/start failed with result 'timeout'.
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-624d8542\x2d3fab\x2d4533\x2dac65\x2d6e5dad72ee1f.device: Job dev-disk-by\x2duuid-624d8542\x2d3fab\x2d4533\x2dac65\x2d6e5dad72ee1f.device/start timed out.
Mar 21 03:31:16 eyrya systemd[1]: Timed out waiting for device /dev/disk/by-uuid/624d8542-3fab-4533-ac65-6e5dad72ee1f.
Mar 21 03:31:16 eyrya systemd[1]: Dependency failed for /media/hey00/data_1.
Mar 21 03:31:16 eyrya systemd[1]: Dependency failed for Local File Systems.
Mar 21 03:31:16 eyrya systemd[1]: local-fs.target: Job local-fs.target/start failed with result 'dependency'.
Mar 21 03:31:16 eyrya systemd[1]: local-fs.target: Triggering OnFailure= dependencies.
Mar 21 03:31:16 eyrya systemd[1]: media-hey00-data_1.mount: Job media-hey00-data_1.mount/start failed with result 'dependency'.
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-624d8542\x2d3fab\x2d4533\x2dac65\x2d6e5dad72ee1f.device: Job dev-disk-by\x2duuid-624d8542\x2d3fab\x2d4533\x2dac65\x2d6e5dad72ee1f.device/start failed with result 'timeout'.
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-4e0978f7\x2d63d5\x2d4315\x2dab1a\x2de379a65a7c09.device: Job dev-disk-by\x2duuid-4e0978f7\x2d63d5\x2d4315\x2dab1a\x2de379a65a7c09.device/start timed out.
Mar 21 03:31:16 eyrya systemd[1]: Timed out waiting for device /dev/disk/by-uuid/4e0978f7-63d5-4315-ab1a-e379a65a7c09.
Mar 21 03:31:16 eyrya systemd[1]: Dependency failed for /media/hey00/data_0.
Mar 21 03:31:16 eyrya systemd[1]: media-hey00-data_0.mount: Job media-hey00-data_0.mount/start failed with result 'dependency'.
Mar 21 03:31:16 eyrya systemd[1]: dev-disk-by\x2duuid-4e0978f7\x2d63d5\x2d4315\x2dab1a\x2de379a65a7c09.device: Job dev-disk-by\x2duuid-4e0978f7\x2d63d5\x2d4315\x2dab1a\x2de379a65a7c09.device/start failed with result 'timeout'.
Mar 21 03:31:16 eyrya systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Mar 21 03:31:16 eyrya systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Mar 21 03:31:16 eyrya systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.
Mar 21 03:31:16 eyrya systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Mar 21 03:31:16 eyrya systemd[1]: Reached target Timer Units.
Mar 21 03:31:16 eyrya systemd[1]: Listening on System Extension Image Management (Varlink).
Mar 21 03:31:16 eyrya systemd[1]: Reached target Sound Card.
Mar 21 03:31:16 eyrya systemd[1]: Reached target Preparation for Network.
Mar 21 03:31:16 eyrya systemd[1]: Reached target Network.
Mar 21 03:31:16 eyrya systemd[1]: Reached target Path Units.
Mar 21 03:31:16 eyrya systemd[1]: Reached target Socket Units.
Mar 21 03:31:16 eyrya systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Mar 21 03:31:16 eyrya systemd[1]: Mounting /tmp...
Mar 21 03:31:16 eyrya systemd[1]: Started Emergency Shell.
Mar 21 03:31:16 eyrya systemd[1]: Reached target Emergency Mode.
Mar 21 03:31:16 eyrya systemd[1]: Rebuild Dynamic Linker Cache was skipped because no trigger condition checks were met.
Mar 21 03:31:16 eyrya systemd[1]: Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Mar 21 03:31:16 eyrya systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.
Mar 21 03:31:16 eyrya systemd[1]: TPM2 PCR Barrier (Initialization) was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
Mar 21 03:31:16 eyrya systemd[1]: Starting Create Volatile Files and Directories...
Mar 21 03:31:16 eyrya systemd[1]: Mounted /tmp.
Mar 21 03:31:16 eyrya systemd[1]: Finished Create Volatile Files and Directories.
Mar 21 03:31:16 eyrya systemd[1]: First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
Mar 21 03:31:16 eyrya systemd[1]: First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
Mar 21 03:31:16 eyrya systemd[1]: Rebuild Journal Catalog was skipped because of an unmet condition check (ConditionNeedsUpdate=/var).
Mar 21 03:31:16 eyrya systemd[1]: Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id).
Mar 21 03:31:16 eyrya systemd[1]: Starting Network Time Synchronization...
Mar 21 03:31:16 eyrya systemd[1]: Update is Completed was skipped because no trigger condition checks were met.
Mar 21 03:31:16 eyrya systemd[1]: Starting Record System Boot/Shutdown in UTMP...
Mar 21 03:31:16 eyrya systemd[1]: Started Process Core Dump (PID 578/UID 0).
Mar 21 03:31:16 eyrya systemd[1]: Started Process Core Dump (PID 577/UID 0).
Mar 21 03:31:16 eyrya systemd[1]: Finished Record System Boot/Shutdown in UTMP.
Mar 21 03:31:16 eyrya systemd[1]: Started Network Time Synchronization.
Mar 21 03:31:16 eyrya systemd[1]: Reached target System Time Set.
Mar 21 03:31:16 eyrya systemd[1]: Startup finished in 14.363s (firmware) + 4.559s (loader) + 5.451s (kernel) + 2.018s (initrd) + 1min 30.716s (userspace) = 1min 57.109s.
Mar 21 03:31:16 eyrya systemd-coredump[643]: [?] Process 492 (ddcutil) of user 0 dumped core.
                                             
                                             Stack trace of thread 492:
                                             #0  0x000077f0c8e6a15c n/a (libc.so.6 + 0x16a15c)
                                             #1  0x0000561f81be5031 strsplit (ddcutil + 0x8b031)
                                             #2  0x0000561f81bf74ba n/a (ddcutil + 0x9d4ba)
                                             #3  0x0000561f81bf7778 is_possible_monitor_by_hiddev_name (ddcutil + 0x9d778)
                                             #4  0x0000561f81bf78a9 check_usb_monitor (ddcutil + 0x9d8a9)
                                             #5  0x0000561f81b75752 main (ddcutil + 0x1b752)
                                             #6  0x000077f0c8d25cd0 n/a (libc.so.6 + 0x25cd0)
                                             #7  0x000077f0c8d25d8a __libc_start_main (libc.so.6 + 0x25d8a)
                                             #8  0x0000561f81b75895 _start (ddcutil + 0x1b895)
                                             ELF object binary architecture: AMD x86-64
Mar 21 03:31:16 eyrya systemd-coredump[644]: [?] Process 491 (ddcutil) of user 0 dumped core.
                                             
                                             Stack trace of thread 491:
                                             #0  0x000076c7c73dd15c n/a (libc.so.6 + 0x16a15c)
                                             #1  0x0000566e3a279031 strsplit (ddcutil + 0x8b031)
                                             #2  0x0000566e3a28b4ba n/a (ddcutil + 0x9d4ba)
                                             #3  0x0000566e3a28b778 is_possible_monitor_by_hiddev_name (ddcutil + 0x9d778)
                                             #4  0x0000566e3a28b8a9 check_usb_monitor (ddcutil + 0x9d8a9)
                                             #5  0x0000566e3a209752 main (ddcutil + 0x1b752)
                                             #6  0x000076c7c7298cd0 n/a (libc.so.6 + 0x25cd0)
                                             #7  0x000076c7c7298d8a __libc_start_main (libc.so.6 + 0x25d8a)
                                             #8  0x0000566e3a209895 _start (ddcutil + 0x1b895)
                                             ELF object binary architecture: AMD x86-64
Mar 21 03:31:16 eyrya (udev-worker)[487]: hiddev4: Process '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev4 -v' terminated by signal SEGV.
Mar 21 03:31:16 eyrya (udev-worker)[487]: hiddev4: Failed to wait for spawned command '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev4 -v': Input/output error
Mar 21 03:31:16 eyrya (udev-worker)[487]: hiddev4: /usr/lib/udev/rules.d/60-ddcutil-usb.rules:8 Failed to execute "/usr/bin/ddcutil chkusbmon /dev/usb/hiddev4 -v": Input/output error
Mar 21 03:31:16 eyrya (udev-worker)[483]: hiddev3: Process '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev3 -v' terminated by signal SEGV.
Mar 21 03:31:16 eyrya (udev-worker)[483]: hiddev3: Failed to wait for spawned command '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev3 -v': Input/output error
Mar 21 03:31:16 eyrya (udev-worker)[483]: hiddev3: /usr/lib/udev/rules.d/60-ddcutil-usb.rules:8 Failed to execute "/usr/bin/ddcutil chkusbmon /dev/usb/hiddev3 -v": Input/output error
Mar 21 03:31:16 eyrya mtp-probe[653]: checking bus 3, device 6: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.2"
Mar 21 03:31:16 eyrya mtp-probe[653]: bus: 3, device: 6 was not an MTP device
Mar 21 03:31:16 eyrya mtp-probe[654]: checking bus 3, device 3: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-6"
Mar 21 03:31:16 eyrya mtp-probe[654]: bus: 3, device: 3 was not an MTP device
Mar 21 03:31:16 eyrya mtp-probe[660]: checking bus 3, device 5: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-7"
Mar 21 03:31:16 eyrya mtp-probe[658]: checking bus 3, device 7: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.3"
Mar 21 03:31:16 eyrya mtp-probe[657]: checking bus 3, device 4: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.1"
Mar 21 03:31:16 eyrya mtp-probe[662]: checking bus 3, device 6: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.2"
Mar 21 03:31:16 eyrya mtp-probe[658]: bus: 3, device: 7 was not an MTP device
Mar 21 03:31:16 eyrya mtp-probe[662]: bus: 3, device: 6 was not an MTP device
Mar 21 03:31:16 eyrya mtp-probe[657]: bus: 3, device: 4 was not an MTP device
Mar 21 03:31:16 eyrya mtp-probe[661]: checking bus 3, device 8: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.4"
Mar 21 03:31:16 eyrya mtp-probe[661]: bus: 3, device: 8 was not an MTP device
Mar 21 03:31:16 eyrya systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Mar 21 03:31:17 eyrya mtp-probe[660]: bus: 3, device: 5 was not an MTP device
Mar 21 03:31:17 eyrya systemd[1]: systemd-coredump@1-577-0.service: Deactivated successfully.
Mar 21 03:31:17 eyrya systemd[1]: systemd-coredump@0-578-0.service: Deactivated successfully.
Mar 21 03:31:17 eyrya kernel: r8169 0000:0e:00.0 eth0: RTL8125B, 74:56:3c:b3:ab:24, XID 641, IRQ 121
Mar 21 03:31:17 eyrya kernel: r8169 0000:0e:00.0 eth0: jumbo features [frames: 9194 bytes, tx checksumming: ko]
Mar 21 03:31:17 eyrya kernel: Bluetooth: Core ver 2.22
Mar 21 03:31:17 eyrya kernel: NET: Registered PF_BLUETOOTH protocol family
Mar 21 03:31:17 eyrya kernel: Bluetooth: HCI device and connection manager initialized
Mar 21 03:31:17 eyrya kernel: Bluetooth: HCI socket layer initialized
Mar 21 03:31:17 eyrya kernel: Bluetooth: L2CAP socket layer initialized
Mar 21 03:31:17 eyrya kernel: Bluetooth: SCO socket layer initialized
Mar 21 03:31:17 eyrya kernel: r8169 0000:0e:00.0 enp14s0: renamed from eth0
Mar 21 03:31:17 eyrya kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Mar 21 03:31:17 eyrya kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Mar 21 03:31:17 eyrya kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
Mar 21 03:31:17 eyrya kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
Mar 21 03:31:17 eyrya kernel: cfg80211: failed to load regulatory.db
Mar 21 03:31:17 eyrya kernel: raid6: skipped pq benchmark and selected avx512x4
Mar 21 03:31:17 eyrya kernel: raid6: using avx512x2 recovery algorithm
Mar 21 03:31:17 eyrya kernel: xor: automatically using best checksumming function   avx       
Mar 21 03:31:17 eyrya kernel: usbcore: registered new interface driver btusb
Mar 21 03:31:17 eyrya kernel: Bluetooth: hci0: HW/SW Version: 0x008a008a, Build Time: 20240219103618
Mar 21 03:31:17 eyrya mtp-probe[792]: checking bus 3, device 7: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.3"
Mar 21 03:31:17 eyrya mtp-probe[792]: bus: 3, device: 7 was not an MTP device
Mar 21 03:31:17 eyrya systemd[1]: Starting Load/Save RF Kill Switch Status...
Mar 21 03:31:17 eyrya systemd[1]: Reached target Bluetooth Support.
Mar 21 03:31:17 eyrya systemd[1]: Started Load/Save RF Kill Switch Status.
Mar 21 03:31:17 eyrya kernel: Btrfs loaded, zoned=yes, fsverity=yes
Mar 21 03:31:17 eyrya kernel: mt7921e 0000:0f:00.0: enabling device (0000 -> 0002)
Mar 21 03:31:17 eyrya kernel: mt7921e 0000:0f:00.0: ASIC revision: 79220010
Mar 21 03:31:17 eyrya mtp-probe[806]: checking bus 3, device 8: "/sys/devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.4"
Mar 21 03:31:17 eyrya mtp-probe[806]: bus: 3, device: 8 was not an MTP device
Mar 21 03:31:17 eyrya kernel: mt7921e 0000:0f:00.0: HW/SW Version: 0x8a108a10, Build Time: 20240219103244a
Mar 21 03:31:17 eyrya kernel: Bluetooth: hci0: Device setup in 166655 usecs
Mar 21 03:31:17 eyrya kernel: Bluetooth: hci0: HCI Enhanced Setup Synchronous Connection command is advertised, but not supported.
Mar 21 03:31:17 eyrya kernel: mt7921e 0000:0f:00.0: WM Firmware Version: ____000000, Build Time: 20240219103337
Mar 21 03:31:17 eyrya kernel: input: Logitech G305 as /devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.1/3-3.1:1.2/0003:046D:C53F.0006/0003:046D:4074.000B/input/input42
Mar 21 03:31:17 eyrya kernel: logitech-hidpp-device 0003:046D:4074.000B: input,hidraw4: USB HID v1.11 Keyboard [Logitech G305] on usb-0000:13:00.0-3.1/input2:1
Mar 21 03:31:17 eyrya kernel: Bluetooth: hci0: AOSP extensions version v0.96
Mar 21 03:31:17 eyrya kernel: Bluetooth: hci0: AOSP quality report is not supported
Mar 21 03:31:17 eyrya kernel: input: Logitech K400 Plus as /devices/pci0000:00/0000:00:02.1/0000:03:00.0/0000:04:0c.0/0000:13:00.0/usb3/3-3/3-3.2/3-3.2:1.2/0003:046D:C52B.0009/0003:046D:404D.000C/input/input43
Mar 21 03:31:17 eyrya kernel: logitech-hidpp-device 0003:046D:404D.000C: input,hidraw5: USB HID v1.11 Keyboard [Logitech K400 Plus] on usb-0000:13:00.0-3.2/input2:1
Mar 21 03:31:20 eyrya systemd[1]: Reloading requested from client PID 649 ('systemd-sulogin') (unit emergency.service)...
Mar 21 03:31:20 eyrya systemd[1]: Reloading...
Mar 21 03:31:21 eyrya systemd[1]: Reloading finished in 204 ms.
Mar 21 03:31:21 eyrya systemd[1]: Stopped target Bluetooth Support.
Mar 21 03:31:21 eyrya systemd[1]: Stopped target Emergency Mode.
Mar 21 03:31:21 eyrya systemd[1]: Stopped target Sound Card.
Mar 21 03:31:21 eyrya systemd[1]: TPM2 PCR Extension (Varlink) was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
Mar 21 03:31:21 eyrya systemd[1]: Activating swap /dev/disk/by-uuid/a6e9e876-114b-433b-8fe2-0560179a29c3...
Mar 21 03:31:21 eyrya systemd[1]: Mounting /media/hey00/data_0...
Mar 21 03:31:21 eyrya systemd[1]: Mounting /media/hey00/data_1...
Mar 21 03:31:21 eyrya systemd[1]: Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
Mar 21 03:31:21 eyrya systemd[1]: Stopping Emergency Shell...
Mar 21 03:31:21 eyrya systemd[1]: Starting Load Kernel Module configfs...
Mar 21 03:31:21 eyrya systemd[1]: Starting Load Kernel Module dm_mod...
Mar 21 03:31:21 eyrya systemd[1]: Starting Load Kernel Module drm...
Mar 21 03:31:21 eyrya systemd[1]: Starting Load Kernel Module fuse...
Mar 21 03:31:21 eyrya systemd[1]: Starting Load Kernel Module loop...
Mar 21 03:31:21 eyrya systemd[1]: Rebuild Hardware Database was skipped because of an unmet condition check (ConditionNeedsUpdate=/etc).
Mar 21 03:31:21 eyrya systemd[1]: TPM2 PCR Machine ID Measurement was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
Mar 21 03:31:21 eyrya systemd[1]: Stopping Load/Save RF Kill Switch Status...
Mar 21 03:31:21 eyrya systemd[1]: Create System Users was skipped because no trigger condition checks were met.
Mar 21 03:31:21 eyrya systemd[1]: TPM2 SRK Setup (Early) was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
Mar 21 03:31:21 eyrya systemd[1]: TPM2 SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
Mar 21 03:31:21 eyrya systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Stopped Virtual Console Setup.
Mar 21 03:31:21 eyrya systemd[1]: First Boot Wizard was skipped because of an unmet condition check (ConditionFirstBoot=yes).
Mar 21 03:31:21 eyrya systemd[1]: First Boot Complete was skipped because of an unmet condition check (ConditionFirstBoot=yes).
Mar 21 03:31:21 eyrya systemd[1]: emergency.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Stopped Emergency Shell.
Mar 21 03:31:21 eyrya kernel: Adding 33554428k swap on /dev/sdc2.  Priority:-2 extents:1 across:33554428k 
Mar 21 03:31:21 eyrya kernel: BTRFS: device label data_1 devid 1 transid 30607 /dev/sdb1 scanned by mount (855)
Mar 21 03:31:21 eyrya systemd[1]: Activated swap /dev/disk/by-uuid/a6e9e876-114b-433b-8fe2-0560179a29c3.
Mar 21 03:31:21 eyrya systemd[1]: systemd-rfkill.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Stopped Load/Save RF Kill Switch Status.
Mar 21 03:31:21 eyrya systemd[1]: modprobe@configfs.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Finished Load Kernel Module configfs.
Mar 21 03:31:21 eyrya systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Finished Load Kernel Module dm_mod.
Mar 21 03:31:21 eyrya systemd[1]: modprobe@drm.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Finished Load Kernel Module drm.
Mar 21 03:31:21 eyrya systemd[1]: modprobe@fuse.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Finished Load Kernel Module fuse.
Mar 21 03:31:21 eyrya systemd[1]: modprobe@loop.service: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Finished Load Kernel Module loop.
Mar 21 03:31:21 eyrya kernel: BTRFS info (device sdb1): first mount of filesystem 624d8542-3fab-4533-ac65-6e5dad72ee1f
Mar 21 03:31:21 eyrya kernel: BTRFS info (device sdb1): using crc32c (crc32c-intel) checksum algorithm
Mar 21 03:31:21 eyrya kernel: BTRFS info (device sdb1): disk space caching is enabled
Mar 21 03:31:21 eyrya systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Mar 21 03:31:21 eyrya systemd[1]: Started Forward Password Requests to Wall Directory Watch.
Mar 21 03:31:21 eyrya systemd[1]: Reached target Swaps.
Mar 21 03:31:21 eyrya systemd[1]: systemd-rfkill.socket: Deactivated successfully.
Mar 21 03:31:21 eyrya systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Mar 21 03:31:21 eyrya systemd[1]: Repartition Root Disk was skipped because no trigger condition checks were met.
Mar 21 03:31:21 eyrya systemd[1]: Mounted /media/hey00/data_0.
Mar 21 03:31:21 eyrya kernel: EXT4-fs (sda1): mounted filesystem 4e0978f7-63d5-4315-ab1a-e379a65a7c09 r/w with ordered data mode. Quota mode: none.
Mar 21 03:31:21 eyrya kernel: BTRFS warning (device sdb1): devid 1 physical 0 len 4194304 inside the reserved space
Mar 21 03:31:30 eyrya systemd[1]: Mounted /media/hey00/data_1.
Mar 21 03:31:30 eyrya systemd[1]: Reached target Local File Systems.
Mar 21 03:31:30 eyrya systemd[1]: Rebuild Dynamic Linker Cache was skipped because no trigger condition checks were met.
Mar 21 03:31:30 eyrya systemd[1]: Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Mar 21 03:31:30 eyrya systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.
Mar 21 03:31:30 eyrya systemd[1]: Rebuild Journal Catalog was skipped because of an unmet condition check (ConditionNeedsUpdate=/var).
Mar 21 03:31:30 eyrya systemd[1]: Commit a transient machine-id on disk was skipped because of an unmet condition check (ConditionPathIsMountPoint=/etc/machine-id).
Mar 21 03:31:30 eyrya systemd[1]: Update is Completed was skipped because no trigger condition checks were met.
Mar 21 03:31:30 eyrya systemd[1]: Reached target System Initialization.

From the log, it seems systemd fails to mount my swap partition, and two of my data partitions that are on my HDDs: data_0 and data_1. data_backup is also on a HDD but in noauto, so not mounted at boot and no issue.
My data partitions on my SSD have no issues.

After I hit ctl-D, there are some other log lines indicating successful mount of those three partitions.

My fstab seems ok, I copied my old from my previous debian install (modified the root partition of course). Then I manually mounted everything and used genfstab. I also did an update-grub after each modification, no luck.
Here it is:

tmpfs                                       /tmp                    tmpfs   noatime,mode=1777       0 0 

# ssd 1
UUID=7286-47F2                              /boot/efi               vfat    fmask=0137,dmask=0027   0 2 
UUID=8a80996b-508e-4a4f-a3d2-40d2513f5107   /                       ext4    noatime                 0 1 
UUID=12588B7C588B5CFB /media/hey00/win11 auto nosuid,nodev,nofail,x-gvfs-show 0 0
UUID=8a3b830c-5f4b-4534-933d-d2131e5eede8 /media/hey00/kubuntu ext4 defaults 0 0

# ssd 2
UUID=AC0E64300E63F1AE /media/hey00/data_ntfs auto nosuid,nodev,nofail,x-gvfs-show 0 0

# hdd 1
UUID=4e0978f7-63d5-4315-ab1a-e379a65a7c09 /media/hey00/data_0 ext4 defaults 0 0

# hdd 2
UUID=624d8542-3fab-4533-ac65-6e5dad72ee1f /media/hey00/data_1 btrfs defaults 0 0

# hdd 3
UUID=23c189e1-1823-4849-b29e-a6c73bcef913 /media/hey00/data_backup btrfs noauto 0 0
UUID=a6e9e876-114b-433b-8fe2-0560179a29c3 none      swap       sw                 0 0

and lsblk -f:

NAME        FSTYPE FSVER LABEL       UUID                                 FSAVAIL FSUSE% MOUNTPOINTS
sda                                                                                      
`-sda1      ext4   1.0   data_0      4e0978f7-63d5-4315-ab1a-e379a65a7c09  400.8G    80% /media/hey00/data_0
sdb                                                                                      
`-sdb1      btrfs        data_1      624d8542-3fab-4533-ac65-6e5dad72ee1f  719.1G    74% /media/hey00/data_1
sdc                                                                                      
|-sdc1      btrfs        data_backup 23c189e1-1823-4849-b29e-a6c73bcef913                
`-sdc2      swap   1                 a6e9e876-114b-433b-8fe2-0560179a29c3                [SWAP]
nvme0n1                                                                                  
|-nvme0n1p1 vfat   FAT32             7286-47F2                              60.7M    37% /boot/efi
|-nvme0n1p2                                                                              
|-nvme0n1p3 ntfs         win10       12588B7C588B5CFB                       36.3G    76% /media/hey00/win11
|-nvme0n1p4 ntfs         winre       8EF8EB93F8EB77BB                                    
|-nvme0n1p5 ext4   1.0   kubuntu     8a3b830c-5f4b-4534-933d-d2131e5eede8   86.8G    36% /media/hey00/kubuntu
`-nvme0n1p6 ext4   1.0   endeavouros 8a80996b-508e-4a4f-a3d2-40d2513f5107  133.3G    12% /
nvme1n1                                                                                  
|-nvme1n1p1                                                                              
`-nvme1n1p2 ntfs         data_ntfs   AC0E64300E63F1AE                        3.2T    11% /media/hey00/data_ntfs

I'm out of options to try, if you have any idea of how I can solve that, I'm thankful.

Last edited by hey00 (2024-03-22 17:34:21)

seth · 2024-03-21 15:38:56

Mar 21 03:30:47 eyrya (udev-worker)[483]: hiddev3: Spawned process '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev3 -v' [491] is taking longer than 59s to complete
Mar 21 03:30:47 eyrya (udev-worker)[487]: hiddev4: Spawned process '/usr/bin/ddcutil chkusbmon /dev/usb/hiddev4 -v' [492] is taking longer than 59s to complete
Mar 21 03:30:47 eyrya systemd-udevd[477]: hiddev3: Worker [483] processing SEQNUM=3515 is taking a long time
Mar 21 03:30:47 eyrya systemd-udevd[477]: hiddev4: Worker [487] processing SEQNUM=3521 is taking a long time

Look for the udev rule that invokes ddcutil and move it away.
If you've not added one, it's most likely one of

usr/lib/udev/rules.d/60-ddcutil-i2c.rules
usr/lib/udev/rules.d/60-ddcutil-usb.rules

hey00 · 2024-03-21 16:04:28

Thanks for the advice, I removed /usr/lib/udev/rules.d/60-ddcutil-usb.rules and it seems to fix the problem somehow.
I still have some "a start/stop job is running for /dev..." at boot and shutdown, but it hangs only for around 10 seconds and doesn't block the boot anymore.

If I can take more of your time, do you know why ddcutil causes mount problems? I saw it in the logs, but considering it seems to be a tool to manipulate the screen, and since the errors were about my partitions, I ruled it out.
Or did I miss something?

seth · 2024-03-21 16:14:33

ddcutil is polling /dev/usb/hiddev{3,4} (possibly your keyboard), doesn't get an answer and stalls udev (udel rules are not supposed to run longtime jobs) and that just times out everything else.
Your swap and disk are most likely innocent victims here

=> figure what those hiddevs are and whether they maybe cause other problems

hey00 · 2024-03-21 17:57:37

Weird. Those two are my keyboards, they are plugged in a usb3 switch, to switch them from my pc to my work laptop quickly.

From my tests, it seems the problem arises if all 4 ports of the switch are populated by usb devices, or if at least 2 are, and one of them is my logitech wireless keyboard's dongle, but not always, it depends on the ports used. I've changed what I've plugged in and how, I have a working configuration now.

Thanks, you don't imagine how close I was to giving linux up, despite using it for over 15 years.

seth · 2024-03-21 20:56:47

\o/
Please always remember to mark resolved threads by editing your initial posts subject - so others will know that there's no task left, but maybe a solution to find.
Thanks.

Geeky_1 · 2024-11-07 03:12:16

seth wrote:

ddcutil is polling /dev/usb/hiddev{3,4} (possibly your keyboard), doesn't get an answer and stalls udev (udel rules are not supposed to run longtime jobs) and that just times out everything else.
Your swap and disk are most likely innocent victims here

Thank you very much - Google search turned up this thread. This was one of many errors I got after updating to the latest Ubuntu LTS, getting an error, and boot failures afterwards. Saved me from troubleshooting the boot disk, swapping out drives and reinstalling an older version of Ubuntu, etc. There were other serious errors such as "Watchdog detected hard LOCKUP on Cpu 6", "usb 3-3 device descroiptor read/64 error -71", etc. Searches on the other errors resulted in changing ACPI and other stuff. I suspected the USB as I had problems initially setting up this computer I was given a couple years ago with a USB keyboard - for some weird reason, I could only initially boot and install from an aftermarket wireless keyboard it came with - every time I tried to boot with a cabled USB keyboard, it failed until after I did the initial setup and/or install. So after reading your solution, I simply unplugged all USB devices (except keyboard and mouse) and it booted fine. I just wished I had tried that before reinstalling the older LTS version and wiping out everything on the boot disk and still getting boot errors. Just hope I had backed up all the data on my boot disk to my data disk.

Last edited by Geeky_1 (2024-11-07 03:15:53)

Arch Linux

#1 2024-03-21 11:03:01

[SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

#2 2024-03-21 15:38:56

Re: [SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

#3 2024-03-21 16:04:28

Re: [SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

#4 2024-03-21 16:14:33

Re: [SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

#5 2024-03-21 17:57:37

Re: [SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

#6 2024-03-21 20:56:47

Re: [SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

#7 2024-11-07 03:12:16

Re: [SOLVED] Timed out waiting for device /dev/disk/by-uuid/... at boot

Board footer