when startup delays become bugs

Paolo Bonzini pbonzini at redhat.com
Wed May 15 09:58:15 UTC 2013


Il 15/05/2013 05:43, Adam Williamson ha scritto:
> On Tue, 2013-05-14 at 15:51 -0600, Chris Murphy wrote:
> 
>> But firewalld goes from 7 seconds to 18 seconds? Why? avahi-daemon,
>> restorecond, all are an order of magnitude longer on F19 than F18.
>> It's a 3+ minute userspace hit on the startup time where the kernel
>> takes 1.9 seconds. Off hand this doesn't seem reasonable, especially
>> sendmail. If the time can't be brought down by a lot, can it ship
>> disabled by default?
> 
> FWIW, I found your results here interesting, so I did a little test of
> my own. I did default DVD installs of F17, F18 and F19 Beta TC4, ran
> through firstboot, rebooted, then rebooted again and ran systemd-analyze
> (to let prelink kick in). Results are that F18's slightly slower than
> F17 and F19 is somewhat slower again. My numbers are way way faster than
> your numbers overall, though; VMs do seem to perform very quickly on
> this box for whatever reason.

Can you include here the QEMU command line or libvirt XML definition?

Unless you have something like cache=none or cache='none' in it
(respectively for QEMU and libvirt), chances are that you're using the
host memory as a very fast and large disk cache for your VM. :)

(VMs tend to be fast in the initramfs anyway, because they do not have
much hardware to initialize, especially graphics cards).

Paolo

