ubuntuusers.de

WLAN-Einwahlprobleme seit Routerwechsel

Status: Gelöst | Ubuntu-Version: Ubuntu 14.04 (Trusty Tahr)
Antworten |

Mortifikator

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Moin!

Ich bin vor einiger Zeit auf Ubuntu 14.04 LTS umgestiegen, weil ich mit Windows ab 8.0 und MS immer unglücklicher wurde. Ich habe diesen Schritt in keiner Weise bereut und weine Windows keine Träne nach. Mittlerweile verfüge ich über ein solides Ubuntu/Linux "Anwenderwissen", allerdings reicht das leider nicht für kniffligere Probleme. Ein solches Problem beschäftigt mich gerade, und ich hoffe, daß mir die Fachleute hier helfen können:

- Ich hatte seit vielen Jahren einen extrem zuverlässigen Router Fritzbox WLAN Fon 7170 Vers. F: http://avm.de/service/fritzbox/fritzbox-7170/uebersicht/

- Als USB-WLAN-Stick mit Ubuntu nutze ich einen CSL 300Mbit mit Ralink RT5572, der für den Linux-Betrieb ausgewiesen ist. (Netzwerk-Standard: 802.11a/b/g/n | Verschlüsselung: 64/128-bit WEP, WPA, WPA2, TKIP, AES, WAPI | Modulationen: DSSS with CCK, DQPSK, DBPSK OFDM with BPSK, QPSK, 16QAM, 64QAM) http://www.amazon.de/gp/product/B00LLIOT34?keywords=csl%20wlan%20stick&qid=1443010557&ref_=sr_1_2&sr=8-2

lsusb: Bus 002 Device 003: ID 148f:5572 Ralink Technology, Corp. RT5572 Wireless Adapter

- Mein Rechner: ASUS H97-Plus, 16 GB RAM, Intel i5-4690, ASUS GeForce GTX 750 DCSL 2GB GDDR5 128bit PCI-E 3 (Treiber: NVidia 346.87).

- Mein Ubuntu: Linux JS 3.16.0-49-generic #65~14.04.1-Ubuntu SMP Wed Sep 9 10:03:23 UTC 2015 x86_64 x86_64 x86_64 GNU/Linux

Der Rechner läuft mit Ubuntu wie geschmiert, und der Router mit dem WLAN-Stick war bisher ein "Dream Team": Eingesteckt, sofort Kontakt ohne zusätzliche Treiber, extrem schnelle und automatische Einwahl, stabile und schnelle Verbindung zu jeder Zeit. Rundum sorglos.

Fritzbox 7170: Fester Kanal, 2,4 GHz, 802.11 g+n, WPA2 PSK, Sichtbare SSID, Keine IPTV-Optimierung oder sonstige Optimierung, Keine MAC-Beschränkung.

iwconfig
wlan0     IEEE 802.11abgn  ESSID:"*!!*Crenshaw_The_1_&_Only*!!*"  
          Mode:Managed  Frequency:2.447 GHz  Access Point: C8:0E:14:CE:ED:BC   
          Bit Rate=54 Mb/s   Tx-Power=20 dBm   
          Retry short limit:7   RTS thr:off   Fragment thr:off
          Power Management:off
          Link Quality=46/70  Signal level=-54 dBm  
          Rx invalid nwid:0  Rx invalid crypt:0  Rx invalid frag:0
          Tx excessive retries:0  Invalid misc:117   Missed beacon:0

Nun war ich gezwungen, einen neuen Router zu kaufen, und entschied mich nach jahrelanger Firmenzufriedenheit für die neue Fritzbox 7490: http://avm.de/produkte/fritzbox/fritzbox-7490/

Dieser neue Router läuft einwandfrei, alle Hausgeräte kommunizieren problemlos mit ihm. Die Signalstärke ist gut, wenn auch (ärgerlicherweise) schwächer als bei dem deutlich älteren Modell mit klassischer Antenne. Trotzdem bekomme ich z.B. direkt neben meinem Rechner laut iPad volle 3 Striche und ein stabiles Signal (Entfernung ca. 10 m, 1 Holztür, 1 Steinwand 24 cm).

Nun habe ich folgendes Problem: Wenn mein System einige Stunden aus war und ich es dann anschalte, wird keine WLAN-Verbindung mehr aufgebaut. Der Ubuntu-Netzwerkmanager sucht und sucht und probiert es immer wieder, aber es kommt keine Verbindung zustande, obwohl mein WLAN als verfügbar und ausreichend stark angezeigt wird. Alles manuelle Probieren nützt ebenfalls nichts. Schalte ich den Rechner danach aber komplett aus und wieder an, funktioniert es plötzlich so wie früher mit der alten 7170.

Die Verbindungsdaten im Netzwerkmanager: Automatische Einwahl, SSID angegeben, Infrastruktur, BSSID fest, MAC-Adresse des Gerätes fest (wlan0), MTU automatisch, WPA2 Personal, IPv4 Automatisch (DHCP), IPv6 ignorieren

Ich habe am System nichts geändert, am WLAN-Stick, am OS, am BIOS/UEFI oder an der Einwahl; alles ist wie vorher, nur der Router wechselte. Ich würde daher nur ungern z.B. einen anderen Netzwerkmanager installieren, weil der Originalmanager von 14.04 bisher problemlos funktionierte. Ich bin jedoch ratlos, warum die automatische Einwahl beim ersten Aufstart nun nicht mehr klappt.

Fritzbox 7490: Fester Kanal, 2,4 GHz, 802.11 g+n, WPA2 PSK, Sichtbare SSID, Keine IPTV-Optimierung oder sonstige Optimierung, Keine MAC-Beschränkung, IPv6 deaktiviert.

iwconfig
wlan0     IEEE 802.11abgn  ESSID:"*!!*Crenshaw_The_1_&_Only*!!*"  
          Mode:Managed  Frequency:2.447 GHz  Access Point: C8:0E:14:CE:ED:BC   
          Bit Rate=300 Mb/s   Tx-Power=20 dBm   
          Retry short limit:7   RTS thr:off   Fragment thr:off
          Power Management:off
          Link Quality=46/70  Signal level=-64 dBm  
          Rx invalid nwid:0  Rx invalid crypt:0  Rx invalid frag:0
          Tx excessive retries:0  Invalid misc:130   Missed beacon:0
ifconfig -a
wlan0     Link encap:Ethernet  Hardware Adresse 24:05:0f:34:4a:75  
          inet Adresse:192.168.178.38  Bcast:192.168.178.255  Maske:255.255.255.0
          inet6-Adresse: fe80::2605:fff:fe34:4a75/64 Gültigkeitsbereich:Verbindung
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metrik:1
          RX-Pakete:14382 Fehler:0 Verloren:0 Überläufe:0 Fenster:0
          TX-Pakete:13099 Fehler:0 Verloren:0 Überläufe:0 Träger:0
          Kollisionen:0 Sendewarteschlangenlänge:1000 
          RX-Bytes:12325379 (12.3 MB)  TX-Bytes:1929508 (1.9 MB)
route -n
Kernel-IP-Routentabelle
Ziel            Router          Genmask         Flags Metric Ref    Use Iface
0.0.0.0         192.168.178.1   0.0.0.0         UG    0      0        0 wlan0
172.16.89.0     0.0.0.0         255.255.255.0   U     0      0        0 vmnet1
172.16.234.0    0.0.0.0         255.255.255.0   U     0      0        0 vmnet8
192.168.178.0   0.0.0.0         255.255.255.0   U     9      0        0 wlan0
cat /var/lib/NetworkManager/NetworkManager.state
[main]
NetworkingEnabled=true
WirelessEnabled=true
WWANEnabled=true
WimaxEnabled=true
cat /etc/NetworkManager/NetworkManager.conf 
[main]
plugins=ifupdown,keyfile,ofono
dns=dnsmasq
no-auto-default=F0:79:59:63:2D:14,
[ifupdown]
managed=false
rfkill list 
0: phy0: Wireless LAN
	Soft blocked: no
	Hard blocked: no
