https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c1 Andreas Jaeger changed: What |Removed |Added ---------------------------------------------------------------------------- Status|NEW |NEEDINFO InfoProvider| |carlos.e.r@opensuse.org AssignedTo|bnc-team-screening@forge.pr |fcrozat@suse.com |ovo.novell.com | --- Comment #1 from Andreas Jaeger 2011-12-06 14:29:02 UTC --- Carlos, what kind of networking setup do you use? Dhcp or static address? -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c3 --- Comment #3 from Carlos Robinson 2011-12-13 01:36:00 UTC --- This is the log extract of the boot while network is started - it takes half a minute. I have added and nfs mount, but that one is fast. If you want the full log, please ask. Dec 13 02:21:13 Elanor haveged: arch: x86#012vendor: intel#012generic: 0#012i_cache: 32#012d_cache: 32#012loop_idx: 28#012loop_idxmax: 40#012loop_sz: 31094#012loop_szmax: 100861#012etime: 7111#012havege_ndpt 0 Dec 13 02:21:13 Elanor cpufreq[734]: Loading CPUFreq modules - hardware support not available..skipped Dec 13 02:21:14 Elanor vmtoolsd[787]: Starting vmtoolsd ..done Dec 13 02:21:14 Elanor kernel: [ 7.607267] ip6_tables: (C) 2000-2006 Netfilter Core Team Dec 13 02:21:14 Elanor kernel: [ 7.677383] nf_conntrack version 0.5.0 (5913 buckets, 23652 max) Dec 13 02:21:14 Elanor kernel: [ 7.734167] ip_tables: (C) 2000-2006 Netfilter Core Team Dec 13 02:21:14 Elanor SuSEfirewall2: Firewall rules set to CLOSE. Dec 13 02:21:14 Elanor SuSEfirewall2_init[737]: Loading basic firewall rules .done Dec 13 02:21:14 Elanor network[881]: Setting up (localfs) network interfaces: Dec 13 02:21:15 Elanor network[881]: lo Dec 13 02:21:15 Elanor ifup: lo Dec 13 02:21:15 Elanor ifup: lo Dec 13 02:21:15 Elanor ifup: IP address: 127.0.0.1/8 Dec 13 02:21:15 Elanor network[881]: lo IP address: 127.0.0.1/8 Dec 13 02:21:15 Elanor ifup: Dec 13 02:21:15 Elanor network[881]: ..done eth0 device: Intel Corporation 82545EM Gigabit Ethernet Co Dec 13 02:21:15 Elanor ifup: eth0 device: Intel Corporation 82545EM Gigabit Ethernet Co Dec 13 02:21:16 Elanor kernel: [ 9.728050] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: None Dec 13 02:21:16 Elanor ifup-dhcp: eth0 Starting DHCP4+DHCP6 client Dec 13 02:21:16 Elanor dhcpcd[1264]: eth0: dhcpcd 3.2.3 starting Dec 13 02:21:16 Elanor dhcpcd[1264]: eth0: hardware address = 00:0c:29:6b:70:77 Dec 13 02:21:16 Elanor kernel: [ 9.809631] NET: Registered protocol family 17 Dec 13 02:21:16 Elanor dhcpcd[1264]: eth0: broadcasting for a lease Dec 13 02:21:16 Elanor ifup-dhcp: . Dec 13 02:21:17 Elanor dhcpcd[1264]: eth0: offered 192.168.74.131 from 192.168.74.254 Dec 13 02:21:17 Elanor dhcpcd[1264]: eth0: checking 192.168.74.131 is available on attached networks Dec 13 02:21:17 Elanor avahi-daemon[786]: Registering new address record for fe80::20c:29ff:fe6b:7077 on eth0.*. Dec 13 02:21:18 Elanor dhcpcd[1264]: eth0: leased 192.168.74.131 for 1800 seconds Dec 13 02:21:18 Elanor dhcpcd[1264]: eth0: adding IP address 192.168.74.131/24 Dec 13 02:21:18 Elanor avahi-daemon[786]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.74.131. Dec 13 02:21:18 Elanor avahi-daemon[786]: New relevant interface eth0.IPv4 for mDNS. Dec 13 02:21:18 Elanor avahi-daemon[786]: Registering new address record for 192.168.74.131 on eth0.IPv4. Dec 13 02:21:18 Elanor dhcpcd[1264]: eth0: adding default route via 192.168.74.2 metric 0 Dec 13 02:21:18 Elanor ifdown: eth0 device: Intel Corporation 82545EM Gigabit Ethernet Controller (Copper) (rev 01) Dec 13 02:21:19 Elanor ifup: eth0 device: Intel Corporation 82545EM Gigabit Ethernet Controller (Copper) (rev 01) Dec 13 02:21:19 Elanor ifup-dhcp: . Dec 13 02:21:22 Elanor ifup-dhcp: . Dec 13 02:21:24 Elanor ifup-dhcp: . Dec 13 02:21:26 Elanor kernel: [ 20.218706] eth0: no IPv6 routers present Dec 13 02:21:27 Elanor ifup-dhcp: . Dec 13 02:21:29 Elanor ifup-dhcp: . Dec 13 02:21:30 Elanor kernel: [ 24.279306] hrtimer: interrupt took 4385651 ns Dec 13 02:21:32 Elanor ifup-dhcp: . Dec 13 02:21:35 Elanor ifup-dhcp: . Dec 13 02:21:36 Elanor network[881]: eth0 Starting DHCP4+DHCP6 client. . . . . . . Dec 13 02:21:36 Elanor ifup-dhcp: Dec 13 02:21:36 Elanor network[881]: eth0 DHCP4 continues in background Dec 13 02:21:36 Elanor ifup-dhcp: eth0 DHCP4 continues in background Dec 13 02:21:36 Elanor network[881]: eth0 DHCP6 continues in background Dec 13 02:21:36 Elanor ifup-dhcp: eth0 DHCP6 continues in background Dec 13 02:21:36 Elanor network[881]: [1Awaiting Dec 13 02:21:36 Elanor network[881]: Waiting for mandatory devices: eth0 Dec 13 02:21:44 Elanor network[881]: 7 6 5 3 2 1 Dec 13 02:21:44 Elanor network[881]: eth0 device: Intel Corporation 82545EM Gigabit Ethernet Co Dec 13 02:21:44 Elanor network[881]: eth0 . . . is just beeing set up Dec 13 02:21:44 Elanor network[881]: eth0 IP address: 192.168.74.131/24 Dec 13 02:21:44 Elanor network[881]: eth0 is up Dec 13 02:21:44 Elanor network[881]: [1Awaiting Dec 13 02:21:44 Elanor network[881]: eth0 interface could not be set up until now Dec 13 02:21:44 Elanor network[881]: ..failedSetting up service (localfs) network . . . . . . . . . ...failed Dec 13 02:21:44 Elanor systemd[1]: network.service: control process exited, code=exited status=7 Dec 13 02:21:44 Elanor systemd[1]: Unit network.service entered failed state. Dec 13 02:21:45 Elanor bluez-coldplug[3678]: ..done -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c5 --- Comment #5 from Carlos Robinson 2011-12-14 13:03:25 UTC --- Created an attachment (id=467433) --> (http://bugzilla.novell.com/attachment.cgi?id=467433) logs requested -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c7 --- Comment #7 from Carlos Robinson 2011-12-14 21:11:17 UTC --- Created an attachment (id=467533) --> (http://bugzilla.novell.com/attachment.cgi?id=467533) logs requested Yep, here you have. Rebooted in verbose mode and attached demsg output. Elanor:~ # rcnetwork status redirecting to systemctl network.service - LSB: Configure the localfs depending network interfaces Loaded: loaded (/etc/init.d/network) Active: failed since Wed, 14 Dec 2011 22:04:35 +0100; 5min ago Process: 855 ExecStart=/etc/init.d/network start (code=exited, status=7/NOTRUNNING) CGroup: name=systemd:/system/network.service ├ 1258 /sbin/dhclient6 -6 -cf /var/lib/dhcp6/dhclient6.eth0.conf -lf /var/lib/dhcp6/dhclient6.eth0.lease -pf /var/run/dhclient6.eth0.pid -q eth0 └ 4061 /sbin/dhcpcd --netconfig -L -E -c /etc/sysconfig/network/scripts/dhcpcd-hook -t 0 -h Elanor eth0 Elanor:~ # -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c9 --- Comment #9 from Carlos Robinson 2011-12-20 13:39:57 UTC --- No, you can see in the output of rcnetwork status that it failed. The problem is that network is working fine but the status says failed, in red color. -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c11 Marius Tomaschewski changed: What |Removed |Added ---------------------------------------------------------------------------- Status|NEW |NEEDINFO InfoProvider| |carlos.e.r@opensuse.org --- Comment #11 from Marius Tomaschewski 2011-12-21 10:26:58 UTC --- Yes, it returns non-zero status when it is unable to configure in the time specified in /etc/sysconfig/network/config: WAIT_FOR_INTERFACES (default: 30 sec) This message is not a problem, just an info: ifup[571]: Service network not started and mode 'auto' -> skipping and means, that the eth0 became visible but could not be started via udev hotplug, because the network service (rcnetwork) were not yet started. The question is what is the reason for. A call of "ps axf" as soon as possible (while the network is still waiting/running) should show it. It is very likely the if-up.d/21-dhcpcd-hook-samba script blocks here (not only the 21-cifs) trying "systemdctl force-reload nmb.service" that blocks, even nmb service is completely unused. OK, rcnetwork has been started in the second 7: [ 7.598059] systemd[1]: About to execute: /etc/init.d/network start [ 7.602976] systemd[1]: Forked /etc/init.d/network as 855 [ 7.603095] systemd[1]: network.service changed dead -> start .. [ 12.104185] systemd[1]: Trying to enqueue job nmb.service/reload/replace [ 12.104207] systemd[1]: Installed new job nmb.service/reload as 192 [ 12.104212] systemd[1]: Enqueued job nmb.service/reload as 192 [ 12.104333] systemd[1]: Got D-Bus request: org.freedesktop.systemd1.Manager.GetUnit() on /org/freedesktop/systemd1 [ 12.104409] systemd[1]: Got D-Bus request: org.freedesktop.DBus.Properties.Get() on /org/freedesktop/systemd1/unit/nmb_2eservice This is (one of) the nmb reload mentioned above. .. [ 19.763112] eth0: no IPv6 routers present OK, here the interface setup basically finished (IPv6 autoconf)... [ 39.490158] systemd[1]: Received SIGCHLD from PID 855 (network). [ 39.490192] systemd[1]: Got SIGCHLD for process 855 (network) [ 39.490234] systemd[1]: Child 855 died (code=exited, status=7/NOTRUNNING) [ 39.490237] systemd[1]: Child 855 belongs to network.service [ 39.490242] systemd[1]: network.service: control process exited, code=exited status=7 [ 39.490245] systemd[1]: network.service got final SIGCHLD for state start [ 39.490272] systemd[1]: network.service changed start -> failed [ 39.490341] systemd[1]: Job network.service/start finished, result=failed [ 39.490356] systemd[1]: Unit network.service entered failed state. rcnetwork failed due to timeout (39 sec - 7 sec > 30 sec). [ 39.490441] systemd[1]: network.target changed dead -> active [ 39.490446] systemd[1]: Job network.target/start finished, result=done [ 39.490454] systemd[1]: Job nmb.service/reload finished, result=skipped The nmb.service reload returned finally... So this seems to be duplicate of bug 735943 / bug 725503 / bug 724777. A "rm -f /etc/sysconfig/network/if-up.d/21*" should solve the problem as workaround. Does it? Please attach also the output of "ps axwwwf" when possible to catch the moment where rcnetwork is still waiting (executes ifstatus again and again). -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c13 Carlos Robinson changed: What |Removed |Added ---------------------------------------------------------------------------- Status|NEEDINFO |NEW InfoProvider|carlos.e.r@opensuse.org | --- Comment #13 from Carlos Robinson 2011-12-21 20:19:19 UTC --- (In reply to comment #11)

