[Freedombox-discuss] IP address acquisition in "stable" vs "testing" on A20-OLinuXino-MICRO

[Bart Notelaers]

Hello James!
Thank you for the reply and suggestion. I compared the syslogs for both systems ('stable' 2017-06-18 and 'unstable' latest) and found two interesting bits;

Both systems appear to use the same dhclient settings to find the DHCP server: 'stable' fails and 'unstable' succeeds.
In the 'stable' system there is an additional mention of "Failed to start Network Manager Wait Online".

Booting from the 'stable' image 
Nov  3 17:17:46 freedombox NetworkManager[335]: <info>  [1478193466.3775] device (eth0): state change: disconnected -> prepare (reason 'none') [30 40 0]
Nov  3 17:17:46 freedombox NetworkManager[335]: <info>  [1478193466.3831] manager: NetworkManager state is now CONNECTING
Nov  3 17:17:46 freedombox NetworkManager[335]: <info>  [1478193466.3966] device (eth0): state change: prepare -> config (reason 'none') [40 50 0]
Nov  3 17:17:46 freedombox NetworkManager[335]: <info>  [1478193466.6636] device (eth0): state change: config -> ip-config (reason 'none') [50 70 0]
Nov  3 17:17:46 freedombox NetworkManager[335]: <info>  [1478193466.6668] dhcp4 (eth0): activation: beginning transaction (timeout in 45 seconds)
Nov  3 17:17:46 freedombox NetworkManager[335]: <info>  [1478193466.6873] dhcp4 (eth0): dhclient started with pid 941
Nov  3 17:17:46 freedombox dhclient[941]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
[...]
Nov  3 17:17:50 freedombox dhclient[941]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 9
Nov  3 17:17:59 freedombox dhclient[941]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 11
Nov  3 17:18:10 freedombox dhclient[941]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 20
Nov  3 17:18:30 freedombox dhclient[941]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 17
Nov  3 17:18:32 freedombox NetworkManager[335]: <warn>  [1478193512.2174] dhcp4 (eth0): request timed out
Nov  3 17:18:32 freedombox NetworkManager[335]: <info>  [1478193512.2177] dhcp4 (eth0): state changed unknown -> timeout
Nov  3 17:18:32 freedombox NetworkManager[335]: <info>  [1478193512.2533] dhcp4 (eth0): canceled DHCP transaction, DHCP client pid 941
Nov  3 17:18:32 freedombox NetworkManager[335]: <info>  [1478193512.2536] dhcp4 (eth0): state changed timeout -> done
Nov  3 17:18:32 freedombox NetworkManager[335]: <info>  [1478193512.2557] device (eth0): state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Nov  3 17:18:32 freedombox NetworkManager[335]: <info>  [1478193512.2617] manager: NetworkManager state is now DISCONNECTED
[...]
Nov  3 17:20:34 freedombox systemd[1]: NetworkManager-wait-online.service: Main process exited, code=exited, status=1/FAILURE
Nov  3 17:20:34 freedombox systemd[1]: Failed to start Network Manager Wait Online.
Nov  3 17:20:34 freedombox systemd[1]: NetworkManager-wait-online.service: Unit entered failed state.
Nov  3 17:20:34 freedombox systemd[1]: NetworkManager-wait-online.service: Failed with result 'exit-code'.

And booting from the Unstable image;
Mar  5 22:16:55 freedombox NetworkManager[357]: <info>  [1520288215.6580] device (eth0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
Mar  5 22:16:55 freedombox NetworkManager[357]: <info>  [1520288215.6638] manager: NetworkManager state is now CONNECTING
Mar  5 22:16:55 freedombox NetworkManager[357]: <info>  [1520288215.6846] device (eth0): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
[...]
Mar  5 22:16:59 freedombox NetworkManager[357]: <info>  [1520288219.6992] device (eth0): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
Mar  5 22:16:59 freedombox NetworkManager[357]: <info>  [1520288219.7195] dhcp4 (eth0): activation: beginning transaction (timeout in 45 seconds)
Mar  5 22:16:59 freedombox NetworkManager[357]: <info>  [1520288219.7726] dhcp4 (eth0): dhclient started with pid 590
Mar  5 22:17:00 freedombox dhclient[590]: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
Mar  5 22:17:00 freedombox dhclient[590]: DHCPREQUEST of 192.168.1.105 on eth0 to 255.255.255.255 port 67
Mar  5 22:17:00 freedombox dhclient[590]: DHCPOFFER of 192.168.1.105 from 192.168.1.1
Mar  5 22:17:00 freedombox dhclient[590]: DHCPACK of 192.168.1.105 from 192.168.1.1