lsmod
Module                  Size  Used by
ctr                    13049  3 
ccm                    17773  3 
vmnet                  51269  13 
arc4                   12608  2 
vmw_vsock_vmci_transport    26278  0 
vsock                  34903  1 vmw_vsock_vmci_transport
vmw_vmci               62976  1 vmw_vsock_vmci_transport
vmmon                  84056  0 
bnep                   19624  2 
rfcomm                 69509  0 
rt2800usb              27189  0 
bluetooth             446409  10 bnep,rfcomm
rt2x00usb              20742  1 rt2800usb
6lowpan_iphc           18702  1 bluetooth
rt2800lib              89076  1 rt2800usb
rt2x00lib              55307  3 rt2x00usb,rt2800lib,rt2800usb
mac80211              652777  3 rt2x00lib,rt2x00usb,rt2800lib
cfg80211              498458  2 mac80211,rt2x00lib
crc_ccitt              12707  1 rt2800lib
hid_generic            12559  0 
usbhid                 52616  0 
hid                   110426  2 hid_generic,usbhid
binfmt_misc            17468  1 
snd_hda_codec_hdmi     47548  1 
nvidia               8383896  44 
eeepc_wmi              13151  0 
asus_wmi               24094  1 eeepc_wmi
sparse_keymap          13948  1 asus_wmi
mxm_wmi                13021  0 
intel_rapl             18783  0 
x86_pkg_temp_thermal    14205  0 
intel_powerclamp       18823  0 
kvm_intel             143630  0 
kvm                   452096  1 kvm_intel
crct10dif_pclmul       14307  0 
crc32_pclmul           13133  0 
ghash_clmulni_intel    13230  0 
aesni_intel           152552  6 
aes_x86_64             17131  1 aesni_intel
lrw                    13286  1 aesni_intel
gf128mul               14951  1 lrw
glue_helper            13990  1 aesni_intel
ablk_helper            13597  1 aesni_intel
cryptd                 20359  3 ghash_clmulni_intel,aesni_intel,ablk_helper
serio_raw              13483  0 
snd_hda_codec_realtek    77561  1 
snd_hda_codec_generic    69011  1 snd_hda_codec_realtek
snd_hda_intel          30469  5 
snd_hda_controller     30228  1 snd_hda_intel
snd_seq_midi           13564  0 
snd_seq_midi_event     14899  1 snd_seq_midi
snd_hda_codec         139719  5 snd_hda_codec_realtek,snd_hda_codec_hdmi,snd_hda_codec_generic,snd_hda_intel,snd_hda_controller
tpm_infineon           17131  0 
snd_rawmidi            30876  1 snd_seq_midi
snd_hwdep              17698  1 snd_hda_codec
video                  20128  1 asus_wmi
snd_pcm               104112  4 snd_hda_codec_hdmi,snd_hda_codec,snd_hda_intel,snd_hda_controller
snd_seq                63074  2 snd_seq_midi_event,snd_seq_midi
snd_seq_device         14497  3 snd_seq,snd_rawmidi,snd_seq_midi
snd_timer              29562  2 snd_pcm,snd_seq
acpi_pad               17942  0 
drm                   311018  3 nvidia
snd                    79468  21 snd_hda_codec_realtek,snd_hwdep,snd_timer,snd_hda_codec_hdmi,snd_pcm,snd_seq,snd_rawmidi,snd_hda_codec_generic,snd_hda_codec,snd_hda_intel,snd_seq_device
mei_me                 19696  0 
mei                    87875  1 mei_me
mac_hid                13227  0 
shpchp                 37047  0 
soundcore              15047  2 snd,snd_hda_codec
wmi                    19193  2 mxm_wmi,asus_wmi
parport_pc             32741  0 
ppdev                  17671  0 
coretemp               13441  0 
lp                     17759  0 
parport                42348  3 lp,ppdev,parport_pc
r8169                  71694  0 
mii                    13934  1 r8169
ahci                   34142  3 
libahci                32424  1 ahci
iwlist chan 
eth0      no frequency information.
vmnet1    no frequency information.
wlan0     32 channels in total; available frequencies :
          Channel 01 : 2.412 GHz
          Channel 02 : 2.417 GHz
          Channel 03 : 2.422 GHz
          Channel 04 : 2.427 GHz
          Channel 05 : 2.432 GHz
          Channel 06 : 2.437 GHz
          Channel 07 : 2.442 GHz
          Channel 08 : 2.447 GHz
          Channel 09 : 2.452 GHz
          Channel 10 : 2.457 GHz
          Channel 11 : 2.462 GHz
          Channel 12 : 2.467 GHz
          Channel 13 : 2.472 GHz
          Channel 36 : 5.18 GHz
          Channel 38 : 5.19 GHz
          Channel 40 : 5.2 GHz
          Channel 42 : 5.21 GHz
          Channel 44 : 5.22 GHz
          Channel 46 : 5.23 GHz
          Channel 48 : 5.24 GHz
          Channel 52 : 5.26 GHz
          Channel 54 : 5.27 GHz
          Channel 56 : 5.28 GHz
          Channel 58 : 5.29 GHz
          Channel 60 : 5.3 GHz
          Channel 62 : 5.31 GHz
          Channel 64 : 5.32 GHz
          Channel 100 : 5.5 GHz
          Channel 102 : 5.51 GHz
          Channel 104 : 5.52 GHz
          Channel 106 : 5.53 GHz
          Channel 108 : 5.54 GHz
          Current Frequency:2.447 GHz (Channel 8)

lubux

Anmeldungsdatum:
21. November 2012

Beiträge: 14393

Mortifikator schrieb:

Der Ubuntu-Netzwerkmanager sucht und sucht und probiert es immer wieder, aber es kommt keine Verbindung zustande, obwohl mein WLAN als verfügbar und ausreichend stark angezeigt wird.

Versuch mal mit einer ESSID ohne Sonderzeichen und ohne Leerstellen. Siehe im Terminal auch die Ausgabe von:

sudo wpa_cli

während der Netwerkmanager sucht. Und anschließend die Ausgabe von:

sudo cat /var/log/syslog | grep -iE 'wlan|dhc|error|warn|fail|auth|assoc|wpa_sup|reason'

EDIT:

Konfiguriere dein Ubuntu auch so, dass sofort nach dem Start der arp-cache geflusht wird und ein statischer arp-cache-Eintrag für deine FritzBox gemacht wird (z. B. mit einem cronjob).

EDIT 2:

In deiner neuen Fritzbox 7490 den Ubuntu-PC mit Name und MAC-Adresse so konfigurieren, dass dieser vom DHCP-Server der FritzBox, immer die gleiche IPv4-Adresse bekommt (d. h. statische/feste IP-Adresse per DHCP).

EDIT 3:

Mortifikator schrieb:

... obwohl mein WLAN als verfügbar und ausreichend stark angezeigt wird.

Es kann auch sein, dass die Verfügbarkeit deines WLANs lediglich dem Networkmanager (basierend auf die Konfiguration) bekannt ist und nicht dem wpa_supplicant (der ja tatsächlich danach suchen/schauen muss). Evtl. hat der wpa_supplicant bei seinem 1. scan der APs, aus welchen Gründen auch immer, dein WLAN nicht gefunden. Siehe zum Zeitpunkt der Suche und nicht zustande kommen der Verbindung, die Ausgabe von:

sudo wpa_cli scan_results

und ob dein WLAN in dieser Ausgabe, dabei ist. Evtl. einen längeren Zeitraum (z. B auch bis 10 Minuten) warten und den PC nicht neu starten, um festzustellen (mit Hilfe der Ausgabe von wpa_cli), wann der wpa_supplicant seinen 2. scan der APs macht und ob in diesem 2. scan dein WLAN gefunden und damit verbunden wird.

Mortifikator

(Themenstarter)

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Danke für deine Hilfe, ich denke, wir kommen der Sache schon näher.

Folgende Situation ergab sich nun: Ich änderte die IPv4-Einstellung in der 7490 wie empfohlen und die ESSID zu FB-JS-MB. Ein Aufstart zeigte leider wieder das Einwahlproblem, und selbst ein Herunterfahren mit Neustart führte nicht zum Erfolg: keine Verbindung. Ich bereitete dann die Protokolle vor, änderte die SSID in einigen Geräten hier im Haus und ließ den Rechner dabei an. Einige Minuten später erfolgte schließlich die Einwahl ohne weiteres Zutun von mir. Somit ist vermutlich davon auszugehen, daß Ubuntu-Netzwerk(manager) und der neue Router sich anfangs nicht erkennen und das erst nach einiger Zeit klappt.

PS: Momentan ist das Problem für mich nicht leicht zu reproduzieren, weil es "unzuverlässig" ist. Ich machte nun zwei Kaltstarts, und beide Male wählte er sich sofort ein. Ich werde daher erst einmal einige Zeit warten müssen und es dann neu versuchen.

sudo wpa_cli

wpa_cli v2.1
Copyright (c) 2004-2014, Jouni Malinen <j@w1.fi> and contributors
This software may be distributed under the terms of the BSD license.
See README for more details.
Selected interface 'wlan0'
Interactive mode
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>Reject scan trigger since one is already pending
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>Reject scan trigger since one is already pending
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
> 

sudo cat /var/log/syslog | grep -iE 'wlan|dhc|error|warn|fail|auth|assoc|wpa_sup|reason'

