[Pkg-utopia-maintainers] Bug#774025: network-manager: DHCPv6 does not work

Ralf Jung post at ralfj.de
Sat Dec 27 15:06:14 UTC 2014 

Package: network-manager
Version: 0.9.10.0-4
Severity: normal

Dear Maintainer,

DHCPv6 does not work. I set up a connection (using the Plasma frontend) with
* IPv4: Disabled
* IPv6: Automatic (DHCP only)
but when I try to connect, that attempt fails quickly and NM falls back
to another connection. (This is all wireless.)
I am attaching the log output (an excerpt from the systemd journal).

I don't know whether DHCPv6 is working properly here, but my impression
(and my conclusion from the logfiles and the Wireshark logs) is that
NM does not even try to talk with a DHCPv6 server.

I will be at this place for another 3 days, and cannot do any testing
thereafter.

Kind regards,
Ralf

-- System Information:
Debian Release: 8.0
  APT prefers testing
  APT policy: (990, 'testing'), (100, 'unstable')
Architecture: amd64 (x86_64)
Foreign Architectures: i386

Kernel: Linux 3.17.7+ (SMP w/4 CPU cores)
Locale: LANG=en_GB.UTF-8, LC_CTYPE=en_GB.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Init: systemd (via /run/systemd/system)

Versions of packages network-manager depends on:
ii  adduser                3.113+nmu3
ii  dbus                   1.8.12-1
ii  init-system-helpers    1.22
ii  isc-dhcp-client        4.3.1-5
ii  libc6                  2.19-13
ii  libdbus-1-3            1.8.12-1
ii  libdbus-glib-1-2       0.102-1
ii  libgcrypt20            1.6.2-4+b1
ii  libglib2.0-0           2.42.1-1
ii  libgnutls-deb0-28      3.3.8-5
ii  libgudev-1.0-0         215-8
ii  libmm-glib0            1.4.0-1
ii  libndp0                1.4-2
ii  libnewt0.52            0.52.17-1+b1
ii  libnl-3-200            3.2.24-2
ii  libnl-genl-3-200       3.2.24-2
ii  libnl-route-3-200      3.2.24-2
ii  libnm-glib4            0.9.10.0-4
ii  libnm-util2            0.9.10.0-4
ii  libpam-systemd         215-8
ii  libpolkit-gobject-1-0  0.105-8
ii  libreadline6           6.3-8+b2
ii  libsoup2.4-1           2.48.0-1
ii  libsystemd0            215-8
ii  libteamdctl0           1.12-1
ii  libuuid1               2.25.2-4
ii  lsb-base               4.1+Debian13+nmu1
ii  policykit-1            0.105-8
ii  udev                   215-8
ii  wpasupplicant          2.3-1

Versions of packages network-manager recommends:
ii  crda            3.13-1
ii  dnsmasq-base    2.72-2
ii  iptables        1.4.21-2+b1
ii  iputils-arping  3:20121221-5+b2
ii  modemmanager    1.4.0-1
ii  ppp             2.4.6-3

Versions of packages network-manager suggests:
ii  avahi-autoipd  0.6.31-4+b2
pn  libteam-utils  <none>

-- Configuration Files:
/etc/NetworkManager/NetworkManager.conf changed:
[main]
plugins=ifupdown,keyfile
no-auto-default=10:BF:48:05:C7:F7,
[ifupdown]
managed=false