A "rm -f /etc/sysconfig/network/if-up.d/21*" should solve the problem as workaround.

Does it?

Yep. Well, I moved them :-) Elanor:~ # rcnetwork status redirecting to systemctl network.service - LSB: Configure the localfs depending network interfaces Loaded: loaded (/etc/init.d/network) Active: active (running) since Wed, 21 Dec 2011 21:11:51 +0100; 2min 57s ago Process: 853 ExecStart=/etc/init.d/network start (code=exited, status=0/SUCCESS) CGroup: name=systemd:/system/network.service ├ 1248 /sbin/dhclient6 -6 -cf /var/lib/dhcp6/dhclient6.eth0.conf -lf /var/lib/dhcp6/dhclient6.eth0.lease -pf /var/run/dhclient6.eth0.pid -q eth0 └ 1790 /sbin/dhcpcd --netconfig -L -E -c /etc/sysconfig/network/scripts/dhcpcd-hook -t 0 -h Elanor eth0 Elanor:~ #

Please attach also the output of "ps axwwwf" when possible to catch the moment where rcnetwork is still waiting (executes ifstatus again and again).

This I don't know how to do it. I do not have access till I can log in, directly or via ssh, and by that time I guess it is too late. The code should have to be inserted in a service script, and that is something I do not know how to with systemd. -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c15 --- Comment #15 from Carlos Robinson 2011-12-22 10:15:16 UTC --- Created an attachment (id=468649) --> (http://bugzilla.novell.com/attachment.cgi?id=468649) tar requested -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c17 Bernhard Wiedemann changed: What |Removed |Added ---------------------------------------------------------------------------- CC| |bwiedemann@suse.com Platform|VMWare |All Blocks| |696902 --- Comment #17 from Bernhard Wiedemann 2012-01-02 17:21:21 CET --- I found a related problem: rcnetwork stop would not stop the network, when in "failed" state (even though it was up). moving /etc/sysconfig/network/if-up.d/21-dhcpcd-hook-samba also helped here. testing in a kvm VM with dhcp4 - no NTP or IPv6 involved. -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c19 --- Comment #19 from Marius Tomaschewski 2012-01-04 15:07:43 UTC --- See also bug 727771 and bug 732910 -- the systemd update has been released and is available already. sysconfig and dhcp-client test packages are at: http://download.opensuse.org/repositories/home:/mtomaschewski:/branches:/ope... -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.

https://bugzilla.novell.com/show_bug.cgi?id=732930 https://bugzilla.novell.com/show_bug.cgi?id=732930#c21 Marius Tomaschewski changed: What |Removed |Added ---------------------------------------------------------------------------- Status|NEW |RESOLVED Resolution| |DUPLICATE --- Comment #21 from Marius Tomaschewski 2012-01-10 13:10:10 UTC --- It is a dup of bug 732395 alias bug 725503 alias ... *** This bug has been marked as a duplicate of bug 732395 *** http://bugzilla.novell.com/show_bug.cgi?id=732395 -- Configure bugmail: https://bugzilla.novell.com/userprefs.cgi?tab=email ------- You are receiving this mail because: ------- You are on the CC list for the bug.