search for: crng

Hello When booting from a slow machine, I can observe dovecot blocking the whole boot process. I traced it down to the getrandom() system call in lib/randgen.c, which blocks until the random number generator is initialized (dmesg "random: crng init done"). This can take up to three minutes (!) on my machine, as there is not much entropy available (no hardware RNG, network VPN is also waiting for random). Unfortunately dovecot calls getrandom() before forking a daemon, which as a consequence blocks the whole init process (OpenRC on...

...> Hello > > > > When booting from a slow machine, I can observe dovecot blocking the > > whole boot process. I traced it down to the getrandom() system call in > > lib/randgen.c, which blocks until the random number generator is > > initialized (dmesg "random: crng init done"). This can take up to three > > minutes (!) on my machine, as there is not much entropy available (no > > hardware RNG, network VPN is also waiting for random). > > > > Unfortunately dovecot calls getrandom() before forking a daemon, which > > as a con...

...:00:1c.0: saving config space at offset 0x38 (reading 0x0) [ 25.145515] pcieport 0000:00:1c.0: saving config space at offset 0x3c (reading 0x201ff) [ 25.145604] pcieport 0000:00:1c.0: PME# enabled [ 26.265697] pcieport 0000:00:1c.0: power state changed by ACPI to D3cold [ 45.468365] random: crng init done [ 105.032727] usb 1-2: USB disconnect, device number 2 <= I removed a usb key, didn't help [ 128.495144] async_tx: api initialized (async) [ 128.514820] device-mapper: uevent: version 1.0.3 [ 128.518186] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initialised: dm-devel at...

...fig space at offset 0x38 (reading 0x0) > [ 25.145515] pcieport 0000:00:1c.0: saving config space at offset 0x3c (reading 0x201ff) > [ 25.145604] pcieport 0000:00:1c.0: PME# enabled > [ 26.265697] pcieport 0000:00:1c.0: power state changed by ACPI to D3cold > [ 45.468365] random: crng init done > [ 105.032727] usb 1-2: USB disconnect, device number 2 <= I removed a usb key, didn't help > [ 128.495144] async_tx: api initialized (async) > [ 128.514820] device-mapper: uevent: version 1.0.3 > [ 128.518186] device-mapper: ioctl: 4.42.0-ioctl (2020-02-27) initi...

...nd for VMware? > > Does it just take longer to start or do some services not start at all? It will take longer to start, it will start. Let me pass that workaround question to someone from vmware/virtualbox and #912087: On a recent kernel you see something like that: [ 68.823013] random: crng init done which means it took almost 69 seconds for the system to initialize its rng. OpenSSH 7.9 can be compilied against OpenSSL 1.1.1 which in turn switched to getrandom() (for its randomness). This syscall will block until kernel's rng is ready which took in this example almost 69 seconds....

On Mon, Oct 16, 2017 at 04:06:42PM +0000, Elias Hickman wrote: > supermin: internal insmod jbd2.ko > supermin: internal insmod mbcache.ko > supermin: internal insmod ext4.ko > [    0.384209] random: crng init done > supermin: internal insmod crc-itu-t.ko > supermin: internal insmod crc4.ko > supermin: internal insmod crc7.ko > supermin: internal insmod crc8.ko > supermin: internal insmod libcrc32c.ko > supermin: picked /sys/block/sdb/dev as root device > supermin: creating /dev...

...Burri via dovecot wrote: > Hello > > When booting from a slow machine, I can observe dovecot blocking the > whole boot process. I traced it down to the getrandom() system call in > lib/randgen.c, which blocks until the random number generator is > initialized (dmesg "random: crng init done"). This can take up to three > minutes (!) on my machine, as there is not much entropy available (no > hardware RNG, network VPN is also waiting for random). > > Unfortunately dovecot calls getrandom() before forking a daemon, which > as a consequence blocks the whole...

Just updated CentOS 9 Stream on a Lenovo T17 Gen 4 Intel and not it won't suspend with the following error: [ 52.604998] Restarting kernel threads ... done. [ 52.605111] OOM killer enabled. [ 52.605111] Restarting tasks ... done. [ 52.606604] random: crng reseeded on system resumption [ 52.616014] thermal thermal_zone9: failed to read out thermal zone (-61) [ 52.791625] PM: suspend exit [ 52.791733] PM: suspend entry (s2idle) [ 52.797260] Filesystems sync: 0.005 seconds [ 52.797579] Freezing user space processes ... (elapsed 0.001 seconds)...

...er 17, 2017, 1:17:54 AM GMT+9, Richard W.M. Jones <rjones@redhat.com> wrote: On Mon, Oct 16, 2017 at 04:06:42PM +0000, Elias Hickman wrote: > supermin: internal insmod jbd2.ko > supermin: internal insmod mbcache.ko > supermin: internal insmod ext4.ko > [    0.384209] random: crng init done > supermin: internal insmod crc-itu-t.ko > supermin: internal insmod crc4.ko > supermin: internal insmod crc7.ko > supermin: internal insmod crc8.ko > supermin: internal insmod libcrc32c.ko > supermin: picked /sys/block/sdb/dev as root device > supermin: creating /dev...

... [ 176.025679] random: crng init done [ 411.168635] netem: version 1.3 [ 456.059840] ------------[ cut here ]------------ [ 456.059849] WARNING: CPU: 4 PID: 1918 at net/ipv4/tcp_output.c:1048 tcp_set_skb_tso_segs+0xeb/0x100 [ 456.059851] Modules linked in: sch_netem cirrus ttm drm_kms_helper crc32_pclmul syscopyarea ghash...

...$Id: sgabios.S 8 2010-04-22 00:03:40Z nlaredo $ (mockbuild@) Mon Jun  9 21:33:48 UTC 2014 Term: 80x24 4 0 SeaBIOS (version 1.10.2-3.el7_4.1) Machine UUID 3b776b94-9173-4174-badb-323caa9893be Booting from ROM... \x1b[2J[    0.000000] random: get_random_bytes called from start_kernel+0x42/0x4be with crng_init=0 [    0.000000] Linux version 4.13.5-1.el7.elrepo.x86_64 (mockbuild@Build64R7) (gcc version 4.8.5 20150623 (Red Hat 4.8.5-16) (GCC)) #1 SMP Thu Oct 5 08:24:09 EDT 2017 [    0.000000] Command line: panic=1 console=ttyS0 edd=off udevtimeout=6000 udev.event-timeout=6000 no_timer_check printk.tim...

...; [ 9.384504] random: ssh-keygen: uninitialized urandom read (32 bytes read) > [ 9.839586] init: failsafe main process (724) killed by TERM signal > [ 14.865443] postgres (1245): /proc/1245/oom_adj is deprecated, please use /proc/1245/oom_score_adj instead. > [ 17.213418] random: crng init done > [ 17.580892] init: plymouth-upstart-bridge main process ended, respawning I suspect an off by one somewhere. I'm looking at the patch and I don't see it but these things are hard to spot sometimes ... > > > > > >> But this may not a > > > &g...

...onntrack version 0.5.0 (16384 buckets, 65536 max) [?? 29.629701] ip6_tables: (C) 2000-2006 Netfilter Core Team [?? 30.773604] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [?? 31.977476] FS-Cache: Loaded [?? 32.170682] FS-Cache: Netfs 'nfs' registered for caching [?? 53.671997] random: crng init done [26399.967630] INFO: task cp:14560 blocked for more than 120 seconds. [26399.967984] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [26399.968202] cp????????????? D ffff89373fc9ac80???? 0 14560 14053 0x00000080 [26399.968211] Call Trace: [26399.96...

...2: Link is Up - 1Gbps/Full - flow control off [ 14.631682] mvneta f1030000.ethernet eth1: Link is Up - 1Gbps/Full - flow control off [ 14.631697] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready [ 14.631799] IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [ 15.260026] random: crng init done [ 15.408152] fuse init (API version 7.26) [ 16.791999] mvneta f1070000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx [ 16.792014] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready

...27] IPv6: ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready Jan 25 13:16:40 localhost kernel: [ 14.872519] IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready Jan 25 13:16:40 localhost kernel: [ 15.613113] fuse init (API version 7.26) Jan 25 13:16:40 localhost kernel: [ 15.645347] random: crng init done Jan 25 13:16:41 localhost kernel: [ 16.153852] nouveau 0000:01:00.0: fifo: DMA_PUSHER - ch 4 [Xorg[3049]] get 0000000000 put 0000000000 ib_get 00000000 ib_put 00000002 state a0000000 (err: IB_EMPTY) push 00406040 Jan 25 13:16:42 localhost kernel: [ 17.042696] mvneta f1070000.ethernet...

...LB entries: 4KB 0, 2MB 0, 4MB 0 [ 1.189209] tlb_flushall_shift: 6 [ 1.198225] Speculative Store Bypass: Vulnerable [ 1.206223] FEATURE SPEC_CTRL Not Present [ 1.218208] FEATURE IBPB_SUPPORT Not Present [ 4.853233] Spectre V2 : Vulnerable: Retpoline without IBPB [ 13.376012] random: crng init done [ 101.375237] Freeing SMP alternatives: 24k freed [ 110.720007] BUG: unable to handle kernel NULL pointer dereference at 0000000000000102 [ 110.721000] IP: [<ffffffffad8b3ef2>] __queue_work+0x32/0x3e0 [ 110.721000] PGD 0 [ 110.721000] Oops: 0000 [#1] SMP [ 110.721000] Modules...

Ok, I have an update to this problem. I added the nouveau list because I can't quite tell if the issue is: - the PCIe changes that went in 5.6 I think (or 5.5?), referenced below - a new issue with thunderbold on thinkpad P73, that seems to be triggered if I have a USB-C yubikey in the port. With 5.7, my issues went away if I removed the USB key during boot, showing an interaction

Hi Ben, Thanks for your reply. My replies follow in between. Luís On Thu, Jan 25, 2018 at 5:40 AM, Ben Skeggs <skeggsb at gmail.com> wrote: > On 24 January 2018 at 06:19, Luís Mendes <luis.p.mendes at gmail.com> wrote: >> Hi Arnd, >> >> Sorry for sending this email directly to you, but maybe you can help >> me, or guide me where to look for. >>

...stment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GIC: Using split EOI/Deactivate mode [ 0.000000] random: get_random_bytes called from start_kernel+0x2a8/0x434 with crng_init=0 [ 0.000000] arch_timer: cp15 timer(s) running at 31.25MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xe6a171046, max_idle_ns: 881590405314 ns [ 0.000002] sched_clock: 56 bits at 31MHz, resolution 32ns, wraps every 4398046511088ns [ 0.00...

...[ 0.353127] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14 > [ 0.353645] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15 > [ 0.541003] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10 > [ 0.545766] random: fast init done > [ 0.548737] random: crng init done > [ 0.565923] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11 > [ 0.567592] scsi host2: Virtio SCSI HBA > [ 0.569801] scsi 2:0:0:0: Direct-Access QEMU QEMU HARDDISK > 2.5+ PQ: 0 ANSI: 5 > [ 0.570526] scsi 2:0:1:0: Direct-Access QEMU QEMU HARD...