Sep 23 16:15:35 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 23 16:15:35 JS vmnetBridge: Adding interface wlan0 index:3
Sep 23 16:15:35 JS vmnetBridge: Started bridge wlan0 to virtual network 0.
Sep 23 16:15:35 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:15:35 JS kernel: [    8.685334] bridge-wlan0: device is wireless, enabling SMAC
Sep 23 16:15:35 JS kernel: [    8.685335] bridge-wlan0: up
Sep 23 16:15:35 JS kernel: [    8.685337] bridge-wlan0: attached
Sep 23 16:15:35 JS kernel: [    8.686065] wlan0: deauthenticating from c8:0e:14:ce:ed:bc by local choice (Reason: 2=PREV_AUTH_NOT_VALID)
Sep 23 16:15:35 JS kernel: [    8.724449] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:15:35 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-DISCONNECTED bssid=c8:0e:14:ce:ed:bc reason=2 locally_generated=1
Sep 23 16:15:35 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 23 16:15:35 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: 4-way handshake -> authenticating
Sep 23 16:15:35 JS NetworkManager[820]: <warn> Connection disconnected (reason -2)
Sep 23 16:15:35 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 23 16:15:35 JS vmnetBridge: Removing interface wlan0 index:3
Sep 23 16:15:35 JS kernel: [    8.748897] wlan0: send auth to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:15:35 JS kernel: [    8.749211] bridge-wlan0: disabling the bridge
Sep 23 16:15:35 JS vmnetBridge: Stopped bridge wlan0 to virtual network 0.
Sep 23 16:15:35 JS kernel: [    8.760019] bridge-wlan0: down
Sep 23 16:15:35 JS kernel: [    8.760032] bridge-wlan0: detached
Sep 23 16:15:35 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:15:36 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 23 16:15:37 JS avahi-daemon[793]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::2605:fff:fe34:4a75.
Sep 23 16:15:37 JS avahi-daemon[793]: New relevant interface wlan0.IPv6 for mDNS.
Sep 23 16:15:37 JS avahi-daemon[793]: Registering new address record for fe80::2605:fff:fe34:4a75 on wlan0.*.
Sep 23 16:15:38 JS kernel: [   11.893224] wlan0: send auth to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:15:39 JS kernel: [   11.997214] wlan0: send auth to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:15:39 JS kernel: [   12.105102] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:15:39 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:15:39 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:15:47 JS gnome-session[1880]: WARNING: Could not parse desktop file gnome-screensaver.desktop or it references a not found TryExec binary
Sep 23 16:15:48 JS kernel: [   21.879897] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 23 16:15:48 JS kernel: [   21.880316] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 23 16:15:48 JS kernel: [   21.888774] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 23 16:15:48 JS kernel: [   21.889195] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 23 16:15:47 JS wpa_supplicant[1220]: message repeated 2 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 23 16:15:50 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:15:50 JS kernel: [   23.730587] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:15:50 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 23 16:15:50 JS kernel: [   23.762702] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:15:51 JS kernel: [   23.963032] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:15:51 JS kernel: [   24.166850] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:15:51 JS kernel: [   24.370682] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:15:51 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:15:52 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:15:52 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:15:58 JS NetworkManager[820]: <warn> Activation (wlan0/wireless): association took too long.
Sep 23 16:15:58 JS NetworkManager[820]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 23 16:15:58 JS NetworkManager[820]: <warn> Activation (wlan0/wireless): asking for new secrets
Sep 23 16:15:58 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:15:58 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:15:58 JS NetworkManager[820]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:15:58 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 23 16:15:58 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:15:58 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:15:58 JS kernel: [   31.265571] systemd-hostnamed[2316]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!
Sep 23 16:16:09 JS wpa_supplicant[1220]: message repeated 3 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 23 16:16:12 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:16:12 JS kernel: [   45.060517] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:16:12 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 23 16:16:12 JS kernel: [   45.092538] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:16:12 JS kernel: [   45.292877] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:16:12 JS kernel: [   45.496713] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:16:12 JS kernel: [   45.700552] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:16:12 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 23 16:16:12 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:16:22 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:16:22 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:16:22 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 23 16:16:23 JS NetworkManager[820]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 23 16:16:23 JS NetworkManager[820]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 23 16:16:23 JS NetworkManager[820]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 23 16:16:23 JS NetworkManager[820]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 23 16:16:23 JS NetworkManager[820]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 23 16:16:23 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:16:23 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:16:23 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:16:26 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 23 16:16:26 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:16:26 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:16:26 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:16:26 JS kernel: [   58.992422] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:16:26 JS kernel: [   59.024960] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 23 16:16:26 JS kernel: [   59.225053] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:16:26 JS kernel: [   59.428869] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:16:26 JS kernel: [   59.632699] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:16:26 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 23 16:16:26 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:16:36 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:16:36 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:16:36 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 23 16:16:41 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:16:44 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:16:44 JS kernel: [   77.733915] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:16:44 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 23 16:16:44 JS kernel: [   77.776921] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:16:45 JS kernel: [   77.977139] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:16:45 JS kernel: [   78.180936] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:16:45 JS kernel: [   78.384794] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:16:45 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
Sep 23 16:16:45 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:16:51 JS NetworkManager[820]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 23 16:16:51 JS NetworkManager[820]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 23 16:16:51 JS NetworkManager[820]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 23 16:16:51 JS NetworkManager[820]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 23 16:16:51 JS NetworkManager[820]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 23 16:16:51 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 23 16:16:54 JS NetworkManager[820]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:16:54 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 23 16:16:54 JS NetworkManager[820]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:16:54 JS NetworkManager[820]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:16:54 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 23 16:16:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:16:55 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:17:00 JS wpa_supplicant[1220]: message repeated 2 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 23 16:17:03 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:17:03 JS kernel: [   96.025310] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:17:03 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 23 16:17:03 JS kernel: [   96.057278] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:17:03 JS kernel: [   96.257575] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:17:03 JS kernel: [   96.461409] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:17:03 JS kernel: [   96.665235] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:17:03 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 23 16:17:03 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:17:13 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:17:13 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:17:13 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 23 16:17:18 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:17:19 JS NetworkManager[820]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 23 16:17:19 JS NetworkManager[820]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 23 16:17:19 JS NetworkManager[820]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 23 16:17:19 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:17:19 JS NetworkManager[820]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 23 16:17:19 JS NetworkManager[820]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 23 16:17:19 JS wpa_supplicant[1220]: wlan0: Reject scan trigger since one is already pending
Sep 23 16:17:19 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:17:21 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> inactive
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 23 16:17:22 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:17:22 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:17:22 JS kernel: [  114.919312] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: inactive -> authenticating
Sep 23 16:17:22 JS kernel: [  114.945252] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:17:22 JS kernel: [  115.145509] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 23 16:17:22 JS kernel: [  115.349331] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 23 16:17:22 JS kernel: [  115.553161] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 23 16:17:22 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 23 16:17:22 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 23 16:17:32 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:17:32 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 23 16:17:32 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 23 16:17:37 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:17:47 JS NetworkManager[820]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 23 16:17:47 JS NetworkManager[820]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 23 16:17:47 JS NetworkManager[820]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 23 16:17:47 JS NetworkManager[820]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 23 16:17:47 JS NetworkManager[820]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 23 16:17:45 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:17:47 JS wpa_supplicant[1220]: wlan0: Reject scan trigger since one is already pending
Sep 23 16:17:47 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:17:47 JS NetworkManager[820]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 23 16:17:48 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> inactive
Sep 23 16:17:50 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 23 16:22:47 JS NetworkManager[820]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:22:47 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 23 16:22:47 JS NetworkManager[820]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 23 16:22:47 JS NetworkManager[820]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 23 16:22:47 JS NetworkManager[820]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 23 16:22:47 JS NetworkManager[820]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 23 16:22:47 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: inactive -> scanning
Sep 23 16:22:47 JS wpa_supplicant[1220]: message repeated 7 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 23 16:22:50 JS wpa_supplicant[1220]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:22:50 JS kernel: [  442.694354] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 23 16:22:50 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 23 16:22:50 JS kernel: [  442.726490] wlan0: send auth to c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:22:50 JS wpa_supplicant[1220]: wlan0: Trying to associate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 23 16:22:50 JS kernel: [  442.734512] wlan0: authenticated
Sep 23 16:22:50 JS kernel: [  442.735012] wlan0: associate with c8:0e:14:ce:ed:bc (try 1/3)
Sep 23 16:22:50 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: authenticating -> associating
Sep 23 16:22:50 JS kernel: [  442.762685] wlan0: RX AssocResp from c8:0e:14:ce:ed:bc (capab=0x431 status=0 aid=3)
Sep 23 16:22:50 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011003
Sep 23 16:15:36 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 23 16:22:50 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011003
Sep 23 16:22:50 JS wpa_supplicant[1220]: wlan0: Associated with c8:0e:14:ce:ed:bc
Sep 23 16:22:50 JS kernel: [  442.766965] wlan0: associated
Sep 23 16:22:50 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
Sep 23 16:22:50 JS wpa_supplicant[1220]: wlan0: WPA: Key negotiation completed with c8:0e:14:ce:ed:bc [PTK=CCMP GTK=CCMP]
Sep 23 16:22:50 JS wpa_supplicant[1220]: wlan0: CTRL-EVENT-CONNECTED - Connection to c8:0e:14:ce:ed:bc completed [id=0 id_str=]
Sep 23 16:22:50 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 23 16:22:50 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 23 16:22:50 JS vmnetBridge: Adding interface wlan0 index:3
Sep 23 16:22:50 JS vmnetBridge: Started bridge wlan0 to virtual network 0.
Sep 23 16:22:50 JS kernel: [  442.785880] bridge-wlan0: device is wireless, enabling SMAC
Sep 23 16:22:50 JS kernel: [  442.785882] bridge-wlan0: up
Sep 23 16:22:50 JS kernel: [  442.785883] bridge-wlan0: attached
Sep 23 16:22:50 JS NetworkManager[820]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Sep 23 16:22:50 JS NetworkManager[820]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'FB-JS-MB'.
Sep 23 16:22:50 JS NetworkManager[820]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Sep 23 16:22:50 JS NetworkManager[820]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Sep 23 16:22:50 JS NetworkManager[820]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Sep 23 16:22:50 JS NetworkManager[820]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Sep 23 16:22:50 JS NetworkManager[820]: <info> dhclient started with pid 2571
Sep 23 16:22:50 JS NetworkManager[820]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Sep 23 16:22:50 JS dhclient: Internet Systems Consortium DHCP Client 4.2.4
Sep 23 16:22:50 JS dhclient: Copyright 2004-2012 Internet Systems Consortium.
Sep 23 16:22:50 JS dhclient: All rights reserved.
Sep 23 16:22:50 JS dhclient: For info, please visit https://www.isc.org/software/dhcp/
Sep 23 16:22:50 JS dhclient: 
Sep 23 16:22:50 JS NetworkManager[820]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
Sep 23 16:22:50 JS dhclient: Listening on LPF/wlan0/24:05:0f:34:4a:75
Sep 23 16:22:50 JS dhclient: Sending on   LPF/wlan0/24:05:0f:34:4a:75
Sep 23 16:22:50 JS dhclient: Sending on   Socket/fallback
Sep 23 16:22:50 JS dhclient: DHCPREQUEST of 192.168.178.38 on wlan0 to 255.255.255.255 port 67 (xid=0x1e083334)
Sep 23 16:22:53 JS dhclient: DHCPREQUEST of 192.168.178.38 on wlan0 to 255.255.255.255 port 67 (xid=0x1e083334)
Sep 23 16:22:53 JS dhclient: DHCPACK of 192.168.178.38 from 192.168.178.1
Sep 23 16:22:53 JS dhclient: bound to 192.168.178.38 -- renewal in 341204 seconds.
Sep 23 16:22:53 JS NetworkManager[820]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
Sep 23 16:22:53 JS NetworkManager[820]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Sep 23 16:22:53 JS NetworkManager[820]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Sep 23 16:22:53 JS avahi-daemon[793]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.38.
Sep 23 16:22:53 JS avahi-daemon[793]: New relevant interface wlan0.IPv4 for mDNS.
Sep 23 16:22:53 JS avahi-daemon[793]: Registering new address record for 192.168.178.38 on wlan0.IPv4.
Sep 23 16:22:54 JS NetworkManager[820]: <info> (wlan0): device state change: ip-config -> secondaries (reason 'none') [70 90 0]
Sep 23 16:22:54 JS NetworkManager[820]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Sep 23 16:22:54 JS NetworkManager[820]: <info> (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0]
Sep 23 16:22:54 JS NetworkManager[820]: <info> Policy set 'FB-JS-MB' (wlan0) as default for IPv4 routing and DNS.
Sep 23 16:22:54 JS NetworkManager[820]: <warn> dnsmasq not available on the bus, can't update servers.
Sep 23 16:22:54 JS NetworkManager[820]: <error> [1443018174.433596] [nm-dns-dnsmasq.c:396] update(): dnsmasq owner not found on bus: Could not get owner of name 'org.freedesktop.NetworkManager.dnsmasq': no such name
Sep 23 16:22:54 JS NetworkManager[820]: <warn> DNS: plugin dnsmasq update failed
Sep 23 16:22:54 JS dnsmasq[2574]: Übersetzungsoptionen: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth
Sep 23 16:22:54 JS dnsmasq[2574]: Warnung: keine vorgelagerten (Upstream) Server konfiguriert
Sep 23 16:22:54 JS NetworkManager[820]: <info> Activation (wlan0) successful, device activated.
Sep 23 16:22:54 JS NetworkManager[820]: <warn> dnsmasq appeared on DBus: :1.81
Sep 23 16:26:25 JS wpa_supplicant[1220]: wlan0: WPA: Group rekeying completed with c8:0e:14:ce:ed:bc [GTK=CCMP]

