[Bug 518196] Re: Intel iwlagn driver hangs from time to time
dave945
dave at dtabor.com
Sat Feb 27 22:53:39 UTC 2010
After unplugging eth0, wlan0 runs for about a minute then quits. Here
is the sequence of events:
Feb 27 17:31:43 tabord-laptop kernel: [ 47.352057] wlan0: no IPv6 routers present
Feb 27 17:31:50 tabord-laptop kernel: [ 54.364177] e1000e: eth0 NIC Link is Down
Feb 27 17:31:50 tabord-laptop NetworkManager: <info> (eth0): carrier now OFF (device state 8, deferring action for 4 seconds)
Feb 27 17:31:55 tabord-laptop NetworkManager: <info> (eth0): device state change: 8 -> 2 (reason 40)
Feb 27 17:31:55 tabord-laptop NetworkManager: <info> (eth0): deactivating device (reason: 40).
Feb 27 17:31:55 tabord-laptop NetworkManager: <info> (eth0): canceled DHCP transaction, dhcp client pid 1794
Feb 27 17:31:55 tabord-laptop NetworkManager: <WARN> check_one_route(): (eth0) error -34 returned from rtnl_route_del(): Sucess#012
Feb 27 17:31:55 tabord-laptop avahi-daemon[968]: Withdrawing address record for 10.0.1.17 on eth0.
Feb 27 17:31:55 tabord-laptop avahi-daemon[968]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.0.1.17.
Feb 27 17:31:55 tabord-laptop avahi-daemon[968]: Interface eth0.IPv4 no longer relevant for mDNS.
Feb 27 17:31:55 tabord-laptop NetworkManager: <info> Policy set 'Auto Tabor (5 GHz)' (wlan0) as default for routing and DNS.
Feb 27 17:32:04 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:32:28 tabord-laptop anacron[2450]: Anacron 2.3 started on 2010-02-27
Feb 27 17:32:28 tabord-laptop anacron[2450]: Normal exit (0 jobs run)
Feb 27 17:32:28 tabord-laptop kernel: [ 91.927340] CPU0 attaching NULL sched-domain.
Feb 27 17:32:28 tabord-laptop kernel: [ 91.927344] CPU1 attaching NULL sched-domain.
Feb 27 17:32:28 tabord-laptop kernel: [ 91.934050] thinkpad_acpi: EC reports that Thermal Table has changed
Feb 27 17:32:28 tabord-laptop kernel: [ 91.940567] CPU0 attaching sched-domain:
Feb 27 17:32:28 tabord-laptop kernel: [ 91.940570] domain 0: span 0-1 level MC
Feb 27 17:32:28 tabord-laptop kernel: [ 91.940572] groups: 0 1
Feb 27 17:32:28 tabord-laptop kernel: [ 91.940576] CPU1 attaching sched-domain:
Feb 27 17:32:28 tabord-laptop kernel: [ 91.940577] domain 0: span 0-1 level MC
Feb 27 17:32:28 tabord-laptop kernel: [ 91.940579] groups: 1 0
Feb 27 17:32:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:32:44 tabord-laptop wpa_supplicant[1356]: Trying to associate with 00:1f:f3:f8:a1:db (SSID='Tabor (5 GHz)' freq=5745 MHz)
Feb 27 17:32:44 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: completed -> associating
Feb 27 17:32:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
Feb 27 17:32:44 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associating -> disconnected
Feb 27 17:32:44 tabord-laptop kernel: [ 107.648220] wlan0: deauthenticating from f8:1e:df:fa:e6:1c by local choice (reason=3)
Feb 27 17:32:44 tabord-laptop kernel: [ 107.651297] wlan0: direct probe to AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:32:44 tabord-laptop kernel: [ 107.652818] wlan0: direct probe responded
Feb 27 17:32:44 tabord-laptop kernel: [ 107.652825] wlan0: authenticate with AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:32:44 tabord-laptop kernel: [ 107.653295] wlan0: authenticated
Feb 27 17:32:44 tabord-laptop wpa_supplicant[1356]: Associated with 00:1f:f3:f8:a1:db
Feb 27 17:32:44 tabord-laptop kernel: [ 107.672526] wlan0: associate with AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:32:44 tabord-laptop kernel: [ 107.675404] wlan0: RX ReassocResp from 00:1f:f3:f8:a1:db (capab=0x511 status=0 aid=1)
Feb 27 17:32:44 tabord-laptop kernel: [ 107.675410] wlan0: associated
Feb 27 17:32:44 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: disconnected -> associated
Feb 27 17:32:44 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associated -> 4-way handshake
Feb 27 17:32:44 tabord-laptop wpa_supplicant[1356]: WPA: Key negotiation completed with 00:1f:f3:f8:a1:db [PTK=CCMP GTK=TKIP]
Feb 27 17:32:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-CONNECTED - Connection to 00:1f:f3:f8:a1:db completed (reauth) [id=0 id_str=]
Feb 27 17:32:44 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: 4-way handshake -> group handshake
Feb 27 17:32:44 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: group handshake -> completed
Feb 27 17:32:47 tabord-laptop NetworkManager: <debug> [1267309967.003700] periodic_update(): Roamed from BSSID F8:1E:DF:FA:E6:1C (Tabor (5 GHz)) to 00:1F:F3:F8:A1:DB (Tabor (5 GHz))
Feb 27 17:33:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): device state change: 8 -> 3 (reason 0)
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): deactivating device (reason: 0).
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): canceled DHCP transaction, dhcp client pid 2302
Feb 27 17:33:50 tabord-laptop NetworkManager: <WARN> check_one_route(): (wlan0) error -34 returned from rtnl_route_del(): Sucess#012
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) starting connection 'Auto Tabor (5 GHz)'
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): device state change: 3 -> 4 (reason 0)
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0/wireless): access point 'Auto Tabor (5 GHz)' has security, but secrets are required.
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): device state change: 5 -> 6 (reason 0)
Feb 27 17:33:50 tabord-laptop avahi-daemon[968]: Withdrawing address record for 10.0.1.10 on wlan0.
Feb 27 17:33:50 tabord-laptop avahi-daemon[968]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.1.10.
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 27 17:33:50 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: completed -> disconnected
Feb 27 17:33:50 tabord-laptop kernel: [ 174.228627] wlan0: deauthenticating from 00:1f:f3:f8:a1:db by local choice (reason=3)
Feb 27 17:33:50 tabord-laptop kernel: [ 174.228679] wlan0: deauthenticating from f8:1e:df:fa:e6:1c by local choice (reason=3)
Feb 27 17:33:50 tabord-laptop avahi-daemon[968]: Interface wlan0.IPv4 no longer relevant for mDNS.
Feb 27 17:33:50 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): device state change: 6 -> 4 (reason 0)
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0/wireless): connection 'Auto Tabor (5 GHz)' has security, and secrets exist. No new secrets needed.
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Config: added 'ssid' value 'Tabor (5 GHz)'
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Config: added 'scan_ssid' value '1'
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Config: added 'psk' value '<omitted>'
Feb 27 17:33:50 tabord-laptop NetworkManager: nm_setting_802_1x_get_pkcs11_engine_path: assertion `NM_IS_SETTING_802_1X (setting)' failed
Feb 27 17:33:50 tabord-laptop NetworkManager: nm_setting_802_1x_get_pkcs11_module_path: assertion `NM_IS_SETTING_802_1X (setting)' failed
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> Config: set interface ap_scan to 1
Feb 27 17:33:50 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: disconnected -> scanning
Feb 27 17:33:53 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:33:53 tabord-laptop wpa_supplicant[1356]: Trying to associate with 00:1f:f3:f8:a1:db (SSID='Tabor (5 GHz)' freq=5745 MHz)
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: scanning -> associating
Feb 27 17:33:53 tabord-laptop kernel: [ 177.406542] wlan0: deauthenticating from f8:1e:df:fa:e6:1c by local choice (reason=3)
Feb 27 17:33:53 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:33:53 tabord-laptop kernel: [ 177.458130] wlan0: direct probe to AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:33:53 tabord-laptop kernel: [ 177.459624] wlan0: direct probe responded
Feb 27 17:33:53 tabord-laptop kernel: [ 177.459631] wlan0: authenticate with AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:33:53 tabord-laptop kernel: [ 177.460124] wlan0: authenticated
Feb 27 17:33:53 tabord-laptop kernel: [ 177.460155] wlan0: associate with AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:33:53 tabord-laptop kernel: [ 177.463039] wlan0: RX AssocResp from 00:1f:f3:f8:a1:db (capab=0x511 status=0 aid=1)
Feb 27 17:33:53 tabord-laptop wpa_supplicant[1356]: Associated with 00:1f:f3:f8:a1:db
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associating -> associated
Feb 27 17:33:53 tabord-laptop kernel: [ 177.463045] wlan0: associated
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associated -> 4-way handshake
Feb 27 17:33:53 tabord-laptop wpa_supplicant[1356]: WPA: Key negotiation completed with 00:1f:f3:f8:a1:db [PTK=CCMP GTK=TKIP]
Feb 27 17:33:53 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-CONNECTED - Connection to 00:1f:f3:f8:a1:db completed (reauth) [id=0 id_str=]
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: 4-way handshake -> group handshake
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: group handshake -> completed
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'Tabor (5 GHz)'.
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> (wlan0): device state change: 5 -> 7 (reason 0)
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Beginning DHCP transaction (timeout in 45 seconds)
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> dhclient started with pid 2545
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) started...
Feb 27 17:33:53 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) complete.
Feb 27 17:33:54 tabord-laptop dhclient: Internet Systems Consortium DHCP Client V3.1.2
Feb 27 17:33:54 tabord-laptop dhclient: Copyright 2004-2008 Internet Systems Consortium.
Feb 27 17:33:54 tabord-laptop dhclient: All rights reserved.
Feb 27 17:33:54 tabord-laptop dhclient: For info, please visit http://www.isc.org/sw/dhcp/
Feb 27 17:33:54 tabord-laptop dhclient:
Feb 27 17:33:54 tabord-laptop NetworkManager: <info> DHCP: device wlan0 state changed normal exit -> preinit
Feb 27 17:33:54 tabord-laptop dhclient: Listening on LPF/wlan0/00:1e:65:22:14:ae
Feb 27 17:33:54 tabord-laptop dhclient: Sending on LPF/wlan0/00:1e:65:22:14:ae
Feb 27 17:33:54 tabord-laptop dhclient: Sending on Socket/fallback
Feb 27 17:33:57 tabord-laptop dhclient: DHCPREQUEST of 10.0.1.10 on wlan0 to 255.255.255.255 port 67
Feb 27 17:33:58 tabord-laptop kernel: [ 182.371787] CPU0 attaching NULL sched-domain.
Feb 27 17:33:58 tabord-laptop kernel: [ 182.371791] CPU1 attaching NULL sched-domain.
Feb 27 17:33:58 tabord-laptop kernel: [ 182.380196] thinkpad_acpi: EC reports that Thermal Table has changed
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384648] CPU0 attaching sched-domain:
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384651] domain 0: span 0-1 level MC
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384653] groups: 0 1
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384656] domain 1: span 0-1 level CPU
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384658] groups: 0-1 (__cpu_power = 2048)
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384662] CPU1 attaching sched-domain:
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384663] domain 0: span 0-1 level MC
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384665] groups: 1 0
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384668] domain 1: span 0-1 level CPU
Feb 27 17:33:58 tabord-laptop kernel: [ 182.384670] groups: 0-1 (__cpu_power = 2048)
Feb 27 17:34:00 tabord-laptop dhclient: DHCPREQUEST of 10.0.1.10 on wlan0 to 255.255.255.255 port 67
Feb 27 17:34:08 tabord-laptop dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 3
Feb 27 17:34:11 tabord-laptop dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 7
Feb 27 17:34:15 tabord-laptop kernel: [ 199.048163] hub 6-0:1.0: port 2 disabled by hub (EMI?), re-enabling...
Feb 27 17:34:15 tabord-laptop kernel: [ 199.048175] usb 6-2: USB disconnect, address 2
Feb 27 17:34:15 tabord-laptop kernel: [ 199.316122] usb 6-2: new low speed USB device using uhci_hcd and address 3
Feb 27 17:34:16 tabord-laptop kernel: [ 199.498150] usb 6-2: configuration #1 chosen from 1 choice
Feb 27 17:34:16 tabord-laptop kernel: [ 199.544688] input: Microsoft Microsoft USB Wireless Mouse as /devices/pci0000:00/0000:00:1d.0/usb6/6-2/6-2:1.0/input/input16
Feb 27 17:34:16 tabord-laptop kernel: [ 199.544869] generic-usb 0003:045E:00B9.0002: input,hidraw0: USB HID v1.11 Mouse [Microsoft Microsoft USB Wireless Mouse] on usb-0000:00:1d.0-2/input0
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> (eth0): carrier now ON (device state 2)
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> (eth0): device state change: 2 -> 3 (reason 40)
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) starting connection 'Auto eth0'
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> (eth0): device state change: 3 -> 4 (reason 0)
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> (eth0): device state change: 4 -> 5 (reason 0)
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
Feb 27 17:34:16 tabord-laptop kernel: [ 200.068886] e1000e: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> (eth0): device state change: 5 -> 7 (reason 0)
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Beginning DHCP transaction (timeout in 45 seconds)
Feb 27 17:34:16 tabord-laptop dhclient: Internet Systems Consortium DHCP Client V3.1.2
Feb 27 17:34:16 tabord-laptop dhclient: Copyright 2004-2008 Internet Systems Consortium.
Feb 27 17:34:16 tabord-laptop dhclient: All rights reserved.
Feb 27 17:34:16 tabord-laptop dhclient: For info, please visit http://www.isc.org/sw/dhcp/
Feb 27 17:34:16 tabord-laptop dhclient:
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> dhclient started with pid 2605
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP6 Configure Get) started...
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP6 Configure Get) complete.
Feb 27 17:34:16 tabord-laptop NetworkManager: <info> DHCP: device eth0 state changed normal exit -> preinit
Feb 27 17:34:16 tabord-laptop dhclient: Listening on LPF/eth0/00:24:7e:6a:f5:54
Feb 27 17:34:16 tabord-laptop dhclient: Sending on LPF/eth0/00:24:7e:6a:f5:54
Feb 27 17:34:16 tabord-laptop dhclient: Sending on Socket/fallback
Feb 27 17:34:18 tabord-laptop dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 7
Feb 27 17:34:18 tabord-laptop dhclient: DHCPREQUEST of 10.0.1.17 on eth0 to 255.255.255.255 port 67
Feb 27 17:34:18 tabord-laptop dhclient: DHCPACK of 10.0.1.17 from 10.0.1.1
Feb 27 17:34:18 tabord-laptop dhclient: bound to 10.0.1.17 -- renewal in 39263 seconds.
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> DHCP: device eth0 state changed preinit -> reboot
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure Get) scheduled...
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure Get) started...
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> address 10.0.1.17
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> prefix 24 (255.255.255.0)
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> gateway 10.0.1.1
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> nameserver '10.0.1.1'
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> domain name 'hsd1.md.comcast.net.'
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure Get) complete.
Feb 27 17:34:18 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
Feb 27 17:34:18 tabord-laptop avahi-daemon[968]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.0.1.17.
Feb 27 17:34:18 tabord-laptop avahi-daemon[968]: New relevant interface eth0.IPv4 for mDNS.
Feb 27 17:34:18 tabord-laptop avahi-daemon[968]: Registering new address record for 10.0.1.17 on eth0.IPv4.
Feb 27 17:34:19 tabord-laptop NetworkManager: <info> (eth0): device state change: 7 -> 8 (reason 0)
Feb 27 17:34:19 tabord-laptop NetworkManager: <info> Policy set 'Auto eth0' (eth0) as default for routing and DNS.
Feb 27 17:34:19 tabord-laptop NetworkManager: <info> Activation (eth0) successful, device activated.
Feb 27 17:34:19 tabord-laptop NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.
Feb 27 17:34:19 tabord-laptop ntpdate[2658]: adjust time server 91.189.94.4 offset 0.002359 sec
Feb 27 17:34:25 tabord-laptop dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 9
Feb 27 17:34:34 tabord-laptop dhclient: DHCPDISCOVER on wlan0 to 255.255.255.255 port 67 interval 11
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): device state change: 7 -> 3 (reason 0)
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): deactivating device (reason: 0).
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): canceled DHCP transaction, dhcp client pid 2545
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Policy set 'Auto eth0' (eth0) as default for routing and DNS.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) starting connection 'Auto Tabor (5 GHz)'
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): device state change: 3 -> 4 (reason 0)
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0/wireless): connection 'Auto Tabor (5 GHz)' has security, and secrets exist. No new secrets needed.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Config: added 'ssid' value 'Tabor (5 GHz)'
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Config: added 'scan_ssid' value '1'
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Config: added 'psk' value '<omitted>'
Feb 27 17:34:37 tabord-laptop NetworkManager: nm_setting_802_1x_get_pkcs11_engine_path: assertion `NM_IS_SETTING_802_1X (setting)' failed
Feb 27 17:34:37 tabord-laptop NetworkManager: nm_setting_802_1x_get_pkcs11_module_path: assertion `NM_IS_SETTING_802_1X (setting)' failed
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Config: set interface ap_scan to 1
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: completed -> disconnected
Feb 27 17:34:37 tabord-laptop kernel: [ 221.176581] wlan0: deauthenticating from 00:1f:f3:f8:a1:db by local choice (reason=3)
Feb 27 17:34:37 tabord-laptop kernel: [ 221.176632] wlan0: deauthenticating from f8:1e:df:fa:e6:1c by local choice (reason=3)
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: disconnected -> scanning
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: Failed to initiate AP scan.
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: Trying to associate with f8:1e:df:fa:e6:1c (SSID='Tabor (5 GHz)' freq=5745 MHz)
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: scanning -> associating
Feb 27 17:34:37 tabord-laptop kernel: [ 221.206141] wlan0: deauthenticating from f8:1e:df:fa:e6:1c by local choice (reason=3)
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:34:37 tabord-laptop kernel: [ 221.320964] wlan0: direct probe to AP f8:1e:df:fa:e6:1c (try 1)
Feb 27 17:34:37 tabord-laptop kernel: [ 221.321873] wlan0: direct probe responded
Feb 27 17:34:37 tabord-laptop kernel: [ 221.321881] wlan0: authenticate with AP f8:1e:df:fa:e6:1c (try 1)
Feb 27 17:34:37 tabord-laptop kernel: [ 221.322960] wlan0: authenticated
Feb 27 17:34:37 tabord-laptop kernel: [ 221.322991] wlan0: associate with AP f8:1e:df:fa:e6:1c (try 1)
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: Associated with f8:1e:df:fa:e6:1c
Feb 27 17:34:37 tabord-laptop kernel: [ 221.325800] wlan0: RX AssocResp from f8:1e:df:fa:e6:1c (capab=0x511 status=0 aid=2)
Feb 27 17:34:37 tabord-laptop kernel: [ 221.325806] wlan0: associated
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associating -> associated
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associated -> 4-way handshake
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: WPA: Key negotiation completed with f8:1e:df:fa:e6:1c [PTK=CCMP GTK=TKIP]
Feb 27 17:34:37 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-CONNECTED - Connection to f8:1e:df:fa:e6:1c completed (reauth) [id=0 id_str=]
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: 4-way handshake -> group handshake
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: group handshake -> completed
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'Tabor (5 GHz)'.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> (wlan0): device state change: 5 -> 7 (reason 0)
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Beginning DHCP transaction (timeout in 45 seconds)
Feb 27 17:34:37 tabord-laptop dhclient: Internet Systems Consortium DHCP Client V3.1.2
Feb 27 17:34:37 tabord-laptop dhclient: Copyright 2004-2008 Internet Systems Consortium.
Feb 27 17:34:37 tabord-laptop dhclient: All rights reserved.
Feb 27 17:34:37 tabord-laptop dhclient: For info, please visit http://www.isc.org/sw/dhcp/
Feb 27 17:34:37 tabord-laptop dhclient:
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> dhclient started with pid 2677
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) started...
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP6 Configure Get) complete.
Feb 27 17:34:37 tabord-laptop NetworkManager: <info> DHCP: device wlan0 state changed normal exit -> preinit
Feb 27 17:34:37 tabord-laptop dhclient: Listening on LPF/wlan0/00:1e:65:22:14:ae
Feb 27 17:34:37 tabord-laptop dhclient: Sending on LPF/wlan0/00:1e:65:22:14:ae
Feb 27 17:34:37 tabord-laptop dhclient: Sending on Socket/fallback
Feb 27 17:34:39 tabord-laptop dhclient: DHCPREQUEST of 10.0.1.10 on wlan0 to 255.255.255.255 port 67
Feb 27 17:34:39 tabord-laptop dhclient: DHCPACK of 10.0.1.10 from 10.0.1.1
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> DHCP: device wlan0 state changed preinit -> reboot
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) scheduled...
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) started...
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> address 10.0.1.10
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> prefix 24 (255.255.255.0)
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> gateway 10.0.1.1
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> nameserver '10.0.1.1'
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> domain name 'hsd1.md.comcast.net.'
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) scheduled...
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 4 of 5 (IP4 Configure Get) complete.
Feb 27 17:34:39 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) started...
Feb 27 17:34:39 tabord-laptop avahi-daemon[968]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.1.10.
Feb 27 17:34:39 tabord-laptop avahi-daemon[968]: New relevant interface wlan0.IPv4 for mDNS.
Feb 27 17:34:39 tabord-laptop avahi-daemon[968]: Registering new address record for 10.0.1.10 on wlan0.IPv4.
Feb 27 17:34:39 tabord-laptop dhclient: bound to 10.0.1.10 -- renewal in 38431 seconds.
Feb 27 17:34:40 tabord-laptop NetworkManager: <info> Policy set 'Auto eth0' (eth0) as default for routing and DNS.
Feb 27 17:34:40 tabord-laptop NetworkManager: <info> (wlan0): device state change: 7 -> 8 (reason 0)
Feb 27 17:34:40 tabord-laptop NetworkManager: <debug> [1267310080.053171] periodic_update(): Roamed from BSSID 00:1F:F3:F8:A1:DB (Tabor (5 GHz)) to F8:1E:DF:FA:E6:1C (Tabor (5 GHz))
Feb 27 17:34:40 tabord-laptop NetworkManager: <info> Activation (wlan0) successful, device activated.
Feb 27 17:34:40 tabord-laptop NetworkManager: <info> Activation (wlan0) Stage 5 of 5 (IP Configure Commit) complete.
Feb 27 17:34:40 tabord-laptop ntpdate[2729]: adjust time server 91.189.94.4 offset -0.001126 sec
Feb 27 17:35:04 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:35:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:35:47 tabord-laptop kernel: [ 291.248225] e1000e: eth0 NIC Link is Down
Feb 27 17:35:47 tabord-laptop NetworkManager: <info> (eth0): carrier now OFF (device state 8, deferring action for 4 seconds)
Feb 27 17:35:51 tabord-laptop NetworkManager: <info> (eth0): device state change: 8 -> 2 (reason 40)
Feb 27 17:35:52 tabord-laptop NetworkManager: <info> (eth0): deactivating device (reason: 40).
Feb 27 17:35:52 tabord-laptop NetworkManager: <info> (eth0): canceled DHCP transaction, dhcp client pid 2605
Feb 27 17:35:52 tabord-laptop NetworkManager: <WARN> check_one_route(): (eth0) error -34 returned from rtnl_route_del(): Sucess#012
Feb 27 17:35:52 tabord-laptop avahi-daemon[968]: Withdrawing address record for 10.0.1.17 on eth0.
Feb 27 17:35:52 tabord-laptop avahi-daemon[968]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.0.1.17.
Feb 27 17:35:52 tabord-laptop NetworkManager: <info> Policy set 'Auto Tabor (5 GHz)' (wlan0) as default for routing and DNS.
Feb 27 17:35:52 tabord-laptop avahi-daemon[968]: Interface eth0.IPv4 no longer relevant for mDNS.
Feb 27 17:36:30 tabord-laptop kernel: [ 333.528636] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = f8:1e:df:fa:e6:1c tid = 0
Feb 27 17:36:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:38:04 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:38:04 tabord-laptop wpa_supplicant[1356]: Trying to associate with 00:1f:f3:f8:a1:db (SSID='Tabor (5 GHz)' freq=5745 MHz)
Feb 27 17:38:04 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: completed -> associating
Feb 27 17:38:04 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
Feb 27 17:38:04 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associating -> disconnected
Feb 27 17:38:04 tabord-laptop kernel: [ 427.760256] wlan0: deauthenticating from f8:1e:df:fa:e6:1c by local choice (reason=3)
Feb 27 17:38:04 tabord-laptop kernel: [ 427.761411] wlan0: direct probe to AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:38:04 tabord-laptop kernel: [ 427.765428] wlan0: direct probe responded
Feb 27 17:38:04 tabord-laptop kernel: [ 427.765435] wlan0: authenticate with AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:38:04 tabord-laptop kernel: [ 427.771190] wlan0: authenticated
Feb 27 17:38:04 tabord-laptop kernel: [ 427.784253] wlan0: associate with AP 00:1f:f3:f8:a1:db (try 1)
Feb 27 17:38:04 tabord-laptop wpa_supplicant[1356]: Associated with 00:1f:f3:f8:a1:db
Feb 27 17:38:04 tabord-laptop kernel: [ 427.787131] wlan0: RX ReassocResp from 00:1f:f3:f8:a1:db (capab=0x511 status=0 aid=1)
Feb 27 17:38:04 tabord-laptop kernel: [ 427.787134] wlan0: associated
Feb 27 17:38:04 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: disconnected -> associated
Feb 27 17:38:04 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: associated -> 4-way handshake
Feb 27 17:38:04 tabord-laptop wpa_supplicant[1356]: WPA: Key negotiation completed with 00:1f:f3:f8:a1:db [PTK=CCMP GTK=TKIP]
Feb 27 17:38:04 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-CONNECTED - Connection to 00:1f:f3:f8:a1:db completed (reauth) [id=0 id_str=]
Feb 27 17:38:04 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: 4-way handshake -> group handshake
Feb 27 17:38:04 tabord-laptop NetworkManager: <info> (wlan0): supplicant connection state: group handshake -> completed
Feb 27 17:38:05 tabord-laptop NetworkManager: <debug> [1267310285.001873] periodic_update(): Roamed from BSSID F8:1E:DF:FA:E6:1C (Tabor (5 GHz)) to 00:1F:F3:F8:A1:DB (Tabor (5 GHz))
Feb 27 17:38:49 tabord-laptop kernel: [ 472.846477] thinkpad_acpi: EC reports that Thermal Table has changed
Feb 27 17:38:49 tabord-laptop anacron[2833]: Anacron 2.3 started on 2010-02-27
Feb 27 17:38:49 tabord-laptop anacron[2833]: Normal exit (0 jobs run)
Feb 27 17:38:49 tabord-laptop kernel: [ 473.080706] CPU0 attaching NULL sched-domain.
Feb 27 17:38:49 tabord-laptop kernel: [ 473.080717] CPU1 attaching NULL sched-domain.
Feb 27 17:38:49 tabord-laptop kernel: [ 473.092683] CPU0 attaching sched-domain:
Feb 27 17:38:49 tabord-laptop kernel: [ 473.092690] domain 0: span 0-1 level MC
Feb 27 17:38:49 tabord-laptop kernel: [ 473.092696] groups: 0 1
Feb 27 17:38:49 tabord-laptop kernel: [ 473.092708] CPU1 attaching sched-domain:
Feb 27 17:38:49 tabord-laptop kernel: [ 473.092712] domain 0: span 0-1 level MC
Feb 27 17:38:49 tabord-laptop kernel: [ 473.092718] groups: 1 0
Feb 27 17:39:44 tabord-laptop wpa_supplicant[1356]: CTRL-EVENT-SCAN-RESULTS
Feb 27 17:40:57 tabord-laptop kernel: [ 601.288300] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:1f:f3:f8:a1:db tid = 0
--
Intel iwlagn driver hangs from time to time
https://bugs.launchpad.net/bugs/518196
You received this bug notification because you are a member of Kernel
Bugs, which is subscribed to linux in ubuntu.
More information about the kernel-bugs
mailing list