-- no debconf information
-------------- next part --------------
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: SME: Trying to authenticate with 6c:f3:7f:ec:e9:d0 (SSID='31C3' freq=5540 MHz)
Dec 27 14:06:52 r-schnelltop kernel: wlan0: authenticate with 6c:f3:7f:ec:e9:d0
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: Trying to associate with 6c:f3:7f:ec:e9:d0 (SSID='31C3' freq=5540 MHz)
Dec 27 14:06:52 r-schnelltop kernel: wlan0: send auth to 6c:f3:7f:ec:e9:d0 (try 1/3)
Dec 27 14:06:52 r-schnelltop kernel: wlan0: authenticated
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: Associated with 6c:f3:7f:ec:e9:d0
Dec 27 14:06:52 r-schnelltop kernel: wlan0: associate with 6c:f3:7f:ec:e9:d0 (try 1/3)
Dec 27 14:06:52 r-schnelltop kernel: wlan0: RX AssocResp from 6c:f3:7f:ec:e9:d0 (capab=0x1011 status=0 aid=19)
Dec 27 14:06:52 r-schnelltop kernel: wlan0: associated
Dec 27 14:06:52 r-schnelltop kernel: cfg80211: Calling CRDA for country: DE
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): supplicant interface state: authenticating -> associated
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-STARTED EAP authentication started
Dec 27 14:06:52 r-schnelltop kernel: cfg80211: Regulatory domain changed to country: DE
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:  DFS Master region: ETSI
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (2400000 KHz - 2483500 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5150000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5250000 KHz - 5350000 KHz @ 80000 KHz), (N/A, 2000 mBm), (0 s)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5470000 KHz - 5725000 KHz @ 80000 KHz), (N/A, 2698 mBm), (0 s)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (57240000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-PROPOSED-METHOD vendor=0 method=21
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-METHOD EAP vendor 0 method 21 (TTLS) selected
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-PEER-CERT depth=1 subject='/C=IL/O=StartCom Ltd./OU=Secure Digital Certificate Signing/CN=StartCom Class 1 Primary Intermediate Server CA'
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-PEER-CERT depth=1 subject='/C=IL/O=StartCom Ltd./OU=Secure Digital Certificate Signing/CN=StartCom Class 1 Primary Intermediate Server CA'
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-PEER-CERT depth=0 subject='/description=PJT57Mnq7X1ULcT1/C=DE/CN=radius.c3noc.net/emailAddress=postmaster at c3noc.net'
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-EAP-SUCCESS EAP authentication completed successfully
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: WPA: Key negotiation completed with 6c:f3:7f:ec:e9:d0 [PTK=CCMP GTK=CCMP]
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-CONNECTED - Connection to 6c:f3:7f:ec:e9:d0 completed [id=0 id_str=]
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): supplicant interface state: associated -> completed
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network '31C3'.
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-49 noise=9999 txrate=12000
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Beginning DHCPv6 transaction (timeout in 45 seconds)
Dec 27 14:06:52 r-schnelltop kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 6c:f3:7f:ec:e9:d0
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> dhclient started with pid 9891
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): DHCPv6 state changed nbi -> preinit6
Dec 27 14:06:52 r-schnelltop dhclient[9891]: Can't bind to dhcp address: Cannot assign requested address
Dec 27 14:06:52 r-schnelltop dhclient[9891]: Please make sure there is no other dhcp server
Dec 27 14:06:52 r-schnelltop dhclient[9891]: running and that there's no entry for dhcp or
Dec 27 14:06:52 r-schnelltop dhclient[9891]: bootp in /etc/inetd.conf.   Also make sure you
Dec 27 14:06:52 r-schnelltop dhclient[9891]: are not running HP JetAdmin software, which
Dec 27 14:06:52 r-schnelltop dhclient[9891]: includes a bootp server.
Dec 27 14:06:52 r-schnelltop dhclient[9891]: 
Dec 27 14:06:52 r-schnelltop dhclient[9891]: If you think you have received this message due to a bug rather
Dec 27 14:06:52 r-schnelltop dhclient[9891]: than a configuration issue please read the section on submitting
Dec 27 14:06:52 r-schnelltop dhclient[9891]: bugs on either our web page at www.isc.org or in the README file
Dec 27 14:06:52 r-schnelltop dhclient[9891]: before submitting a bug.  These pages explain the proper
Dec 27 14:06:52 r-schnelltop dhclient[9891]: process and the information we find helpful for debugging..
Dec 27 14:06:52 r-schnelltop dhclient[9891]: 
Dec 27 14:06:52 r-schnelltop dhclient[9891]: exiting.
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): DHCPv6 client pid 9891 exited with status 1
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) started...
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): device state change: ip-config -> failed (reason 'ip-config-unavailable') [70 120 5]
Dec 27 14:06:52 r-schnelltop kernel: wlan0: deauthenticating from 6c:f3:7f:ec:e9:d0 by local choice (Reason: 3=DEAUTH_LEAVING)
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> NetworkManager state is now DISCONNECTED
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <warn> Activation (wlan0) failed for connection '31C3 NAT64'
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> Activation (wlan0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): deactivating device (reason 'none') [0]
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-DISCONNECTED bssid=6c:f3:7f:ec:e9:d0 reason=3 locally_generated=1
Dec 27 14:06:52 r-schnelltop kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Dec 27 14:06:52 r-schnelltop kernel: cfg80211: Calling CRDA to update world regulatory domain
Dec 27 14:06:52 r-schnelltop kernel: cfg80211: World regulatory domain updated:
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:  DFS Master region: unset
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5170000 KHz - 5250000 KHz @ 160000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5250000 KHz - 5330000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop kernel: cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
Dec 27 14:06:52 r-schnelltop wpa_supplicant[1306]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <warn> Connection disconnected (reason -3)
Dec 27 14:06:52 r-schnelltop NetworkManager[968]: <info> (wlan0): supplicant interface state: completed -> disconnected

More information about the Pkg-utopia-maintainers mailing list