After upgrading dhcpcd to 5.2.7 on gentoo-sources-2.6.35 net.* start of services during boot leads to long (up to seveal minutes) random delays. With dhcpcd-5.2.6 or kernel 2.6.34 everything is OK. The situations is opposite to the problem, which leaded to appeariance of dhcpcd-5.2.7 in tree. Reproducible: Always Steps to Reproduce: 1. update kernel to 2.6.35 2. update dhcpcd to 5.2.7 3. add net.* services to default runlevel or to hotplug 4. try to boot Actual Results: System halts on net. services (both ethernet and wifi ones) time to time In the same time NetworkManager works fine.
emerge --info Portage 2.2_rc67 (default/linux/amd64/10.0/desktop, gcc-4.5.0, glibc-2.11.2-r0, 2.6.35-gentoo x86_64) ================================================================= System uname: Linux-2.6.35-gentoo-x86_64-Intel-R-_Core-TM-_i7_CPU_Q_720_@_1.60GHz-with-gentoo-2.0.1 Timestamp of tree: Fri, 06 Aug 2010 09:45:02 +0000 app-shells/bash: 4.1_p7 dev-java/java-config: 2.1.11 dev-lang/python: 2.6.5-r3, 3.1.2-r4 dev-util/cmake: 2.8.1-r2 sys-apps/baselayout: 2.0.1 sys-apps/openrc: 0.6.1-r1 sys-apps/sandbox: 2.2 sys-devel/autoconf: 2.13, 2.65-r1 sys-devel/automake: 1.8.5-r4, 1.9.6-r3, 1.10.3, 1.11.1 sys-devel/binutils: 2.20.1-r1 sys-devel/gcc: 4.4.4-r1, 4.5.0 sys-devel/gcc-config: 1.4.1 sys-devel/libtool: 2.2.10 virtual/os-headers: 2.6.34 ACCEPT_KEYWORDS="amd64 ~amd64" ACCEPT_LICENSE="* -@EULA PUEL dlj-1.1 skype-eula googleearth AdobeFlash-10.1" CBUILD="x86_64-pc-linux-gnu" CFLAGS="-O2 -march=native -pipe" CHOST="x86_64-pc-linux-gnu" CONFIG_PROTECT="/etc /usr/share/X11/xkb /usr/share/config /var/lib/hsqldb" CONFIG_PROTECT_MASK="/etc/ca-certificates.conf /etc/env.d /etc/env.d/java/ /etc/eselect/postgresql /etc/fonts/fonts.conf /etc/gconf /etc/gentoo-release /etc/php/apache2-php5/ext-active/ /etc/php/cgi-php5/ext-active/ /etc/php/cli-php5/ext-active/ /etc/revdep-rebuild /etc/sandbox.d /etc/splash /etc/terminfo /etc/texmf/language.dat.d /etc/texmf/language.def.d /etc/texmf/updmap.d /etc/texmf/web2c" CXXFLAGS="-O2 -march=native -pipe" DISTDIR="/var/portage/distfiles" FEATURES="assume-digests collision-protect distlocks fixpackages news nostrip parallel-fetch preserve-libs protect-owned sandbox sfperms strict unmerge-logs unmerge-orphans userfetch" GENTOO_MIRRORS="http://de-mirror.org/distro/gentoo/ http://gentoo.mneisen.org/ http://gentoo.tiscali.nl/" LANG="uk_UA.UTF-8" LDFLAGS="-Wl,-O1 -Wl,--as-needed -Wl,--hash-style=both" LINGUAS="ru uk eo en de" MAKEOPTS="-j4" PKGDIR="/var/portage/packages" PORTAGE_COMPRESS="lzma" PORTAGE_COMPRESS_FLAGS="--best" PORTAGE_CONFIGROOT="/" PORTAGE_RSYNC_OPTS="--recursive --links --safe-links --perms --times --compress --force --whole-file --delete --stats --timeout=180 --exclude=/distfiles --exclude=/local --exclude=/packages" PORTAGE_TMPDIR="/var/tmp" PORTDIR="/var/portage" PORTDIR_OVERLAY="/var/repositories/sunrise /var/repositories/qting-edge /var/repositories/kde /var/repositories/emacs /var/repositories/science /var/repositories/otih /var/repositories/lightscribe /var/repositories/x11 /var/repositories/gentoo-quebec /var/repositories/my" SYNC="rsync://rsync1.de.gentoo.org/gentoo-portage" USE="X a52 aac acl acpi alsa amd64 apache2 avahi bash-completion berkdb bittorrent bluetooth branding bzip2 cairo cdr cleartype cli consolekit cracklib crypt cups curl cxx dbus djvu dri dts dv dvd dvdr emacs emboss encode exif exiv2 expat fam fbcon fbsplash ffmpeg firefox firefox3 flac fontconfig freetype fuse gdbm gif gimp git gnuplot gnutls gphoto2 gpm gs gtk hal iconv imagemagick inotify ipv6 ipw3945 java java5 java6 jingle joystick jpeg jpeg2k kde kde4 kdehiddenvisibility kerberos kipi kpathsea laptop lastfm latex lcms ldap libnotify lm_sensors lmsensors logrotate lzma lzo mad matroska mikmod mmap mmx mng modules moznopango mp3 mp4 mpeg mpi mudflap multilib musicbrainz ncurses networkmanager newspr nls nptl nptlonly nsplugin ogg ogm openexr opengl openmp paludis pam pango pch pcre pdf perl phonon plasma png policykit ppds pppd python qml qt3support qt4 raw rcc readline reflection romio samba sdl semantic-desktop session slp social-desktop spell spl sse sse2 sse3 ssl ssse3 startup-notification svg symlink sysfs syslog system-sqlite tcpd tetex threads thumbnail tiff tk truetype udev unicode usb utemper v4l v4l2 vaapi vhosts vim-syntax vorbis vpx webkit wifi wmf x264 xattr xcb xcomposite xft xine xinerama xinetd xml xmp xorg xscreensaver xulrunner xv xvid zeroconf zlib" ALSA_CARDS="hda-intel" ALSA_PCM_PLUGINS="adpcm alaw asym copy dmix dshare dsnoop empty extplug file hooks iec958 ioplug ladspa lfloat linear meter mmap_emul mulaw multi null plug rate route share shm softvol" APACHE2_MODULES="actions alias auth_basic authn_alias authn_anon authn_dbm authn_default authn_file authz_dbm authz_default authz_groupfile authz_host authz_owner authz_user autoindex cache cgi cgid dav dav_fs dav_lock deflate dir disk_cache env expires ext_filter file_cache filter headers include info log_config logio mem_cache mime mime_magic negotiation rewrite setenvif speling status unique_id userdir usertrack vhost_alias" CAMERAS="canon sony fuji ptp2" ELIBC="glibc" INPUT_DEVICES="evdev joystick keyboard mouse synaptics wacom" KERNEL="linux" LCD_DEVICES="bayrad cfontz cfontz633 glk hd44780 lb216 lcdm001 mtxorb ncurses text" LINGUAS="ru uk eo en de" LIRC_DEVICES="wpc8769l" RUBY_TARGETS="ruby18" SANE_BACKENDS="snapscan" USERLAND="GNU" VIDEO_CARDS="v4l radeon fglrx" XTABLES_ADDONS="quota2 psd pknock lscan length2 ipv4options ipset ipp2p iface geoip fuzzy condition tee tarpit sysrq steal rawnat logmark ipmark dhcpmac delude chaos account" Unset: CPPFLAGS, CTARGET, EMERGE_DEFAULT_OPTS, FFLAGS, INSTALL_MASK, LC_ALL, PORTAGE_RSYNC_EXTRA_OPTS
Created attachment 241609 [details] Kernel config
Created attachment 241611 [details] conf.d/network
Hello Eugene, (In reply to comment #0) > After upgrading dhcpcd to 5.2.7 on gentoo-sources-2.6.35 net.* start of > services during boot leads to long (up to seveal minutes) random delays. With > dhcpcd-5.2.6 or kernel 2.6.34 everything is OK. This situation has two updates, Can you please debug this step by step? - try the old dhcpcd on the new kernel - boot into the old kernel and try the new dhcpcd (test the old kernel with the old dhcpcd in case something other happened) > The situations is opposite to > the problem, which leaded to appeariance of dhcpcd-5.2.7 in tree. Can you please provide a reference to this problem? Thanks, Michael
Hello Michael, > This situation has two updates, Can you please debug this step by step? > - try the old dhcpcd on the new kernel Works (5.2.6) > - boot into the old kernel and try the new dhcpcd Works (2.6.34), as I remember > (test the old kernel with the old dhcpcd in case something other happened) Will check a littel bit later > > The situations is opposite to > > the problem, which leaded to appeariance of dhcpcd-5.2.7 in tree. > > Can you please provide a reference to this problem? http://bugs.gentoo.org/show_bug.cgi?id=331087, https://bugzilla.kernel.org/show_bug.cgi?id=16187. Also there was a small discussion on Gentoo forums: http://forums.gentoo.org/viewtopic-p-6374908.html
Roy, do you have any suggestions for this? It seems to be the opposite of what was going on with the previous dhcpcd version. Thanks, William
Can you attach the output of this please? pkill dhcpcd dhcpcd -dB
(In reply to comment #7) > Can you attach the output of this please? > pkill dhcpcd > dhcpcd -dB and show where the lags are
I've tried to make some tests with both dhcpcd versions (and thus recompiled it many times) but after that I'm unable to reproduce the problem :( During that recompilations only gcc was upgrated from 4.5.0 to 4.5.1. Probably, bug should be closed as invalid now
(In reply to comment #9) > I've tried to make some tests with both dhcpcd versions (and thus recompiled it > many times) but after that I'm unable to reproduce the problem :( During that > recompilations only gcc was upgrated from 4.5.0 to 4.5.1. > Probably, bug should be closed as invalid now Ok, I am closing this per your request. Please re-open with the information requested if it re-occurs. Thanks, William
The bug is still exists, unfortunately. What can I add to original description? 1. It occurs only during the normal boot process. If I start net services manually (after booting without them), or even if I use interactive boot mode, everything is OK always. 2. In case of wireless interface, even led does not switch on (does not blink) during these timeouts. However, usually this led starts to blink as soon as ath9k module is loaded. 3. If boot process freeze, it is possible sometimes to unfreeze it by initiating events in system by pressing keys. Usually 2 switches of VTs work.
(In reply to comment #8) > (In reply to comment #7) > > Can you attach the output of this please? > > pkill dhcpcd > > dhcpcd -dB > > and show where the lags are > There are no lags if I run dhcpcd manually after boot. However, output is: dhcpcd -dB wlan0 dhcpcd[23622]: version 5.2.7 starting dhcpcd[23622]: wlan0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason PREINIT dhcpcd[23622]: wlan0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason CARRIER dhcpcd[23622]: wlan0: reading lease `/var/lib/dhcpcd/dhcpcd-wlan0.lease' dhcpcd[23622]: wlan0: rebinding lease of 192.168.2.100 dhcpcd[23622]: wlan0: sending REQUEST (xid 0x8a5ce767), next in 4.72 seconds dhcpcd[23622]: wlan0: acknowledged 192.168.2.100 from 192.168.2.1 dhcpcd[23622]: wlan0: checking for 192.168.2.100 dhcpcd[23622]: wlan0: sending ARP probe (1 of 3), next in 1.82 seconds dhcpcd[23622]: wlan0: sending ARP probe (2 of 3), next in 1.67 seconds dhcpcd[23622]: wlan0: sending ARP probe (3 of 3), next in 2.00 seconds dhcpcd[23622]: wlan0: leased 192.168.2.100 for infinity dhcpcd[23622]: wlan0: adding IP address 192.168.2.100/24 dhcpcd[23622]: wlan0: adding route to 192.168.2.0/24 dhcpcd[23622]: wlan0: adding default route via 192.168.2.1 dhcpcd[23622]: wlan0: writing lease `/var/lib/dhcpcd/dhcpcd-wlan0.lease' dhcpcd[23622]: wlan0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason BOUND dhcpcd[23622]: wlan0: sending ARP announce (1 of 2), next in 2.00 seconds dhcpcd[23622]: wlan0: sending ARP announce (2 of 2)
Same here, such a bummer if you happen to get a new wireless card and you're trying to get it up for the first time :) foghorn mofo # dhcpcd -dB dhcpcd[2876]: version 5.2.7 starting dhcpcd[2876]: eth0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason PREINIT dhcpcd[2876]: eth0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason CARRIER dhcpcd[2876]: wlan0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason PREINIT dhcpcd[2876]: wlan0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason NOCARRIER dhcpcd[2876]: vboxnet0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason PREINIT dhcpcd[2876]: vboxnet0: executing `/lib/dhcpcd/dhcpcd-run-hooks', reason CARRIER dhcpcd[2876]: eth0: reading lease `/var/lib/dhcpcd/dhcpcd-eth0.lease' dhcpcd[2876]: eth0: rebinding lease of 192.168.1.140 dhcpcd[2876]: eth0: sending REQUEST (xid 0x6507b822), next in 3.40 seconds dhcpcd[2876]: vboxnet0: reading lease `/var/lib/dhcpcd/dhcpcd-vboxnet0.lease' dhcpcd[2876]: vboxnet0: broadcasting for a lease dhcpcd[2876]: vboxnet0: sending DISCOVER (xid 0x945430d7), next in 3.97 seconds dhcpcd[2876]: wlan0: waiting for carrier dhcpcd[2876]: eth0: sending REQUEST (xid 0x6507b822), next in 7.35 seconds dhcpcd[2876]: vboxnet0: sending DISCOVER (xid 0x945430d7), next in 7.86 seconds dhcpcd[2876]: eth0: broadcasting for a lease dhcpcd[2876]: eth0: sending DISCOVER (xid 0xbd257c86), next in 4.65 seconds dhcpcd[2876]: vboxnet0: sending DISCOVER (xid 0x945430d7), next in 16.82 seconds dhcpcd[2876]: eth0: sending DISCOVER (xid 0xbd257c86), next in 8.87 seconds dhcpcd[2876]: eth0: sending DISCOVER (xid 0xbd257c86), next in 16.33 seconds dhcpcd[2876]: vboxnet0: sending DISCOVER (xid 0x945430d7), next in 31.87 seconds dhcpcd[2876]: timed out dhcpcd[2876]: eth0: sending DISCOVER (xid 0xbd257c86), next in 31.12 seconds dhcpcd[2876]: vboxnet0: sending DISCOVER (xid 0x945430d7), next in 64.85 seconds dhcpcd[2876]: eth0: sending DISCOVER (xid 0xbd257c86), next in 64.78 seconds dhcpcd[2876]: vboxnet0: sending DISCOVER (xid 0x945430d7), next in 63.29 seconds dhcpcd[2876]: eth0: sending DISCOVER (xid 0xbd257c86), next in 64.74 seconds
The error output on my system was: /sbin/dhcpcd: invalid option -- 'N' The option 'N' is derived from the configuration in /etc/conf.d/net: config_eth0=( "dhcp" ) dhcp_eth0=( "nontp" ) I found that if I disable the 'nontp' directive, then the boot process works just fine. But according to http://bit.ly/crIgYE line 81 the option should be possible to use (thou there are no mentions of the 'N' option in 'man dhcpcd', nor is there any other suggestion to what to use instead of 'N' or 'nontp').
With gentoo-sources-2.6.35-r5 it seems to be working fine
According to comment #15, this should be working now. Please re-open if it is still an issue. Thanks much, William
i'm seeing this running gentoo-sources-2.6.36, dhcpcd 4.0.15 and e1000 inside virtualbox-bin 3.2.10. i have nontp in net. waiting for carrier pause length seems to be random.
looking better with 5.2.8 now. https://bugzilla.kernel.org/show_bug.cgi?id=16187#c12
