Re: Disconnections



Can you post the output of /var/log/syslog with the NM messages?
There have been some reports of disconnects due to scanning and I
wonder if this is the case here.

Sure:
debian:~# cat /var/log/syslog | grep NetworkManager

Apr 22 21:03:22 debian NetworkManager: <information>^Istarting...
Apr 22 21:03:22 debian NetworkManager: <information>^Iwlan0_rename:
Device is fully-supported using driver 'hostap_pci'.
Apr 22 21:03:22 debian NetworkManager:
<information>^Inm_device_init(): waiting for device's worker thread to
start
Apr 22 21:03:22 debian NetworkManager:
<information>^Inm_device_init(): device's worker thread started,
continuing.
Apr 22 21:03:22 debian NetworkManager: <information>^INow managing
wireless (802.11) device 'wlan0_rename'.
Apr 22 21:03:22 debian NetworkManager: <information>^IDeactivating
device wlan0_rename.
Apr 22 21:03:22 debian NetworkManager: <information>^Ieth1: Device is
fully-supported using driver 'e100'.
Apr 22 21:03:22 debian NetworkManager:
<information>^Inm_device_init(): waiting for device's worker thread to
start
Apr 22 21:03:22 debian NetworkManager:
<information>^Inm_device_init(): device's worker thread started,
continuing.
Apr 22 21:03:22 debian NetworkManager: <information>^INow managing
wired Ethernet (802.3) device 'eth1'.
Apr 22 21:03:22 debian NetworkManager: <information>^IDeactivating device eth1.
Apr 22 21:03:22 debian NetworkManager: <information>^IWill activate
wired connection 'eth1' because it now has a link.
Apr 22 21:03:22 debian NetworkManager: <information>^ISWITCH: no
current connection, found better connection 'eth1'.
Apr 22 21:03:22 debian NetworkManager: <information>^IWill activate
connection 'eth1'.
Apr 22 21:03:22 debian NetworkManager: <information>^IDevice eth1
activation scheduled...
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) started...
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 1 of 5 (Device Prepare) scheduled...
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 1 of 5 (Device Prepare) started...
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 2 of 5 (Device Configure) scheduled...
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 1 of 5 (Device Prepare) complete.
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 2 of 5 (Device Configure) starting...
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 2 of 5 (Device Configure) successful.
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 2 of 5 (Device Configure) complete.
Apr 22 21:03:22 debian NetworkManager: <information>^IActivation
(eth1) Stage 3 of 5 (IP Configure Start) started...
Apr 22 21:03:23 debian NetworkManager: <debug
info>^I[1177293803.303126] nm_hal_device_added (): New device added
(hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input').
Apr 22 21:03:23 debian NetworkManager: <information>^IActivation
(eth1) Beginning DHCP transaction.
Apr 22 21:03:23 debian NetworkManager: <information>^IActivation
(eth1) Stage 3 of 5 (IP Configure Start) complete.
Apr 22 21:03:23 debian NetworkManager: <information>^IDHCP daemon
state is now 12 (successfully started) for interface eth1
Apr 22 21:03:24 debian NetworkManager: <information>^IDHCP daemon
state is now 1 (starting) for interface eth1
Apr 22 21:03:25 debian NetworkManager: <information>^IDHCP daemon
state is now 4 (reboot) for interface eth1
Apr 22 21:03:25 debian NetworkManager: <information>^IActivation
(eth1) Stage 4 of 5 (IP Configure Get) scheduled...
Apr 22 21:03:25 debian NetworkManager: <information>^IOld device
'eth1' activating, won't change.
Apr 22 21:03:25 debian NetworkManager: <information>^IActivation
(eth1) Stage 4 of 5 (IP Configure Get) started...
Apr 22 21:03:25 debian NetworkManager: <information>^IRetrieved the
following IP4 configuration from the DHCP daemon:
Apr 22 21:03:25 debian NetworkManager: <information>^I  address 192.168.28.119
Apr 22 21:03:25 debian NetworkManager: <information>^I  netmask 255.255.255.0
Apr 22 21:03:25 debian NetworkManager: <information>^I  broadcast
192.168.28.255
Apr 22 21:03:25 debian NetworkManager: <information>^I  gateway 192.168.28.1
Apr 22 21:03:25 debian NetworkManager: <information>^I  nameserver 192.168.28.1
Apr 22 21:03:25 debian NetworkManager: <information>^IActivation
(eth1) Stage 5 of 5 (IP Configure Commit) scheduled...
Apr 22 21:03:25 debian NetworkManager: <information>^IActivation
(eth1) Stage 4 of 5 (IP Configure Get) complete.
Apr 22 21:03:25 debian NetworkManager: <information>^IActivation
(eth1) Stage 5 of 5 (IP Configure Commit) started...
Apr 22 21:03:25 debian NetworkManager: <debug
info>^I[1177293805.439722] nm_hal_device_added (): New device added
(hal udi is '/org/freedesktop/Hal/devices/platform_bluetooth').
Apr 22 21:03:26 debian NetworkManager: <information>^IClearing nscd
hosts cache.
Apr 22 21:03:26 debian NetworkManager: <WARNING>^I nm_spawn_process
(): nm_spawn_process('/usr/sbin/nscd -i hosts'): could not spawn
process. (Failed to execute child process "/usr/sbin/nscd" (No such
file or directory))
Apr 22 21:03:26 debian NetworkManager: <information>^IActivation
(eth1) successful, device activated.
Apr 22 21:03:26 debian NetworkManager: <information>^IActivation
(eth1) Finish handler scheduled.
Apr 22 21:03:26 debian NetworkManager: <information>^IActivation
(eth1) Stage 5 of 5 (IP Configure Commit) complete.
Apr 22 21:03:47 debian NetworkManager: <information>^IUpdating allowed
wireless network lists.
Apr 22 21:04:07 debian NetworkManager: <debug
info>^I[1177293847.821797] nm_device_802_11_wireless_get_activation_ap
(): Forcing AP 'strausshouse'
Apr 22 21:04:07 debian NetworkManager: <information>^IUser Switch:
/org/freedesktop/NetworkManager/Devices/wlan0_5f_rename / strausshouse
Apr 22 21:04:07 debian NetworkManager: <information>^IDeactivating
device wlan0_rename.
Apr 22 21:04:07 debian NetworkManager: <information>^IDevice
wlan0_rename activation scheduled...
Apr 22 21:04:07 debian NetworkManager: <information>^IDeactivating device eth1.
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) started...
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 1 of 5 (Device Prepare) scheduled...
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 1 of 5 (Device Prepare) started...
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 2 of 5 (Device Configure) scheduled...
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 1 of 5 (Device Prepare) complete.
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 2 of 5 (Device Configure) starting...
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename/wireless): access point 'strausshouse' is encrypted, but
NO valid key exists.  New key needed.
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) New wireless user key requested for network
'strausshouse'.
Apr 22 21:04:08 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 2 of 5 (Device Configure) complete.
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename) New wireless user key for network 'strausshouse'
received.
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 1 of 5 (Device Prepare) scheduled...
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 1 of 5 (Device Prepare) started...
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 2 of 5 (Device Configure) scheduled...
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 1 of 5 (Device Prepare) complete.
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 2 of 5 (Device Configure) starting...
Apr 22 21:04:12 debian NetworkManager: <information>^IActivation
(wlan0_rename/wireless): access point 'strausshouse' is encrypted, and
a key exists.  No new key needed.
Apr 22 21:04:12 debian NetworkManager: <information>^ISUP: sending
command 'INTERFACE_ADD
wlan0_rename^I^Iwext^I/var/run/wpa_supplicant^I'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'AP_SCAN 1'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'ADD_NETWORK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was '0'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'SET_NETWORK 0 ssid 73747261757373686f757365'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'SET_NETWORK 0 proto WPA2'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'SET_NETWORK 0 key_mgmt WPA-PSK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'SET_NETWORK 0 psk <key>'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: sending
command 'ENABLE_NETWORK 0'
Apr 22 21:04:13 debian NetworkManager: <information>^ISUP: response was 'OK'
Apr 22 21:04:13 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 2 of 5 (Device Configure) complete.
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Global control interface
'/var/run/wpa_supplicant-global'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX global ctrl_iface -
hexdump_ascii(len=57):
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      49 4e 54 45 52 46 41 43 45
5f 41 44 44 20 77 6c   INTERFACE_ADD wl
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      61 6e 30 5f 72 65 6e 61 6d
65 09 09 77 65 78 74   an0_rename__wext
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      09 2f 76 61 72 2f 72 75 6e
2f 77 70 61 5f 73 75   _/var/run/wpa_su
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      70 70 6c 69 63 61 6e 74 09
                    pplicant_
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE GLOBAL INTERFACE_ADD
'wlan0_rename^I^Iwext^I/var/run/wpa_supplicant^I'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Initializing interface
'wlan0_rename' conf 'N/A' driver 'wext' ctrl_interface
'/var/run/wpa_supplicant' bridge 'N/A'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Initializing interface (2)
'wlan0_rename'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: SUPP_PAE entering state
DISCONNECTED
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: KEY_RX entering state
NO_KEY_RECEIVE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: SUPP_BE entering state
INITIALIZE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAP: EAP entering state DISABLED
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
portEnabled=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
portValid=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): SIOCGIWRANGE: WE(compiled)=20
WE(source)=18 enc_capa=0xf
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   capabilities: key_mgmt 0xf enc
0xf
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WEXT: Operstate: linkmode=1,
operstate=5
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): ddress: 00:20:e0:89:8f:e2
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_wpa
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=0
key_idx=0 set_tx=0 seq_len=0 key_len=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=0
key_idx=1 set_tx=0 seq_len=0 key_len=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=0
key_idx=2 set_tx=0 seq_len=0 key_len=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=0
key_idx=3 set_tx=0 seq_len=0 key_len=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):
wpa_driver_wext_set_countermeasures
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):
wpa_driver_wext_set_drop_unencrypted
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Setting scan request: 0 sec
100000 usec
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Added interface wlan0_rename
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x11003 ([UP][LOWER_UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK, IFLA_IFNAME:
Interface 'wlan0_rename' added
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK, IFLA_IFNAME:
Interface 'wlan0_rename' added
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=9):
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      41 50 5f 53 43 41 4e 20 31
                    AP_SCAN 1
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=11):
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):  44 44 5f 4e 45 54 57 4f 52 4b
             ADD_NETWORK
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: ADD_NETWORK
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=43): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: SET_NETWORK id=0
name='ssid'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: value -
hexdump_ascii(len=24): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): ssid - hexdump_ascii(len=12):
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      73 74 72 61 75 73 73 68 6f
75 73 65               strausshouse
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=24): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: SET_NETWORK id=0
name='proto'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: value -
hexdump_ascii(len=4): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): proto: 0x2
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=30): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: SET_NETWORK id=0
name='key_mgmt'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: value -
hexdump_ascii(len=7): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): key_mgmt: 0x2
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=82): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: SET_NETWORK id=0
name='psk'
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: value -
hexdump_ascii(len=64): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): PSK - hexdump(len=32): [REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX ctrl_iface -
hexdump_ascii(len=16):
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):      45 4e 41 42 4c 45 5f 4e 45
54 57 4f 52 4b 20 30   ENABLE_NETWORK 0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE: ENABLE_NETWORK id=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Setting scan request: 0 sec 0
usec
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):  SCANNING
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Starting AP scan (broadcast SSID)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Trying to get current scan
results first without requesting a new scan to speed up initial
association
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Received 526 bytes of scan
results (3 BSSes)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Scan results: 3
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Selecting BSS from priority group
0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 0: 00:13:10:88:68:d4
ssid='strausshouse' wpa_ie_len=0 rsn_ie_len=0 caps=0x11
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):    skip - no WPA/RSN IE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 1: 00:12:17:f0:52:e9
ssid='snowboard' wpa_ie_len=0 rsn_ie_len=0 caps=0x11
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):    skip - no WPA/RSN IE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 2: 7e:6f:b9:df:34:f7
ssid='hpsetup' wpa_ie_len=0 rsn_ie_len=0 caps=0x2
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):    skip - no WPA/RSN IE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): No suitable AP found.
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Setting scan request: 0 sec 0
usec
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Starting AP scan (broadcast SSID)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE monitor attached -
hexdump(len=40): 2f 76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61
6e 61 67 65 72 2f 77 70 61 5f 63 74 72 6c 5f 32 38 38 35 2d 32 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Scan timeout - try to get results
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Received 979 bytes of scan
results (5 BSSes)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Scan results: 5
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Selecting BSS from priority group
0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): _len=26 caps=0x11
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):    selected based on RSN IE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Trying to associate with
00:13:10:88:68:d4 (SSID='strausshouse' freq=2452 MHz)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE monitor send -
hexdump(len=40): 2f 76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61
6e 61 67 65 72 2f 77 70 61 5f 63 74 72 6c 5f 32 38 38 35 2d 32 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Cancelling scan request
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: clearing own WPA/RSN IE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Automatic auth_alg selection: 0x1
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: using IEEE 802.11i/D9.0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Selected cipher suites:
group 8 pairwise 24 key_mgmt 2 proto 2
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: set AP WPA IE -
hexdump(len=30): dd 1c 00 50 f2 01 01 00 00 50 f2 02 02 00 00 50 f2 04
00 50 f2 02 01 00 00 50 f2 02 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: set AP RSN IE -
hexdump(len=26): 30 18 01 00 00 0f ac 02 02 00 00 0f ac 04 00 0f ac 02
01 00 00 0f ac 02 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: using GTK TKIP
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: using PTK CCMP
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: using KEY_MGMT WPA-PSK
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Set own WPA IE default -
hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f
ac 02 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): No keys have been configured -
skip key clearing
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):
wpa_driver_wext_set_drop_unencrypted
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: SCANNING -> ASSOCIATING
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): r_wext_set_operstate: operstate
0->0 (DORMANT)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WEXT: Operstate: linkmode=-1,
operstate=5
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_associate
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Setting authentication timeout:
10 sec 0 usec
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
EAP success=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
EAP fail=0
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
portControl=Auto
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: Ignored PMKID candidate
without preauth flag
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b04 len=12
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b1a len=21
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=0
ifi_flags=0x11003 ([UP][LOWER_UP])
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK, IFLA_IFNAME:
Interface 'wlan0_rename' added
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX EAPOL from 00:13:10:88:68:d4
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 0 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 16 dd 14 00 0f ac 04 39 36 07 11 47 91 3e cd 0b 85 a0 45
19 5f 7b 86
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Setting authentication timeout:
10 sec 0 usec
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): IEEE 802.1X RX: version=2 type=3
length=117
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   EAPOL-Key type=2
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_info 0x8a (ver=2 keyidx=0
rsvd=0 Pairwise Ack)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_length=16
key_data_length=22
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   replay_counter -
hexdump(len=8): 00 00 00 00 00 00 00 02
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_nonce - hexdump(len=32): 12
bc c1 4e e1 9a 89 04 99 30 b1 e1 63 49 31 b1 c2 d1 f4 85 3f b4 e0 70
29 09 40 1a fc 96 aa 95
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_iv - hexdump(len=16): 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_rsc - hexdump(len=8): 00 00
00 00 00 00 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_id (reserved) -
hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_mic - hexdump(len=16): 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 16 dd 14 00 0f ac 04 39 36 07
11 47 91 3e cd 0b 85 a0 45 19 5f 7b 86
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: ASSOCIATING ->
4WAY_HANDSHAKE
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RX message 1 of 4-Way
Handshake from 00:13:10:88:68:d4 (ver=2)
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: msg 1/4 key data -
hexdump(len=22): dd 14 00 0f ac 04 39 36 07 11 47 91 3e cd 0b 85 a0 45
19 5f 7b 86
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: PMKID from Authenticator -
hexdump(len=16): 39 36 07 11 47 91 3e cd 0b 85 a0 45 19 5f 7b 86
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: no matching PMKID found
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Renewed SNonce -
hexdump(len=32): 44 60 14 47 a5 40 85 44 de 1b 55 60 39 9b 4a f8 81 89
7e 64 17 51 f3 6a 91 f6 37 65 a6 75 96 62
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: PMK - hexdump(len=32):
[REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: PTK - hexdump(len=64):
[REMOVED]
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: WPA IE for msg 2/4 -
hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f
ac 02 00 00
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Sending EAPOL-Key 2/4
Apr 22 21:04:16 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Use BSSID
(00:13:10:88:68:d4) as the destination for EAPOL-Key
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 0 00 00 00 00 00 00 00 00 02 44
60 14 47 a5 40 85 44 de 1b 55 60 39 9b 4a f8 81 89 7e 64 17 51 f3 6a
91 f6 37 65 a6 75 96 62 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7e 71 ad fe 9e 3d
89 fe de ef 9f 0e 4c cb fc b2 00 16 30 14 01 00 00 0f ac 02 01 00 00
0f ac 04 01 00 00 0f ac 02 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX EAPOL from 00:13:10:88:68:d4
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX EAPOL - hexdump(len=121): 02
03 00 75 02 00 8a 00 10 00 00 00 00 00 00 00 03 12 bc c1 4e e1 9a 89
04 99 30 b1 e1 63 49 31 b1 c2 d1 f4 85 3f b4 e0 70 29 09 40 1a fc 96
aa 95 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 16 dd 14 00 0f ac 04 39 36 07 11 47 91 3e cd 0b 85 a0
45 19 5f 7b 86
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): IEEE 802.1X RX: version=2 type=3
length=117
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   EAPOL-Key type=2
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_info 0x8a (ver=2 keyidx=0
rsvd=0 Pairwise Ack)
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_length=16
key_data_length=22
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   replay_counter -
hexdump(len=8): 00 00 00 00 00 00 00 03
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):  89 04 99 30 b1 e1 63 49 31 b1 c2
d1 f4 85 3f b4 e0 70 29 09 40 1a fc 96 aa 95
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_iv - hexdump(len=16): 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_rsc - hexdump(len=8): 00 00
00 00 00 00 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_id (reserved) -
hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_mic - hexdump(len=16): 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RX EAPOL-Key -
hexdump(len=121): 02 03 00 75 02 00 8a 00 10 00 00 00 00 00 00 00 03
12 bc c1 4e e1 9a 89 04 99 30 b1 e1 63 49 31 b1 c2 d1 f4 85 3f b4 e0
70 29 09 40 1a fc 96 aa 95 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 16 dd 14 00 0f ac 04 39 36 07 11
47 91 3e cd 0b 85 a0 45 19 5f 7b 86
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: 4WAY_HANDSHAKE ->
4WAY_HANDSHAKE
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RX message 1 of 4-Way
Handshake from 00:13:10:88:68:d4 (ver=2)
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: msg 1/4 key data -
hexdump(len=22): dd 14 00 0f ac 04 39 36 07 11 47 91 3e cd 0b 85 a0 45
19 5f 7b 86
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 47 91 3e cd 0b 85 a0 45 19 5f 7b
86
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: no matching PMKID found
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: PMK - hexdump(len=32):
[REMOVED]
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: PTK - hexdump(len=64):
[REMOVED]
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: WPA IE for msg 2/4 -
hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f
ac 02 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Sending EAPOL-Key 2/4
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: TX EAPOL-Key -
hexdump(len=121): 01 03 00 75 02 01 0a 00 00 00 00 00 00 00 00 00 03
44 60 14 47 a5 40 85 44 de 1b 55 60 39 9b 4a f8 81 89 7e 64 17 51 f3
6a 91 f6 37 65 a6 75 96 62 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 35 d9 d8 1a 98
d0 c3 d2 8c 99 1f b6 ff 93 4c e3 00 16 30 14 01 00 00 0f ac 02 01 00
00 0f ac 04 01 00 00 0f ac 02 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX EAPOL from 00:13:10:88:68:d4
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):  e7 ef 00 50 d5 c9 dd e7 bc b6 35
04 03 1f 43 9f 03 05 ff 1b 14 fc 5c 41 5a 1b f4 ae 1a 6f 04 c1 3c c3
dc 9f b4 38 37 48 8a c3 6f d2 2c 6b 85 0f 66 73 35 14 66 dc 70 c5 48
0e 66 b2 84 60 b2 bc 54 4f 92 03 7d 70 c1 6c 28 76 23 fb f8 a1 ad d6
33 87 a4 1e
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473): IEEE 802.1X RX: version=2 type=3
length=175
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   EAPOL-Key type=2
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_info 0x13ca (ver=2 keyidx=0
rsvd=0 Pairwise Install Ack MIC Secure Encr)
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_length=16
key_data_length=80
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   replay_counter -
hexdump(len=8): 00 00 00 00 00 00 00 04
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_nonce - hexdump(len=32): 12
bc c1 4e e1 9a 89 04 99 30 b1 e1 63 49 31 b1 c2 d1 f4 85 3f b4 e0 70
29 09 40 1a fc 96 aa 95
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_iv - hexdump(len=16): c2 d1
f4 85 3f b4 e0 70 29 09 40 1a fc 96 aa 96
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_rsc - hexdump(len=8): f4 07
00 00 00 00 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_id (reserved) -
hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 22 21:04:17 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_mic - hexdump(len=16): 1e
31 e9 7b 81 f3 8c d3 24 0c a5 fd 1a 9d e7 ef
Apr 22 21:04:17 debian NetworkManager: <information>^IActivation
(wlan0_rename/wireless) Stage 2 of 5 (Device Configure) successful.
Connected to access point 'strausshouse'.
Apr 22 21:04:17 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 3 of 5 (IP Configure Start) scheduled.
Apr 22 21:04:17 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 3 of 5 (IP Configure Start) started...
Apr 22 21:04:18 debian NetworkManager: <information>^IActivation
(wlan0_rename) Beginning DHCP transaction.
Apr 22 21:04:18 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 3 of 5 (IP Configure Start) complete.
Apr 22 21:04:18 debian NetworkManager: <information>^IDHCP daemon
state is now 12 (successfully started) for interface wlan0_rename
Apr 22 21:04:19 debian NetworkManager: <information>^IDHCP daemon
state is now 1 (starting) for interface wlan0_rename
Apr 22 21:04:22 debian NetworkManager: <information>^IDHCP daemon
state is now 2 (bound) for interface wlan0_rename
Apr 22 21:04:22 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 4 of 5 (IP Configure Get) scheduled...
Apr 22 21:04:22 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 4 of 5 (IP Configure Get) started...
Apr 22 21:04:22 debian NetworkManager: <information>^IRetrieved the
following IP4 configuration from the DHCP daemon:
Apr 22 21:04:22 debian NetworkManager: <information>^I  address 192.168.28.116
Apr 22 21:04:22 debian NetworkManager: <information>^I  netmask 255.255.255.0
Apr 22 21:04:22 debian NetworkManager: <information>^I  broadcast
192.168.28.255
Apr 22 21:04:22 debian NetworkManager: <information>^I  gateway 192.168.28.1
Apr 22 21:04:22 debian NetworkManager: <information>^I  nameserver 192.168.28.1
Apr 22 21:04:22 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 5 of 5 (IP Configure Commit) scheduled...
Apr 22 21:04:22 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 4 of 5 (IP Configure Get) complete.
Apr 22 21:04:22 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 5 of 5 (IP Configure Commit) started...
Apr 22 21:04:23 debian NetworkManager: <information>^IClearing nscd
hosts cache.
Apr 22 21:04:23 debian NetworkManager: <WARNING>^I nm_spawn_process
(): nm_spawn_process('/usr/sbin/nscd -i hosts'): could not spawn
process. (Failed to execute child process "/usr/sbin/nscd" (No such
file or directory))
Apr 22 21:04:23 debian NetworkManager: <information>^IActivation
(wlan0_rename) Finish handler scheduled.
Apr 22 21:04:23 debian NetworkManager: <information>^IActivation
(wlan0_rename) successful, device activated.
Apr 22 21:04:23 debian NetworkManager: <debug
info>^I[1177293863.144701] nm_dbus_signal_filter ():
NetworkManagerInfo triggered update of wireless network 'strausshouse'
Apr 22 21:04:23 debian NetworkManager: <information>^IActivation
(wlan0_rename) Stage 5 of 5 (IP Configure Commit) complete.
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): b4 e0 70 29 09 40 1a fc 96 aa 95
c2 d1 f4 85 3f b4 e0 70 29 09 40 1a fc 96 aa 96 f4 07 00 00 00 00 00
00 00 00 00 00 00 00 00 00 1e 31 e9 7b 81 f3 8c d3 24 0c a5 fd 1a 9d
e7 ef 00 50 d5 c9 dd e7 bc b6 35 04 03 1f 43 9f 03 05 ff 1b 14 fc 5c
41 5a 1b f4 ae 1a 6f 04 c1 3c c3 dc 9f b4 38 37 48 8a c3 6f d2 2c 6b
85 0f 66 73 35 14 66 dc 70 c5 48 0e 66 b2 84 60 b2 bc 54 4f 92 03 7d
70 c1 6c 28 76 23 fb f8 a1 ad d6 33 87 a4 1e
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: encrypted key data -
hexdump(len=80): d5 c9 dd e7 bc b6 35 04 03 1f 43 9f 03 05 ff 1b 14 fc
5c 41 5a 1b f4 ae 1a 6f 04 c1 3c c3 dc 9f b4 38 37 48 8a c3 6f d2 2c
6b 85 0f 66 73 35 14 66 dc 70 c5 48 0e 66 b2 84 60 b2 bc 54 4f 92 03
7d 70 c1 6c 28 76 23 fb f8 a1 ad d6 33 87 a4 1e
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: decrypted EAPOL-Key key data
- hexdump(len=72): [REMOVED]
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: 4WAY_HANDSHAKE ->
4WAY_HANDSHAKE
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RX message 3 of 4-Way
Handshake from 00:13:10:88:68:d4 (ver=2)
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 6f 5f 78 c8 bb 5c 59 48 0a 5e e1
30 dd 8f 5d 3f 20 c5 9c 44 e7 25 08 93 a4 fe 1f d8 e3 dd 00 00 00 00
00
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Sending EAPOL-Key 4/4
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: TX EAPOL-Key -
hexdump(len=99): 01 03 00 5f 02 03 0a 00 00 00 00 00 00 00 00 00 04 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 06 91 0a 11 9d 7a
0c cb 35 c5 5d 9d 1a d1 36 6f 00 00
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Installing PTK to the
driver.
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=3
key_idx=0 set_tx=1 seq_len=6 key_len=16
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
portValid=1
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: 4WAY_HANDSHAKE ->
GROUP_HANDSHAKE
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: received GTK in pairwise
handshake - hexdump(len=34): [REMOVED]
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Group Key - hexdump(len=32):
[REMOVED]
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Installing GTK to the driver
(keyidx=1 tx=0).
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RSC - hexdump(len=6): f4 07
00 00 00 00
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=2
key_idx=1 set_tx=0 seq_len=6 key_len=32
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Key negotiation completed
with 00:13:10:88:68:d4 [PTK=CCMP GTK=TKIP]
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): nitor send - hexdump(len=40): 2f
76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61 6e 61 67 65 72 2f
77 70 61 5f 63 74 72 6c 5f 32 38 38 35 2d 32 00
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Cancelling authentication timeout
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: GROUP_HANDSHAKE ->
COMPLETED
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL-EVENT-CONNECTED - Connection
to 00:00:00:00:00:00 completed (auth) [id=0 id_str=]
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE monitor send -
hexdump(len=40): 2f 76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61
6e 61 67 65 72 2f 77 70 61 5f 63 74 72 6c 5f 32 38 38 35 2d 32 00
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_operstate:
operstate 0->1 (UP)
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WEXT: Operstate: linkmode=-1,
operstate=6
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
portValid=1
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAPOL: External notification -
EAP success=1
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): EAP: EAP entering state DISABLED
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK, IFLA_IFNAME:
Interface 'wlan0_rename' added
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): s event: cmd=0x8b06 len=8
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX EAPOL from 00:13:10:88:68:d4
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RX EAPOL - hexdump(len=147): 02
03 00 8f 02 13 82 00 00 00 00 00 00 00 00 00 05 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 c2 d1 f4 85 3f b4 e0 70 29 09 40 1a fc 96 aa 97 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 f3 15 67 4a 5a 3c 41 b9 5f ad 06 0e
f4 25 dd dd 00 30 7d da d2 0d 6c 38 a8 dd 9b cf 34 43 28 94 5f 63 3f
1e c8 16 8f 59 80 ec 9d 99 7b 9c b4 ec f5 f9 d7 c8 1e e9 b0 58 3d f1
4e 08 a2 3e 24 e2 32 eb
Apr 22 21:08:22 debian NetworkManager:
<information>^Iwpa_supplicant(3473): IEEE 802.1X RX: version=2 type=3
length=143
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): ey type=2
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_info 0x1382 (ver=2 keyidx=0
rsvd=0 Group Ack MIC Secure Encr)
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_length=0 key_data_length=48
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   replay_counter -
hexdump(len=8): 00 00 00 00 00 00 00 05
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_nonce - hexdump(len=32): 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_iv - hexdump(len=16): c2 d1
f4 85 3f b4 e0 70 29 09 40 1a fc 96 aa 97
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_rsc - hexdump(len=8): 00 00
00 00 00 00 00 00
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_id (reserved) -
hexdump(len=8): 00 00 00 00 00 00 00 00
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473):   key_mic - hexdump(len=16): f3
15 67 4a 5a 3c 41 b9 5f ad 06 0e f4 25 dd dd
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 08 a2 3e 24 e2 32 eb
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: encrypted key data -
hexdump(len=48): 7d da d2 0d 6c 38 a8 dd 9b cf 34 43 28 94 5f 63 3f 1e
c8 16 8f 59 80 ec 9d 99 7b 9c b4 ec f5 f9 d7 c8 1e e9 b0 58 3d f1 4e
08 a2 3e 24 e2 32 eb
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: decrypted EAPOL-Key key data
- hexdump(len=40): [REMOVED]
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RX message 1 of Group Key or
STAKey Handshake from 00:13:10:88:68:d4 (ver=2)
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: msg 1/2 key data -
hexdump(len=40): dd 26 00 0f ac 01 02 00 aa af ff 40 da dd c8 1e 88 19
db f3 21 a9 bf 6a 55 07 bf 34 67 6f f8 e5 58 92 62 71 2a 47 1c 07
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RSN: received GTK in group key
handshake - hexdump(len=34): 02 00 aa af ff 40 da dd c8 1e 88 19 db f3
21 a9 bf 6a 55 07 bf 34 67 6f f8 e5 58 92 62 71 2a 47 1c 07
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: COMPLETED ->
GROUP_HANDSHAKE
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Group Key - hexdump(len=32):
[REMOVED]
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Installing GTK to the driver
(keyidx=2 tx=0).
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: RSC - hexdump(len=6): 00 00
00 00 00 00
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): wpa_driver_wext_set_key: alg=2
key_idx=2 set_tx=0 seq_len=6 key_len=32
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Sending EAPOL-Key 2/2
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): 00 00 00 00 05 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 e9 43 9d a8 30 23 1d 85 92 cd a8
2f 7c fb 44 3a 00 00
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): WPA: Group rekeying completed
with 00:13:10:88:68:d4 [GTK=TKIP]
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): CTRL_IFACE monitor send -
hexdump(len=40): 2f 76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61
6e 61 67 65 72 2f 77 70 61 5f 63 74 72 6c 5f 32 38 38 35 2d 32 00
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): State: GROUP_HANDSHAKE ->
COMPLETED
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): =0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x1003 ([UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK, IFLA_IFNAME:
Interface 'wlan0_rename' added
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x1003 ([UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x1003 ([UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): RTM_NEWLINK: operstate=1
ifi_flags=0x1003 ([UP])
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Wireless event: cmd=0x8b06 len=8
Apr 22 21:29:36 debian NetworkManager:
<information>^Iwpa_supplicant(3473): Ignore event for foreign ifindex
3



[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]