retitle 707186 network-manager: wireless reconnection doesn't work without restarting NM stop
Hey. Sorry for not having provided further information (debug logs), bug I somehow got distracted back then and forgot about this. Even though it seems that there is no goal to properly integrate NM into Debian, the requested information shall be found here (at the very end) now: On Wed, 08 May 2013 04:16:41 +0200 Michael Biebl <[email protected]> wrote: >As a first advice, if you want to manage your wireless interface with >NM, I would recommed *against* using /e/n/i and managed=true. >ifupdown will still manage your wlan0-foo interface and having two >network management systems handling the same interface is not going to >work out well. Well I still stick to the point that Debian's native (and working) network management tool is ifupdown, which also means that it's configuration is the native configuration which other packages/systems shall integrate into. Even when not using managed-mode, NM has far too many issues and bugs which makes it unusable as a general replacement for ifupdown - and no I'm not saying ifupdown is perfect (the syntax of (/e/n/interfaces is actually ugly), and no, nothing of this criticism is agains you personally. That NM isn't Debian's default/native network management configuration system, seems to be backed by the majority of the community and especially the tech-ctte. And as long as this hasn't changed (and it seems it won't in the foreseeable future) I consider NM merely a GUI framework, that should read the real native config files from the respective systems (ifupdown, vpnc, strongswan, etc.), allow connections to be managed via GUI from the desktop and programs to be informed about connectivity. But the real work and especially place for configuration are still the respective native tools - cause while NM breaks something with basically every update (even on minor versions), these tools always work. >What kind of desktop environment are you using? Back then it was GNOME Classic, nowadays it's Cinnamon. >Do you have proper PolicyKit permissions? I would guess so, cause how could connecting the first time work, if there weren't sufficient permissions. >Is you desktop session marked as active and >local? (ck-list-sessions) Well since ck is deprecated now and since I'm run on systemd I took the logind equivalent information: $ loginctl session-status 6 6 - calestyo (1000) Since: Tue 2014-09-30 01:55:41 CEST; 42min ago Leader: 27514 (gdm-session-wor) Seat: seat0; vc7 Display: :0 Service: gdm-password; type x11; class user State: active Unit: session-6.scope So I guess yes. I shall perhaps add, that with cinnamon, killing the nm-applet is no longer necessary (actually nm-applet isn't used AFAICS(!?). But restarting NM itself is still necessary in order to "re-connect" after the first time a WiFi connection has been disconnected. >As for debugging, see [1]. Please attach a debug log. *************************************************************************************** Here NM has already started and is running, but no connection has been made yet *************************************************************************************** NetworkManager[31344]: <debug> [1412036408.304814] [nm-supplicant-interface.c:747] iface_check_netreply_cb(): Supplicant supports network credentials requests NetworkManager[31344]: <info> (wlan0): supplicant interface state: starting -> ready NetworkManager[31344]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] NetworkManager[31344]: <warn> Trying to remove a non-existant call id. NetworkManager[31344]: <info> (wlan0): supplicant interface state: ready -> scanning NetworkManager[31344]: <info> (wlan0) supports 5 scan SSIDs NetworkManager[31344]: <warn> Could not get scan request result: Scan request rejected NetworkManager[31344]: <warn> Could not get scan request result: Scan request rejected NetworkManager[31344]: <debug> [1412036410.781096] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1003 NetworkManager[31344]: <info> (wlan0): supplicant interface state: scanning -> inactive *************************************************************************************** Now I select my WPA-PSK connection in the NM applet *************************************************************************************** NetworkManager[31344]: <debug> [1412036433.820618] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1003 NetworkManager[31344]: <info> Activation (wlan0) starting connection 'Ifupdown (wlan0-scientia.net)' NetworkManager[31344]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] NetworkManager[31344]: <info> NetworkManager state is now CONNECTING NetworkManager[31344]: <debug> [1412036434.134688] [nm-manager.c:4242] policy_activating_device_changed(): ActivatingConnection now Ifupdown (wlan0-scientia.net) NetworkManager[31344]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... NetworkManager[31344]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... NetworkManager[31344]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... NetworkManager[31344]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. NetworkManager[31344]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... NetworkManager[31344]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] NetworkManager[31344]: <info> Activation (wlan0/wireless): connection 'Ifupdown (wlan0-scientia.net)' has security, and secrets exist. No new secrets needed. NetworkManager[31344]: <info> Config: added 'ssid' value 'scientia.net' NetworkManager[31344]: <info> Config: added 'scan_ssid' value '1' NetworkManager[31344]: <info> Config: added 'key_mgmt' value 'WPA-PSK' NetworkManager[31344]: <info> Config: added 'psk' value '<omitted>' NetworkManager[31344]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. NetworkManager[31344]: <info> Config: set interface ap_scan to 1 NetworkManager[31344]: <info> (wlan0): supplicant interface state: inactive -> authenticating NetworkManager[31344]: <info> (wlan0): supplicant interface state: authenticating -> associating NetworkManager[31344]: <debug> [1412036434.322409] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11003 NetworkManager[31344]: <debug> [1412036434.322484] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11003 NetworkManager[31344]: <debug> [1412036434.322541] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11003 NetworkManager[31344]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake NetworkManager[31344]: <debug> [1412036434.366708] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11043 NetworkManager[31344]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed NetworkManager[31344]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'scientia.net'. NetworkManager[31344]: <debug> [1412036434.371906] [nm-device.c:3069] nm_device_activate_schedule_stage3_ip_config_start(): Activation (wlan0) setting firewall zone 'default' NetworkManager[31344]: <debug> [1412036434.371925] [nm-firewall-manager.c:112] nm_firewall_manager_add_or_change_zone(): (wlan0) firewall zone add/change skipped (not running) NetworkManager[31344]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled. NetworkManager[31344]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started... NetworkManager[31344]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0] NetworkManager[31344]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds) NetworkManager[31344]: <debug> [1412036434.372573] [nm-dhcp-dhclient.c:627] dhclient_start(): running: /sbin/dhclient -d -sf /usr/lib/NetworkManager/nm-dhcp-client.action -pf /var/run/dhclient-wlan0.pid -lf /var/lib/NetworkManager/dhclient-9375b2e6-428a-71f6-32f7-4e37e36f0bdd-wlan0.lease -cf /var/lib/NetworkManager/dhclient-wlan0.conf wlan0 NetworkManager[31344]: <info> dhclient started with pid 31397 NetworkManager[31344]: <debug> [1412036434.374037] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '2' NetworkManager[31344]: <info> Activation (wlan0) Beginning IP6 addrconf. NetworkManager[31344]: <debug> [1412036434.374080] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '1' NetworkManager[31344]: <debug> [1412036434.374179] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '0' NetworkManager[31344]: <debug> [1412036434.374260] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x0) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036434.374273] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.374280] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.374287] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.374364] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' NetworkManager[31344]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete. NetworkManager[31344]: <debug> [1412036434.374415] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 25 NetworkManager[31344]: <debug> [1412036434.374452] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 5 -> 4: NetworkManager[31344]: <debug> [1412036434.374471] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) lost route: fe80::/64 via none NetworkManager[31344]: <debug> [1412036434.374481] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x0) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036434.374500] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.374655] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.374803] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.375063] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 25 NetworkManager[31344]: <debug> [1412036434.375097] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 4 -> 3: NetworkManager[31344]: <debug> [1412036434.375280] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) lost route: ff00::/8 via none NetworkManager[31344]: <debug> [1412036434.375473] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x0) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036434.375705] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.375926] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.376138] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.376497] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 21 NetworkManager[31344]: <debug> [1412036434.376575] [nm-ip6-manager.c:885] process_address_change(): (wlan0): address cache size: 2 -> 2: NetworkManager[31344]: <debug> [1412036434.376791] [nm-ip6-manager.c:835] dump_address_change(): (wlan0) lost address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036434.377172] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036434.377199] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 3 -> 4: NetworkManager[31344]: <debug> [1412036434.377392] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) new route: ff00::/8 via none NetworkManager[31344]: <debug> [1412036434.377531] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x0) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036434.377665] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.377804] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.377932] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.378201] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036434.378225] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 4 -> 5: NetworkManager[31344]: <debug> [1412036434.378349] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) new route: fe80::/64 via none NetworkManager[31344]: <debug> [1412036434.378479] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x0) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036434.378611] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) Internet Systems Consortium DHCP Client 4.3.1 NetworkManager[31344]: <debug> [1412036434.378884] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) Copyright 2004-2014 Internet Systems Consortium. NetworkManager[31344]: <debug> [1412036434.379157] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) All rights reserved. For info, please visit https://www.isc.org/software/dhcp/ NetworkManager[31344]: <debug> [1412036434.379583] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036434.379849] [nm-ip6-manager.c:1302] process_newlink(): ((none)): ignoring unknown or completed device NetworkManager[31344]: <debug> [1412036434.379987] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 1 flags 0x10049 NetworkManager[31344]: <debug> [1412036434.380122] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036434.380251] [nm-ip6-manager.c:1302] process_newlink(): ((none)): ignoring unknown or completed device NetworkManager[31344]: <debug> [1412036434.380628] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 2 flags 0x1003 NetworkManager[31344]: <debug> [1412036434.380781] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036434.380924] [nm-ip6-manager.c:415] device_set_ra_flags(): (wlan0) IP6 device ra_flags: 0x00000000 () -> 0x80000080 (O) NetworkManager[31344]: <debug> [1412036434.381049] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036434.381181] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.381314] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.381448] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) NetworkManager[31344]: <debug> [1412036434.381584] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11043 NetworkManager[31344]: <info> (wlan0): DHCPv4 state changed nbi -> preinit NetworkManager[31344]: <debug> [1412036434.383523] [nm-device.c:1945] dhcp4_state_changed(): (wlan0): new DHCPv4 client state 1 Listening on LPF/wlan0/60:67:20:09:9a:a4 Sending on LPF/wlan0/60:67:20:09:9a:a4 Sending on Socket/fallback DHCPREQUEST on wlan0 to 255.255.255.255 port 67 NetworkManager[31344]: <debug> [1412036434.416420] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036435.260557] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036435.260647] [nm-ip6-manager.c:1302] process_newlink(): ((none)): ignoring unknown or completed device NetworkManager[31344]: <debug> [1412036435.260710] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 1 flags 0x10049 NetworkManager[31344]: <debug> [1412036435.260790] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036435.260852] [nm-ip6-manager.c:1302] process_newlink(): ((none)): ignoring unknown or completed device NetworkManager[31344]: <debug> [1412036435.260891] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 2 flags 0x1003 NetworkManager[31344]: <debug> [1412036435.260915] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036435.260931] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036435.260946] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036435.260960] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state unconfigured) NetworkManager[31344]: <debug> [1412036435.260970] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state unconfigured) NetworkManager[31344]: <debug> [1412036435.260993] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11043 NetworkManager[31344]: <debug> [1412036435.675777] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 20 NetworkManager[31344]: <debug> [1412036435.675941] [nm-ip6-manager.c:885] process_address_change(): (wlan0): address cache size: 2 -> 3: NetworkManager[31344]: <debug> [1412036435.676061] [nm-ip6-manager.c:835] dump_address_change(): (wlan0) new address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036435.676119] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'unconfigured'/'got-address') NetworkManager[31344]: <debug> [1412036435.676196] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state unconfigured) NetworkManager[31344]: <debug> [1412036435.676248] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036435.676290] [nm-ip6-manager.c:369] device_set_state(): (wlan0) IP6 device state: unconfigured -> got-link-local NetworkManager[31344]: <debug> [1412036435.676315] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.676334] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.676429] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036435.676483] [nm-ip6-manager.c:926] process_route_change(): (unknown): route cache size: 5 -> 6: NetworkManager[31344]: <debug> [1412036435.676515] [nm-ip6-manager.c:855] dump_route_change(): (unknown) new route: fe80::6267:20ff:fe09:9aa4 via none NetworkManager[31344]: <debug> [1412036435.678872] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036435.678988] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036435.679014] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 6 -> 7: NetworkManager[31344]: <debug> [1412036435.679031] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) new route: none via fe80::3631:c4ff:fe42:e53e NetworkManager[31344]: <debug> [1412036435.679050] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'got-link-local'/'got-address') NetworkManager[31344]: <debug> [1412036435.679066] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.679087] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036435.679200] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.679526] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.679934] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036435.680249] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 7 -> 8: NetworkManager[31344]: <debug> [1412036435.680573] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) new route: 2001:a60:146e:5c01::/64 via none NetworkManager[31344]: <debug> [1412036435.680910] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'got-link-local'/'got-address') NetworkManager[31344]: <debug> [1412036435.681255] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.681590] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036435.681920] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.682265] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.682687] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 52 NetworkManager[31344]: <debug> [1412036435.683012] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036435.683313] [nm-ip6-manager.c:926] process_route_change(): (wlan0): route cache size: 8 -> 9: NetworkManager[31344]: <debug> [1412036435.683663] [nm-ip6-manager.c:855] dump_route_change(): (wlan0) new route: fd00::/64 via none NetworkManager[31344]: <debug> [1412036435.684015] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'got-link-local'/'got-address') NetworkManager[31344]: <debug> [1412036435.684354] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.684701] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036435.685040] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.685420] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.685838] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 52 NetworkManager[31344]: <debug> [1412036435.686162] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 68 NetworkManager[31344]: <debug> [1412036435.686460] [nm-ip6-manager.c:1210] process_nduseropt(): processing netlink nduseropt message NetworkManager[31344]: <debug> [1412036435.686784] [nm-ip6-manager.c:1028] process_nduseropt_rdnss(): (wlan0): found RA-provided nameserver fd00::3631:c4ff:fe42:e53e (expires in 7200 seconds) NetworkManager[31344]: <debug> [1412036435.687078] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x80000080) (state/target 'got-link-local'/'got-address') NetworkManager[31344]: <debug> [1412036435.687388] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.687735] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036435.688002] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-link-local) NetworkManager[31344]: <debug> [1412036435.688269] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-link-local) NetworkManager[31344]: <debug> [1412036436.260315] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036436.260378] [nm-ip6-manager.c:1302] process_newlink(): ((none)): ignoring unknown or completed device NetworkManager[31344]: <debug> [1412036436.260415] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 1 flags 0x10049 NetworkManager[31344]: <debug> [1412036436.260449] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036436.260475] [nm-ip6-manager.c:1302] process_newlink(): ((none)): ignoring unknown or completed device NetworkManager[31344]: <debug> [1412036436.260514] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 2 flags 0x1003 NetworkManager[31344]: <debug> [1412036436.260566] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 16 NetworkManager[31344]: <debug> [1412036436.260611] [nm-ip6-manager.c:415] device_set_ra_flags(): (wlan0) IP6 device ra_flags: 0x80000080 (O) -> 0x800000b0 (SRO) NetworkManager[31344]: <debug> [1412036436.260637] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x800000B0) (state/target 'got-link-local'/'got-address') NetworkManager[31344]: <debug> [1412036436.260653] [nm-ip6-manager.c:369] device_set_state(): (wlan0) IP6 device state: got-link-local -> got-ra NetworkManager[31344]: <debug> [1412036436.260681] [nm-ip6-manager.c:739] check_ra_flags(): router advertisement requests parallel DHCPv6 NetworkManager[31344]: <debug> [1412036436.260690] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state got-ra) NetworkManager[31344]: <debug> [1412036436.260701] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036436.261043] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-ra) NetworkManager[31344]: <debug> [1412036436.261550] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-ra) NetworkManager[31344]: <debug> [1412036436.262034] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x11043 NetworkManager[31344]: <debug> [1412036436.819783] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 20 NetworkManager[31344]: <debug> [1412036436.819927] [nm-ip6-manager.c:885] process_address_change(): (wlan0): address cache size: 3 -> 4: NetworkManager[31344]: <debug> [1412036436.820011] [nm-ip6-manager.c:835] dump_address_change(): (wlan0) new address: 2001:a60:146e:5c01:6267:20ff:fe09:9aa4/ NetworkManager[31344]: <debug> [1412036436.820075] [nm-ip6-manager.c:807] nm_ip6_device_sync_from_netlink(): (wlan0): syncing with netlink (ra_flags 0x800000B0) (state/target 'got-ra'/'got-address') NetworkManager[31344]: <debug> [1412036436.820127] [nm-ip6-manager.c:739] check_ra_flags(): router advertisement requests parallel DHCPv6 NetworkManager[31344]: <debug> [1412036436.820168] [nm-ip6-manager.c:743] check_ra_flags(): (wlan0): router advertisement checked (state got-ra) NetworkManager[31344]: <debug> [1412036436.820220] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: fe80::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036436.820266] [nm-ip6-manager.c:697] check_addresses(): (wlan0): netlink address: 2001:a60:146e:5c01:6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036436.820324] [nm-ip6-manager.c:369] device_set_state(): (wlan0) IP6 device state: got-ra -> got-address NetworkManager[31344]: <debug> [1412036436.820370] [nm-ip6-manager.c:719] check_addresses(): (wlan0): addresses checked (state got-address) NetworkManager[31344]: <debug> [1412036436.820429] [nm-ip6-manager.c:766] check_addrconf_complete(): (wlan0): reached target state or Managed-mode requested (state 'got-address') (dhcp opts 0x1) NetworkManager[31344]: <debug> [1412036436.820499] [nm-ip6-manager.c:798] check_addrconf_complete(): (wlan0): dhcp_opts checked (state got-address) NetworkManager[31344]: <debug> [1412036436.820636] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036436.820697] [nm-ip6-manager.c:926] process_route_change(): (unknown): route cache size: 9 -> 10: NetworkManager[31344]: <debug> [1412036436.821069] [nm-ip6-manager.c:855] dump_route_change(): (unknown) new route: 2001:a60:146e:5c01:6267:20ff:fe09:9aa4 via none NetworkManager[31344]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) starting DHCPv6 as requested by IPv6 router... NetworkManager[31344]: <debug> [1412036436.821980] [nm-dhcp-dhclient.c:728] get_duid(): Looking for DHCPv6 DUID in '/var/lib/NetworkManager/dhclient6-9375b2e6-428a-71f6-32f7-4e37e36f0bdd-wlan0.lease'. NetworkManager[31344]: <debug> [1412036436.822065] [nm-dhcp-client.c:481] nm_dhcp_client_start_ip6(): (wlan0): DHCPv6 DUID is '00:04:f0:38:89:b5:96:da:08:42:1c:80:6f:b2:f7:67:b6:21' NetworkManager[31344]: <info> Activation (wlan0) Beginning DHCPv6 transaction (timeout in 45 seconds) NetworkManager[31344]: <debug> [1412036436.822958] [nm-dhcp-dhclient.c:627] dhclient_start(): running: /sbin/dhclient -d -6 -S -sf /usr/lib/NetworkManager/nm-dhcp-client.action -pf /var/run/dhclient6-wlan0.pid -lf /var/lib/NetworkManager/dhclient6-9375b2e6-428a-71f6-32f7-4e37e36f0bdd-wlan0.lease -cf /var/lib/NetworkManager/dhclient6-wlan0.conf wlan0 NetworkManager[31344]: <info> dhclient started with pid 31399 Internet Systems Consortium DHCP Client 4.3.1 Copyright 2004-2014 Internet Systems Consortium. All rights reserved. For info, please visit https://www.isc.org/software/dhcp/ Listening on Socket/wlan0 Sending on Socket/wlan0 PRC: Requesting information (INIT). XMT: Forming Info-Request, 0 ms elapsed. XMT: Info-Request on wlan0, interval 970ms. NetworkManager[31344]: <debug> [1412036437.244876] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036437.247441] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036437.251812] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036437.455719] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 20 NetworkManager[31344]: <debug> [1412036437.455815] [nm-ip6-manager.c:885] process_address_change(): (wlan0): address cache size: 5 -> 5: NetworkManager[31344]: <debug> [1412036437.455836] [nm-ip6-manager.c:835] dump_address_change(): (wlan0) new address: fd00::6267:20ff:fe09:9aa4/64 NetworkManager[31344]: <debug> [1412036437.455911] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 NetworkManager[31344]: <debug> [1412036437.455938] [nm-ip6-manager.c:926] process_route_change(): (unknown): route cache size: 12 -> 13: NetworkManager[31344]: <debug> [1412036437.455954] [nm-ip6-manager.c:855] dump_route_change(): (unknown) new route: fd00::6267:20ff:fe09:9aa4 via none NetworkManager[31344]: <debug> [1412036438.61963] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 XMT: Forming Info-Request, 970 ms elapsed. XMT: Info-Request on wlan0, interval 1930ms. NetworkManager[31344]: <debug> [1412036439.299803] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 XMT: Forming Info-Request, 2900 ms elapsed. XMT: Info-Request on wlan0, interval 3970ms. NetworkManager[31344]: <debug> [1412036440.195703] [nm-ip6-manager.c:1334] netlink_notification(): netlink event type 24 DHCPREQUEST on wlan0 to 255.255.255.255 port 67 DHCPACK from 192.168.0.1 NetworkManager[31344]: <info> (wlan0): DHCPv4 state changed preinit -> reboot NetworkManager[31344]: <debug> [1412036442.173636] [nm-device.c:1945] dhcp4_state_changed(): (wlan0): new DHCPv4 client state 8 NetworkManager[31344]: <info> address 192.168.0.100 NetworkManager[31344]: <info> prefix 24 (255.255.255.0) NetworkManager[31344]: <info> gateway 192.168.0.1 NetworkManager[31344]: <info> nameserver '192.168.0.1' NetworkManager[31344]: <info> domain name 'fritz.box' NetworkManager[31344]: <info> domain search 'scientia.net.' NetworkManager[31344]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled... NetworkManager[31344]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started... NetworkManager[31344]: <debug> [1412036442.175980] [nm-system.c:194] sync_addresses(): (wlan0): syncing addresses (family 2) NetworkManager[31344]: <debug> [1412036442.176020] [nm-system.c:280] sync_addresses(): (wlan0): adding address '192.168.0.100/24' bound to 192.168.0.100 -- renewal in 1293329 seconds. NetworkManager[31344]: <debug> [1412036443.176547] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET (2) addr 192.168.0.0/24 NetworkManager[31344]: <debug> [1412036443.176911] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1) NetworkManager[31344]: <debug> [1412036443.176978] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change NetworkManager[31344]: <debug> [1412036443.177005] [nm-dns-manager.c:1017] nm_dns_manager_end_updates(): (device_ip4_config_changed): no DNS changes to commit (0) NetworkManager[31344]: <info> (wlan0): device state change: ip-config -> secondaries (reason 'none') [70 90 0] NetworkManager[31344]: <debug> [1412036443.177134] [nm-device.c:5261] nm_device_queue_state(): (wlan0): queued state change to activated (id 209) NetworkManager[31344]: <debug> [1412036443.177180] [nm-manager.c:4242] policy_activating_device_changed(): ActivatingConnection now (none) NetworkManager[31344]: <debug> [1412036443.177206] [nm-device.c:5191] nm_device_state_changed(): (wlan0): device entered SECONDARIES state NetworkManager[31344]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete. NetworkManager[31344]: <debug> [1412036443.177274] [nm-device.c:5219] queued_set_state(): (wlan0): running queued state change to activated (id 209) NetworkManager[31344]: <info> (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0] NetworkManager[31344]: <debug> [1412036443.190290] [nm-manager.c:4150] connectivity_changed(): connectivity checking indicates FULL NetworkManager[31344]: <info> NetworkManager state is now CONNECTED_GLOBAL NetworkManager[31344]: <debug> [1412036443.190541] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): (device_state_changed): queueing DNS updates (1) NetworkManager[31344]: <debug> [1412036443.190557] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (2) NetworkManager[31344]: <info> Policy set 'Ifupdown (wlan0-scientia.net)' (wlan0) as default for IPv4 routing and DNS. NetworkManager[31344]: <debug> [1412036443.190675] [nm-manager.c:4209] policy_default_device_changed(): PrimaryConnection now Ifupdown (wlan0-scientia.net) NetworkManager[31344]: <debug> [1412036443.190715] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed NetworkManager[31344]: <debug> [1412036443.190731] [nm-dns-manager.c:1017] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (1) NetworkManager[31344]: <debug> [1412036443.190746] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed NetworkManager[31344]: <debug> [1412036443.190760] [nm-dns-manager.c:1022] nm_dns_manager_end_updates(): (device_state_changed): committing DNS changes (0) NetworkManager[31344]: <debug> [1412036443.190772] [nm-dns-manager.c:591] update_dns(): updating resolv.conf NetworkManager[31344]: <info> Writing DNS information to /sbin/resolvconf NetworkManager[31344]: <debug> [1412036443.262306] [nm-device-wifi.c:518] get_active_ap(): (wlan0): active BSSID: 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036443.262394] [nm-device-wifi.c:528] get_active_ap(): (wlan0): active SSID: 'scientia.net' NetworkManager[31344]: <debug> [1412036443.262470] [nm-device-wifi.c:538] get_active_ap(): Pass #1 NetworkManager[31344]: <debug> [1412036443.262488] [nm-device-wifi.c:554] get_active_ap(): AP: 'scientia.net' 34:31:c4:42:e5:40 NetworkManager[31344]: <debug> [1412036443.262501] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.262509] [nm-device-wifi.c:554] get_active_ap(): AP: 'Nanas' 08:96:d7:03:80:2f NetworkManager[31344]: <debug> [1412036443.262515] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.262523] [nm-device-wifi.c:554] get_active_ap(): AP: 'KD WLAN Hotspot+' 0c:47:3d:3e:ce:9c NetworkManager[31344]: <debug> [1412036443.262530] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.262537] [nm-device-wifi.c:554] get_active_ap(): AP: 'dlink' 1c:7e:e5:00:68:88 NetworkManager[31344]: <debug> [1412036443.262544] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.262550] [nm-device-wifi.c:554] get_active_ap(): AP: 'HITRON-9EE0' 78:8d:f7:73:9e:e8 NetworkManager[31344]: <debug> [1412036443.262557] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.262704] [nm-device-wifi.c:554] get_active_ap(): AP: 'NETGEAR' c0:3f:0e:c8:f1:0a NetworkManager[31344]: <debug> [1412036443.262893] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.263080] [nm-device-wifi.c:554] get_active_ap(): AP: 'WLAN-GJDSWW' a4:99:47:7c:46:87 NetworkManager[31344]: <debug> [1412036443.263278] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.263454] [nm-device-wifi.c:554] get_active_ap(): AP: 'Igel' c0:4a:00:38:e1:8d NetworkManager[31344]: <debug> [1412036443.263620] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.263782] [nm-device-wifi.c:554] get_active_ap(): AP: 'o2-WLAN24' 9c:80:df:98:ec:f4 NetworkManager[31344]: <debug> [1412036443.263950] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.264120] [nm-device-wifi.c:554] get_active_ap(): AP: 'o2-WLAN60' 00:1c:28:a7:8a:a7 NetworkManager[31344]: <debug> [1412036443.264285] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.264455] [nm-device-wifi.c:554] get_active_ap(): AP: 'HITRON-EF40' 68:b6:fc:26:ef:48 NetworkManager[31344]: <debug> [1412036443.264620] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.264791] [nm-device-wifi.c:554] get_active_ap(): AP: 'FRITZ!Box 7362 SL' 34:31:c4:3c:5f:08 NetworkManager[31344]: <debug> [1412036443.264954] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.265124] [nm-device-wifi.c:554] get_active_ap(): AP: 'Rollespiel' 08:96:d7:17:8e:90 NetworkManager[31344]: <debug> [1412036443.265288] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.265459] [nm-device-wifi.c:554] get_active_ap(): AP: 'ALICE-WLAN16' 00:1c:28:74:38:cf NetworkManager[31344]: <debug> [1412036443.265621] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.265788] [nm-device-wifi.c:554] get_active_ap(): AP: 'ALICE-WLAN29' 88:25:2c:97:da:52 NetworkManager[31344]: <debug> [1412036443.265952] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.266120] [nm-device-wifi.c:554] get_active_ap(): AP: 'KDG-2B4DE' 34:31:c4:0e:02:14 NetworkManager[31344]: <debug> [1412036443.266286] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.266453] [nm-device-wifi.c:554] get_active_ap(): AP: 'HITRON-CE90' 0c:47:3d:3e:ce:98 NetworkManager[31344]: <debug> [1412036443.266619] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.266805] [nm-device-wifi.c:554] get_active_ap(): AP: 'ALICE-WLAN20' 74:31:70:0a:55:c1 NetworkManager[31344]: <debug> [1412036443.266969] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.267122] [nm-device-wifi.c:554] get_active_ap(): AP: 'o2-WLAN95' 88:03:55:f9:02:83 NetworkManager[31344]: <debug> [1412036443.267285] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.267454] [nm-device-wifi.c:554] get_active_ap(): AP: 'EasyBox-2A6626' 74:31:70:2a:66:e0 NetworkManager[31344]: <debug> [1412036443.267640] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.267782] [nm-device-wifi.c:554] get_active_ap(): AP: 'WLAN-2B6092' 88:25:2c:2b:60:a8 NetworkManager[31344]: <debug> [1412036443.267920] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.268064] [nm-device-wifi.c:554] get_active_ap(): AP: 'Quagan Fuuuu' 88:03:55:7b:d8:db NetworkManager[31344]: <debug> [1412036443.268218] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.268390] [nm-device-wifi.c:554] get_active_ap(): AP: 'Quagan Fuuuu' 88:03:55:7b:d8:d9 NetworkManager[31344]: <debug> [1412036443.268557] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.268725] [nm-device-wifi.c:554] get_active_ap(): AP: 'o2-WLAN08' 88:03:55:6b:29:5c NetworkManager[31344]: <debug> [1412036443.268890] [nm-device-wifi.c:562] get_active_ap(): BSSID mismatch NetworkManager[31344]: <debug> [1412036443.269059] [nm-device-wifi.c:554] get_active_ap(): AP: 'scientia.net' 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036443.269232] [nm-device-wifi.c:594] get_active_ap(): matched NetworkManager[31344]: <info> (wlan0): roamed from BSSID 34:31:C4:42:E5:40 (scientia.net) to 34:31:C4:42:E5:41 (scientia.net) NetworkManager[31344]: <info> Activation (wlan0) successful, device activated. XMT: Forming Info-Request, 6870 ms elapsed. XMT: Info-Request on wlan0, interval 8120ms. NetworkManager[31344]: <debug> [1412036444.260241] [nm-device-wifi.c:518] get_active_ap(): (wlan0): active BSSID: 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036444.260548] [nm-device-wifi.c:528] get_active_ap(): (wlan0): active SSID: 'scientia.net' NetworkManager[31344]: <debug> [1412036444.260906] [nm-device-wifi.c:538] get_active_ap(): Pass #1 NetworkManager[31344]: <debug> [1412036444.260985] [nm-device-wifi.c:554] get_active_ap(): AP: 'scientia.net' 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036444.261038] [nm-device-wifi.c:594] get_active_ap(): matched *************************************************************************************** At this point the connection to the WiFi Router has been successfully established and networking/internet works. *************************************************************************************** *************************************************************************************** Next I close the connection, here by simply disabling WiFi in the NM Applet *************************************************************************************** NetworkManager[31344]: <debug> [1412036450.263643] [nm-device-wifi.c:518] get_active_ap(): (wlan0): active BSSID: 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036450.263738] [nm-device-wifi.c:528] get_active_ap(): (wlan0): active SSID: 'scientia.net' NetworkManager[31344]: <debug> [1412036450.263796] [nm-device-wifi.c:538] get_active_ap(): Pass #1 NetworkManager[31344]: <debug> [1412036450.263808] [nm-device-wifi.c:554] get_active_ap(): AP: 'scientia.net' 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036450.263819] [nm-device-wifi.c:594] get_active_ap(): matched XMT: Forming Info-Request, 15000 ms elapsed. XMT: Info-Request on wlan0, interval 15460ms. NetworkManager[31344]: <debug> [1412036456.262808] [nm-device-wifi.c:518] get_active_ap(): (wlan0): active BSSID: 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036456.262959] [nm-device-wifi.c:528] get_active_ap(): (wlan0): active SSID: 'scientia.net' NetworkManager[31344]: <debug> [1412036456.263085] [nm-device-wifi.c:538] get_active_ap(): Pass #1 NetworkManager[31344]: <debug> [1412036456.263109] [nm-device-wifi.c:554] get_active_ap(): AP: 'scientia.net' 34:31:c4:42:e5:41 NetworkManager[31344]: <debug> [1412036456.263141] [nm-device-wifi.c:594] get_active_ap(): matched NetworkManager[31344]: <debug> [1412036457.769867] [nm-manager.c:4751] manager_radio_user_toggled(): (WiFi): setting radio disabled by user NetworkManager[31344]: <debug> [1412036457.778784] [nm-manager.c:1609] manager_update_radio_enabled(): (wlan0): setting radio disabled NetworkManager[31344]: <debug> [1412036457.778833] [nm-device-wifi.c:3580] set_enabled(): (wlan0): device now disabled NetworkManager[31344]: <info> (wlan0): device state change: activated -> unavailable (reason 'none') [100 20 0] NetworkManager[31344]: <info> (wlan0): deactivating device (reason 'none') [0] NetworkManager[31344]: <debug> [1412036457.778931] [nm-firewall-manager.c:166] nm_firewall_manager_remove_from_zone(): (wlan0) firewall zone remove skipped (not running) NetworkManager[31344]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 31397 NetworkManager[31344]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 31399 NetworkManager[31344]: <debug> [1412036458.180164] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/disable_ipv6' to '0' NetworkManager[31344]: <debug> [1412036458.180242] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/accept_ra' to '0' NetworkManager[31344]: <debug> [1412036458.180267] [NetworkManagerUtils.c:583] nm_utils_do_sysctl(): sysctl: setting '/proc/sys/net/ipv6/conf/wlan0/use_tempaddr' to '0' NetworkManager[31344]: <debug> [1412036458.180395] [nm-device-wifi.c:854] _set_hw_addr(): (wlan0): no MAC address change needed NetworkManager[31344]: <debug> [1412036458.180525] [nm-system.c:1404] nm_system_iface_flush_routes(): (wlan0): flushing routes ifindex 3 family UNSPEC (0) NetworkManager[31344]: <debug> [1412036458.207018] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET (2) addr 0.0.0.0/0 NetworkManager[31344]: <debug> [1412036458.207052] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.207102] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET (2) addr 192.168.0.0/24 NetworkManager[31344]: <debug> [1412036458.207119] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.207151] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/32 NetworkManager[31344]: <debug> [1412036458.207170] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.0/8 NetworkManager[31344]: <debug> [1412036458.207185] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.0.0.1/32 NetworkManager[31344]: <debug> [1412036458.207202] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET (2) addr 127.255.255.255/32 NetworkManager[31344]: <debug> [1412036458.207219] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET (2) addr 192.168.0.0/32 NetworkManager[31344]: <debug> [1412036458.207232] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.207266] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET (2) addr 192.168.0.100/32 NetworkManager[31344]: <debug> [1412036458.207284] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.207319] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET (2) addr 192.168.0.255/32 NetworkManager[31344]: <debug> [1412036458.207560] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.207939] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET6 (10) addr ::1/128 NetworkManager[31344]: <debug> [1412036458.208242] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr 2001:a60:146e:5c01::/64 NetworkManager[31344]: <debug> [1412036458.208578] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.208827] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr 2a03:2880:2020:6f09:face:b00c:0:1/128 NetworkManager[31344]: <debug> [1412036458.208975] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.209159] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr 2a03:2880:2020:7f00:face:b00c:0:1/128 NetworkManager[31344]: <debug> [1412036458.209248] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.209416] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr 2a03:2880:2130:4f00:face:b00c:0:1/128 NetworkManager[31344]: <debug> [1412036458.209544] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.209731] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr 2a03:2880:f01c:301:face:b00c:0:1/128 NetworkManager[31344]: <debug> [1412036458.209843] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.210006] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr fd00::/64 NetworkManager[31344]: <debug> [1412036458.210133] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.210296] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr fe80::3631:c4ff:fe42:e53e/128 NetworkManager[31344]: <debug> [1412036458.210425] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr fe80::/64 NetworkManager[31344]: <debug> [1412036458.210569] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr 0:0:2100::300:0/0 NetworkManager[31344]: <debug> [1412036458.210711] [nm-system.c:1368] delete_one_route(): deleting route NetworkManager[31344]: <debug> [1412036458.210912] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET6 (10) addr ::1/128 NetworkManager[31344]: <debug> [1412036458.211022] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET6 (10) addr 2001:a60:146e:5c01:6267:20ff:fe09:9aa4/128 NetworkManager[31344]: <debug> [1412036458.211153] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET6 (10) addr fd00::6267:20ff:fe09:9aa4/128 NetworkManager[31344]: <debug> [1412036458.211296] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET6 (10) addr fe80::6267:20ff:fe09:9aa4/128 NetworkManager[31344]: <debug> [1412036458.211439] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr ff02::1/128 NetworkManager[31344]: <debug> [1412036458.211594] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr ff02::1:2/128 NetworkManager[31344]: <debug> [1412036458.211759] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr ff02::1:ff09:9aa4/128 NetworkManager[31344]: <debug> [1412036458.211907] [nm-netlink-utils.c:356] dump_route(): route idx 3 family INET6 (10) addr ff00::/8 NetworkManager[31344]: <debug> [1412036458.212057] [nm-netlink-utils.c:356] dump_route(): route idx 1 family INET6 (10) addr 0:0:4100::/0 NetworkManager[31344]: <debug> [1412036458.212363] [nm-system.c:194] sync_addresses(): (wlan0): syncing addresses (family 0) NetworkManager[31344]: <debug> [1412036458.212403] [nm-system.c:247] sync_addresses(): (wlan0): removing address '192.168.0.100/24' NetworkManager[31344]: <debug> [1412036458.212602] [nm-system.c:247] sync_addresses(): (wlan0): removing address 'fd00::6267:20ff:fe09:9aa4/64' NetworkManager[31344]: <debug> [1412036458.212763] [nm-system.c:247] sync_addresses(): (wlan0): removing address '2001:a60:146e:5c01:6267:20ff:fe09:9aa4/64' NetworkManager[31344]: <debug> [1412036458.212941] [nm-system.c:230] sync_addresses(): (wlan0): ignoring IPv6 link-local address NetworkManager[31344]: <debug> [1412036458.213126] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): (device_ip4_config_changed): queueing DNS updates (1) NetworkManager[31344]: <debug> [1412036458.213274] [nm-manager.c:4209] policy_default_device_changed(): PrimaryConnection now (none) NetworkManager[31344]: <debug> [1412036458.213446] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration changed NetworkManager[31344]: <debug> [1412036458.213595] [nm-dns-manager.c:1022] nm_dns_manager_end_updates(): (device_ip4_config_changed): committing DNS changes (0) NetworkManager[31344]: <debug> [1412036458.213762] [nm-dns-manager.c:591] update_dns(): updating resolv.conf NetworkManager[31344]: <info> Removing DNS information from /sbin/resolvconf NetworkManager[31344]: <debug> [1412036458.277513] [nm-manager.c:4150] connectivity_changed(): connectivity checking indicates NONE NetworkManager[31344]: <info> NetworkManager state is now DISCONNECTED NetworkManager[31344]: <debug> [1412036458.277635] [nm-dns-manager.c:995] nm_dns_manager_begin_updates(): (update_routing_and_dns): queueing DNS updates (1) NetworkManager[31344]: <debug> [1412036458.277668] [nm-dns-manager.c:1013] nm_dns_manager_end_updates(): (nm_dns_manager_end_updates): DNS configuration did not change NetworkManager[31344]: <debug> [1412036458.277683] [nm-dns-manager.c:1017] nm_dns_manager_end_updates(): (update_routing_and_dns): no DNS changes to commit (0) NetworkManager[31344]: <debug> [1412036458.278948] [nm-device-wifi.c:1366] is_available(): (wlan0): not available because not enabled NetworkManager[31344]: <debug> [1412036458.278972] [nm-device.c:5154] nm_device_state_changed(): (wlan0): device not yet available for transition to DISCONNECTED NetworkManager[31344]: <info> (wlan0): taking down device. NetworkManager[31344]: <info> WiFi hardware radio set disabled NetworkManager[31344]: <debug> [1412036458.284527] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1003 NetworkManager[31344]: <debug> [1412036458.284707] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1003 NetworkManager[31344]: <debug> [1412036458.284762] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1043 NetworkManager[31344]: <debug> [1412036458.285362] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1002 NetworkManager[31344]: <debug> [1412036458.312463] [nm-udev-manager.c:568] handle_uevent(): UDEV event: action 'change' subsys 'rfkill' device 'rfkill0' NetworkManager[31344]: <debug> [1412036458.312589] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch rfkill0 state now 0/1 NetworkManager[31344]: <debug> [1412036458.312607] [nm-udev-manager.c:243] recheck_killswitches(): WiFi rfkill state now 'soft-blocked' NetworkManager[31344]: <debug> [1412036458.312623] [nm-manager.c:1757] manager_rfkill_update_one_type(): WiFi hw-enabled 1 sw-enabled 0 NetworkManager[31344]: <info> WiFi now disabled by radio killswitch *************************************************************************************** At this point I try to re-connect (again by clicking on the WPA-PSK connection in the NM applet *************************************************************************************** NetworkManager[31344]: <debug> [1412036466.21271] [nm-manager.c:4751] manager_radio_user_toggled(): (WiFi): setting radio enabled by user NetworkManager[31344]: <debug> [1412036466.30355] [nm-manager.c:1609] manager_update_radio_enabled(): (wlan0): setting radio enabled NetworkManager[31344]: <debug> [1412036466.30406] [nm-device-wifi.c:3580] set_enabled(): (wlan0): device now enabled NetworkManager[31344]: <info> (wlan0): bringing up device. NetworkManager[31344]: <debug> [1412036466.30708] [nm-device-wifi.c:3598] set_enabled(): (wlan0): enable blocked by failure to bring device up NetworkManager[31344]: <info> WiFi hardware radio set enabled NetworkManager[31344]: <debug> [1412036466.77933] [nm-udev-manager.c:568] handle_uevent(): UDEV event: action 'change' subsys 'rfkill' device 'rfkill0' NetworkManager[31344]: <debug> [1412036466.78109] [nm-udev-manager.c:216] recheck_killswitches(): WiFi rfkill switch rfkill0 state now 1/0 NetworkManager[31344]: <debug> [1412036466.78144] [nm-udev-manager.c:243] recheck_killswitches(): WiFi rfkill state now 'unblocked' NetworkManager[31344]: <debug> [1412036466.78171] [nm-manager.c:1757] manager_rfkill_update_one_type(): WiFi hw-enabled 1 sw-enabled 1 NetworkManager[31344]: <info> WiFi now enabled by radio killswitch NetworkManager[31344]: <debug> [1412036466.78223] [nm-manager.c:1609] manager_update_radio_enabled(): (wlan0): setting radio enabled NetworkManager[31344]: <debug> [1412036466.78239] [nm-device-wifi.c:3580] set_enabled(): (wlan0): device now enabled NetworkManager[31344]: <info> (wlan0): bringing up device. NetworkManager[31344]: <debug> [1412036466.171040] [nm-supplicant-manager.c:90] nm_supplicant_manager_iface_get(): (wlan0): creating new supplicant interface NetworkManager[31344]: <debug> [1412036466.171145] [nm-supplicant-interface.c:1022] interface_add(): (wlan0): adding interface to supplicant NetworkManager[31344]: <debug> [1412036466.171279] [nm-device-wifi.c:3615] set_enabled(): (wlan0): enable waiting on supplicant state NetworkManager[31344]: <debug> [1412036466.171353] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1003 NetworkManager[31344]: <debug> [1412036466.237305] [nm-supplicant-interface.c:849] interface_add_done(): (wlan0): interface added to supplicant NetworkManager[31344]: <info> (wlan0) supports 5 scan SSIDs NetworkManager[31344]: <debug> [1412036466.238137] [nm-supplicant-interface.c:747] iface_check_netreply_cb(): Supplicant supports network credentials requests NetworkManager[31344]: <info> (wlan0): supplicant interface state: starting -> ready NetworkManager[31344]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42] NetworkManager[31344]: <warn> Trying to remove a non-existant call id. NetworkManager[31344]: <info> (wlan0): supplicant interface state: ready -> disconnected NetworkManager[31344]: <info> (wlan0) supports 5 scan SSIDs NetworkManager[31344]: <warn> Could not get scan request result: Scan request rejected NetworkManager[31344]: <debug> [1412036468.850564] [nm-netlink-monitor.c:164] link_msg_handler(): netlink link message: iface idx 3 flags 0x1003 NetworkManager[31344]: <info> (wlan0): supplicant interface state: disconnected -> inactive NetworkManager[31344]: <info> Activation (wlan0) starting connection 'Ifupdown (wlan0-scientia.net)' NetworkManager[31344]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0] NetworkManager[31344]: <info> NetworkManager state is now CONNECTING NetworkManager[31344]: <debug> [1412036471.337295] [nm-manager.c:4242] policy_activating_device_changed(): ActivatingConnection now Ifupdown (wlan0-scientia.net) NetworkManager[31344]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled... NetworkManager[31344]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started... NetworkManager[31344]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled... NetworkManager[31344]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete. NetworkManager[31344]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting... NetworkManager[31344]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0] NetworkManager[31344]: <info> Activation (wlan0/wireless): access point 'Ifupdown (wlan0-scientia.net)' has security, but secrets are required. NetworkManager[31344]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0] NetworkManager[31344]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete. *************************************************************************************** here it waits "forever", with no connection being established anymore *************************************************************************************** Cheers, Chris.
smime.p7s
Description: S/MIME cryptographic signature
