Re: networkmanager-0.9.8.9 will not connect to a wired network

[Dan Williams <dcbw redhat com>]

On Wed, 2014-04-23 at 11:37 -0500, Dan Williams wrote:
> On Tue, 2014-04-22 at 10:05 +0000, John Frankish wrote:
> > I compiled networkmanager-0.9.8.9 from source to /usr/local to use dhcpcd (also compiled from source).
> >
> > Since networkmanager configured as above looks for /usr/local/etc/hosts, I adjusted the source to look at 
> > /etc/hosts (it already knew to look for /etc/resolv.conf).
> >
> > Run from the console, neworkmanager looks as though it connects to an ipv4 wired network (I've tried two 
> > different networks), modifies /etc/resolv.conf accordingly, but it does not actually connect -I cannot 
> > ping the router nor google.com.
> >
> > Dhcpcd run alone from the console connects without problems.
> >
> > This is the same problem I experienced using networkmanager-0.9.8.8 reported in another thread.
> >
> > I've attached the networkmanager debug output and the strace output, but neither seem to give a clue as 
> > to the problem - I believe that either networkmanager is trying to write something to /usr/local/etc that 
> > is in /etc (or vice versa) or there is some kind of linux-pam/polkit permissions error, but I cannot see 
> > evidence of either in the debug output.
> >
> > From the debug snippet below things look to have worked, but they didn't - any troubleshooting hints 
> > would be gratefully received.
>
> The x.x.x.x/0 bits are likely the problem.  Let's investigate why that's
> happening especially since NetworkManager says it got the right prefix
> from dhcpcd.
>
> Would you mind applying the attached patch to your sources?  Then re-run
> the test and reply with the output so we can debug a bit further.

One more thing, when things aren't working, can you provide the output
of:

ip addr
ip route

Thanks!
Dan