sudo wpa_cli scan_results

Selected interface 'wlan0'
bssid / frequency / signal level / flags / ssid
00:00:00:00:00:00	2447	-74	[WPA2-PSK-CCMP][ESS]	FB-JS-MB
c8:0e:14:ce:ed:bc	2447	-74	[WPA2-PSK-CCMP][ESS]	FB-JS-MB

Kaltstart 1:
Selected interface 'wlan0'
bssid / frequency / signal level / flags / ssid
c8:0e:14:ce:ed:bc	2447	-64	[WPA2-PSK-CCMP][ESS]	FB-JS-MB

Kaltstart 2:
Selected interface 'wlan0'
bssid / frequency / signal level / flags / ssid
c8:0e:14:ce:ed:bc	2447	-60	[WPA2-PSK-CCMP][ESS]	FB-JS-MB

Mortifikator

(Themenstarter)

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Heute trat das Problem leider wieder auf, und ich habe alles entsprechend protokolliert (s.u.). Die Verbindung erfolgte erst nach einer Wartezeit von mehreren Minuten und mehreren automatischen Versuchen - allerdings ohne Resets und Kaltstarts. Ich schloß dann noch mal die alte Fritzbox an, dort lief wieder alles beim ersten Versuch glatt. ☹

Selected interface 'wlan0'
bssid / frequency / signal level / flags / ssid
34:31:c4:85:6a:19	2462	-48	[WPA-PSK-TKIP][WPA2-PSK-CCMP][WPS][ESS]	FRITZ!Box 7312
d4:21:22:d6:ba:13	2437	-82	[WPA2-PSK-CCMP][WPS][ESS]	WLAN-633436
5c:35:3b:c2:e3:93	2412	-82	[WPA-PSK-CCMP+TKIP][WPA2-PSK-CCMP+TKIP][WPS][ESS]	MaReG
d4:21:22:d6:ba:14	2437	-84	[ESS]	Telekom_FON
04:35:3b:c2:e3:95	2412	-86	[ESS]	Vodafone Hotspot
00:00:00:00:00:00	2447	-58	[WPA2-PSK-CCMP][ESS]	FB-JS-MB
c8:0e:14:ce:ed:bc	2447	-64	[WPA2-PSK-CCMP][ESS]	FB-JS-MB
wpa_cli v2.1
Copyright (c) 2004-2014, Jouni Malinen <j@w1.fi> and contributors
This software may be distributed under the terms of the BSD license.
See README for more details.
Selected interface 'wlan0'
Interactive mode
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>Reject scan trigger since one is already pending
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>Reject scan trigger since one is already pending
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>CTRL-EVENT-SCAN-STARTED 
<3>CTRL-EVENT-SCAN-RESULTS 
<3>WPS-AP-AVAILABLE 
<3>SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>Trying to associate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
<3>Associated with c8:0e:14:ce:ed:bc
<3>WPA: Key negotiation completed with c8:0e:14:ce:ed:bc [PTK=CCMP GTK=CCMP]
<3>CTRL-EVENT-CONNECTED - Connection to c8:0e:14:ce:ed:bc completed [id=0 id_str=]
>
Sep 24 09:29:58 JS kernel: [    8.589894] bridge-wlan0: up
Sep 24 09:29:58 JS kernel: [    8.589896] bridge-wlan0: attached
Sep 24 09:29:58 JS kernel: [    8.590623] wlan0: deauthenticating from c8:0e:14:ce:ed:bc by local choice (Reason: 2=PREV_AUTH_NOT_VALID)
Sep 24 09:29:58 JS kernel: [    8.628285] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:29:58 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-DISCONNECTED bssid=c8:0e:14:ce:ed:bc reason=2 locally_generated=1
Sep 24 09:29:58 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 24 09:29:58 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 24 09:29:58 JS vmnetBridge: Removing interface wlan0 index:3
Sep 24 09:29:58 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: 4-way handshake -> authenticating
Sep 24 09:29:58 JS NetworkManager[865]: <warn> Connection disconnected (reason -2)
Sep 24 09:29:58 JS kernel: [    8.652749] wlan0: send auth to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:29:58 JS kernel: [    8.652934] bridge-wlan0: disabling the bridge
Sep 24 09:29:58 JS vmnetBridge: Stopped bridge wlan0 to virtual network 0.
Sep 24 09:29:58 JS kernel: [    8.659851] bridge-wlan0: down
Sep 24 09:29:58 JS kernel: [    8.659864] bridge-wlan0: detached
Sep 24 09:29:58 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:29:59 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 24 09:30:00 JS avahi-daemon[816]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::2605:fff:fe34:4a75.
Sep 24 09:30:00 JS avahi-daemon[816]: New relevant interface wlan0.IPv6 for mDNS.
Sep 24 09:30:00 JS avahi-daemon[816]: Registering new address record for fe80::2605:fff:fe34:4a75 on wlan0.*.
Sep 24 09:30:01 JS kernel: [   11.797069] wlan0: send auth to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:30:01 JS kernel: [   11.901032] wlan0: send auth to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:30:02 JS kernel: [   12.004945] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:30:02 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:30:02 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:30:13 JS NetworkManager[865]: <warn> error requesting auth for org.freedesktop.NetworkManager.wifi.share.open: (3) GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: Could not get UID of name ':1.26': no such name
Sep 24 09:30:13 JS gnome-session[1942]: WARNING: Could not parse desktop file gnome-screensaver.desktop or it references a not found TryExec binary
Sep 24 09:30:16 JS kernel: [   26.073702] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 09:30:16 JS kernel: [   26.074530] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 09:30:16 JS kernel: [   26.076177] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 09:30:16 JS kernel: [   26.076810] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 09:30:21 JS NetworkManager[865]: <warn> Activation (wlan0/wireless): association took too long.
Sep 24 09:30:21 JS NetworkManager[865]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 09:30:21 JS NetworkManager[865]: <warn> Activation (wlan0/wireless): asking for new secrets
Sep 24 09:30:21 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:30:21 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:30:21 JS NetworkManager[865]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:30:21 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 09:30:21 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:30:21 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:30:21 JS kernel: [   31.224762] systemd-hostnamed[2288]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!
Sep 24 09:30:18 JS wpa_supplicant[1265]: message repeated 3 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 24 09:30:21 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:30:21 JS kernel: [   31.691270] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:30:21 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 09:30:21 JS kernel: [   31.723693] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:30:22 JS kernel: [   31.924033] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:30:22 JS kernel: [   32.127869] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:30:22 JS kernel: [   32.331674] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:30:22 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:30:23 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:30:23 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:30:23 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:30:23 JS kernel: [   33.385617] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:30:23 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 09:30:23 JS kernel: [   33.406239] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:30:23 JS kernel: [   33.606595] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:30:23 JS kernel: [   33.810420] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:30:24 JS kernel: [   34.014250] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:30:24 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 09:30:24 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:30:34 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:30:34 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:30:34 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 09:30:39 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:30:42 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:30:42 JS kernel: [   52.098067] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:30:42 JS kernel: [   52.130417] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:30:42 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 09:30:42 JS kernel: [   52.330688] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:30:42 JS kernel: [   52.534522] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:30:42 JS kernel: [   52.738339] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:30:42 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
Sep 24 09:30:42 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:30:46 JS NetworkManager[865]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 09:30:46 JS NetworkManager[865]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 09:30:46 JS NetworkManager[865]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 09:30:46 JS NetworkManager[865]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 09:30:46 JS NetworkManager[865]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 09:30:46 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 09:30:49 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:30:49 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:30:49 JS kernel: [   58.992197] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:30:49 JS kernel: [   59.024504] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> authenticating
Sep 24 09:30:49 JS kernel: [   59.224829] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:30:49 JS kernel: [   59.428659] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:30:49 JS kernel: [   59.632485] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:30:49 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 09:30:49 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:30:59 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:30:59 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:30:59 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 09:31:04 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:31:07 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:31:07 JS kernel: [   77.722969] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:31:07 JS kernel: [   77.757004] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:31:07 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 09:31:08 JS kernel: [   77.956953] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:31:08 JS kernel: [   78.160757] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:31:08 JS kernel: [   78.364567] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:31:08 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
Sep 24 09:31:08 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:31:14 JS NetworkManager[865]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 09:31:14 JS NetworkManager[865]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 09:31:14 JS NetworkManager[865]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 09:31:14 JS NetworkManager[865]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 09:31:14 JS NetworkManager[865]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 09:31:14 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 09:31:17 JS NetworkManager[865]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:31:17 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 09:31:17 JS NetworkManager[865]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:31:17 JS NetworkManager[865]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:31:17 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 09:31:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:31:18 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:31:23 JS wpa_supplicant[1265]: message repeated 2 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 24 09:31:26 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:31:26 JS kernel: [   96.005042] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:31:26 JS kernel: [   96.037113] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:31:26 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 09:31:26 JS kernel: [   96.237394] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:31:26 JS kernel: [   96.441255] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:31:26 JS kernel: [   96.645069] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:31:26 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 09:31:26 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:31:36 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:31:36 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:31:36 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 09:31:41 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:31:42 JS NetworkManager[865]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 09:31:42 JS NetworkManager[865]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 09:31:42 JS NetworkManager[865]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 09:31:42 JS NetworkManager[865]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 09:31:42 JS NetworkManager[865]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 09:31:42 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:31:42 JS wpa_supplicant[1265]: wlan0: Reject scan trigger since one is already pending
Sep 24 09:31:42 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:31:44 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> inactive
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 09:31:45 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:31:45 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:31:45 JS kernel: [  114.914480] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: inactive -> authenticating
Sep 24 09:31:45 JS kernel: [  114.937167] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:31:45 JS kernel: [  115.137332] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 09:31:45 JS kernel: [  115.341134] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 09:31:45 JS kernel: [  115.545002] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 09:31:45 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 09:31:45 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 09:31:55 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:31:55 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 09:31:55 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 09:32:00 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:32:10 JS NetworkManager[865]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 09:32:10 JS NetworkManager[865]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 09:32:10 JS NetworkManager[865]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 09:32:10 JS NetworkManager[865]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 09:32:10 JS NetworkManager[865]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 09:32:10 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:32:08 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:32:10 JS wpa_supplicant[1265]: wlan0: Reject scan trigger since one is already pending
Sep 24 09:32:10 JS NetworkManager[865]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 09:32:11 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> inactive
Sep 24 09:32:13 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 09:37:10 JS NetworkManager[865]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:37:10 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 09:37:10 JS NetworkManager[865]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 09:37:10 JS NetworkManager[865]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 09:37:10 JS NetworkManager[865]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 09:37:10 JS NetworkManager[865]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 09:37:10 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: inactive -> scanning
Sep 24 09:37:10 JS wpa_supplicant[1265]: message repeated 7 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 24 09:37:13 JS wpa_supplicant[1265]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:37:13 JS kernel: [  442.730177] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 09:37:13 JS kernel: [  442.762683] wlan0: send auth to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:37:13 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 09:37:13 JS kernel: [  442.766947] wlan0: authenticated
Sep 24 09:37:13 JS wpa_supplicant[1265]: wlan0: Trying to associate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 09:37:13 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: authenticating -> associating
Sep 24 09:37:13 JS kernel: [  442.771022] wlan0: associate with c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 09:37:13 JS kernel: [  442.791286] wlan0: RX AssocResp from c8:0e:14:ce:ed:bc (capab=0x431 status=0 aid=2)
Sep 24 09:29:59 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 24 09:37:13 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011003
Sep 24 09:37:13 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011003
Sep 24 09:37:13 JS wpa_supplicant[1265]: wlan0: Associated with c8:0e:14:ce:ed:bc
Sep 24 09:37:13 JS kernel: [  442.795663] wlan0: associated
Sep 24 09:37:13 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
Sep 24 09:37:13 JS wpa_supplicant[1265]: wlan0: WPA: Key negotiation completed with c8:0e:14:ce:ed:bc [PTK=CCMP GTK=CCMP]
Sep 24 09:37:13 JS wpa_supplicant[1265]: wlan0: CTRL-EVENT-CONNECTED - Connection to c8:0e:14:ce:ed:bc completed [id=0 id_str=]
Sep 24 09:37:13 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 24 09:37:13 JS vmnetBridge: Adding interface wlan0 index:3
Sep 24 09:37:13 JS vmnetBridge: Started bridge wlan0 to virtual network 0.
Sep 24 09:37:13 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 24 09:37:13 JS kernel: [  442.813285] bridge-wlan0: device is wireless, enabling SMAC
Sep 24 09:37:13 JS kernel: [  442.813286] bridge-wlan0: up
Sep 24 09:37:13 JS kernel: [  442.813288] bridge-wlan0: attached
Sep 24 09:37:13 JS NetworkManager[865]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Sep 24 09:37:13 JS NetworkManager[865]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'FB-JS-MB'.
Sep 24 09:37:13 JS NetworkManager[865]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Sep 24 09:37:13 JS NetworkManager[865]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Sep 24 09:37:13 JS NetworkManager[865]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Sep 24 09:37:13 JS NetworkManager[865]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Sep 24 09:37:13 JS NetworkManager[865]: <info> dhclient started with pid 2516
Sep 24 09:37:13 JS NetworkManager[865]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Sep 24 09:37:13 JS dhclient: Internet Systems Consortium DHCP Client 4.2.4
Sep 24 09:37:13 JS dhclient: Copyright 2004-2012 Internet Systems Consortium.
Sep 24 09:37:13 JS dhclient: All rights reserved.
Sep 24 09:37:13 JS dhclient: For info, please visit https://www.isc.org/software/dhcp/
Sep 24 09:37:13 JS dhclient: 
Sep 24 09:37:13 JS NetworkManager[865]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
Sep 24 09:37:13 JS dhclient: Listening on LPF/wlan0/24:05:0f:34:4a:75
Sep 24 09:37:13 JS dhclient: Sending on   LPF/wlan0/24:05:0f:34:4a:75
Sep 24 09:37:13 JS dhclient: Sending on   Socket/fallback
Sep 24 09:37:13 JS dhclient: DHCPREQUEST of 192.168.178.38 on wlan0 to 255.255.255.255 port 67 (xid=0x126680d1)
Sep 24 09:37:16 JS dhclient: DHCPREQUEST of 192.168.178.38 on wlan0 to 255.255.255.255 port 67 (xid=0x126680d1)
Sep 24 09:37:16 JS dhclient: DHCPACK of 192.168.178.38 from 192.168.178.1
Sep 24 09:37:16 JS dhclient: bound to 192.168.178.38 -- renewal in 378183 seconds.
Sep 24 09:37:16 JS NetworkManager[865]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
Sep 24 09:37:16 JS NetworkManager[865]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Sep 24 09:37:16 JS NetworkManager[865]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Sep 24 09:37:16 JS avahi-daemon[816]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.38.
Sep 24 09:37:16 JS avahi-daemon[816]: New relevant interface wlan0.IPv4 for mDNS.
Sep 24 09:37:16 JS avahi-daemon[816]: Registering new address record for 192.168.178.38 on wlan0.IPv4.
Sep 24 09:37:17 JS NetworkManager[865]: <info> (wlan0): device state change: ip-config -> secondaries (reason 'none') [70 90 0]
Sep 24 09:37:17 JS NetworkManager[865]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Sep 24 09:37:17 JS NetworkManager[865]: <info> (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0]
Sep 24 09:37:17 JS NetworkManager[865]: <info> Policy set 'FB-JS-MB' (wlan0) as default for IPv4 routing and DNS.
Sep 24 09:37:17 JS NetworkManager[865]: <warn> dnsmasq not available on the bus, can't update servers.
Sep 24 09:37:17 JS NetworkManager[865]: <error> [1443080237.511971] [nm-dns-dnsmasq.c:396] update(): dnsmasq owner not found on bus: Could not get owner of name 'org.freedesktop.NetworkManager.dnsmasq': no such name
Sep 24 09:37:17 JS NetworkManager[865]: <warn> DNS: plugin dnsmasq update failed
Sep 24 09:37:17 JS dnsmasq[2519]: Übersetzungsoptionen: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth
Sep 24 09:37:17 JS dnsmasq[2519]: Warnung: keine vorgelagerten (Upstream) Server konfiguriert
Sep 24 09:37:27 JS NetworkManager[865]: <info> Activation (wlan0) successful, device activated.
Sep 24 09:37:27 JS NetworkManager[865]: <warn> dnsmasq appeared on DBus: :1.81

