Server not found. Network is unreachable. dhcpcd? [Solved]

Issues Related to Networking (Wired and Wireless)

Moderator: Moderators

Server not found. Network is unreachable. dhcpcd? [Solved]

Postby Fitzcarraldo » Sat May 31, 2008 23:32

Network trouble again, I'm afraid. The recent migration to OpenRC and a new version dhcpcd software merged last Friday seem to me to be the likely culprits.

I upgraded around 50 packages last Friday (including dhcp and dhcpcd, which I think may be at the root of my problem) and, upon rebooting, have no network access any more.

KNetworkManager shows the little RJ45 plug, and a right-click on the icon shows WiFi networks in range if I have the WiFi Kill Switch turned to Off, but I cannot access the Internet or anything else on my home network. Firefox just shows a white window with the message "Server not found".

If I ping my hub from a Terminal window I get the message "connect: Network is unreachable"

I've tried re-merging openrc-0.2.4 (not 0.2.5 as I've read dire warnings about it in the Gentoo Bugzilla) and dhcpcd-3.2.3 and dhcpcd-4.0.0_beta5. I've tried re-merging them with the compat USE flag. I've tried "net-setup eth0" and "net-setup eth1". All to no avail. So I'm typing this from my Windows XP installation.

I may be wrong, but I think the problem is down to OpenRC and dhcpcd. Anyway, has anyone got any suggestions on how I can get networking going again?

Below is some information from issuing various commands in a Terminal window (I've left the WiFi Kill Switch in the On position as I would like to concentrate on getting wired Ethernet working again first):

Code: Select all
# ifconfig
eth0      Link encap:Ethernet  HWaddr 00:16:36:85:6d:77
          inet addr:169.254.163.51  Bcast:169.254.255.255  Mask:255.255.0.0
          inet6 addr: fe80::216:36ff:fe85:6d77/64 Scope:Link
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:43 errors:0 dropped:0 overruns:0 frame:0
          TX packets:86 errors:0 dropped:0 overruns:0 carrier:0
          collisions:24 txqueuelen:10
          RX bytes:5228 (5.1 KiB)  TX bytes:17857 (17.4 KiB)
          Memory:90100000-90120000

lo        Link encap:Local Loopback
          inet addr:127.0.0.1  Mask:255.0.0.0
          inet6 addr: ::1/128 Scope:Host
          UP LOOPBACK RUNNING  MTU:16436  Metric:1
          RX packets:177 errors:0 dropped:0 overruns:0 frame:0
          TX packets:177 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:28004 (27.3 KiB)  TX bytes:28004 (27.3 KiB)


Code: Select all
# dmesg | grep eth0
[   20.847288] eth0: (PCI Express:2.5GB/s:Width x1) 00:16:36:85:6d:77
[   20.847291] eth0: Intel(R) PRO/1000 Network Connection
[   20.847306] eth0: MAC: 2, PHY: 2, PBA No: ffffff-0ff
[   48.535116] ADDRCONF(NETDEV_UP): eth0: link is not ready
[   50.471422] eth0: Link is Up 10 Mbps Half Duplex, Flow Control: None
[   50.471427] eth0: 10/100 speed: disabling TSO
[   50.471951] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   60.614702] eth0: no IPv6 routers present
[  122.801885] eth0: no IPv6 routers present


Code: Select all
# dmesg | grep 3945
[   20.426607] iwl3945: Intel(R) PRO/Wireless 3945ABG/BG Network Connection driver for Linux, 1.2.26ks
[   20.426610] iwl3945: Copyright(c) 2003-2008 Intel Corporation
[   20.426750] iwl3945: Detected Intel Wireless WiFi Link 3945ABG
[   20.488038] iwl3945: Tunable channels: 13 802.11bg, 23 802.11a channels
[   20.488474] phy0: Selected rate control algorithm 'iwl-3945-rs'
[   44.360186] iwl3945: Radio disabled by HW RF Kill switch
[   47.095262] iwl3945: Radio disabled by HW RF Kill switch


Code: Select all
# ping 192.168.1.254
connect: Network is unreachable


Code: Select all
# eix openrc
[D] sys-apps/openrc
     Available versions:  ~0.2.2 ~0.2.2-r1[1] ~0.2.3 ~0.2.3-r1[1] ~0.2.4 ~0.2.4-r1 ~0.2.4-r10[1] **9999 **9999-r1[1] {debug kernel_FreeBSD kernel_linux ncurses pam unicode}
     Installed versions:  0.2.4(21:09:33 31/05/08)(kernel_linux ncurses pam unicode -debug -kernel_FreeBSD)
     Homepage:            http://roy.marples.name/openrc
     Description:         OpenRC manages the services, startup and shutdown of a host