> F17
> ---
> 
> Startup finished in 493ms (kernel) + 794ms (initramfs) + 2751ms
> (userspace) = 4039ms
> 
>    446ms udev-settle.service
>    345ms NetworkManager.service
>    268ms systemd-logind.service
>    266ms ip6tables.service
>    262ms avahi-daemon.service
>    261ms iptables.service
>    173ms mcelog.service
>    170ms nfs-lock.service
>    145ms udev-trigger.service
>    136ms udev.service
>    135ms abrt-ccpp.service
>    122ms spice-vdagentd.service
>    117ms sendmail.service
>    114ms sm-client.service
>    110ms media.mount
>    106ms sys-kernel-debug.mount
>    105ms fedora-loadmodules.service
>    105ms dev-hugepages.mount
>    103ms dev-mqueue.mount
>    100ms sys-kernel-security.mount
>     98ms rsyslog.service
>     91ms remount-rootfs.service
>     90ms dbus.service
>     86ms sys-kernel-config.mount
>     84ms systemd-vconsole-setup.service
>     84ms acpid.service
>     77ms boot.mount
>     62ms systemd-tmpfiles-setup.service
>     56ms abrt-vmcore.service
>     53ms fedora-storage-init.service
>     53ms systemd-user-sessions.service
>     49ms sshd.service
>     47ms auditd.service
>     44ms systemd-remount-api-vfs.service
>     41ms colord.service
>     41ms systemd-sysctl.service
>     38ms bluetooth.service
>     32ms fedora-storage-init-late.service
>     28ms fedora-readonly.service
>     28ms lvm2-monitor.service
>     27ms systemd-readahead-collect.service
>     25ms colord-sane.service
>     18ms udisks2.service
>     18ms mdmonitor-takeover.service
>     13ms upower.service
>     13ms accounts-daemon.service
>     11ms rtkit-daemon.service
>     10ms rpcbind.service
>      9ms fedora-wait-storage.service
> 
> F18
> ---
> 
> Startup finished in 521ms (kernel) + 616ms (initramfs) + 3348ms
> (userspace) = 4485ms
> 
>    742ms iscsid.service
>    607ms firewalld.service
>    460ms systemd-udev-settle.service
>    372ms chronyd.service
>    369ms restorecond.service
>    321ms gdm.service
>    292ms abrt-ccpp.service
>    279ms ksmtuned.service
>    231ms accounts-daemon.service
>    208ms spice-vdagentd.service
>    208ms auditd.service
>    182ms systemd-logind.service
>    174ms avahi-daemon.service
>    167ms rtkit-daemon.service
>    163ms sm-client.service
>    116ms fedora-readonly.service
>    110ms fedora-loadmodules.service
>    109ms systemd-udev-trigger.service
>    104ms NetworkManager.service
>    101ms mcelog.service
>     95ms systemd-udevd.service
>     87ms sendmail.service
>     84ms sys-kernel-debug.mount
>     82ms dev-hugepages.mount
>     82ms dev-mqueue.mount
>     79ms iscsi.service
>     74ms systemd-remount-fs.service
>     64ms sys-kernel-config.mount
>     56ms systemd-vconsole-setup.service
>     52ms colord.service
>     42ms fedora-storage-init.service
>     41ms systemd-user-sessions.service
>     35ms udisks2.service
>     34ms ksm.service
>     34ms polkit.service
>     29ms systemd-tmpfiles-setup.service
>     28ms rpcbind.service
>     26ms bluetooth.service
>     24ms fedora-storage-init-late.service
>     23ms sshd.service
>     16ms abrt-vmcore.service
>     15ms upower.service
>     15ms lvm2-monitor.service
>     15ms systemd-sysctl.service
>     13ms systemd-modules-load.service
>     13ms mdmonitor-takeover.service
>     10ms boot.mount
>      4ms tmp.mount
> 
> F19
> ---
> 
> Startup finished in 411ms (kernel) + 745ms (initrd) + 4.704s (userspace)
> = 5.861s
> 
>           2.745s plymouth-quit-wait.service
>           2.389s NetworkManager-wait-online.service
>           1.078s accounts-daemon.service
>           1.026s firewalld.service
>           1.007s restorecond.service
>            987ms avahi-daemon.service
>            479ms iprupdate.service
>            385ms iprinit.service
>            356ms systemd-udev-settle.service
>            297ms ksmtuned.service
>            236ms spice-vdagentd.service
>            233ms abrt-ccpp.service
>            223ms plymouth-start.service
>            195ms gdm.service
>            185ms lvm2-monitor.service
>            171ms systemd-logind.service
>            169ms rtkit-daemon.service
>            160ms fedora-loadmodules.service
>            138ms sm-client.service
>            133ms systemd-udev-trigger.service
>            112ms iscsi.service
>            108ms systemd-fsck-root.service
>            106ms NetworkManager.service
>             97ms sshd.service
>             87ms polkit.service
>             83ms mcelog.service
>             82ms systemd-tmpfiles-setup-dev.service
>             81ms dev-mqueue.mount
>             80ms isdn.service
>             80ms dev-hugepages.mount
>             79ms sys-kernel-debug.mount
>             79ms systemd-modules-load.service
>             78ms iprdump.service
>             75ms tmp.mount
>             65ms systemd-fsck at dev-disk-by\x2duuid-51452866\x2dd2e9
> \x2d4ba5\x2d84cf\x2d00b46fc88fe2.service
>             64ms sendmail.service
>             56ms systemd-localed.service
>             54ms ksm.service
>             54ms abrt-vmcore.service
>             52ms systemd-user-sessions.service
>             45ms systemd-sysctl.service
>             45ms rpcbind.service
>             42ms systemd-udevd.service
>             38ms systemd-vconsole-setup.service
>             37ms fedora-readonly.service
>             36ms bluetooth.service
>             34ms plymouth-read-write.service
>             33ms dmraid-activation.service
>             33ms lvm2-lvmetad.service
>             32ms systemd-update-utmp-runlevel.service
>             31ms boot.mount
>             28ms udisks2.service
>             28ms systemd-remount-fs.service
>             26ms auditd.service
>             26ms colord.service
>             21ms systemd-tmpfiles-setup.service
>             19ms dev-mapper-fedora\x2dswap.swap
>             15ms upower.service
>              8ms systemd-readahead-done.service
>              8ms systemd-journal-flush.service
>              5ms sys-kernel-config.mount
> 



More information about the devel mailing list