mrkramps Team-Icon

Avatar von mrkramps

Anmeldungsdatum:
10. Oktober 2006

Beiträge: 5523

Wohnort: south central EL

Hast du mal das 5-GHz-WLAN deaktiviert?

Mortifikator

(Themenstarter)

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Ja, von Anfang an. 5 GHz können hier im Haus bisher nur die AVM-WLAN-Sticks empfangen, außerdem ist die Signalstärke deutlich schlechter als bei 2,4.

PS: Zumindest konnte ich das Problem des etwas schwächeren Signals der 7490 gegenüber der 7170 augenscheinlich beheben, indem ich extrem viel Feinjustierung beim Routerstandplatz vornahm. Bisher scheinen mir die Signalstärken nun gleichauf zu sein; mal schauen, ob das so bleibt.

Mortifikator

(Themenstarter)

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Neuer Versuch mit gleichem Ergebnis. Die Verbindung kommt bei den ersten Versuchen (1. Scan) nicht zustande, dann gibt es eine Einwahlpause, danach funktioniert es (vermutlich beim 2. Scan). Insgesamt liegen ca. 6-8 Minuten zwischen Kaltstart und Verbindungsaufbau.

Selected interface 'wlan0'
bssid / frequency / signal level / flags / ssid
34:31:c4:85:6a:19	2412	-48	[WPA-PSK-TKIP][WPA2-PSK-CCMP][WPS][ESS]	FRITZ!Box 7312
d4:21:22:d6:ba:13	2437	-76	[WPA2-PSK-CCMP][WPS][ESS]	WLAN-633436
d4:21:22:d6:ba:14	2437	-78	[ESS]	Telekom_FON
00:00:00:00:00:00	2447	-58	[WPA2-PSK-CCMP][ESS]	FB-JS-MB
c8:0e:14:ce:ed:bc	2447	-62	[WPA2-PSK-CCMP][ESS]	FB-JS-MB
04:35:3b:c2:e3:95	2412	-84	[ESS]	Vodafone Hotspot
5c:35:3b:c2:e3:93	2412	-82	[WPA-PSK-CCMP+TKIP][WPA2-PSK-CCMP+TKIP][WPS][ESS]	MaReG
.Error:org.freedesktop.DBus.Error.NameHasNoOwner: Could not get UID of name ':1.20': no such name
Sep 24 13:49:31 JS NetworkManager[835]: <warn> error requesting auth for org.freedesktop.NetworkManager.wifi.share.open: (3) GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: Could not get UID of name ':1.20': no such name
Sep 24 13:49:31 JS gnome-session[1916]: WARNING: Could not parse desktop file gnome-screensaver.desktop or it references a not found TryExec binary
Sep 24 13:49:33 JS kernel: [   30.234872] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 13:49:33 JS kernel: [   30.235327] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 13:49:33 JS kernel: [   30.236338] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 13:49:33 JS kernel: [   30.237264] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
Sep 24 13:49:34 JS NetworkManager[835]: <warn> Activation (wlan0/wireless): association took too long.
Sep 24 13:49:34 JS NetworkManager[835]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 13:49:34 JS NetworkManager[835]: <warn> Activation (wlan0/wireless): asking for new secrets
Sep 24 13:49:34 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:49:34 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:49:34 JS NetworkManager[835]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:49:34 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 13:49:34 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:49:34 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:49:33 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:49:36 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:49:36 JS kernel: [   33.514207] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:49:36 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 13:49:36 JS kernel: [   33.546467] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:49:36 JS kernel: [   33.746989] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 13:49:37 JS kernel: [   33.950638] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 13:49:37 JS kernel: [   34.154465] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 13:49:37 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 13:49:37 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 13:49:47 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:49:47 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 13:49:47 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 13:49:52 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:49:55 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:49:55 JS kernel: [   52.238084] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:49:55 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 13:49:55 JS kernel: [   52.270538] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:49:55 JS kernel: [   52.470895] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 13:49:55 JS kernel: [   52.674722] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 13:49:56 JS kernel: [   52.878563] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 13:49:56 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
Sep 24 13:49:56 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 13:49:59 JS NetworkManager[835]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 13:49:59 JS NetworkManager[835]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 13:49:59 JS NetworkManager[835]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 13:49:59 JS NetworkManager[835]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 13:49:59 JS NetworkManager[835]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 13:49:59 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 13:50:02 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:50:02 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:50:02 JS kernel: [   58.992593] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: disconnected -> authenticating
Sep 24 13:50:02 JS kernel: [   59.024808] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:50:02 JS kernel: [   59.225166] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 13:50:02 JS kernel: [   59.428992] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 13:50:02 JS kernel: [   59.632812] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 13:50:02 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 13:50:02 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 13:50:12 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:50:12 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 13:50:12 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 13:50:17 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:50:20 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:50:20 JS kernel: [   77.744535] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:50:20 JS kernel: [   77.776928] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:50:20 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 13:50:21 JS kernel: [   77.977222] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 13:50:21 JS kernel: [   78.181085] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 13:50:21 JS kernel: [   78.384891] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 13:50:21 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=2 duration=20
Sep 24 13:50:21 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 13:50:27 JS NetworkManager[835]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 13:50:27 JS NetworkManager[835]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 13:50:27 JS NetworkManager[835]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 13:50:27 JS NetworkManager[835]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 13:50:27 JS NetworkManager[835]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 13:50:27 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 13:50:30 JS NetworkManager[835]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:50:30 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 13:50:30 JS NetworkManager[835]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:50:30 JS NetworkManager[835]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:50:30 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 13:50:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:50:31 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 13:50:36 JS wpa_supplicant[1261]: message repeated 2 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 24 13:50:39 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:50:39 JS kernel: [   96.013089] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:50:39 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 13:50:39 JS kernel: [   96.045294] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:50:39 JS kernel: [   96.245695] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 13:50:39 JS kernel: [   96.449567] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 13:50:39 JS kernel: [   96.653384] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 13:50:39 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 13:50:39 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 13:50:49 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:50:49 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 13:50:49 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 13:50:54 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:50:55 JS NetworkManager[835]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 13:50:55 JS NetworkManager[835]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 13:50:55 JS NetworkManager[835]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 13:50:55 JS NetworkManager[835]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 13:50:55 JS NetworkManager[835]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 13:50:55 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:50:55 JS wpa_supplicant[1261]: wlan0: Reject scan trigger since one is already pending
Sep 24 13:50:55 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:50:57 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> inactive
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 13:50:58 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:50:58 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:50:58 JS kernel: [  114.927847] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:50:58 JS kernel: [  114.949559] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: inactive -> authenticating
Sep 24 13:50:58 JS kernel: [  115.149625] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 2/3)
Sep 24 13:50:58 JS kernel: [  115.353450] wlan0: direct probe to c8:0e:14:ce:ed:bc (try 3/3)
Sep 24 13:50:58 JS kernel: [  115.557302] wlan0: authentication with c8:0e:14:ce:ed:bc timed out
Sep 24 13:50:58 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="FB-JS-MB" auth_failures=1 duration=10
Sep 24 13:50:58 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> disconnected
Sep 24 13:51:08 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:51:08 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: disconnected -> scanning
Sep 24 13:51:08 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="FB-JS-MB"
Sep 24 13:51:13 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:51:23 JS NetworkManager[835]: <warn> Activation (wlan0/wireless): association took too long, failing activation.
Sep 24 13:51:23 JS NetworkManager[835]: <info> (wlan0): device state change: config -> failed (reason 'SSID not found') [50 120 53]
Sep 24 13:51:23 JS NetworkManager[835]: <warn> Activation (wlan0) failed for connection 'FB-JS-MB'
Sep 24 13:51:23 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:51:23 JS NetworkManager[835]: <info> (wlan0): device state change: failed -> disconnected (reason 'none') [120 30 0]
Sep 24 13:51:23 JS NetworkManager[835]: <info> (wlan0): deactivating device (reason 'none') [0]
Sep 24 13:51:21 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:51:23 JS wpa_supplicant[1261]: wlan0: Reject scan trigger since one is already pending
Sep 24 13:51:23 JS NetworkManager[835]: <warn> Couldn't disconnect supplicant interface: This interface is not connected.
Sep 24 13:51:24 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> inactive
Sep 24 13:51:26 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-SCAN-STARTED 
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) starting connection 'FB-JS-MB'
Sep 24 13:56:23 JS NetworkManager[835]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:56:23 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0/wireless): access point 'FB-JS-MB' has security, but secrets are required.
Sep 24 13:56:23 JS NetworkManager[835]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Sep 24 13:56:23 JS NetworkManager[835]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Sep 24 13:56:23 JS NetworkManager[835]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0/wireless): connection 'FB-JS-MB' has security, and secrets exist.  No new secrets needed.
Sep 24 13:56:23 JS NetworkManager[835]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Sep 24 13:56:23 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: inactive -> scanning
Sep 24 13:56:23 JS wpa_supplicant[1261]: message repeated 7 times: [ wlan0: CTRL-EVENT-SCAN-STARTED ]
Sep 24 13:56:26 JS wpa_supplicant[1261]: wlan0: SME: Trying to authenticate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:56:26 JS kernel: [  442.718982] wlan0: authenticate with c8:0e:14:ce:ed:bc
Sep 24 13:56:26 JS kernel: [  442.750835] wlan0: send auth to c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Sep 24 13:56:26 JS wpa_supplicant[1261]: wlan0: Trying to associate with c8:0e:14:ce:ed:bc (SSID='FB-JS-MB' freq=2447 MHz)
Sep 24 13:56:26 JS kernel: [  442.753934] wlan0: authenticated
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: authenticating -> associating
Sep 24 13:56:26 JS kernel: [  442.759167] wlan0: associate with c8:0e:14:ce:ed:bc (try 1/3)
Sep 24 13:56:26 JS kernel: [  442.779098] wlan0: RX AssocResp from c8:0e:14:ce:ed:bc (capab=0x431 status=0 aid=2)
Sep 24 13:56:26 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011003
Sep 24 13:49:12 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00001003
Sep 24 13:56:26 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011003
Sep 24 13:56:26 JS wpa_supplicant[1261]: wlan0: Associated with c8:0e:14:ce:ed:bc
Sep 24 13:56:26 JS kernel: [  442.783600] wlan0: associated
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
Sep 24 13:56:26 JS wpa_supplicant[1261]: wlan0: WPA: Key negotiation completed with c8:0e:14:ce:ed:bc [PTK=CCMP GTK=CCMP]
Sep 24 13:56:26 JS wpa_supplicant[1261]: wlan0: CTRL-EVENT-CONNECTED - Connection to c8:0e:14:ce:ed:bc completed [id=0 id_str=]
Sep 24 13:56:26 JS vmnet-natd: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 24 13:56:26 JS vmnetBridge: RTM_NEWLINK: name:wlan0 index:3 flags:0x00011043
Sep 24 13:56:26 JS vmnetBridge: Adding interface wlan0 index:3
Sep 24 13:56:26 JS vmnetBridge: Started bridge wlan0 to virtual network 0.
Sep 24 13:56:26 JS kernel: [  442.797949] bridge-wlan0: device is wireless, enabling SMAC
Sep 24 13:56:26 JS kernel: [  442.797950] bridge-wlan0: up
Sep 24 13:56:26 JS kernel: [  442.797952] bridge-wlan0: attached
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'FB-JS-MB'.
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Sep 24 13:56:26 JS NetworkManager[835]: <info> dhclient started with pid 2332
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Beginning IP6 addrconf.
Sep 24 13:56:26 JS avahi-daemon[600]: Withdrawing address record for fe80::2605:fff:fe34:4a75 on wlan0.
Sep 24 13:56:26 JS avahi-daemon[600]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::2605:fff:fe34:4a75.
Sep 24 13:56:26 JS avahi-daemon[600]: Interface wlan0.IPv6 no longer relevant for mDNS.
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Sep 24 13:56:26 JS dhclient: Internet Systems Consortium DHCP Client 4.2.4
Sep 24 13:56:26 JS dhclient: Copyright 2004-2012 Internet Systems Consortium.
Sep 24 13:56:26 JS dhclient: All rights reserved.
Sep 24 13:56:26 JS dhclient: For info, please visit https://www.isc.org/software/dhcp/
Sep 24 13:56:26 JS dhclient: 
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
Sep 24 13:56:26 JS dhclient: Listening on LPF/wlan0/24:05:0f:34:4a:75
Sep 24 13:56:26 JS dhclient: Sending on   LPF/wlan0/24:05:0f:34:4a:75
Sep 24 13:56:26 JS dhclient: Sending on   Socket/fallback
Sep 24 13:56:26 JS dhclient: DHCPREQUEST of 192.168.178.38 on wlan0 to 255.255.255.255 port 67 (xid=0x4a1845be)
Sep 24 13:56:26 JS dhclient: DHCPACK of 192.168.178.38 from 192.168.178.1
Sep 24 13:56:26 JS dhclient: bound to 192.168.178.38 -- renewal in 394018 seconds.
Sep 24 13:56:26 JS NetworkManager[835]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Sep 24 13:56:26 JS NetworkManager[835]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Sep 24 13:56:26 JS avahi-daemon[600]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.38.
Sep 24 13:56:26 JS avahi-daemon[600]: New relevant interface wlan0.IPv4 for mDNS.
Sep 24 13:56:26 JS avahi-daemon[600]: Registering new address record for 192.168.178.38 on wlan0.IPv4.
Sep 24 13:56:27 JS NetworkManager[835]: <info> (wlan0): device state change: ip-config -> secondaries (reason 'none') [70 90 0]
Sep 24 13:56:27 JS NetworkManager[835]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Sep 24 13:56:27 JS NetworkManager[835]: <info> (wlan0): device state change: secondaries -> activated (reason 'none') [90 100 0]
Sep 24 13:56:27 JS NetworkManager[835]: <info> Policy set 'FB-JS-MB' (wlan0) as default for IPv4 routing and DNS.
Sep 24 13:56:27 JS NetworkManager[835]: <warn> dnsmasq not available on the bus, can't update servers.
Sep 24 13:56:27 JS NetworkManager[835]: <error> [1443095787.323527] [nm-dns-dnsmasq.c:396] update(): dnsmasq owner not found on bus: Could not get owner of name 'org.freedesktop.NetworkManager.dnsmasq': no such name
Sep 24 13:56:27 JS NetworkManager[835]: <warn> DNS: plugin dnsmasq update failed
Sep 24 13:56:27 JS dnsmasq[2335]: Übersetzungsoptionen: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth
Sep 24 13:56:27 JS dnsmasq[2335]: Warnung: keine vorgelagerten (Upstream) Server konfiguriert
Sep 24 13:56:27 JS NetworkManager[835]: <info> Activation (wlan0) successful, device activated.
Sep 24 13:56:27 JS NetworkManager[835]: <warn> dnsmasq appeared on DBus: :1.80
Sep 24 13:56:27 JS avahi-daemon[600]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::2605:fff:fe34:4a75.
Sep 24 13:56:27 JS avahi-daemon[600]: New relevant interface wlan0.IPv6 for mDNS.
Sep 24 13:56:27 JS avahi-daemon[600]: Registering new address record for fe80::2605:fff:fe34:4a75 on wlan0.*.
Sep 24 13:56:28 JS avahi-daemon[600]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::2605:fff:fe34:4a75.
Sep 24 13:56:28 JS avahi-daemon[600]: Joining mDNS multicast group on interface wlan0.IPv6 with address fd00::e47f:7f4e:a579:bb8d.
Sep 24 13:56:28 JS avahi-daemon[600]: Registering new address record for fd00::e47f:7f4e:a579:bb8d on wlan0.*.
Sep 24 13:56:28 JS NetworkManager[835]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) starting DHCPv6 as requested by IPv6 router...
Sep 24 13:56:28 JS avahi-daemon[600]: Withdrawing address record for fe80::2605:fff:fe34:4a75 on wlan0.
Sep 24 13:56:28 JS NetworkManager[835]: <info> Activation (wlan0) Beginning DHCPv6 transaction (timeout in 45 seconds)
Sep 24 13:56:28 JS NetworkManager[835]: <info> dhclient started with pid 2481
Sep 24 13:56:28 JS dhclient: Internet Systems Consortium DHCP Client 4.2.4
Sep 24 13:56:28 JS dhclient: Copyright 2004-2012 Internet Systems Consortium.
Sep 24 13:56:28 JS dhclient: All rights reserved.
Sep 24 13:56:28 JS dhclient: For info, please visit https://www.isc.org/software/dhcp/
Sep 24 13:56:28 JS dhclient: 
Sep 24 13:56:28 JS dhclient: Bound to *:546
Sep 24 13:56:28 JS dhclient: Listening on Socket/wlan0
Sep 24 13:56:28 JS dhclient: Sending on   Socket/wlan0
Sep 24 13:56:29 JS dhclient: XMT: Info-Request on wlan0, interval 980ms.
Sep 24 13:56:29 JS dhclient: RCV: Reply message on wlan0 from fe80::ca0e:14ff:fece:edba.
Sep 24 13:56:29 JS NetworkManager[835]: <info> (wlan0): DHCPv6 state changed nbi -> renew6
Sep 24 13:56:29 JS NetworkManager[835]: <info> Activation (wlan0) Stage 5 of 5 (IPv6 Commit) scheduled...
Sep 24 13:56:29 JS NetworkManager[835]: <info> (wlan0): DHCPv6 client pid 2481 exited with status 0
Sep 24 13:56:29 JS NetworkManager[835]: <info> Activation (wlan0) Stage 5 of 5 (IPv6 Commit) started...
Sep 24 13:56:29 JS avahi-daemon[600]: Registering new address record for fd00::2605:fff:fe34:4a75 on wlan0.*.
Sep 24 13:56:30 JS NetworkManager[835]: <error> [1443095790.31955] [nm-system.c:1266] nm_system_replace_default_ip6_route(): (wlan0): failed to set IPv6 default route: -7
Sep 24 13:56:30 JS NetworkManager[835]: <info> Policy set 'FB-JS-MB' (wlan0) as default for IPv6 routing and DNS.
Sep 24 13:56:30 JS NetworkManager[835]: <info> Activation (wlan0) Stage 5 of 5 (IPv6 Commit) complete.
Sep 24 13:56:49 JS kernel: [  465.785152] systemd-hostnamed[2525]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!