[1] "sabayon" /usr/portage/local/layman/sabayon


Code: Select all
# eix -I dhcp
[I] net-misc/dhcp
     Available versions:  3.0.3-r9 3.0.6 3.1.0 {doc kernel_linux minimal selinux static}
     Installed versions:  3.1.0(19:13:51 30/05/08)(kernel_linux -doc -minimal -selinux -static)
     Homepage:            http://www.isc.org/products/DHCP
     Description:         ISC Dynamic Host Configuration Protocol

[D] net-misc/dhcpcd
     Available versions:  2.0.5-r1 3.0.16-r1 3.1.5-r1 ~3.2.2 3.2.3 ~4.0.0_beta1 ~4.0.0_beta2 ~4.0.0_beta3 ~4.0.0_beta4 ~4.0.0_beta5 {+compat build debug static vram zeroconf}
     Installed versions:  4.0.0_beta5(21:08:25 31/05/08)(zeroconf -+compat)
     Homepage:            http://roy.marples.name/dhcpcd
     Description:         A DHCP client

Found 2 matches.
#


I should emphasise that the Windows XP installation I'm using at this moment is on the same PC dual booting with SL and connected to the same network and hub. So the fact that I am typing this means that there is nothing wrong with the hub or its access to the Internet. So the problem must be with SL.
Last edited by Fitzcarraldo on Sat Jun 07, 2008 8:25, edited 1 time in total.
User avatar
Fitzcarraldo
Sagely Hen
 
Posts: 7981
Joined: Sat Mar 10, 2007 5:40
Location: United Kingdom

Re: Server not found. Network is unreachable. dhcpcd?

Postby Fitzcarraldo » Sun Jun 01, 2008 10:10

Some more information, as I'm in a public location at the moment. I switched the laptop's WiFi Kill Switch to the Off position (i.e. I enabled WiFi) and clicked on one of several unencrypted public WiFi networks that are visible when I right-click on the KNetworkManager icon in the top Panel. Pressing Ctrl-Alt-F12 while NetworkManager was trying to establish connection showed various messages, two of which were:

localhost NetworkManager: <info> Device 'eth1' DHCP transaction took too long (>45s), stopping it.
localhost NetworkManager: <info> Activation (eth1) Stage 4 of 5 (IP Configure Timeout) scheduled...

So it does look to me like DHCP is broken.

I have also now tried another tip from one of the several Gentoo Bugzilla bug reports on dhcpcd: I deleted /var/lib/dhcpcd and re-merged dhcpcd-4.0.0_Beta5, but it did not solve the problem.
User avatar
Fitzcarraldo
Sagely Hen
 
Posts: 7981
Joined: Sat Mar 10, 2007 5:40
Location: United Kingdom

Re: Server not found. Network is unreachable. dhcpcd?

Postby Fitzcarraldo » Thu Jun 05, 2008 7:38

I'm still not able to access a wired or wireless network or the Internet.

I've just tried re-merging dhcpcd-4.0.0_beta5, dhcp-3.1.0, nss-mdns-0.10, dnsmasq-2.41 and kdnssd-0.1.2, but to no avail.

I still have KNetworkManager's wired Ethernet icon appearing in the top Panel, but still cannot access the network or the Internet. Also, I still cannot connect to a WiFi network I select from the KNetworkManager drop-down menu.

And I still get the message "connect: Network is unreachable" if I try and ping anything. However, I have discovered that if I type the command "dhcpcd -h www.anydomain.com eth0" as root in a Terminal window then I can ping an IP address but not a domain name:

Code: Select all
# ping 125.252.225.27
connect: Network is unreachable
# dhcpcd -h www.hilton.com eth0
# ping 125.252.225.27
PING 125.252.225.27 (125.252.225.27) 56(84) bytes of data.
64 bytes from 125.252.225.27: icmp_seq=1 ttl=50 time=508 ms
64 bytes from 125.252.225.27: icmp_seq=2 ttl=50 time=563 ms
64 bytes from 125.252.225.27: icmp_seq=3 ttl=50 time=581 ms
64 bytes from 125.252.225.27: icmp_seq=4 ttl=50 time=506 ms
64 bytes from 125.252.225.27: icmp_seq=5 ttl=50 time=507 ms

--- 125.252.225.27 ping statistics ---
6 packets transmitted, 5 received, 16% packet loss, time 4996ms
rtt min/avg/max/mdev = 506.883/533.458/581.562/32.370 ms
# ping www.hilton.com
ping: unknown host www.hilton.com
#


Any dhcp, dhcpcd and DNS experts out there? I'm at a complete loss at the moment.