> Thanks!
> Dan
>
> > Regards
> > John
> >
> > ----------
> >
> > dhcpcd[6086]: eth0: leased 10.180.20.123 for 259200 seconds
> > dhcpcd[6086]: eth0: adding route to 10.180.20.0/24
> > NetworkManager[6068]: <info> (eth0): DHCPv4 state changed preinit -> bound
> > NetworkManager[6068]: <debug> [1397985943.868098] [nm-device.c:1945] dhcp4_state_changed(): (eth0): new 
> > DHCPv4 client state 3
> > NetworkManager[6068]: <info>   address 10.180.20.123
> > NetworkManager[6068]: <info>   prefix 24 (255.255.255.0)
> > NetworkManager[6068]: <info>   gateway 10.180.20.1
> > NetworkManager[6068]: <info>   nameserver '10.180.1.10'
> > NetworkManager[6068]: <info>   domain name 'mena.saxonservices.local'
> > NetworkManager[6068]: <info> Activation (eth0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
> > NetworkManager[6068]: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) started...
> > NetworkManager[6068]: <debug> [1397985943.870957] [nm-system.c:194] sync_addresses(): (eth0): syncing 
> > addresses (family 2)
> > NetworkManager[6068]: <debug> [1397985943.871084] [nm-system.c:247] sync_addresses(): (eth0): removing 
> > address '10.180.20.123/24'
> > NetworkManager[6068]: <debug> [1397985943.871263] [nm-system.c:280] sync_addresses(): (eth0): adding 
> > address '10.180.20.123/0'
> > dhcpcd[6086]: eth0: removing IP address 10.180.20.123/24
> > dhcpcd[6086]: eth0: deleting route to 10.180.20.0/24
> > NetworkManager[6068]: <debug> [1397985944.871915] [nm-netlink-utils.c:356] dump_route():   route idx 1 
> > family INET (2) addr 127.0.0.1/32
> > NetworkManager[6068]: <debug> [1397985944.872102] [nm-netlink-utils.c:356] dump_route():   route idx 1 
> > family INET (2) addr 127.0.0.0/32
> > NetworkManager[6068]: <debug> [1397985944.872172] [nm-netlink-utils.c:356] dump_route():   route idx 1 
> > family INET (2) addr 127.0.0.0/8
> > NetworkManager[6068]: <debug> [1397985944.872244] [nm-netlink-utils.c:356] dump_route():   route idx 1 
> > family INET (2) addr 127.0.0.1/32
> > NetworkManager[6068]: <debug> [1397985944.872319] [nm-netlink-utils.c:356] dump_route():   route idx 1 
> > family INET (2) addr 127.255.255.255/32
> > NetworkManager[6068]: <debug> [1397985944.872590] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): 
> > (device_ip4_config_changed): queueing DNS updates (1)
> > NetworkManager[6068]: <debug> [1397985944.872675] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): 
> > (nm_dns_manager_end_updates): DNS configuration did not change
> > NetworkManager[6068]: <debug> [1397985944.872735] [nm-dns-manager.c:1017] nm_dns_manager_end_updates(): 
> > (device_ip4_config_changed): no DNS changes to commit (0)
> > NetworkManager[6068]: <info> (eth0): device state change: ip-config -> secondaries (reason 'none') [70 90 
> > 0]
> > NetworkManager[6068]: <debug> [1397985944.873173] [nm-device.c:5261] nm_device_queue_state(): (eth0): 
> > queued state change to activated (id 60)
> > NetworkManager[6068]: <debug> [1397985944.873315] [nm-manager.c:4142] policy_activating_device_changed(): 
> > ActivatingConnection now (none)
> > NetworkManager[6068]: <debug> [1397985944.873423] [nm-device.c:5191] nm_device_state_changed(): (eth0): 
> > device entered SECONDARIES state
> > NetworkManager[6068]: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) complete.
> > NetworkManager[6068]: <info> (eth0): DHCPv4 state changed bound -> expire
> > NetworkManager[6068]: <debug> [1397985944.875537] [nm-device.c:1945] dhcp4_state_changed(): (eth0): new 
> > DHCPv4 client state 17
> > NetworkManager[6068]: <debug> [1397985944.875983] [nm-device.c:5219] queued_set_state(): (eth0): running 
> > queued state change to activated (id 60)
> > NetworkManager[6068]: <info> (eth0): device state change: secondaries -> activated (reason 'none') [90 
> > 100 0]
> > NetworkManager[6068]: <debug> [1397985944.876484] [nm-manager.c:4050] connectivity_changed(): 
> > connectivity checking indicates FULL
> > NetworkManager[6068]: <info> NetworkManager state is now CONNECTED_GLOBAL
> > NetworkManager[6068]: <debug> [1397985944.876992] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): 
> > (device_state_changed): queueing DNS updates (1)
> > NetworkManager[6068]: <debug> [1397985944.877065] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): 
> > (update_routing_and_dns): queueing DNS updates (2)
> > NetworkManager[6068]: <info> Policy set 'Wired connection 1' (eth0) as default for IPv4 routing and DNS.
> > NetworkManager[6068]: <debug> [1397985944.877721] [nm-manager.c:4109] policy_default_device_changed(): 
> > PrimaryConnection now Wired connection 1
> > NetworkManager[6068]: <debug> [1397985944.877842] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): 
> > (nm_dns_manager_end_updates): DNS configuration changed
> > NetworkManager[6068]: <debug> [1397985944.877893] [nm-dns-manager.c:1017] nm_dns_manager_end_updates(): 
> > (update_routing_and_dns): no DNS changes to commit (1)
> > NetworkManager[6068]: <debug> [1397985944.877945] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): 
> > (nm_dns_manager_end_updates): DNS configuration changed
> > NetworkManager[6068]: <debug> [1397985944.877988] [nm-dns-manager.c:1022] nm_dns_manager_end_updates(): 
> > (device_state_changed): committing DNS changes (0)
> > NetworkManager[6068]: <debug> [1397985944.878029] [nm-dns-manager.c:591] update_dns(): updating 
> > resolv.conf
> > NetworkManager[6068]: <info> Activation (eth0) successful, device activated.
> >
> > _______________________________________________
> > networkmanager-list mailing list
> > networkmanager-list gnome org
> > https://mail.gnome.org/mailman/listinfo/networkmanager-list
>
> _______________________________________________
> networkmanager-list mailing list
> networkmanager-list gnome org
> https://mail.gnome.org/mailman/listinfo/networkmanager-list