lubux

Anmeldungsdatum:
21. November 2012

Beiträge: 14393

Mortifikator schrieb:

Neuer Versuch mit gleichem Ergebnis. Die Verbindung kommt bei den ersten Versuchen (1. Scan) nicht zustande, dann gibt es eine Einwahlpause, danach funktioniert es (vermutlich beim 2. Scan). Insgesamt liegen ca. 6-8 Minuten zwischen Kaltstart und Verbindungsaufbau.

Selected interface 'wlan0'
bssid / frequency / signal level / flags / ssid
00:00:00:00:00:00	2447	-58	[WPA2-PSK-CCMP][ESS]	FB-JS-MB
c8:0e:14:ce:ed:bc	2447	-62	[WPA2-PSK-CCMP][ESS]	FB-JS-MB

Beim 1. Scan (im noch nicht verbundenen Zustand) erkennt dein wpa_supplicant lediglich die BSSID 00:00:00:00:00:00 (MAC-Adresse der FritzBox) in Zusammenhang mit der SSID "FB-JS-MB", und so kann keine Verbindung zustande kommen. Dann wird der default Wert des timeouts (delay) für autoscan (evtl. 300 Sekunden und gefühlt die ca. 6 bis 8 Minuten bis fertig verbunden) abgewartet und dann erfolgt der 2. Scan (im nicht verbundenen Zustand), der dann erfolgreich ist weil die richtige BSSID c8:0e:14:ce:ed:bc erkannt wird.