You may have realised from the above Terminal output that I'm in a hotel at the moment, so playing around with static IP is not an option and, in any case, dynamic IP allocation and DNS were working before, so I would like to get back to that situation.

Any suggestions on what I could try?
User avatar
Fitzcarraldo
Sagely Hen
 
Posts: 7981
Joined: Sat Mar 10, 2007 5:40
Location: United Kingdom

Re: Server not found. Network is unreachable. dhcpcd?

Postby xlnagla » Fri Jun 06, 2008 4:21

I'm afraid pretty much all I know about networking is straight from the gentoo handbook and wireless guides - but if you just want internet you can play around with a static IP - use the one assigned to your windows install. Doesn't solve the problem, but may help a bit. I can't believe you've been caused so much trouble by this migration... are all your net things manually symlinked as per the migration guide? If so you may want to check back on net.lo and the bunch, because a recent update rendered net.sh obsolete, and if you manually symlinked then etc-update (or whatever you use) might have missed it. Worth a thought.

~xlnagla
xlnagla
Sagely Hen
 
Posts: 1078
Joined: Mon May 28, 2007 2:44

Re: Server not found. Network is unreachable. dhcpcd?

Postby Fitzcarraldo » Fri Jun 06, 2008 11:52

Thanks for the reply. This openrc/dhcp thing is a PITA. OpenRC and DHCPCD seem to be a work in progress. The Gentoo Bugzilla has plenty of bug reports for openrc and dhcpcd, and there are several posts in the Gentoo Forums too about the recent revisions of these packages. I now wish I had left well alone and not merged the latest versions of everything, as I now cannot get back to where I was before for some reason. The net.lo stuff all looks OK to me. I didn't manually symlink.

Before the problem began I was successfully using the 2.6.25 kernel and iwlwifi (iwl3945). After the problem appeared, re-merging various packages had no effect, so I decided to drop back to the 2.6.23-r1 kernel and ipw3945 to see if that helped, but the behaviour remained exactly the same.

Yesterday I tried re-merging NetworkManager and KNetworkManager, but that didn't have any effect either. Today I downloaded via Windows XP the ebuild and tarball for openrc-0.2.5 and merged it (I was using openrc-0.2.4) to see if that would make any difference, but it didn't. Below is the content of /var/log/messages not long after I did a reboot at 08:20:20 (BST) with the Ethernet cable plugged in to my laptop. Then at 08:27:09 (BST) I unplugged the Ethernet cable from the laptop and right-clicked on a WiFi network in the KNetworkManager drop-down menu. After a while KNetworkManager displayed the error message "Connection Failure. Could not connect to the network MagiNet [email protected] (eth1)". It can be seen from the log that the DHCP transaction is not working, neither for eth0 (wired) nor eth1 (wireless). This behaviour has been consistent since the problem started a week ago.

I find it odd that the timestamp for the avahi-daemon is one hour earlier than for all other timestamps -- is it displaying UTC, or is this a problem with avahi-daemon? Oh, and I re-merged avahi a couple of days ago too, but that didn't change anything either.

