On Tue, 01 Jan 2019 16:52:31 +0100, Michael Biebl wrote: > Am 01.01.19 um 01:40 schrieb gregor herrmann: > > [0] The initialization problems, with loads of: > > WARNING: Device /dev/xxx not initialized in udev database even after > > waiting 10000000 microseconds. > > Is that the only error message from udev? > Have you tried running udev with udev debug logging enabled (see > /etc/udev/udev.conf). > Maybe a debug log provides more hints what's going wrong.
Thanks for your quick reply and your debugging hints. This afternoon I tried to reproduce the issues in a VM but interestingly both didn't show up there (neither the missing modules nor the lvm troubles). -- No idea which difference between the VM and my real system is responsible here. So I tried on my laptop now. This is amd64 with the current 4.19 kernel from unstable, sysvinit, luks+lvm on the internal SSD and an external (USB) disk. Yesterday I downgraded udev to 239-15 and lvm2 to 2.02.176-4.1 to get back a working system. Now I first saved the ouptput of lsmod (attachment lsmod.udev-239-15), updated udev to 240-2, turned on debugging (udev_log=debug; hope that's correct?), and rebooted. What I then found again was a massive amount of not loaded modules. For comparison cf. attachment lsmod.udev-240-2. No visible lvm troubles at that point. Then I updated lvm2 to 240-2, and already at the installation I got: #v+ Installing new version of config file /etc/lvm/lvm.conf ... [....] Setting up LVM Volume Groups... WARNING: Device /dev/sda not initialized in udev database even after waiting 10000000 microseconds. WARNING: Device /dev/dm-0 not initialized in udev database even after waiting 10000000 microseconds. WARNING: Device /dev/sda1 not initialized in udev database even after waiting 10000000 microseconds. [etc.] #v- After a reboot I got the exakt same WARNINGS at "Setting up LVM Volume Groups..." during startup, and also on everything related to lvm, like plain `lvs' etc. Lines related to udev in the syslog are rare: with old lvm2: Jan 1 23:29:56 jadzia kernel: <1055>[ 18.202686] systemd-udevd[548]: Set children_max to 40 Jan 1 23:29:56 jadzia kernel: <1055>[ 18.202749] systemd-udevd[548]: Dedicated cgroup not found: No medium found Jan 1 23:30:02 jadzia kernel: <1055>[ 32.006943] systemd-udevd[548]: Validate module index Jan 1 23:30:02 jadzia kernel: <1055>[ 32.006954] systemd-udevd[548]: Check if link configuration needs reloading. Jan 1 23:30:08 jadzia kernel: <1055>[ 38.494397] systemd-udevd[548]: Cleanup idle workers Jan 1 23:30:08 jadzia kernel: <1055>[ 38.494798] systemd-udevd[548]: Worker [4333] exited Jan 1 23:37:05 jadzia kernel: <1055>[ 455.708050] systemd-udevd[548]: Validate module index Jan 1 23:37:05 jadzia kernel: <1055>[ 455.708083] systemd-udevd[548]: Check if link configuration needs reloading. with new lvm2: Jan 1 23:53:40 jadzia kernel: <1055>[ 18.268102] systemd-udevd[534]: Set children_max to 40 Jan 1 23:53:40 jadzia kernel: <1055>[ 18.268162] systemd-udevd[534]: Dedicated cgroup not found: No medium found Jan 1 23:53:40 jadzia kernel: <1055>[ 24.055069] systemd-udevd[534]: Cleanup idle workers Jan 1 23:53:40 jadzia kernel: <1055>[ 181.898002] systemd-udevd[534]: Validate module index Jan 1 23:53:40 jadzia kernel: <1055>[ 181.898028] systemd-udevd[534]: Check if link configuration needs reloading. Jan 1 23:53:42 jadzia kernel: <1055>[ 189.054934] systemd-udevd[534]: Cleanup idle workers Jan 1 23:57:06 jadzia kernel: <1055>[ 392.914786] systemd-udevd[534]: Unload module index Jan 1 23:57:06 jadzia kernel: <1055>[ 392.914897] systemd-udevd[534]: Unloaded link configuration context. Jan 1 23:57:06 jadzia kernel: [ 392.915694] systemd-udevd: 2084 output lines suppressed due to ratelimiting Jan 1 23:57:06 jadzia kernel: <1055>[ 392.962294] systemd-udevd[7278]: Set children_max to 40 Jan 1 23:57:06 jadzia kernel: <1055>[ 392.962371] systemd-udevd[7278]: Dedicated cgroup not found: No medium found Jan 1 23:57:29 jadzia kernel: <1055>[ 416.241338] systemd-udevd[7278]: Validate module index Jan 1 23:57:29 jadzia kernel: <1055>[ 416.241350] systemd-udevd[7278]: Check if link configuration needs reloading. Jan 1 23:58:08 jadzia kernel: <1055>[ 455.156872] systemd-udevd[7278]: Validate module index Jan 1 23:58:08 jadzia kernel: <1055>[ 455.156901] systemd-udevd[7278]: Check if link configuration needs reloading. /var/log/dmesg* has not much more: with old lvm2: [ 18.268085] systemd-udevd[534]: Unknown filesystem type 62656572 mounted on /sys/fs/cgroup. [ 18.268097] systemd-udevd[534]: Failed to determine root cgroup, ignoring cgroup memory limit: No medium found [ 18.268102] systemd-udevd[534]: Set children_max to 40 [ 18.268122] systemd-udevd[534]: Failed to symlink /proc/kcore to /dev/core: File exists [ 18.268129] systemd-udevd[534]: Failed to symlink /proc/self/fd to /dev/fd: File exists [ 18.268136] systemd-udevd[534]: Failed to symlink /proc/self/fd/0 to /dev/stdin: File exists [ 18.268143] systemd-udevd[534]: Failed to symlink /proc/self/fd/1 to /dev/stdout: File exists [ 18.268149] systemd-udevd[534]: Failed to symlink /proc/self/fd/2 to /dev/stderr: File exists [ 18.268158] systemd-udevd[534]: Unknown filesystem type 62656572 mounted on /sys/fs/cgroup. [ 18.268162] systemd-udevd[534]: Dedicated cgroup not found: No medium found [ 24.055069] systemd-udevd[534]: Cleanup idle workers [ 181.897926] systemd-udevd[534]: 254:5: Device (SEQNUM=2071, ACTION=add) is queued [ 181.898002] systemd-udevd[534]: Validate module index [ 181.898028] systemd-udevd[534]: Check if link configuration needs reloading. [ 181.898301] systemd-udevd[534]: Successfully forked off '(worker)' as PID 1176. [ 181.898406] systemd-udevd[534]: 254:5: Worker [1176] is forked for processing SEQNUM=2071. [ 181.898705] systemd-udevd[534]: dm-5: Device (SEQNUM=2072, ACTION=add) is queued [ 181.898909] systemd-udevd[534]: Successfully forked off '(worker)' as PID 1178. [ 181.899025] systemd-udevd[534]: dm-5: Worker [1178] is forked for processing SEQNUM=2072. [ 181.899338] systemd-udevd[534]: dm-5: Device (SEQNUM=2073, ACTION=change) is queued with new lvm2: [ 18.202665] systemd-udevd[548]: Unknown filesystem type 62656572 mounted on /sys/fs/cgroup. [ 18.202681] systemd-udevd[548]: Failed to determine root cgroup, ignoring cgroup memory limit: No medium found [ 18.202686] systemd-udevd[548]: Set children_max to 40 [ 18.202706] systemd-udevd[548]: Failed to symlink /proc/kcore to /dev/core: File exists [ 18.202714] systemd-udevd[548]: Failed to symlink /proc/self/fd to /dev/fd: File exists [ 18.202721] systemd-udevd[548]: Failed to symlink /proc/self/fd/0 to /dev/stdin: File exists [ 18.202729] systemd-udevd[548]: Failed to symlink /proc/self/fd/1 to /dev/stdout: File exists [ 18.202736] systemd-udevd[548]: Failed to symlink /proc/self/fd/2 to /dev/stderr: File exists [ 18.202744] systemd-udevd[548]: Unknown filesystem type 62656572 mounted on /sys/fs/cgroup. [ 18.202749] systemd-udevd[548]: Dedicated cgroup not found: No medium found [ 23.607394] systemd-udevd[548]: sunrpc: Device (SEQNUM=2084, ACTION=add) is queued [ 23.607416] systemd-udevd[548]: sunrpc: sd-device-monitor: Passed 129 byte to netlink monitor [ 23.607514] systemd-udevd[548]: rpc_inode_cache: Device (SEQNUM=2085, ACTION=add) is queued [ 23.607599] systemd-udevd[548]: rpc_inode_cache: sd-device-monitor: Passed 141 byte to netlink monitor Maybe there's something anyone can make sense of … Sorry for not being able to provide something clearer right now. Cheers, gregor -- .''`. https://info.comodo.priv.at -- Debian Developer https://www.debian.org : :' : OpenPGP fingerprint D1E1 316E 93A7 60A8 104D 85FA BB3A 6801 8649 AA06 `. `' Member VIBE!AT & SPI Inc. -- Supporter Free Software Foundation Europe `- NP: Bob Dylan: Like A Rolling Stone
Module Size Used by nls_ascii 16384 0 nls_cp437 20480 0 vfat 20480 0 fat 86016 1 vfat fuse 122880 2 vboxpci 28672 0 vboxnetadp 28672 0 vboxnetflt 32768 0 vboxdrv 483328 3 vboxpci,vboxnetadp,vboxnetflt zram 28672 4 zsmalloc 28672 1 zram rpcsec_gss_krb5 45056 0 pci_stub 16384 1 nfsv4 684032 2 dns_resolver 16384 1 nfsv4 cpufreq_userspace 16384 0 cpufreq_powersave 16384 0 cpufreq_conservative 16384 0 binfmt_misc 20480 1 uinput 20480 1 nfsd 421888 2 auth_rpcgss 73728 2 nfsd,rpcsec_gss_krb5 nfs_acl 16384 1 nfsd nfs 311296 3 nfsv4 lockd 118784 2 nfsd,nfs grace 16384 2 nfsd,lockd fscache 385024 2 nfsv4,nfs sunrpc 430080 14 nfsd,nfsv4,auth_rpcgss,lockd,rpcsec_gss_krb5,nfs_acl,nfs acpi_call 16384 0 ip6_tables 32768 0 ip_tables 28672 0 x_tables 45056 2 ip6_tables,ip_tables joydev 24576 0 hdaps 16384 1 tp_smapi 32768 0 thinkpad_ec 16384 2 hdaps,tp_smapi loop 32768 0 parport_pc 32768 0 ppdev 20480 0 lp 20480 0 parport 57344 3 parport_pc,lp,ppdev btusb 53248 0 btrtl 16384 1 btusb btbcm 16384 1 btusb btintel 24576 1 btusb uvcvideo 118784 0 bluetooth 643072 4 btrtl,btintel,btbcm,btusb videobuf2_vmalloc 16384 1 uvcvideo cdc_mbim 16384 0 videobuf2_memops 16384 1 videobuf2_vmalloc videobuf2_v4l2 28672 1 uvcvideo videobuf2_common 53248 2 videobuf2_v4l2,uvcvideo drbg 28672 1 videodev 212992 3 videobuf2_v4l2,uvcvideo,videobuf2_common ansi_cprng 16384 0 ecdh_generic 24576 1 bluetooth media 45056 2 videodev,uvcvideo cdc_ncm 40960 1 cdc_mbim usbnet 49152 2 cdc_mbim,cdc_ncm cdc_acm 32768 0 cdc_wdm 24576 1 cdc_mbim mii 16384 1 usbnet snd_hda_codec_hdmi 57344 1 snd_hda_codec_conexant 24576 1 snd_hda_codec_generic 86016 1 snd_hda_codec_conexant arc4 16384 0 intel_rapl 24576 0 x86_pkg_temp_thermal 16384 0 intel_powerclamp 16384 0 coretemp 16384 0 kvm_intel 241664 0 i915 1728512 11 wmi_bmof 16384 0 kvm 729088 1 kvm_intel snd_hda_intel 45056 5 snd_hda_codec 151552 4 snd_hda_codec_generic,snd_hda_codec_conexant,snd_hda_codec_hdmi,snd_hda_intel irqbypass 16384 1 kvm snd_hda_core 94208 5 snd_hda_codec_generic,snd_hda_codec_conexant,snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec snd_hwdep 16384 1 snd_hda_codec intel_cstate 16384 0 snd_pcm_oss 61440 0 snd_mixer_oss 28672 1 snd_pcm_oss intel_uncore 135168 0 drm_kms_helper 204800 1 i915 evdev 28672 30 intel_rapl_perf 16384 0 snd_pcm 114688 6 snd_hda_codec_hdmi,snd_hda_intel,snd_hda_codec,snd_pcm_oss,snd_hda_core drm 483328 12 drm_kms_helper,i915 serio_raw 16384 0 thinkpad_acpi 106496 1 pcspkr 16384 0 snd_timer 36864 2 snd_pcm tpm_tis 16384 0 nvram 16384 1 thinkpad_acpi iTCO_wdt 16384 0 sg 36864 0 i2c_algo_bit 16384 1 i915 tpm_tis_core 20480 1 tpm_tis snd 94208 19 snd_hda_codec_generic,snd_hda_codec_conexant,snd_hda_codec_hdmi,snd_hwdep,snd_hda_intel,snd_hda_codec,snd_timer,snd_pcm_oss,thinkpad_acpi,snd_pcm,snd_mixer_oss iTCO_vendor_support 16384 1 iTCO_wdt mei_me 45056 0 wmi 28672 1 wmi_bmof tpm 65536 2 tpm_tis,tpm_tis_core rfkill 28672 2 bluetooth,thinkpad_acpi mei 118784 1 mei_me soundcore 16384 1 snd rng_core 16384 1 tpm ac 16384 0 video 45056 2 thinkpad_acpi,i915 battery 24576 1 thinkpad_acpi button 16384 0 pcc_cpufreq 16384 0 ext4 733184 5 crc16 16384 2 bluetooth,ext4 mbcache 16384 1 ext4 jbd2 122880 1 ext4 fscrypto 32768 1 ext4 algif_skcipher 16384 0 af_alg 28672 1 algif_skcipher dm_crypt 40960 2 dm_mod 151552 27 dm_crypt hid_generic 16384 0 usbhid 57344 0 hid 139264 2 usbhid,hid_generic sr_mod 28672 0 cdrom 69632 1 sr_mod sd_mod 53248 5 uas 28672 0 ata_generic 16384 0 usb_storage 69632 2 uas crct10dif_pclmul 16384 0 crc32_pclmul 16384 0 crc32c_intel 24576 5 ghash_clmulni_intel 16384 0 pcbc 16384 0 aesni_intel 200704 7 ata_piix 36864 2 aes_x86_64 20480 1 aesni_intel crypto_simd 16384 1 aesni_intel cryptd 28672 5 crypto_simd,ghash_clmulni_intel,aesni_intel xhci_pci 16384 0 glue_helper 16384 1 aesni_intel libata 278528 2 ata_piix,ata_generic xhci_hcd 266240 1 xhci_pci sdhci_pci 45056 0 cqhci 28672 1 sdhci_pci sdhci 57344 1 sdhci_pci scsi_mod 249856 6 sd_mod,usb_storage,uas,libata,sg,sr_mod psmouse 172032 0 ehci_pci 16384 0 ehci_hcd 94208 1 ehci_pci mmc_core 172032 3 sdhci,cqhci,sdhci_pci i2c_i801 28672 0 lpc_ich 28672 0 usbcore 290816 14 xhci_hcd,ehci_pci,usbnet,usbhid,cdc_mbim,cdc_acm,cdc_ncm,usb_storage,cdc_wdm,uvcvideo,ehci_hcd,btusb,xhci_pci,uas e1000e 282624 0 usb_common 16384 1 usbcore thermal 20480 0
Module Size Used by zram 28672 4 zsmalloc 28672 1 zram pci_stub 16384 1 vboxpci 28672 0 rpcsec_gss_krb5 45056 0 vboxnetadp 28672 0 nfsv4 684032 2 vboxnetflt 32768 0 vboxdrv 483328 3 vboxpci,vboxnetadp,vboxnetflt dns_resolver 16384 1 nfsv4 cpufreq_userspace 16384 0 cpufreq_powersave 16384 0 cpufreq_conservative 16384 0 binfmt_misc 20480 1 uinput 20480 1 nfsd 421888 2 auth_rpcgss 73728 2 nfsd,rpcsec_gss_krb5 nfs_acl 16384 1 nfsd nfs 311296 3 nfsv4 lockd 118784 2 nfsd,nfs grace 16384 2 nfsd,lockd fscache 385024 2 nfsv4,nfs sunrpc 430080 14 nfsd,nfsv4,auth_rpcgss,lockd,rpcsec_gss_krb5,nfs_acl,nfs acpi_call 16384 0 ip6_tables 32768 0 ip_tables 28672 0 x_tables 45056 2 ip6_tables,ip_tables joydev 24576 0 hdaps 16384 1 tp_smapi 32768 0 thinkpad_ec 16384 2 hdaps,tp_smapi evdev 28672 6 pcspkr 16384 0 nvram 16384 0 loop 32768 0 parport_pc 32768 0 ppdev 20480 0 lp 20480 0 parport 57344 3 parport_pc,lp,ppdev ext4 733184 5 crc16 16384 1 ext4 mbcache 16384 1 ext4 jbd2 122880 1 ext4 fscrypto 32768 1 ext4 algif_skcipher 16384 0 af_alg 28672 1 algif_skcipher dm_crypt 40960 2 dm_mod 151552 27 dm_crypt hid_generic 16384 0 usbhid 57344 0 hid 139264 2 usbhid,hid_generic sr_mod 28672 0 cdrom 69632 1 sr_mod sd_mod 53248 5 uas 28672 0 ata_generic 16384 0 usb_storage 69632 2 uas crct10dif_pclmul 16384 0 crc32_pclmul 16384 0 crc32c_intel 24576 5 ghash_clmulni_intel 16384 0 pcbc 16384 0 xhci_pci 16384 0 xhci_hcd 266240 1 xhci_pci ata_piix 36864 2 libata 278528 2 ata_piix,ata_generic aesni_intel 200704 7 scsi_mod 249856 5 sd_mod,usb_storage,uas,libata,sr_mod aes_x86_64 20480 1 aesni_intel crypto_simd 16384 1 aesni_intel cryptd 28672 5 crypto_simd,ghash_clmulni_intel,aesni_intel glue_helper 16384 1 aesni_intel sdhci_pci 45056 0 ehci_pci 16384 0 cqhci 28672 1 sdhci_pci ehci_hcd 94208 1 ehci_pci psmouse 172032 0 sdhci 57344 1 sdhci_pci lpc_ich 28672 0 i2c_i801 28672 0 mmc_core 172032 3 sdhci,cqhci,sdhci_pci usbcore 290816 7 xhci_hcd,ehci_pci,usbhid,usb_storage,ehci_hcd,xhci_pci,uas e1000e 282624 0 usb_common 16384 1 usbcore thermal 20480 0
signature.asc
Description: Digital Signature