Ich behaupte jetzt mal, dass es an der Art und Weise, wie hier der wpa_supplicant konfiguriert ist und aufgerufen wird (NM. dbus), verursacht ist.

EDIT:

# Automatic scan
# This is an optional set of parameters for automatic scanning
# within an interface in following format:
#autoscan=<autoscan module name>:<module parameters>
# autoscan is like bgscan but on disconnected or inactive state.
# For instance, on exponential module parameters would be <base>:<limit>
#autoscan=exponential:3:300
# Which means a delay between scans on a base exponential of 3,
# up to the limit of 300 seconds (3, 9, 27 ... 300)
# For periodic module, parameters would be <fixed interval>
#autoscan=periodic:30
# So a delay of 30 seconds will be applied between each scan

Lidux

Anmeldungsdatum:
18. April 2007

Beiträge: 16792

Hallo Mortifikator,

Du könntest auch mal testen die MAC Adresse der Fritzbox im Netzwerkmanager unter deinem Verbindungsprofil / BSSID einzutragen. Weiterhin IP6 komplett zu deaktivieren (Box, Netzwerkmanager und Betriebssystem)

Ist der Gastzugang der FritzBox aktiv, festen und nicht belegten Kanal hast du eingestellt und der N-Modus scheint auch aktiv zu sein ?