Code: Select all
Jun  6 08:21:39 localhost NetworkManager: <info>  starting...
Jun  6 08:21:39 localhost NetworkManager: <info>  New VPN service 'vpnc' (org.freedesktop.NetworkManager.vpnc).
Jun  6 08:21:39 localhost NetworkManager: <info>  Found radio killswitch /org/freedesktop/Hal/devices/ipw_wlan_switch
Jun  6 08:21:39 localhost NetworkManager: <debug> [1212736899.718573] GentooReadConfig(): Enabling DHCP for device eth1.
Jun  6 08:21:39 localhost NetworkManager: <debug> [1212736899.718659] GentooReadConfig(): Found DNS nameservers in config.
Jun  6 08:21:39 localhost NetworkManager: <info>  eth1: Device is fully-supported using driver '(null)'.
Jun  6 08:21:39 localhost NetworkManager: <info>  eth1: driver does not support SSID scans (scan_capa 0x00).
Jun  6 08:21:39 localhost NetworkManager: <info>  nm_device_init(): waiting for device's worker thread to start
Jun  6 08:21:39 localhost NetworkManager: <info>  nm_device_init(): device's worker thread started, continuing.
Jun  6 08:21:39 localhost NetworkManager: <info>  Now managing wireless (802.11) device 'eth1'.
Jun  6 08:21:39 localhost NetworkManager: <info>  Deactivating device eth1.
Jun  6 08:21:40 localhost avahi-daemon[10827]: Found user 'avahi' (UID 108) and group 'avahi' (GID 444).
Jun  6 08:21:40 localhost avahi-daemon[10827]: Successfully dropped root privileges.
Jun  6 08:21:40 localhost avahi-daemon[10827]: avahi-daemon 0.6.22 starting up.
Jun  6 08:21:40 localhost avahi-daemon[10827]: Successfully called chroot().
Jun  6 07:21:40 localhost avahi-daemon[10827]: Successfully dropped remaining capabilities.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Loading service file /services/sftp-ssh.service.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Loading service file /services/ssh.service.
Jun  6 08:21:40 localhost [   48.131334] NET: Registered protocol family 10
Jun  6 08:21:40 localhost [   48.131424] lo: Disabled Privacy Extensions
Jun  6 08:21:40 localhost [   48.131486] ADDRCONF(NETDEV_UP): eth1: link is not ready
Jun  6 07:21:40 localhost avahi-daemon[10827]: System host name is set to 'localhost'. This is not a suitable mDNS host name, looking for alternatives.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Network interface enumeration completed.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Registering HINFO record with values 'X86_64'/'LINUX'.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Server startup complete. Host name is linux.local. Local service cookie is 2607132512.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Service "linux" (/services/ssh.service) successfully established.
Jun  6 07:21:40 localhost avahi-daemon[10827]: Service "SFTP File Transfer on linux" (/services/sftp-ssh.service) successfully established.
Jun  6 08:21:40 localhost /usr/sbin/gpm[10873]: *** info [daemon/startup.c(140)]:
Jun  6 08:21:40 localhost /usr/sbin/gpm[10873]: Started gpm successfully. Entered daemon mode.
Jun  6 08:21:41 localhost /etc/init.d/system-tools-backends[10889]: start-stop-daemon: did not create a valid pid in `/var/run/system-tools-backends.pid'
Jun  6 08:21:41 localhost /etc/init.d/system-tools-backends[10878]: ERROR: system-tools-backends failed to start
Jun  6 08:21:41 localhost [   49.096856] e1000: eth0: e1000_watchdog: NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX
Jun  6 08:21:41 localhost [   49.096861] e1000: eth0: e1000_watchdog: 10/100 speed: disabling TSO
Jun  6 08:21:41 localhost NetworkManager: <debug> [1212736901.734815] GentooReadConfig(): Enabling DHCP for device eth0.
Jun  6 08:21:41 localhost NetworkManager: <debug> [1212736901.734861] GentooReadConfig(): Found DNS nameservers in config.
Jun  6 08:21:41 localhost NetworkManager: <info>  eth0: Device is fully-supported using driver '(null)'.
Jun  6 08:21:41 localhost NetworkManager: <info>  nm_device_init(): waiting for device's worker thread to start
Jun  6 08:21:41 localhost NetworkManager: <info>  nm_device_init(): device's worker thread started, continuing.
Jun  6 08:21:41 localhost NetworkManager: <info>  Now managing wired Ethernet (802.3) device 'eth0'.
Jun  6 08:21:41 localhost NetworkManager: <info>  Deactivating device eth0.
Jun  6 08:21:41 localhost NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link.
Jun  6 08:21:41 localhost NetworkManager: <info>  Will activate wired connection 'eth0' because it now has a link.
Jun  6 08:21:41 localhost NetworkManager: <info>  SWITCH: no current connection, found better connection 'eth0'.
Jun  6 08:21:41 localhost dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.reason
Jun  6 08:21:41 localhost NetworkManager: <info>  Will activate connection 'eth0'.
Jun  6 08:21:41 localhost NetworkManager: <info>  Device eth0 activation scheduled...
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) started...
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started...
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting...
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful.
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete.
Jun  6 08:21:41 localhost NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
Jun  6 08:21:42 localhost NetworkManager: <info>  Wireless now enabled by radio killswitch
Jun  6 08:21:42 localhost NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction.
Jun  6 08:21:42 localhost NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
Jun  6 08:21:42 localhost NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth0
Jun  6 08:21:42 localhost NetworkManager: <debug> [1212736902.952083] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_alsa_sequencer').
Jun  6 08:21:42 localhost NetworkManager: <debug> [1212736902.970957] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_oss_sequencer').
Jun  6 08:21:42 localhost NetworkManager: <debug> [1212736902.973136] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_oss_sequencer_0').
Jun  6 08:21:43 localhost dhcdbd: Unrequested down ?:3
Jun  6 08:21:43 localhost NetworkManager: <info>  DHCP daemon state is now 14 (normal exit) for interface eth0
Jun  6 08:21:43 localhost acpid: client connected from 10936[0:0]
Jun  6 08:21:43 localhost acpid: 1 client rule loaded
Jun  6 08:21:50 localhost NetworkManager: <info>  Old device 'eth0' activating, won't change.
Jun  6 08:21:50 localhost sshd[11169]: Server listening on :: port 22.
Jun  6 08:21:50 localhost sshd[11169]: Server listening on 0.0.0.0 port 22.
Jun  6 08:21:51 localhost cron[11187]: (CRON) STARTUP (V5.0)
Jun  6 08:21:55 localhost [   62.614350] atkbd.c: Spurious ACK on isa0060/serio0. Some program might be trying access hardware directly.
Jun  6 08:21:56 localhost [   63.584924] atkbd.c: Spurious ACK on isa0060/serio0. Some program might be trying access hardware directly.
Jun  6 08:22:05 localhost kdm: :0[11004]: pam_unix(kde:session): session opened for user fitzcarraldo by (uid=0)
Jun  6 08:22:20 localhost NetworkManager: <info>  Old device 'eth0' activating, won't change.
Jun  6 08:22:27 localhost NetworkManager: <info>  Device 'eth0' DHCP transaction took too long (>45s), stopping it.
Jun  6 08:22:27 localhost NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) scheduled...
Jun  6 08:22:27 localhost NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) started...
Jun  6 08:22:27 localhost NetworkManager: <info>  No DHCP reply received.  Automatically obtaining IP via Zeroconf.
Jun  6 08:22:27 localhost NetworkManager: <info>  autoip: Sending probe #0 for IP address 169.254.163.51.
Jun  6 08:22:27 localhost NetworkManager: <info>  autoip: Waiting for reply...
Jun  6 08:22:28 localhost NetworkManager: <info>  autoip: Got some data to check for reply packet.
Jun  6 08:22:28 localhost NetworkManager: <WARN>  get_autoip(): autoip: (eth0) recv arp type=2054, op=1,
Jun  6 08:22:28 localhost NetworkManager: <WARN>  get_autoip():  source = 20.0.0.2 00:05:FF:00:13:EC,
Jun  6 08:22:28 localhost NetworkManager: <WARN>  get_autoip():  target = 20.0.0.2 00:00:00:00:00:00
Jun  6 08:22:28 localhost NetworkManager: <info>  autoip: Sending probe #1 for IP address 169.254.163.51.
Jun  6 08:22:28 localhost NetworkManager: <info>  autoip: Waiting for reply...
Jun  6 08:22:30 localhost NetworkManager: <info>  autoip: Sending probe #2 for IP address 169.254.163.51.
Jun  6 08:22:30 localhost NetworkManager: <info>  autoip: Waiting for reply...
Jun  6 08:22:31 localhost NetworkManager: <info>  autoip: Got some data to check for reply packet.
Jun  6 08:22:31 localhost NetworkManager: <WARN>  get_autoip(): autoip: (eth0) recv arp type=2054, op=1,
Jun  6 08:22:31 localhost NetworkManager: <WARN>  get_autoip():  source = 20.0.0.10 00:05:FF:00:13:AF,
Jun  6 08:22:31 localhost NetworkManager: <WARN>  get_autoip():  target = 20.0.0.10 00:00:00:00:00:00
Jun  6 08:22:31 localhost NetworkManager: <info>  autoip: Sending announce #0 for IP address 169.254.163.51.
Jun  6 08:22:31 localhost NetworkManager: <info>  autoip: Waiting for reply...
Jun  6 08:22:34 localhost NetworkManager: <info>  autoip: Got some data to check for reply packet.
Jun  6 08:22:34 localhost NetworkManager: <WARN>  get_autoip(): autoip: (eth0) recv arp type=2054, op=1,
Jun  6 08:22:34 localhost NetworkManager: <WARN>  get_autoip():  source = 20.0.0.4 00:05:FF:00:13:61,
Jun  6 08:22:34 localhost NetworkManager: <WARN>  get_autoip():  target = 20.0.0.4 00:00:00:00:00:00
Jun  6 08:22:34 localhost NetworkManager: <info>  autoip: Sending announce #1 for IP address 169.254.163.51.
Jun  6 08:22:34 localhost NetworkManager: <info>  autoip: Waiting for reply...
Jun  6 08:22:35 localhost (fitzcarraldo-11423): starting (version 2.22.0), pid 11423 user 'fitzcarraldo'
Jun  6 08:22:35 localhost (fitzcarraldo-11423): Resolved address "xml:readonly:/etc/gconf/gconf.xml.mandatory" to a read-only configuration source at position 0
Jun  6 08:22:35 localhost (fitzcarraldo-11423): Resolved address "xml:readwrite:/home/fitzcarraldo/.gconf" to a writable configuration source at position 1
Jun  6 08:22:35 localhost (fitzcarraldo-11423): Resolved address "xml:readonly:/etc/gconf/gconf.xml.defaults" to a read-only configuration source at position 2
Jun  6 08:22:35 localhost NetworkManager: <info>  autoip: Got some data to check for reply packet.
Jun  6 08:22:35 localhost NetworkManager: <WARN>  get_autoip(): autoip: (eth0) recv arp type=2054, op=1,
Jun  6 08:22:35 localhost NetworkManager: <WARN>  get_autoip():  source = 20.0.0.3 00:05:FF:00:13:D9,
Jun  6 08:22:35 localhost NetworkManager: <WARN>  get_autoip():  target = 20.0.0.3 00:00:00:00:00:00
Jun  6 08:22:35 localhost NetworkManager: <info>  autoip: Sending announce #2 for IP address 169.254.163.51.
Jun  6 08:22:35 localhost NetworkManager: <info>  autoip: Waiting for reply...
Jun  6 08:22:37 localhost NetworkManager: <info>  Updating allowed wireless network lists.
Jun  6 08:22:37 localhost NetworkManager: <info>  Old device 'eth0' activating, won't change.
Jun  6 08:22:37 localhost NetworkManager: <info>  Old device 'eth0' activating, won't change.
Jun  6 08:22:37 localhost NetworkManager: <info>  Old device 'eth0' activating, won't change.
Jun  6 08:22:38 localhost NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
Jun  6 08:22:38 localhost NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Timeout) complete.
Jun  6 08:22:38 localhost NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
Jun  6 07:22:38 localhost avahi-daemon[10827]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.163.51.
Jun  6 07:22:38 localhost avahi-daemon[10827]: New relevant interface eth0.IPv4 for mDNS.
Jun  6 07:22:38 localhost avahi-daemon[10827]: Registering new address record for 169.254.163.51 on eth0.IPv4.
Jun  6 08:22:40 localhost NetworkManager: <info>  Activation (eth0) Finish handler scheduled.
Jun  6 08:22:40 localhost NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.
Jun  6 08:22:40 localhost NetworkManager: <info>  Activation (eth0) successful, device activated.
Jun  6 07:22:41 localhost avahi-daemon[10827]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::216:36ff:fe85:6d77.
Jun  6 07:22:41 localhost avahi-daemon[10827]: New relevant interface eth0.IPv6 for mDNS.
Jun  6 07:22:41 localhost avahi-daemon[10827]: Registering new address record for fe80::216:36ff:fe85:6d77 on eth0.*.
Jun  6 08:22:50 localhost [  110.643171] eth0: no IPv6 routers present
Jun  6 08:22:56 localhost [  115.461144] /var/tmp/portage/media-video/gspcav1-20071224/work/gspcav1-20071224/gspca_core.c: [spca5xx_set_light_freq:1932] Sensor currently not support light frequency banding filters.
Jun  6 08:22:56 localhost [  115.461156] /var/tmp/portage/media-video/gspcav1-20071224/work/gspcav1-20071224/gspca_core.c: [gspca_set_isoc_ep:945] ISO EndPoint found 0x82 AlternateSet 7
Jun  6 08:23:55 localhost su[11662]: Successful su for root by fitzcarraldo
Jun  6 08:23:55 localhost su[11662]: + pts/1 fitzcarraldo:root
Jun  6 08:23:55 localhost su[11662]: pam_unix(su:session): session opened for user root by (uid=1000)
Jun  6 08:27:09 localhost [  222.068323] e1000: eth0: e1000_watchdog: NIC Link is Down
Jun  6 08:27:09 localhost NetworkManager: <info>  SWITCH: terminating current connection 'eth0' because it's no longer valid.
Jun  6 08:27:09 localhost NetworkManager: <info>  Deactivating device eth0.
Jun  6 07:27:09 localhost avahi-daemon[10827]: Withdrawing address record for 169.254.163.51 on eth0.
Jun  6 07:27:09 localhost avahi-daemon[10827]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.163.51.
Jun  6 08:27:09 localhost NetworkManager: nm_device_is_802_3_ethernet: assertion `dev != NULL' failed
Jun  6 08:27:09 localhost NetworkManager: nm_device_is_802_11_wireless: assertion `dev != NULL' failed
Jun  6 07:27:09 localhost avahi-daemon[10827]: Interface eth0.IPv4 no longer relevant for mDNS.
Jun  6 07:27:09 localhost avahi-daemon[10827]: Withdrawing address record for fe80::216:36ff:fe85:6d77 on eth0.
Jun  6 07:27:09 localhost avahi-daemon[10827]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::216:36ff:fe85:6d77.
Jun  6 07:27:09 localhost avahi-daemon[10827]: Interface eth0.IPv6 no longer relevant for mDNS.
Jun  6 08:27:17 localhost dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth1 for sub-path eth1.dbus.get.reason
Jun  6 08:27:17 localhost NetworkManager: <debug> [1212737237.293476] nm_device_802_11_wireless_get_activation_ap(): Forcing AP 'MagiNet [email protected]'
Jun  6 08:27:17 localhost NetworkManager: <info>  User Switch: /org/freedesktop/NetworkManager/Devices/eth1 / MagiNet [email protected]
Jun  6 08:27:17 localhost NetworkManager: <info>  Deactivating device eth1.
Jun  6 08:27:19 localhost NetworkManager: <info>  Device eth1 activation scheduled...
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1) started...
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1) Stage 1 of 5 (Device Prepare) started...
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) starting...
Jun  6 08:27:19 localhost NetworkManager: <info>  Activation (eth1/wireless): access point 'MagiNet [email protected]' is unencrypted, no key needed.
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: sending command 'INTERFACE_ADD eth1              wext    /var/run/wpa_supplicant '
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: response was 'OK'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: sending command 'AP_SCAN 1'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: response was 'OK'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: sending command 'ADD_NETWORK'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: response was '0'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 ssid 4d6167694e65742057694669404c6f756e676531'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: response was 'OK'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: sending command 'SET_NETWORK 0 key_mgmt NONE'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: response was 'OK'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: sending command 'ENABLE_NETWORK 0'
Jun  6 08:27:20 localhost NetworkManager: <info>  SUP: response was 'OK'
Jun  6 08:27:20 localhost NetworkManager: <info>  Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Jun  6 08:27:21 localhost NetworkManager: <info>  Old device 'eth1' activating, won't change.
Jun  6 08:27:55 localhost [  231.039794] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
Jun  6 08:27:55 localhost NetworkManager: <info>  Supplicant state changed: 1
Jun  6 08:27:55 localhost NetworkManager: <info>  Activation (eth1/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to access point 'MagiNet [email protected]'.
Jun  6 08:27:55 localhost NetworkManager: <info>  Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Jun  6 08:27:55 localhost NetworkManager: <info>  Activation (eth1) Stage 3 of 5 (IP Configure Start) started...
Jun  6 08:27:56 localhost NetworkManager: <info>  Activation (eth1) Beginning DHCP transaction.
Jun  6 08:27:56 localhost NetworkManager: <info>  Activation (eth1) Stage 3 of 5 (IP Configure Start) complete.
Jun  6 08:27:56 localhost NetworkManager: <info>  DHCP daemon state is now 12 (successfully started) for interface eth1
Jun  6 08:27:56 localhost NetworkManager: <info>  DHCP daemon state is now 6 (unknown) for interface eth1
Jun  6 08:27:56 localhost dhcdbd: Unrequested down ?:3
Jun  6 08:27:56 localhost NetworkManager: <info>  DHCP daemon state is now 14 (normal exit) for interface eth1
Jun  6 07:27:57 localhost avahi-daemon[10827]: Joining mDNS multicast group on interface eth1.IPv6 with address fe80::218:deff:fe4a:8ea8.
Jun  6 07:27:57 localhost avahi-daemon[10827]: New relevant interface eth1.IPv6 for mDNS.
Jun  6 07:27:57 localhost avahi-daemon[10827]: Registering new address record for fe80::218:deff:fe4a:8ea8 on eth1.*.
Jun  6 08:28:06 localhost [  232.622117] eth1: no IPv6 routers present
Jun  6 08:28:41 localhost NetworkManager: <info>  Device 'eth1' DHCP transaction took too long (>45s), stopping it.
Jun  6 08:28:41 localhost NetworkManager: <info>  Activation (eth1) Stage 4 of 5 (IP Configure Timeout) scheduled...
Jun  6 08:28:41 localhost NetworkManager: <info>  Activation (eth1) Stage 4 of 5 (IP Configure Timeout) started...
Jun  6 08:28:41 localhost NetworkManager: <info>  Activation (eth1) failure scheduled...
Jun  6 08:28:41 localhost NetworkManager: <info>  Activation (eth1) Stage 4 of 5 (IP Configure Timeout) complete.
Jun  6 08:28:41 localhost NetworkManager: <info>  Activation (eth1) failed for access point (MagiNet [email protected])
Jun  6 08:28:41 localhost NetworkManager: <info>  Activation (eth1) failed.
Jun  6 08:28:41 localhost NetworkManager: <info>  Deactivating device eth1.
Jun  6 07:28:41 localhost avahi-daemon[10827]: Withdrawing address record for fe80::218:deff:fe4a:8ea8 on eth1.
Jun  6 07:28:41 localhost avahi-daemon[10827]: Leaving mDNS multicast group on interface eth1.IPv6 with address fe80::218:deff:fe4a:8ea8.
Jun  6 07:28:41 localhost avahi-daemon[10827]: Interface eth1.IPv6 no longer relevant for mDNS.
Jun  6 08:28:43 localhost [  238.928957] ADDRCONF(NETDEV_UP): eth1: link is not ready
Jun  6 08:28:44 localhost [  239.027852] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
Jun  6 07:28:45 localhost avahi-daemon[10827]: Joining mDNS multicast group on interface eth1.IPv6 with address fe80::218:deff:fe4a:8ea8.
Jun  6 07:28:45 localhost avahi-daemon[10827]: New relevant interface eth1.IPv6 for mDNS.
Jun  6 07:28:45 localhost avahi-daemon[10827]: Registering new address record for fe80::218:deff:fe4a:8ea8 on eth1.*.
Jun  6 08:28:54 localhost [  241.313552] eth1: no IPv6 routers present

The SL 3.5 Beta Loop 3 LiveDVD freezes at the boot menu as soon as I press a key on my laptop's keyboard, so I can't even try to repair my current installation using that. I wonder if, when SL 3.5 is released, the LiveDVD will boot on my laptop. But I'm now beginning to wonder if it is worth my re-installing a Gentoo-based distro, as the volatility and fragility of certain fundamental packages at the moment means that a world update or update of certain packages can be disasterous.
User avatar
Fitzcarraldo
Sagely Hen
 
Posts: 7981
Joined: Sat Mar 10, 2007 5:40
Location: United Kingdom

Re: Server not found. Network is unreachable. dhcpcd?

Postby Drain » Sat Jun 07, 2008 1:04

try this:

sudo /etc/init.d/net.eth0 stop
sudo dhcpcd -d eth0

then post your /var/log/dhcpcd.log if you have troubles again
Image
Drain
Simple Hen
 
Posts: 46
Joined: Tue Oct 31, 2006 0:51

Re: Server not found. Network is unreachable. dhcpcd?

Postby Fitzcarraldo » Sat Jun 07, 2008 1:48

Many thanks for the reply, Drain, but been there, done that (many times).

I've cracked the problem, though, after hours of merging different versions of the various network packages. This is what I had to do to get it to work:

- Merge an earlier version of openrc (openrc-0.2.4)
- Merge an earlier version of dhcpcd (dhcpcd-3.1.5-r1)
- Re-merge dhcp-3.1.0
- Upgrade to dhcdbd-3.0

And the last one is tricky: see Gentoo Bugzilla bug report number 214196. I had to patch the ebuild and also the dhcdbd init file. I don't think a newcomer to Linux or SL/Gentoo would stand a chance.

I think the root of the problem lay with dhcdbd. I have only booted once since applying the above changes, so I'm not sure yet if this is stable, but at least I'm able now to sync with Portage and the SL overlay and hopefully rebuild the 2.6.25 kernel and Compiz-Fusion (which I'd also lost when trying to rebuild the 2.6.25 kernel after losing the connection -- see an earlier post).

All these Gentoo problems with openrc, dhcpd, dhcdbd etc. are a major hassle. I hope these packages stabilize soon and all the bugs and problematic interactions are ironed out.
User avatar
Fitzcarraldo
Sagely Hen
 
Posts: 7981
Joined: Sat Mar 10, 2007 5:40
Location: United Kingdom

Re: Server not found. Network is unreachable. dhcpcd?

Postby xlnagla » Sat Jun 07, 2008 2:13

so you're up (for now)?

~xlnagla
xlnagla
Sagely Hen
 
Posts: 1078
Joined: Mon May 28, 2007 2:44

Re: Server not found. Network is unreachable. dhcpcd?

Postby Fitzcarraldo » Sat Jun 07, 2008 8:24

Yes.

But somewhat unimpressed with the level of QA on the network packages by Gentoo devs. I've seen a smattering of posts in the past in the SL Forum by people writing things such as "DHCP doesn't work for me", "I have to use static IP addressing", and so on. I'm no longer surprised.
User avatar
Fitzcarraldo
Sagely Hen
 
Posts: 7981
Joined: Sat Mar 10, 2007 5:40
Location: United Kingdom

Re: Server not found. Network is unreachable. dhcpcd? [Solved]

Postby xlnagla » Sat Jun 07, 2008 19:11

You should see the gentoo networking guide... it basically assumes dhcp won't work out of the box.

~xlnagla
xlnagla
Sagely Hen
 
Posts: 1078
Joined: Mon May 28, 2007 2:44


Return to Networking and Wireless

Who is online

Users browsing this forum: No registered users and 1 guest