Gruss Lidux

Mortifikator

(Themenstarter)

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Moin!

"Du könntest auch mal testen die MAC Adresse der Fritzbox im Netzwerkmanager unter deinem Verbindungsprofil / BSSID einzutragen." Das trage ich immer ein. Leider kein Unterschied.

"Weiterhin IP6 komplett zu deaktivieren (Box, Netzwerkmanager und Betriebssystem)" Leider kein Unterschied mit beiden IPv oder nur mit IPv4.

"Ist der Gastzugang der FritzBox aktiv, festen und nicht belegten Kanal hast du eingestellt und der N-Modus scheint auch aktiv zu sein ?" Gastzugang ist deaktiviert, der Kanal ist fest und der beste, den ich hier kriegen kann, der N-Modus ist aktiv, den kann (und möchte) ich auch nicht ausschalten.

Lubux: "Ich behaupte jetzt mal, dass es an der Art und Weise, wie hier der wpa_supplicant konfiguriert ist und aufgerufen wird (NM. dbus), verursacht ist."

Das scheint mir momentan eine vielversprechende Lösung zu sein. Nur... wie konfiguriere ich den supplicant denn um oder gehe dieses Problem an?

lubux

Anmeldungsdatum:
21. November 2012

Beiträge: 14393

Mortifikator schrieb:

Nur... wie konfiguriere ich den supplicant denn um oder gehe dieses Problem an?

Du könntest versuchen den wpa_supplicant ohne NetworkManager zu nutzen, d. h. mit einer eigenen wpa_supplicant.conf-Datei und den wpa_supplicant aus der interfaces-Datei zu starten. Wenn das zum gleichen Fehler führt, dann die neuste Version des wpa_supplicant aus dem source code (ohne dbus, ohne roaming, mit autoscan) zu kompilieren.

Mortifikator

(Themenstarter)

Anmeldungsdatum:
23. September 2015

Beiträge: 31

Wie kann es denn überhaupt bei einem reinen Routerwechsel zu einem Problem mit dem wpa_supplicant gekommen sein? Eine wpa_supplicant.conf ist bei mir übrigens gar nicht vorhanden.

lubux

Anmeldungsdatum:
21. November 2012

Beiträge: 14393

Mortifikator schrieb:

Wie kann es denn überhaupt bei einem reinen Routerwechsel zu einem Problem mit dem wpa_supplicant gekommen sein?

Es gibt schon Unterschiede zwischen alter und neuer FritzBox. Da müsste man den Verbindungsaufbau bei alter und neuer FritZbox loggen und vergleichen.

Was ich festgestellt habe, ist, dass z. B. das rekeying bei der FB7170 einmal in der Stunde statt findet und bei der FB6360 alle 10 Minuten. Wenn der WLAN-Client der FB6360 nicht sofort auf das rekeying antwortet, dann wird dieser sofort abgemeldet. Die FB7170 ist das etwas toleranter.

Mortifikator schrieb:

Eine wpa_supplicant.conf ist bei mir übrigens gar nicht vorhanden.

Diese Datei (chmod 600) kannst Du z. B. mit:

sudo nano /etc/wpa_supplicant/wpa_supplicant.conf

erstellen und editieren/bearbeiten.

elektronenblitz63

Avatar von elektronenblitz63

Anmeldungsdatum:
16. Januar 2007

Beiträge: 29307

Wohnort: NRW

Hallo,

  • ändere den Funkkanal von Kanal 8 auf 12, der Abstand zum nächsten Netz auf Kanal 6 ist zu gering

  • nimm die BSSID mal aus dem Verbindungsprofil raus

  • auch der CSL Ralink-Stick unterstützt das 5GHz-Band, allerdings ist die Regionseinstellung wohl nicht korrekt

  • die 7490 unterstützt Dualband (2,4 + 5GHz gleichzeitig)

    • im 5GHz-Band ließe sich auch der N-Modus störungsfrei nutzen

  • um alle WLAN-Einstellungen der FB zu erreichen muss der sog. "Expertenmodus" aktiviert werden

    • möglicherweise gibt es da weitere Einstellungen zum Rekeying usw.

Prüfen:

iw reg get
  • wird der Rechner richtig ausgeschaltet oder nur in den Ruhemodus versetzt?

lubux

Anmeldungsdatum:
21. November 2012

Beiträge: 14393

Mortifikator schrieb:

Fritzbox 7170: Fester Kanal, 2,4 GHz, 802.11 g+n, WPA2 PSK, Sichtbare SSID, Keine IPTV-Optimierung oder sonstige Optimierung, Keine MAC-Beschränkung.

iwconfig
wlan0     IEEE 802.11abgn  ESSID:"*!!*Crenshaw_The_1_&_Only*!!*"  
          Mode:Managed  Frequency:2.447 GHz  Access Point: C8:0E:14:CE:ED:BC   
          Bit Rate=54 Mb/s   Tx-Power=20 dBm   
          Retry short limit:7   RTS thr:off   Fragment thr:off
          Power Management:off
          Link Quality=46/70  Signal level=-54 dBm  
          Rx invalid nwid:0  Rx invalid crypt:0  Rx invalid frag:0
          Tx excessive retries:0  Invalid misc:117   Missed beacon:0

Mortifikator schrieb:

Fritzbox 7490: Fester Kanal, 2,4 GHz, 802.11 g+n, WPA2 PSK, Sichtbare SSID, Keine IPTV-Optimierung oder sonstige Optimierung, Keine MAC-Beschränkung, IPv6 deaktiviert.

iwconfig
wlan0     IEEE 802.11abgn  ESSID:"*!!*Crenshaw_The_1_&_Only*!!*"  
          Mode:Managed  Frequency:2.447 GHz  Access Point: C8:0E:14:CE:ED:BC   
          Bit Rate=300 Mb/s   Tx-Power=20 dBm   
          Retry short limit:7   RTS thr:off   Fragment thr:off
          Power Management:off
          Link Quality=46/70  Signal level=-64 dBm  
          Rx invalid nwid:0  Rx invalid crypt:0  Rx invalid frag:0
          Tx excessive retries:0  Invalid misc:130   Missed beacon:0

BTW: Warum wird mit iwconfig, für die FB7170 die identische MAC-Adresse angezeigt wie bei der FB7490?

Antworten |