[ 21.290045] usb 3-1: new full speed USB device using uhci_hcd and address 6 [ 21.427941] usb 3-1: device descriptor read/64, error -71 [ 21.660041] usb 3-1: device descriptor read/64, error -71 [ 21.890032] usb 3-1: new full speed USB device using uhci_hcd and address 7 [ 22.020026] usb 3-1: device descriptor read/64, error -71 [ 22.261307] usb 3-1: device descriptor read/64, error -71 [ 22.490041] usb 3-1: new full speed USB device using uhci_hcd and address 8 [ 22.910016] usb 3-1: device not accepting address 8, error -71 [ 23.030045] usb 3-1: new full speed USB device using uhci_hcd and address 9 [ 23.450057] usb 3-1: device not accepting address 9, error -71 [ 23.450073] hub 3-0:1.0: unable to enumerate USB device on port 1 [ 24.197437] CPU0 attaching NULL sched-domain. [ 24.197441] CPU1 attaching NULL sched-domain. [ 24.250138] CPU0 attaching sched-domain: [ 24.250141] domain 0: span 0-1 level MC [ 24.250143] groups: 0 1 [ 24.250148] CPU1 attaching sched-domain: [ 24.250149] domain 0: span 0-1 level MC [ 24.250151] groups: 1 0 [ 41.436822] wlan0: deauthenticating from 98:4b:e1:1f:4a:10 by local choice (reason=3) [ 41.436929] wlan0: direct probe to AP 98:4b:e1:1f:4a:10 (try 1) [ 41.442392] wlan0: direct probe responded [ 41.442394] wlan0: authenticate with AP 98:4b:e1:1f:4a:10 (try 1) [ 41.455650] wlan0: authenticated [ 41.455681] wlan0: associate with AP 98:4b:e1:1f:4a:10 (try 1) [ 41.460083] wlan0: RX AssocResp from 98:4b:e1:1f:4a:10 (capab=0x431 status=0 aid=1) [ 41.460086] wlan0: associated [ 41.463891] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 41.463935] cfg80211: Calling CRDA for country: NL [ 41.465572] cfg80211: Received country IE: [ 41.465574] cfg80211: Regulatory domain: NL [ 41.465575] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 41.465578] (2402000 KHz - 2494000 KHz @ 40000 KHz), (10000 mBi, 10000 mBm) [ 41.465579] cfg80211: CRDA thinks this should applied: [ 41.465580] cfg80211: Regulatory domain: NL [ 41.465582] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 41.465584] (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 41.465586] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 41.465588] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 41.465589] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2700 mBm) [ 41.465591] cfg80211: We intersect both of these and get: [ 41.465592] cfg80211: Regulatory domain: 98 [ 41.465593] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 41.465595] (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 41.465599] cfg80211: Leaving channel 5180 MHz intact on phy0 - no rule found in band on Country IE [ 41.465601] cfg80211: Leaving channel 5200 MHz intact on phy0 - no rule found in band on Country IE [ 41.465603] cfg80211: Leaving channel 5220 MHz intact on phy0 - no rule found in band on Country IE [ 41.465604] cfg80211: Leaving channel 5240 MHz intact on phy0 - no rule found in band on Country IE [ 41.465606] cfg80211: Leaving channel 5260 MHz intact on phy0 - no rule found in band on Country IE [ 41.465608] cfg80211: Leaving channel 5280 MHz intact on phy0 - no rule found in band on Country IE [ 41.465610] cfg80211: Leaving channel 5300 MHz intact on phy0 - no rule found in band on Country IE [ 41.465612] cfg80211: Leaving channel 5320 MHz intact on phy0 - no rule found in band on Country IE [ 41.465614] cfg80211: Leaving channel 5500 MHz intact on phy0 - no rule found in band on Country IE [ 41.465616] cfg80211: Leaving channel 5520 MHz intact on phy0 - no rule found in band on Country IE [ 41.465618] cfg80211: Leaving channel 5540 MHz intact on phy0 - no rule found in band on Country IE [ 41.465620] cfg80211: Leaving channel 5560 MHz intact on phy0 - no rule found in band on Country IE [ 41.465621] cfg80211: Leaving channel 5580 MHz intact on phy0 - no rule found in band on Country IE [ 41.465623] cfg80211: Leaving channel 5600 MHz intact on phy0 - no rule found in band on Country IE [ 41.465625] cfg80211: Leaving channel 5620 MHz intact on phy0 - no rule found in band on Country IE [ 41.465627] cfg80211: Leaving channel 5640 MHz intact on phy0 - no rule found in band on Country IE [ 41.465629] cfg80211: Leaving channel 5660 MHz intact on phy0 - no rule found in band on Country IE [ 41.465631] cfg80211: Leaving channel 5680 MHz intact on phy0 - no rule found in band on Country IE [ 41.465633] cfg80211: Leaving channel 5700 MHz intact on phy0 - no rule found in band on Country IE [ 41.465635] cfg80211: Leaving channel 5745 MHz intact on phy0 - no rule found in band on Country IE [ 41.465636] cfg80211: Leaving channel 5765 MHz intact on phy0 - no rule found in band on Country IE [ 41.465638] cfg80211: Leaving channel 5785 MHz intact on phy0 - no rule found in band on Country IE [ 41.465640] cfg80211: Leaving channel 5805 MHz intact on phy0 - no rule found in band on Country IE [ 41.465642] cfg80211: Leaving channel 5825 MHz intact on phy0 - no rule found in band on Country IE [ 41.465646] cfg80211: Current regulatory domain updated by AP to: NL [ 41.465647] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 41.465649] (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 46.763230] wlan0: deauthenticated from 98:4b:e1:1f:4a:10 (Reason: 6) [ 46.892537] wlan0: direct probe to AP 98:4b:e1:1f:4a:10 (try 1) [ 46.899209] wlan0: direct probe responded [ 46.899212] wlan0: authenticate with AP 98:4b:e1:1f:4a:10 (try 1) [ 46.903072] wlan0: authenticated [ 46.903090] wlan0: associate with AP 98:4b:e1:1f:4a:10 (try 1) [ 46.907264] wlan0: RX AssocResp from 98:4b:e1:1f:4a:10 (capab=0x431 status=0 aid=1) [ 46.907266] wlan0: associated [ 50.763671] wlan0: deauthenticated from 98:4b:e1:1f:4a:10 (Reason: 6) [ 50.897193] wlan0: direct probe to AP 98:4b:e1:1f:4a:10 (try 1) [ 50.897209] wlan0: deauthenticating from 98:4b:e1:1f:4a:10 by local choice (reason=3) [ 50.899663] wlan0: direct probe to AP 98:4b:e1:1f:4a:00 (try 1) [ 50.901304] wlan0: direct probe responded [ 50.901307] wlan0: authenticate with AP 98:4b:e1:1f:4a:00 (try 1) [ 50.903286] wlan0: authenticated [ 50.903300] wlan0: associate with AP 98:4b:e1:1f:4a:00 (try 1) [ 50.904582] wlan0: RX AssocResp from 98:4b:e1:1f:4a:00 (capab=0x411 status=0 aid=4) [ 50.904584] wlan0: associated [ 51.682070] Intel AES-NI instructions are not detected. [ 51.725850] padlock: VIA PadLock not detected. [ 51.761263] wlan0: no IPv6 routers present [ 70.931315] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 98:4b:e1:1f:4a:00 tid = 0 [ 181.321601] /dev/vmmon[4906]: Module vmmon: registered with major=10 minor=165 [ 181.321611] /dev/vmmon[4906]: Initial HV check: anyNotCapable=0 anyUnlocked=0 anyEnabled=1 anyDisabled=0 [ 181.321616] /dev/vmmon[4906]: HV check: anyNotCapable=0 anyUnlocked=0 anyEnabled=1 anyDisabled=0 [ 181.321618] /dev/vmmon[4906]: Module vmmon: initialized [ 181.328811] /dev/vmci[4914]: VMCI: Driver initialized. [ 181.329132] /dev/vmci[4914]: Module vmci: registered with major=10 minor=53 [ 181.329135] /dev/vmci[4914]: Module vmci: initialized [ 181.436478] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 181.436486] /dev/vmnet: hub 0 does not exist, allocating memory. [ 181.436502] /dev/vmnet: port on hub 0 successfully opened [ 181.436513] bridge-wlan0: device is wireless, enabling SMAC [ 181.436516] bridge-wlan0: up [ 181.436519] bridge-wlan0: attached [ 182.662453] /dev/vmnet: open called by PID 4979 (vmnet-dhcpd) [ 182.662463] /dev/vmnet: hub 1 does not exist, allocating memory. [ 182.662479] /dev/vmnet: port on hub 1 successfully opened [ 182.666496] /dev/vmnet: open called by PID 4982 (vmnet-netifup) [ 182.666503] /dev/vmnet: port on hub 1 successfully opened [ 182.762464] /dev/vmnet: open called by PID 4985 (vmnet-dhcpd) [ 182.762472] /dev/vmnet: hub 8 does not exist, allocating memory. [ 182.762489] /dev/vmnet: port on hub 8 successfully opened [ 182.802702] /dev/vmnet: open called by PID 4991 (vmnet-natd) [ 182.802710] /dev/vmnet: port on hub 8 successfully opened [ 182.823327] /dev/vmnet: open called by PID 4992 (vmnet-netifup) [ 182.823334] /dev/vmnet: port on hub 8 successfully opened [ 192.691263] vmnet1: no IPv6 routers present [ 193.611260] vmnet8: no IPv6 routers present [ 194.141255] /dev/vmmon[5153]: PTSC: initialized at 2528264000 Hz using TSC [ 227.607796] /dev/vmnet: open called by PID 5163 (vmware-vmx) [ 227.607831] /dev/vmnet: port on hub 8 successfully opened [ 229.090091] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 229.440444] usb 1-5: reset high speed USB device using ehci_hcd and address 4 [ 229.632948] uvcvideo: Found UVC 1.00 device CKA7216 (04f2:b053) [ 229.650666] input: CKA7216 as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5:1.0/input/input12 [ 229.850314] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 230.231576] usb 1-5: reset high speed USB device using ehci_hcd and address 4 [ 230.422920] uvcvideo: Found UVC 1.00 device CKA7216 (04f2:b053) [ 230.439643] input: CKA7216 as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5:1.0/input/input13 [ 234.165089] usb 4-1: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.220794] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.221968] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.223081] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.224192] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.225302] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.226413] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.227524] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.228645] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.229758] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.230869] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.231984] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.233099] usb 1-5: usbfs: process 5153 (vmware-vmx) did not claim interface 0 before use [ 234.234224] usb 1-5: usbfs: interface 0 claimed by uvcvideo while 'vmware-vmx' sets config #1 [ 234.234277] usb 1-5: usbfs: interface 0 claimed by uvcvideo while 'vmware-vmx' sets config #1 [ 822.750811] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 823.140961] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 1098.000836] lo: Disabled Privacy Extensions [ 1182.140144] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 1182.171415] bridge-wlan0: disabling the bridge [ 1182.211272] bridge-wlan0: down [ 1182.211283] bridge-wlan0: detached [ 1182.274742] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 1182.274767] /dev/vmnet: hub 0 does not exist, allocating memory. [ 1182.274816] /dev/vmnet: port on hub 0 successfully opened [ 1182.274846] bridge-wlan0: device is wireless, enabling SMAC [ 1182.274856] bridge-wlan0: up [ 1182.274865] bridge-wlan0: attached [ 1182.274948] bridge-wlan0: disabling the bridge [ 1182.290041] bridge-wlan0: down [ 1182.290047] bridge-wlan0: detached [ 1185.297066] wlan0: deauthenticating from 98:4b:e1:1f:4a:10 by local choice (reason=3) [ 1185.323209] wlan0: direct probe to AP 98:4b:e1:1f:4a:00 (try 1) [ 1185.326454] wlan0: direct probe responded [ 1185.326465] wlan0: authenticate with AP 98:4b:e1:1f:4a:00 (try 1) [ 1185.327944] wlan0: authenticated [ 1185.328015] wlan0: associate with AP 98:4b:e1:1f:4a:00 (try 1) [ 1185.329369] wlan0: RX AssocResp from 98:4b:e1:1f:4a:00 (capab=0x411 status=0 aid=4) [ 1185.329376] wlan0: associated [ 1185.355757] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 1185.355795] /dev/vmnet: hub 0 does not exist, allocating memory. [ 1185.355846] /dev/vmnet: port on hub 0 successfully opened [ 1185.355869] bridge-wlan0: device is wireless, enabling SMAC [ 1185.355879] bridge-wlan0: up [ 1185.355885] bridge-wlan0: attached [ 1192.250657] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 98:4b:e1:1f:4a:00 tid = 0 [ 1388.651344] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 1388.652326] bridge-wlan0: disabling the bridge [ 1388.680038] bridge-wlan0: down [ 1388.680048] bridge-wlan0: detached [ 1388.701996] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 1388.702022] /dev/vmnet: hub 0 does not exist, allocating memory. [ 1388.702072] /dev/vmnet: port on hub 0 successfully opened [ 1388.702093] bridge-wlan0: device is wireless, enabling SMAC [ 1388.702102] bridge-wlan0: up [ 1388.702111] bridge-wlan0: attached [ 1388.702165] bridge-wlan0: disabling the bridge [ 1388.730090] bridge-wlan0: down [ 1388.730108] bridge-wlan0: detached [ 1411.605660] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 1411.631472] wlan0: direct probe to AP 98:4b:e1:1f:4a:00 (try 1) [ 1411.632932] wlan0: direct probe responded [ 1411.632935] wlan0: authenticate with AP 98:4b:e1:1f:4a:00 (try 1) [ 1411.633942] wlan0: authenticated [ 1411.633982] wlan0: associate with AP 98:4b:e1:1f:4a:00 (try 1) [ 1411.635321] wlan0: RX AssocResp from 98:4b:e1:1f:4a:00 (capab=0x411 status=0 aid=4) [ 1411.635324] wlan0: associated [ 1411.651649] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 1411.651676] /dev/vmnet: hub 0 does not exist, allocating memory. [ 1411.651726] /dev/vmnet: port on hub 0 successfully opened [ 1411.651747] bridge-wlan0: device is wireless, enabling SMAC [ 1411.651756] bridge-wlan0: up [ 1411.651838] bridge-wlan0: attached [ 1488.851926] /dev/vmnet: open called by PID 5153 (vmware-vmx) [ 1488.851947] /dev/vmnet: port on hub 8 successfully opened [ 1776.190123] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 1776.191446] bridge-wlan0: disabling the bridge [ 1776.221313] bridge-wlan0: down [ 1776.221332] bridge-wlan0: detached [ 1776.250122] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 1776.250134] /dev/vmnet: hub 0 does not exist, allocating memory. [ 1776.250150] /dev/vmnet: port on hub 0 successfully opened [ 1776.250159] bridge-wlan0: device is wireless, enabling SMAC [ 1776.250163] bridge-wlan0: up [ 1776.250167] bridge-wlan0: attached [ 1776.250187] bridge-wlan0: disabling the bridge [ 1776.250411] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 1776.271356] bridge-wlan0: down [ 1776.271369] bridge-wlan0: detached [ 1776.286386] wlan0: direct probe to AP 98:4b:e1:1f:4a:00 (try 1) [ 1776.287837] wlan0: direct probe responded [ 1776.287845] wlan0: authenticate with AP 98:4b:e1:1f:4a:00 (try 1) [ 1776.288764] wlan0: authenticated [ 1776.288805] wlan0: associate with AP 98:4b:e1:1f:4a:00 (try 1) [ 1776.289969] wlan0: RX AssocResp from 98:4b:e1:1f:4a:00 (capab=0x411 status=0 aid=4) [ 1776.289976] wlan0: associated [ 1776.311439] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 1776.311481] /dev/vmnet: hub 0 does not exist, allocating memory. [ 1776.311532] /dev/vmnet: port on hub 0 successfully opened [ 1776.311556] bridge-wlan0: device is wireless, enabling SMAC [ 1776.311565] bridge-wlan0: up [ 1776.312342] bridge-wlan0: attached [ 1911.318633] /dev/vmnet: open called by PID 5153 (vmware-vmx) [ 1911.318648] /dev/vmnet: port on hub 8 successfully opened [ 2108.531412] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 2108.533443] bridge-wlan0: disabling the bridge [ 2108.560071] bridge-wlan0: down [ 2108.560089] bridge-wlan0: detached [ 2108.566354] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 2108.566378] /dev/vmnet: hub 0 does not exist, allocating memory. [ 2108.566427] /dev/vmnet: port on hub 0 successfully opened [ 2108.566445] bridge-wlan0: device is wireless, enabling SMAC [ 2108.566453] bridge-wlan0: up [ 2108.566459] bridge-wlan0: attached [ 2108.566513] bridge-wlan0: disabling the bridge [ 2108.590040] bridge-wlan0: down [ 2108.590047] bridge-wlan0: detached [ 2111.680731] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 2111.711130] wlan0: direct probe to AP 98:4b:e1:1f:4a:00 (try 1) [ 2111.712669] wlan0: direct probe responded [ 2111.712677] wlan0: authenticate with AP 98:4b:e1:1f:4a:00 (try 1) [ 2111.713740] wlan0: authenticated [ 2111.713786] wlan0: associate with AP 98:4b:e1:1f:4a:00 (try 1) [ 2111.715134] wlan0: RX AssocResp from 98:4b:e1:1f:4a:00 (capab=0x411 status=0 aid=4) [ 2111.715141] wlan0: associated [ 2111.740422] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 2111.740449] /dev/vmnet: hub 0 does not exist, allocating memory. [ 2111.740498] /dev/vmnet: port on hub 0 successfully opened [ 2111.740519] bridge-wlan0: device is wireless, enabling SMAC [ 2111.740528] bridge-wlan0: up [ 2111.740615] bridge-wlan0: attached [ 2117.083546] CE: hpet increasing min_delta_ns to 15000 nsec [ 2172.107936] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 98:4b:e1:1f:4a:00 tid = 0 [ 2203.742108] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None [ 2203.742117] 0000:00:19.0: eth0: 10/100 speed: disabling TSO [ 2203.743471] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 2208.135691] bridge-wlan0: disabling the bridge [ 2208.151294] bridge-wlan0: down [ 2208.151302] bridge-wlan0: detached [ 2208.151348] /dev/vmnet: open called by PID 4971 (vmnet-bridge) [ 2208.151359] /dev/vmnet: hub 0 does not exist, allocating memory. [ 2208.151375] /dev/vmnet: port on hub 0 successfully opened [ 2208.151385] bridge-eth0: up [ 2208.151390] bridge-eth0: attached [ 2214.251276] eth0: no IPv6 routers present [ 2297.884749] CE: hpet increasing min_delta_ns to 22500 nsec [ 3959.069890] lo: Disabled Privacy Extensions [ 4076.380471] uvcvideo: Found UVC 1.00 device CKA7216 (04f2:b053) [ 4076.380509] uvcvideo: No streaming interface found for terminal 2. [ 4076.380667] input: CKA7216 as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5:1.0/input/input14 [ 4109.140453] /dev/vmci[8517]: Module vmci: unloaded [ 4109.146479] /dev/vmmon[8526]: Module vmmon: unloaded [ 4109.363982] bridge-eth0: disabling the bridge [ 4109.391552] bridge-eth0: down [ 4109.391566] bridge-eth0: detached [ 4111.299122] /dev/vmmon[8574]: Module vmmon: registered with major=10 minor=165 [ 4111.299143] /dev/vmmon[8574]: Initial HV check: anyNotCapable=0 anyUnlocked=0 anyEnabled=1 anyDisabled=0 [ 4111.299156] /dev/vmmon[8574]: HV check: anyNotCapable=0 anyUnlocked=0 anyEnabled=1 anyDisabled=0 [ 4111.299163] /dev/vmmon[8574]: Module vmmon: initialized [ 4111.345453] /dev/vmci[8582]: VMCI: Driver initialized. [ 4111.346902] /dev/vmci[8582]: Module vmci: registered with major=10 minor=53 [ 4111.346910] /dev/vmci[8582]: Module vmci: initialized [ 4111.526402] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [ 4111.526409] /dev/vmnet: hub 0 does not exist, allocating memory. [ 4111.526425] /dev/vmnet: port on hub 0 successfully opened [ 4111.526437] bridge-eth0: up [ 4111.526441] bridge-eth0: attached [ 4112.673324] /dev/vmnet: open called by PID 8646 (vmnet-dhcpd) [ 4112.673347] /dev/vmnet: hub 1 does not exist, allocating memory. [ 4112.673400] /dev/vmnet: port on hub 1 successfully opened [ 4112.678215] /dev/vmnet: open called by PID 8648 (vmnet-netifup) [ 4112.678239] /dev/vmnet: port on hub 1 successfully opened [ 4112.757370] /dev/vmnet: open called by PID 8651 (vmnet-dhcpd) [ 4112.757396] /dev/vmnet: hub 8 does not exist, allocating memory. [ 4112.757448] /dev/vmnet: port on hub 8 successfully opened [ 4112.824646] /dev/vmnet: open called by PID 8656 (vmnet-natd) [ 4112.824675] /dev/vmnet: port on hub 8 successfully opened [ 4112.830512] /dev/vmnet: open called by PID 8657 (vmnet-netifup) [ 4112.830638] /dev/vmnet: port on hub 8 successfully opened [ 4119.639066] /dev/vmmon[8737]: PTSC: initialized at 2534000000 Hz using TSC [ 4121.252254] /dev/vmnet: open called by PID 8744 (vmware-vmx) [ 4121.252288] /dev/vmnet: port on hub 8 successfully opened [ 4123.491263] vmnet8: no IPv6 routers present [ 4123.570020] vmnet1: no IPv6 routers present [ 4161.010323] usb 1-5: reset high speed USB device using ehci_hcd and address 4 [ 4161.202669] uvcvideo: Found UVC 1.00 device CKA7216 (04f2:b053) [ 4161.219704] input: CKA7216 as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5:1.0/input/input15 [ 4161.430349] usb 1-5: reset high speed USB device using ehci_hcd and address 4 [ 4161.622194] uvcvideo: Found UVC 1.00 device CKA7216 (04f2:b053) [ 4161.639183] input: CKA7216 as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5:1.0/input/input16 [ 4162.060175] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 4162.412847] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 4162.714772] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.716045] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.717234] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.718441] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.719710] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.720956] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.722473] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.723699] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.724897] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.727384] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.728576] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.729767] usb 1-5: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 4162.730959] usb 1-5: usbfs: interface 0 claimed by uvcvideo while 'vmware-vmx' sets config #1 [ 4162.731114] usb 1-5: usbfs: interface 0 claimed by uvcvideo while 'vmware-vmx' sets config #1 [ 8801.591543] cfg80211: Found new beacon on frequency: 5220 MHz (Ch 44) on phy0 [ 9110.969482] CPU0 attaching NULL sched-domain. [ 9110.969486] CPU1 attaching NULL sched-domain. [ 9111.020302] CPU0 attaching sched-domain: [ 9111.020310] domain 0: span 0-1 level MC [ 9111.020317] groups: 0 1 [ 9111.020329] CPU1 attaching sched-domain: [ 9111.020334] domain 0: span 0-1 level MC [ 9111.020340] groups: 1 0 [ 9112.358876] bridge-eth0: disabling the bridge [ 9112.380073] bridge-eth0: down [ 9112.380093] bridge-eth0: detached [ 9112.380228] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [ 9112.380249] /dev/vmnet: hub 0 does not exist, allocating memory. [ 9112.380298] /dev/vmnet: port on hub 0 successfully opened [ 9112.393330] bridge-wlan0: device is wireless, enabling SMAC [ 9112.393341] bridge-wlan0: up [ 9112.453340] bridge-wlan0: attached [ 9112.750072] wlan0: deauthenticating from 98:4b:e1:1f:4a:00 by local choice (reason=3) [ 9112.869505] bridge-wlan0: disabling the bridge on dev down [ 9112.891294] bridge-wlan0: down [ 9112.891570] bridge-wlan0: detached [ 9112.891681] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [ 9112.891706] /dev/vmnet: hub 0 does not exist, allocating memory. [ 9112.891756] /dev/vmnet: port on hub 0 successfully opened [ 9112.891776] bridge-wlan0: attached [ 9118.787514] PM: Syncing filesystems ... done. [ 9119.349073] PM: Preparing system for mem sleep [ 9119.349078] Freezing user space processes ... (elapsed 0.08 seconds) done. [ 9119.430926] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 9119.430979] PM: Entering mem sleep [ 9119.430992] Suspending console(s) (use no_console_suspend to debug) [ 9120.050140] PM: suspend of drv:psmouse dev:serio5 complete after 508.855 msecs [ 9120.070192] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 9120.070263] Monitor-Mwait will be used to enter C-2 state [ 9120.070287] Monitor-Mwait will be used to enter C-3 state [ 9120.076406] sd 0:0:0:0: [sda] Stopping disk [ 9120.724751] PM: suspend of drv:sd dev:0:0:0:0 complete after 654.558 msecs [ 9121.108926] PM: suspend of drv:psmouse dev:serio4 complete after 384.110 msecs [ 9121.210044] PM: suspend of drv:atkbd dev:serio0 complete after 101.100 msecs [ 9121.212252] parport_pc 00:09: disabled [ 9121.290189] tpm_tis 00:04: Operation Timed out [ 9121.291300] ACPI handle has no context! [ 9121.291307] sdhci-pci 0000:86:09.1: PCI INT B disabled [ 9121.291313] ACPI handle has no context! [ 9121.315240] ACPI handle has no context! [ 9121.392434] ata_piix 0000:00:1f.5: PCI INT C disabled [ 9121.410355] ata_piix 0000:00:1f.2: PCI INT A disabled [ 9121.430195] ehci_hcd 0000:00:1d.7: PCI INT D disabled [ 9121.430207] uhci_hcd 0000:00:1d.2: PCI INT C disabled [ 9121.430217] uhci_hcd 0000:00:1d.1: PCI INT B disabled [ 9121.430227] uhci_hcd 0000:00:1d.0: PCI INT A disabled [ 9121.650247] HDA Intel 0000:00:1b.0: PCI INT A disabled [ 9121.675289] HDA Intel 0000:00:1b.0: power state changed by ACPI to D3 [ 9121.675297] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 245.043 msecs [ 9121.675307] ehci_hcd 0000:00:1a.7: PCI INT D disabled [ 9121.675318] uhci_hcd 0000:00:1a.2: PCI INT C disabled [ 9121.675328] uhci_hcd 0000:00:1a.1: PCI INT B disabled [ 9121.675344] uhci_hcd 0000:00:1a.0: PCI INT A disabled [ 9121.675536] e1000e 0000:00:19.0: PCI INT A disabled [ 9121.675541] e1000e 0000:00:19.0: PME# enabled [ 9121.675546] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [ 9121.691497] PM: suspend of devices complete after 2260.085 msecs [ 9121.691499] PM: suspend devices took 2.260 seconds [ 9121.691940] ricoh-mmc: Suspending. [ 9121.691948] ricoh-mmc: Controller is now re-enabled. [ 9121.730238] PM: late suspend of devices complete after 38.734 msecs [ 9121.730880] ACPI: Preparing to enter system sleep state S3 [ 9121.780497] Disabling non-boot CPUs ... [ 9121.780513] CPU0 attaching NULL sched-domain. [ 9121.780515] CPU1 attaching NULL sched-domain. [ 9121.940016] CPU0 attaching NULL sched-domain. [ 9121.941148] Broke affinity for irq 12 [ 9121.941172] Broke affinity for irq 17 [ 9122.050023] CPU 1 is now offline [ 9122.050026] SMP alternatives: switching to UP code [ 9122.056610] Extended CMOS year: 2000 [ 9122.056610] Back to C! [ 9122.056610] CPU0: Thermal monitoring handled by SMI [ 9122.056610] Extended CMOS year: 2000 [ 9122.056610] Enabling non-boot CPUs ... [ 9122.056610] SMP alternatives: switching to SMP code [ 9122.062278] Booting processor 1 APIC 0x1 ip 0x6000 [ 9122.055747] Initializing CPU#1 [ 9122.055747] CPU: L1 I cache: 32K, L1 D cache: 32K [ 9122.055747] CPU: L2 cache: 6144K [ 9122.055747] CPU 1/0x1 -> Node 0 [ 9122.055747] CPU: Physical Processor ID: 0 [ 9122.055747] CPU: Processor Core ID: 1 [ 9122.055747] CPU1: Thermal monitoring handled by SMI [ 9122.220092] CPU1: Intel(R) Core(TM)2 Duo CPU T9400 @ 2.53GHz stepping 06 [ 9122.220148] /dev/vmmon[10642]: HostIF_ReadUptime: detected settimeofday: fixed uptimeBase old 18445438352134349821 new 18445438351441349842 attempts 1 [ 9122.220168] CPU0 attaching NULL sched-domain. [ 9122.290017] CPU0 attaching sched-domain: [ 9122.290019] domain 0: span 0-1 level MC [ 9122.290021] groups: 0 1 [ 9122.290024] CPU1 attaching sched-domain: [ 9122.290026] domain 0: span 0-1 level MC [ 9122.290027] groups: 1 0 [ 9122.290448] CPU1 is up [ 9122.291279] ACPI: Waking up from system sleep state S3 [ 9122.737988] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x80100, writing 0x8010a) [ 9122.737994] pcieport 0000:00:01.0: restoring config space at offset 0xa (was 0xf, writing 0x0) [ 9122.737999] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010) [ 9122.738003] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 9122.738031] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 9122.738046] e1000e 0000:00:19.0: restoring config space at offset 0x6 (was 0x1, writing 0x80c1) [ 9122.738051] e1000e 0000:00:19.0: restoring config space at offset 0x5 (was 0x0, writing 0xdb324000) [ 9122.738055] e1000e 0000:00:19.0: restoring config space at offset 0x4 (was 0x0, writing 0xdb300000) [ 9122.738062] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [ 9122.738086] uhci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 9122.738098] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x8 (was 0x1, writing 0x80a1) [ 9122.738110] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [ 9122.738130] uhci_hcd 0000:00:1a.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [ 9122.738142] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x8 (was 0x1, writing 0x8081) [ 9122.738154] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [ 9122.738173] uhci_hcd 0000:00:1a.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [ 9122.738185] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x8 (was 0x1, writing 0x8061) [ 9122.738197] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [ 9122.738223] ehci_hcd 0000:00:1a.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [ 9122.738240] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325400) [ 9122.738248] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [ 9122.738298] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [ 9122.738328] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 9122.738339] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdb51db41) [ 9122.738343] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xdb20db20) [ 9122.738348] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x9090) [ 9122.738352] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x20200) [ 9122.738359] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [ 9122.738365] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [ 9122.738409] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [ 9122.738420] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xdb71db61) [ 9122.738424] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xdb10db10) [ 9122.738429] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0xa0a0) [ 9122.738437] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [ 9122.738443] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [ 9122.738487] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [ 9122.738498] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xdb91db81) [ 9122.738503] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xdb00d710) [ 9122.738507] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x20000000, writing 0x6050) [ 9122.738512] pcieport 0000:00:1c.2: restoring config space at offset 0x6 (was 0x0, writing 0x440400) [ 9122.738519] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [ 9122.738524] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [ 9122.738568] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 9122.738579] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0xdbb1dba1) [ 9122.738584] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xd700d310) [ 9122.738588] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x4030) [ 9122.738593] pcieport 0000:00:1c.4: restoring config space at offset 0x6 (was 0x0, writing 0x854500) [ 9122.738600] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [ 9122.738605] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [ 9122.738643] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 9122.738656] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x8041) [ 9122.738668] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [ 9122.738686] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 9122.738699] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x8021) [ 9122.738711] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [ 9122.738730] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [ 9122.738742] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x8001) [ 9122.738754] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [ 9122.738779] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [ 9122.738797] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325000) [ 9122.738804] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [ 9122.738828] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x20000, writing 0x200ff) [ 9122.738839] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdff1dc01) [ 9122.738843] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xd300d300) [ 9122.738848] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x22802020) [ 9122.738852] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x20000000, writing 0x208a8600) [ 9122.738862] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100100, writing 0x100107) [ 9122.738937] ata_piix 0000:00:1f.2: restoring config space at offset 0x9 (was 0x1, writing 0x8101) [ 9122.738950] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [ 9122.738975] ata_piix 0000:00:1f.5: restoring config space at offset 0xf (was 0x300, writing 0x30a) [ 9122.738987] ata_piix 0000:00:1f.5: restoring config space at offset 0x8 (was 0x1, writing 0x80f1) [ 9122.738992] ata_piix 0000:00:1f.5: restoring config space at offset 0x7 (was 0x1, writing 0x8141) [ 9122.738996] ata_piix 0000:00:1f.5: restoring config space at offset 0x6 (was 0x1, writing 0x8121) [ 9122.739000] ata_piix 0000:00:1f.5: restoring config space at offset 0x5 (was 0x1, writing 0x8145) [ 9122.739005] ata_piix 0000:00:1f.5: restoring config space at offset 0x4 (was 0x1, writing 0x8129) [ 9122.739012] ata_piix 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [ 9122.739113] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 9122.739322] iwlagn 0000:03:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 9122.739356] iwlagn 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xdb100004) [ 9122.739363] iwlagn 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) [ 9122.739373] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006) [ 9122.739447] ohci1394 0000:86:09.0: restoring config space at offset 0xf (was 0x4020100, writing 0x402010a) [ 9122.739470] ohci1394 0000:86:09.0: restoring config space at offset 0x4 (was 0x0, writing 0xd3001000) [ 9122.739475] ohci1394 0000:86:09.0: restoring config space at offset 0x3 (was 0x800000, writing 0x804010) [ 9122.739504] sdhci-pci 0000:86:09.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 9122.739527] sdhci-pci 0000:86:09.1: restoring config space at offset 0x4 (was 0x0, writing 0xd3001b00) [ 9122.739532] sdhci-pci 0000:86:09.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 9122.739540] sdhci-pci 0000:86:09.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 9122.739565] ricoh-mmc 0000:86:09.2: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 9122.739588] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x4 (was 0x0, writing 0xd3001a00) [ 9122.739593] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 9122.739600] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 9122.739613] ricoh-mmc: Resuming. [ 9122.739623] ricoh-mmc: Controller is now disabled. [ 9122.739637] pci 0000:86:09.3: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 9122.739660] pci 0000:86:09.3: restoring config space at offset 0x4 (was 0x0, writing 0xd3001800) [ 9122.739665] pci 0000:86:09.3: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 9122.739673] pci 0000:86:09.3: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 9122.739694] pci 0000:86:09.4: restoring config space at offset 0xf (was 0x800200, writing 0x180020b) [ 9122.739700] pci 0000:86:09.4: restoring config space at offset 0xe (was 0x0, writing 0x24fc) [ 9122.739705] pci 0000:86:09.4: restoring config space at offset 0xd (was 0x0, writing 0x2400) [ 9122.739710] pci 0000:86:09.4: restoring config space at offset 0xc (was 0x0, writing 0x20fc) [ 9122.739715] pci 0000:86:09.4: restoring config space at offset 0xb (was 0x0, writing 0x2000) [ 9122.739721] pci 0000:86:09.4: restoring config space at offset 0xa (was 0x0, writing 0xf3fff000) [ 9122.739726] pci 0000:86:09.4: restoring config space at offset 0x9 (was 0x0, writing 0xf0000000) [ 9122.739731] pci 0000:86:09.4: restoring config space at offset 0x8 (was 0x0, writing 0xdffff000) [ 9122.739736] pci 0000:86:09.4: restoring config space at offset 0x7 (was 0x0, writing 0xdc000000) [ 9122.739742] pci 0000:86:09.4: restoring config space at offset 0x6 (was 0x0, writing 0xb08a8786) [ 9122.739749] pci 0000:86:09.4: restoring config space at offset 0x4 (was 0x0, writing 0xd3000000) [ 9122.739754] pci 0000:86:09.4: restoring config space at offset 0x3 (was 0x820000, writing 0x824000) [ 9122.751263] yenta_cardbus 0000:86:09.5: Refused to change power state, currently in D3 [ 9123.480017] PM: early resume of drv:yenta_cardbus dev:0000:86:09.5 complete after 740.242 msecs [ 9123.480309] PM: early resume of devices complete after 742.451 msecs [ 9123.561053] e1000e 0000:00:19.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [ 9123.561058] e1000e 0000:00:19.0: setting latency timer to 64 [ 9123.561063] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [ 9123.561068] e1000e 0000:00:19.0: PME# disabled [ 9123.561105] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [ 9123.622253] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 9123.622259] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [ 9123.622281] usb usb3: root hub lost power or was reset [ 9123.622308] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 9123.622319] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [ 9123.622343] usb usb4: root hub lost power or was reset [ 9123.622361] uhci_hcd 0000:00:1a.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 9123.622372] uhci_hcd 0000:00:1a.2: setting latency timer to 64 [ 9123.622395] usb usb5: root hub lost power or was reset [ 9123.622414] ehci_hcd 0000:00:1a.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 9123.622419] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [ 9123.627225] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [ 9123.627287] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [ 9123.627323] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [ 9123.627359] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [ 9123.627365] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [ 9123.627370] HDA Intel 0000:00:1b.0: setting latency timer to 64 [ 9123.627401] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 9123.627406] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 9123.627428] usb usb6: root hub lost power or was reset [ 9123.627455] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [ 9123.627460] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 9123.627482] usb usb7: root hub lost power or was reset [ 9123.627500] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 9123.627506] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [ 9123.627527] usb usb8: root hub lost power or was reset [ 9123.627545] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 20 (level, low) -> IRQ 20 [ 9123.627550] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 9123.627574] pci 0000:00:1e.0: setting latency timer to 64 [ 9123.627586] ata_piix 0000:00:1f.2: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [ 9123.627590] ata_piix 0000:00:1f.2: setting latency timer to 64 [ 9123.627606] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 9123.627620] ata_piix 0000:00:1f.5: setting latency timer to 64 [ 9123.986574] ata3: SATA link down (SStatus 0 SControl 300) [ 9124.001881] ata4: SATA link down (SStatus 0 SControl 310) [ 9124.161635] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 9124.183504] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [ 9124.183506] ata2.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [ 9124.223622] ata2.00: configured for UDMA/100 [ 9124.357982] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 730.323 msecs [ 9124.412745] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[20] MMIO=[d3001000-d30017ff] Max Packet=[2048] IR/IT contexts=[4/4] [ 9124.418776] sdhci-pci 0000:86:09.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [ 9124.630048] tpm_tis 00:04: Operation Timed out [ 9124.630051] PM: resume of drv:tpm_tis dev:00:04 complete after 209.963 msecs [ 9124.632712] parport_pc 00:09: activated [ 9124.910018] PM: resume of drv:usb dev:usb1 complete after 276.861 msecs [ 9125.081303] PM: resume of drv:usb dev:usb2 complete after 171.271 msecs [ 9125.351289] PM: resume of drv:usb dev:usb4 complete after 269.961 msecs [ 9125.621290] PM: resume of drv:usb dev:usb6 complete after 269.975 msecs [ 9125.622887] sd 0:0:0:0: [sda] Starting disk [ 9126.561331] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 9126.581522] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [ 9126.581525] ata1.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [ 9126.622838] ata1.00: configured for UDMA/133 [ 9126.635597] PM: resume of drv:sd dev:0:0:0:0 complete after 1012.710 msecs [ 9126.810040] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 9126.966347] usbfs 4-1:1.0: no reset_resume for driver usbfs? [ 9126.966361] PM: resume of drv:usb dev:4-1 complete after 275.336 msecs [ 9127.230013] usb 6-1: reset low speed USB device using uhci_hcd and address 2 [ 9127.542312] PM: resume of drv:usb dev:6-1 complete after 575.934 msecs [ 9127.582533] PM: resume of devices complete after 4102.171 msecs [ 9127.582750] PM: resume devices took 4.100 seconds [ 9127.582788] PM: Finishing wakeup. [ 9127.582789] Restarting tasks ... done. [ 9127.970698] usb 3-1: new full speed USB device using uhci_hcd and address 10 [ 9128.110042] usb 3-1: device descriptor read/64, error -71 [ 9128.350020] usb 3-1: device descriptor read/64, error -71 [ 9128.630024] usb 3-1: new full speed USB device using uhci_hcd and address 11 [ 9128.751744] usb 3-1: device descriptor read/64, error -71 [ 9128.992675] usb 3-1: device descriptor read/64, error -71 [ 9129.222160] usb 3-1: new full speed USB device using uhci_hcd and address 12 [ 9129.640019] usb 3-1: device not accepting address 12, error -71 [ 9129.695274] usb 4-1: usbfs: process 8737 (vmware-vmx) did not claim interface 0 before use [ 9129.761280] usb 3-1: new full speed USB device using uhci_hcd and address 13 [ 9130.181357] usb 3-1: device not accepting address 13, error -71 [ 9130.181372] hub 3-0:1.0: unable to enumerate USB device on port 1 [ 9130.301268] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 9131.050488] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [ 9131.110059] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [ 9131.110555] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 9131.156114] Registered led device: iwl-phy0::radio [ 9131.156453] Registered led device: iwl-phy0::assoc [ 9131.156778] Registered led device: iwl-phy0::RX [ 9131.157105] Registered led device: iwl-phy0::TX [ 9131.201022] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 9131.201041] bridge-wlan0: enabling the bridge on dev up [ 9131.201045] bridge-wlan0: device is wireless, enabling SMAC [ 9131.201050] bridge-wlan0: up [ 9131.201065] bridge-wlan0: disabling the bridge [ 9131.221271] bridge-wlan0: down [ 9131.221277] bridge-wlan0: detached [ 9131.320025] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [ 9131.880280] CPU0 attaching NULL sched-domain. [ 9131.880285] CPU1 attaching NULL sched-domain. [ 9131.950090] CPU0 attaching sched-domain: [ 9131.950093] domain 0: span 0-1 level MC [ 9131.950095] groups: 0 1 [ 9131.950100] CPU1 attaching sched-domain: [ 9131.950102] domain 0: span 0-1 level MC [ 9131.950104] groups: 1 0 [ 9143.177768] wlan0: deauthenticating from 00:22:f7:21:5f:28 by local choice (reason=3) [ 9143.220788] wlan0: direct probe to AP 00:22:f7:21:5f:28 (try 1) [ 9143.225151] wlan0: direct probe responded [ 9143.225153] wlan0: authenticate with AP 00:22:f7:21:5f:28 (try 1) [ 9143.228854] wlan0: authenticated [ 9143.228865] wlan0: associate with AP 00:22:f7:21:5f:28 (try 1) [ 9143.232573] wlan0: RX AssocResp from 00:22:f7:21:5f:28 (capab=0x411 status=0 aid=2) [ 9143.232576] wlan0: associated [ 9143.238111] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 9143.510539] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [ 9143.510552] /dev/vmnet: hub 0 does not exist, allocating memory. [ 9143.510568] /dev/vmnet: port on hub 0 successfully opened [ 9143.510576] bridge-wlan0: device is wireless, enabling SMAC [ 9143.510579] bridge-wlan0: up [ 9143.510582] bridge-wlan0: attached [ 9153.350033] wlan0: no IPv6 routers present [ 9242.910257] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 0 [11998.040143] hub 6-0:1.0: port 1 disabled by hub (EMI?), re-enabling... [11998.040156] usb 6-1: USB disconnect, address 2 [11998.350079] usb 6-1: new low speed USB device using uhci_hcd and address 3 [11998.527754] usb 6-1: configuration #1 chosen from 1 choice [11998.549852] input: Logitech Trackball as /devices/pci0000:00/0000:00:1d.0/usb6/6-1/6-1:1.0/input/input17 [11998.549956] generic-usb 0003:046D:C404.0002: input,hidraw0: USB HID v1.10 Mouse [Logitech Trackball] on usb-0000:00:1d.0-1/input0 [11999.530052] usb 3-1: new full speed USB device using uhci_hcd and address 14 [11999.660067] usb 3-1: device descriptor read/64, error -71 [11999.901304] usb 3-1: device descriptor read/64, error -71 [12000.131533] usb 3-1: new full speed USB device using uhci_hcd and address 15 [12000.260061] usb 3-1: device descriptor read/64, error -71 [12000.500070] usb 3-1: device descriptor read/64, error -71 [12000.730076] usb 3-1: new full speed USB device using uhci_hcd and address 16 [12001.151308] usb 3-1: device not accepting address 16, error -71 [12001.270117] usb 3-1: new full speed USB device using uhci_hcd and address 17 [12001.700028] usb 3-1: device not accepting address 17, error -71 [12001.700046] hub 3-0:1.0: unable to enumerate USB device on port 1 [12736.390134] usb 3-1: new full speed USB device using uhci_hcd and address 18 [12736.521303] usb 3-1: device descriptor read/64, error -71 [12736.761381] usb 3-1: device descriptor read/64, error -71 [12736.991284] usb 3-1: new full speed USB device using uhci_hcd and address 19 [12737.120025] usb 3-1: device descriptor read/64, error -71 [12737.361275] usb 3-1: device descriptor read/64, error -71 [12737.591326] usb 3-1: new full speed USB device using uhci_hcd and address 20 [12738.011395] usb 3-1: device not accepting address 20, error -71 [12738.131341] usb 3-1: new full speed USB device using uhci_hcd and address 21 [12738.560168] usb 3-1: device not accepting address 21, error -71 [12738.560209] hub 3-0:1.0: unable to enumerate USB device on port 1 [15073.820149] usb 2-2: new high speed USB device using ehci_hcd and address 3 [15073.992567] usb 2-2: configuration #1 chosen from 1 choice [15074.082823] Initializing USB Mass Storage driver... [15074.084100] scsi5 : SCSI emulation for USB Mass Storage devices [15074.084354] usb-storage: device found at 3 [15074.084359] usb-storage: waiting for device to settle before scanning [15074.084395] usbcore: registered new interface driver usb-storage [15074.084403] USB Mass Storage support registered. [15075.510216] usb 2-2: reset high speed USB device using ehci_hcd and address 3 [15075.667215] scsi6 : SCSI emulation for USB Mass Storage devices [15075.672340] usb-storage: device found at 3 [15075.672346] usb-storage: waiting for device to settle before scanning [15075.831581] usb 2-2: reset high speed USB device using ehci_hcd and address 3 [15076.081986] usb 2-2: usbfs: interface 0 claimed by usb-storage while 'vmware-vmx' sets config #1 [18825.920405] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 6 [45474.617395] usb 2-2: USB disconnect, address 3 [72357.707894] CPU0 attaching NULL sched-domain. [72357.707905] CPU1 attaching NULL sched-domain. [72357.760259] CPU0 attaching sched-domain: [72357.760268] domain 0: span 0-1 level MC [72357.760274] groups: 0 1 [72357.760288] CPU1 attaching sched-domain: [72357.760293] domain 0: span 0-1 level MC [72357.760299] groups: 1 0 [72359.210467] wlan0: deauthenticating from 00:22:f7:21:5f:28 by local choice (reason=3) [72359.241767] bridge-wlan0: disabling the bridge [72359.270210] bridge-wlan0: down [72359.270229] bridge-wlan0: detached [72359.333916] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [72359.333941] /dev/vmnet: hub 0 does not exist, allocating memory. [72359.333991] /dev/vmnet: port on hub 0 successfully opened [72359.334019] bridge-wlan0: device is wireless, enabling SMAC [72359.334029] bridge-wlan0: up [72359.449054] bridge-wlan0: attached [72359.449103] bridge-wlan0: disabling the bridge [72359.470093] bridge-wlan0: down [72359.470108] bridge-wlan0: detached [72364.957487] PM: Syncing filesystems ... done. [72365.421264] PM: Preparing system for mem sleep [72365.421269] Freezing user space processes ... (elapsed 0.00 seconds) done. [72365.422279] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [72365.422329] PM: Entering mem sleep [72365.422341] Suspending console(s) (use no_console_suspend to debug) [72365.570044] PM: suspend of drv:ieee80211 dev:phy0 complete after 129.920 msecs [72366.085504] PM: suspend of drv:psmouse dev:serio5 complete after 495.474 msecs [72366.100063] sd 0:0:0:0: [sda] Synchronizing SCSI cache [72366.110503] sd 0:0:0:0: [sda] Stopping disk [72366.754913] PM: suspend of drv:sd dev:0:0:0:0 complete after 654.849 msecs [72367.143655] PM: suspend of drv:psmouse dev:serio4 complete after 388.679 msecs [72367.242265] parport_pc 00:09: disabled [72367.320019] tpm_tis 00:04: Operation Timed out [72367.321107] ACPI handle has no context! [72367.321114] sdhci-pci 0000:86:09.1: PCI INT B disabled [72367.321120] ACPI handle has no context! [72367.345103] ACPI handle has no context! [72367.451686] ata_piix 0000:00:1f.5: PCI INT C disabled [72367.470172] ata_piix 0000:00:1f.2: PCI INT A disabled [72367.490059] ehci_hcd 0000:00:1d.7: PCI INT D disabled [72367.490070] uhci_hcd 0000:00:1d.2: PCI INT C disabled [72367.490081] uhci_hcd 0000:00:1d.1: PCI INT B disabled [72367.490091] uhci_hcd 0000:00:1d.0: PCI INT A disabled [72367.600315] HDA Intel 0000:00:1b.0: PCI INT A disabled [72367.624421] HDA Intel 0000:00:1b.0: power state changed by ACPI to D3 [72367.624429] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 134.306 msecs [72367.624440] ehci_hcd 0000:00:1a.7: PCI INT D disabled [72367.624450] uhci_hcd 0000:00:1a.2: PCI INT C disabled [72367.624460] uhci_hcd 0000:00:1a.1: PCI INT B disabled [72367.624471] uhci_hcd 0000:00:1a.0: PCI INT A disabled [72367.624672] e1000e 0000:00:19.0: PCI INT A disabled [72367.624677] e1000e 0000:00:19.0: PME# enabled [72367.624682] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [72367.641420] PM: suspend of devices complete after 2218.660 msecs [72367.641423] PM: suspend devices took 2.220 seconds [72367.641879] ricoh-mmc: Suspending. [72367.641889] ricoh-mmc: Controller is now re-enabled. [72367.680256] PM: late suspend of devices complete after 38.828 msecs [72367.680898] ACPI: Preparing to enter system sleep state S3 [72367.730766] Disabling non-boot CPUs ... [72367.730785] CPU0 attaching NULL sched-domain. [72367.730787] CPU1 attaching NULL sched-domain. [72367.850016] CPU0 attaching NULL sched-domain. [72367.851134] Broke affinity for irq 5 [72367.960019] CPU 1 is now offline [72367.960022] SMP alternatives: switching to UP code [72367.965776] Extended CMOS year: 2000 [72367.965776] Back to C! [72367.965776] CPU0: Thermal monitoring handled by SMI [72367.965776] Extended CMOS year: 2000 [72367.965776] Enabling non-boot CPUs ... [72367.965776] SMP alternatives: switching to SMP code [72367.971452] Booting processor 1 APIC 0x1 ip 0x6000 [72367.965730] Initializing CPU#1 [72367.965730] CPU: L1 I cache: 32K, L1 D cache: 32K [72367.965730] CPU: L2 cache: 6144K [72367.965730] CPU 1/0x1 -> Node 0 [72367.965730] CPU: Physical Processor ID: 0 [72367.965730] CPU: Processor Core ID: 1 [72367.965730] CPU1: Thermal monitoring handled by SMI [72368.130069] CPU1: Intel(R) Core(TM)2 Duo CPU T9400 @ 2.53GHz stepping 06 [72368.130126] /dev/vmmon[740]: HostIF_ReadUptime: detected settimeofday: fixed uptimeBase old 18445438351441349842 new 18445438350353349751 attempts 1 [72368.130151] CPU0 attaching NULL sched-domain. [72368.200017] CPU0 attaching sched-domain: [72368.200020] domain 0: span 0-1 level MC [72368.200021] groups: 0 1 [72368.200025] CPU1 attaching sched-domain: [72368.200026] domain 0: span 0-1 level MC [72368.200028] groups: 1 0 [72368.200449] CPU1 is up [72368.201283] ACPI: Waking up from system sleep state S3 [72368.447969] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x80100, writing 0x8010a) [72368.447974] pcieport 0000:00:01.0: restoring config space at offset 0xa (was 0xf, writing 0x0) [72368.447980] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010) [72368.447983] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [72368.448012] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [72368.448027] e1000e 0000:00:19.0: restoring config space at offset 0x6 (was 0x1, writing 0x80c1) [72368.448031] e1000e 0000:00:19.0: restoring config space at offset 0x5 (was 0x0, writing 0xdb324000) [72368.448035] e1000e 0000:00:19.0: restoring config space at offset 0x4 (was 0x0, writing 0xdb300000) [72368.448042] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [72368.448067] uhci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [72368.448079] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x8 (was 0x1, writing 0x80a1) [72368.448091] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [72368.448111] uhci_hcd 0000:00:1a.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [72368.448123] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x8 (was 0x1, writing 0x8081) [72368.448135] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [72368.448154] uhci_hcd 0000:00:1a.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [72368.448166] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x8 (was 0x1, writing 0x8061) [72368.448178] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [72368.448205] ehci_hcd 0000:00:1a.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [72368.448223] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325400) [72368.448230] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [72368.448280] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [72368.448310] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [72368.448321] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdb51db41) [72368.448326] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xdb20db20) [72368.448330] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x20009090) [72368.448335] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x20200) [72368.448342] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [72368.448348] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [72368.448392] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [72368.448403] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xdb71db61) [72368.448408] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xdb10db10) [72368.448412] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x2000a0a0) [72368.448421] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [72368.448426] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [72368.448471] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [72368.448482] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xdb91db81) [72368.448486] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xdb00d710) [72368.448491] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x20000000, writing 0x20006050) [72368.448495] pcieport 0000:00:1c.2: restoring config space at offset 0x6 (was 0x0, writing 0x440400) [72368.448502] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [72368.448508] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [72368.448552] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x10a) [72368.448563] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0xdbb1dba1) [72368.448568] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xd700d310) [72368.448572] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x20004030) [72368.448577] pcieport 0000:00:1c.4: restoring config space at offset 0x6 (was 0x0, writing 0x854500) [72368.448584] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [72368.448590] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [72368.448628] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [72368.448640] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x8041) [72368.448653] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [72368.448672] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [72368.448684] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x8021) [72368.448696] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [72368.448715] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [72368.448727] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x8001) [72368.448739] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [72368.448765] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [72368.448783] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325000) [72368.448790] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [72368.448815] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x20000, writing 0x200ff) [72368.448826] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdff1dc01) [72368.448830] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xd300d300) [72368.448835] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x22802020) [72368.448839] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x20000000, writing 0x208a8600) [72368.448849] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100100, writing 0x100107) [72368.448924] ata_piix 0000:00:1f.2: restoring config space at offset 0x9 (was 0x1, writing 0x8101) [72368.448937] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [72368.448962] ata_piix 0000:00:1f.5: restoring config space at offset 0xf (was 0x300, writing 0x30a) [72368.448974] ata_piix 0000:00:1f.5: restoring config space at offset 0x8 (was 0x1, writing 0x80f1) [72368.448979] ata_piix 0000:00:1f.5: restoring config space at offset 0x7 (was 0x1, writing 0x8141) [72368.448983] ata_piix 0000:00:1f.5: restoring config space at offset 0x6 (was 0x1, writing 0x8121) [72368.448988] ata_piix 0000:00:1f.5: restoring config space at offset 0x5 (was 0x1, writing 0x8145) [72368.448992] ata_piix 0000:00:1f.5: restoring config space at offset 0x4 (was 0x1, writing 0x8129) [72368.448999] ata_piix 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [72368.449100] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [72368.449309] iwlagn 0000:03:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [72368.449343] iwlagn 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xdb100004) [72368.449350] iwlagn 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) [72368.449360] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100406) [72368.449431] ohci1394 0000:86:09.0: restoring config space at offset 0xf (was 0x4020100, writing 0x402010a) [72368.449454] ohci1394 0000:86:09.0: restoring config space at offset 0x4 (was 0x0, writing 0xd3001000) [72368.449459] ohci1394 0000:86:09.0: restoring config space at offset 0x3 (was 0x800000, writing 0x804010) [72368.449488] sdhci-pci 0000:86:09.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [72368.449511] sdhci-pci 0000:86:09.1: restoring config space at offset 0x4 (was 0x0, writing 0xd3001b00) [72368.449517] sdhci-pci 0000:86:09.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [72368.449524] sdhci-pci 0000:86:09.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [72368.449549] ricoh-mmc 0000:86:09.2: restoring config space at offset 0xf (was 0x200, writing 0x20b) [72368.449572] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x4 (was 0x0, writing 0xd3001a00) [72368.449578] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [72368.449585] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [72368.449598] ricoh-mmc: Resuming. [72368.449608] ricoh-mmc: Controller is now disabled. [72368.449621] pci 0000:86:09.3: restoring config space at offset 0xf (was 0x200, writing 0x20b) [72368.449644] pci 0000:86:09.3: restoring config space at offset 0x4 (was 0x0, writing 0xd3001800) [72368.449649] pci 0000:86:09.3: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [72368.449656] pci 0000:86:09.3: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [72368.449678] pci 0000:86:09.4: restoring config space at offset 0xf (was 0x800200, writing 0x180020b) [72368.449683] pci 0000:86:09.4: restoring config space at offset 0xe (was 0x0, writing 0x24fc) [72368.449689] pci 0000:86:09.4: restoring config space at offset 0xd (was 0x0, writing 0x2400) [72368.449694] pci 0000:86:09.4: restoring config space at offset 0xc (was 0x0, writing 0x20fc) [72368.449699] pci 0000:86:09.4: restoring config space at offset 0xb (was 0x0, writing 0x2000) [72368.449704] pci 0000:86:09.4: restoring config space at offset 0xa (was 0x0, writing 0xf3fff000) [72368.449709] pci 0000:86:09.4: restoring config space at offset 0x9 (was 0x0, writing 0xf0000000) [72368.449715] pci 0000:86:09.4: restoring config space at offset 0x8 (was 0x0, writing 0xdffff000) [72368.449720] pci 0000:86:09.4: restoring config space at offset 0x7 (was 0x0, writing 0xdc000000) [72368.449725] pci 0000:86:09.4: restoring config space at offset 0x6 (was 0x0, writing 0xb08a8786) [72368.449732] pci 0000:86:09.4: restoring config space at offset 0x4 (was 0x0, writing 0xd3000000) [72368.449738] pci 0000:86:09.4: restoring config space at offset 0x3 (was 0x820000, writing 0x824000) [72368.460017] yenta_cardbus 0000:86:09.5: Refused to change power state, currently in D3 [72369.190020] PM: early resume of drv:yenta_cardbus dev:0000:86:09.5 complete after 740.262 msecs [72369.190315] PM: early resume of devices complete after 742.479 msecs [72369.270593] e1000e 0000:00:19.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [72369.270598] e1000e 0000:00:19.0: setting latency timer to 64 [72369.270604] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [72369.270608] e1000e 0000:00:19.0: PME# disabled [72369.270645] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [72369.333488] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [72369.333494] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [72369.333516] usb usb3: root hub lost power or was reset [72369.333543] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [72369.333555] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [72369.333579] usb usb4: root hub lost power or was reset [72369.333597] uhci_hcd 0000:00:1a.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [72369.333607] uhci_hcd 0000:00:1a.2: setting latency timer to 64 [72369.333631] usb usb5: root hub lost power or was reset [72369.333650] ehci_hcd 0000:00:1a.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [72369.333655] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [72369.338755] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [72369.338816] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [72369.338853] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [72369.338889] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [72369.338894] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [72369.338900] HDA Intel 0000:00:1b.0: setting latency timer to 64 [72369.338933] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [72369.338938] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [72369.338959] usb usb6: root hub lost power or was reset [72369.338986] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [72369.338991] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [72369.339013] usb usb7: root hub lost power or was reset [72369.339031] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [72369.339037] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [72369.339058] usb usb8: root hub lost power or was reset [72369.339076] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 20 (level, low) -> IRQ 20 [72369.339082] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [72369.339094] pci 0000:00:1e.0: setting latency timer to 64 [72369.339106] ata_piix 0000:00:1f.2: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [72369.339110] ata_piix 0000:00:1f.2: setting latency timer to 64 [72369.339126] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [72369.339140] ata_piix 0000:00:1f.5: setting latency timer to 64 [72369.696605] ata4: SATA link down (SStatus 0 SControl 310) [72369.711981] ata3: SATA link down (SStatus 0 SControl 300) [72369.871639] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [72369.893358] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [72369.893360] ata2.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [72369.933381] ata2.00: configured for UDMA/100 [72370.073608] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 734.427 msecs [72370.132243] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[20] MMIO=[d3001000-d30017ff] Max Packet=[2048] IR/IT contexts=[4/4] [72370.138270] sdhci-pci 0000:86:09.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [72370.350018] tpm_tis 00:04: Operation Timed out [72370.350021] PM: resume of drv:tpm_tis dev:00:04 complete after 210.456 msecs [72370.352662] parport_pc 00:09: activated [72370.630065] PM: resume of drv:usb dev:usb1 complete after 276.960 msecs [72370.800031] PM: resume of drv:usb dev:usb2 complete after 169.952 msecs [72371.070064] PM: resume of drv:usb dev:usb4 complete after 270.007 msecs [72371.340058] PM: resume of drv:usb dev:usb6 complete after 269.965 msecs [72371.341690] sd 0:0:0:0: [sda] Starting disk [72372.451354] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [72372.471521] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [72372.471524] ata1.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [72372.532857] ata1.00: configured for UDMA/133 [72372.548503] PM: resume of drv:sd dev:0:0:0:0 complete after 1206.814 msecs [72372.720037] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [72372.876101] usbfs 4-1:1.0: no reset_resume for driver usbfs? [72372.876116] PM: resume of drv:usb dev:4-1 complete after 275.022 msecs [72372.916359] PM: resume of devices complete after 3726.001 msecs [72372.916579] PM: resume devices took 3.720 seconds [72372.916616] PM: Finishing wakeup. [72372.916617] Restarting tasks ... [72372.916679] usb 6-1: USB disconnect, address 3 [72372.927088] done. [72373.301279] usb 3-1: new full speed USB device using uhci_hcd and address 22 [72373.431321] usb 3-1: device descriptor read/64, error -71 [72373.670025] usb 3-1: device descriptor read/64, error -71 [72373.902008] usb 3-1: new full speed USB device using uhci_hcd and address 23 [72373.921829] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [72373.980475] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [72373.981021] ADDRCONF(NETDEV_UP): eth0: link is not ready [72374.031276] usb 3-1: device descriptor read/64, error -71 [72374.271272] usb 3-1: device descriptor read/64, error -71 [72374.501275] usb 3-1: new full speed USB device using uhci_hcd and address 24 [72374.921291] usb 3-1: device not accepting address 24, error -71 [72375.040569] usb 3-1: new full speed USB device using uhci_hcd and address 25 [72375.460035] usb 3-1: device not accepting address 25, error -71 [72375.460057] hub 3-0:1.0: unable to enumerate USB device on port 1 [72391.420328] NetworkManager: page allocation failure. order:4, mode:0x40d0 [72391.420349] Pid: 1041, comm: NetworkManager Tainted: P 2.6.32-31-generic #61-Ubuntu [72391.420355] Call Trace: [72391.420374] [] __alloc_pages_slowpath+0x4a9/0x590 [72391.420385] [] __alloc_pages_nodemask+0x15e/0x1a0 [72391.420397] [] alloc_pages_current+0x87/0xd0 [72391.420406] [] __get_free_pages+0xe/0x50 [72391.420442] [] iwl_tx_queue_alloc+0x50/0x220 [iwlcore] [72391.420462] [] ? iwl_tx_queue_init+0xc5/0x210 [iwlcore] [72391.420482] [] iwl_tx_queue_init+0x13f/0x210 [iwlcore] [72391.420502] [] iwl_txq_ctx_reset+0x297/0x4b0 [iwlcore] [72391.420522] [] iwl_hw_nic_init+0xf8/0x170 [iwlcore] [72391.420537] [] __iwl_up+0x9f/0x390 [iwlagn] [72391.420551] [] iwl_mac_start+0x5a/0x1f0 [iwlagn] [72391.420563] [] ? default_spin_lock_flags+0x9/0x10 [72391.420589] [] ieee80211_open+0x391/0x840 [mac80211] [72391.420600] [] ? notifier_call_chain+0x56/0x80 [72391.420611] [] dev_open+0xa2/0x100 [72391.420618] [] dev_change_flags+0xa1/0x1e0 [72391.420628] [] do_setlink+0x1af/0x430 [72391.420639] [] ? nla_parse+0x34/0x110 [72391.420648] [] rtnl_setlink+0x132/0x180 [72391.420657] [] rtnetlink_rcv_msg+0x1e0/0x220 [72391.420665] [] ? rtnetlink_rcv_msg+0x0/0x220 [72391.420675] [] netlink_rcv_skb+0xa9/0xd0 [72391.420683] [] rtnetlink_rcv+0x25/0x40 [72391.420691] [] netlink_unicast+0x2de/0x2f0 [72391.420699] [] netlink_sendmsg+0x1fe/0x2e0 [72391.420709] [] sock_sendmsg+0x10b/0x140 [72391.420717] [] ? sock_recvmsg+0x11e/0x150 [72391.420728] [] ? autoremove_wake_function+0x0/0x40 [72391.420737] [] ? move_addr_to_kernel+0x64/0x70 [72391.420746] [] ? verify_iovec+0x66/0xd0 [72391.420754] [] sys_sendmsg+0x233/0x3a0 [72391.420762] [] ? sys_sendto+0x185/0x190 [72391.420773] [] ? fput+0x25/0x30 [72391.420781] [] ? filp_close+0x5d/0x90 [72391.420792] [] system_call_fastpath+0x16/0x1b [72391.420797] Mem-Info: [72391.420801] Node 0 DMA per-cpu: [72391.420808] CPU 0: hi: 0, btch: 1 usd: 0 [72391.420813] CPU 1: hi: 0, btch: 1 usd: 0 [72391.420818] Node 0 DMA32 per-cpu: [72391.420824] CPU 0: hi: 186, btch: 31 usd: 0 [72391.420829] CPU 1: hi: 186, btch: 31 usd: 0 [72391.420833] Node 0 Normal per-cpu: [72391.420839] CPU 0: hi: 186, btch: 31 usd: 0 [72391.420844] CPU 1: hi: 186, btch: 31 usd: 0 [72391.420856] active_anon:555428 inactive_anon:197592 isolated_anon:11 [72391.420859] active_file:41715 inactive_file:77617 isolated_file:29 [72391.420861] unevictable:13 dirty:816 writeback:570 unstable:0 [72391.420864] free:43375 slab_reclaimable:18387 slab_unreclaimable:6444 [72391.420866] mapped:38388 shmem:3066 pagetables:7627 bounce:0 [72391.420872] Node 0 DMA free:15908kB min:28kB low:32kB high:40kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15344kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:8kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72391.420896] lowmem_reserve[]: 0 2964 3974 3974 [72391.420906] Node 0 DMA32 free:142948kB min:6004kB low:7504kB high:9004kB active_anon:2037080kB inactive_anon:543056kB active_file:27552kB inactive_file:108912kB unevictable:4kB isolated(anon):0kB isolated(file):32kB present:3036024kB mlocked:4kB dirty:132kB writeback:860kB mapped:36080kB shmem:5744kB slab_reclaimable:34756kB slab_unreclaimable:5016kB kernel_stack:360kB pagetables:5748kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72391.420933] lowmem_reserve[]: 0 0 1010 1010 [72391.420942] Node 0 Normal free:14644kB min:2044kB low:2552kB high:3064kB active_anon:184632kB inactive_anon:247312kB active_file:139308kB inactive_file:201556kB unevictable:48kB isolated(anon):44kB isolated(file):84kB present:1034240kB mlocked:48kB dirty:3132kB writeback:1420kB mapped:117472kB shmem:6520kB slab_reclaimable:38792kB slab_unreclaimable:20752kB kernel_stack:2352kB pagetables:24760kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72391.420969] lowmem_reserve[]: 0 0 0 0 [72391.420978] Node 0 DMA: 1*4kB 2*8kB 3*16kB 3*32kB 4*64kB 1*128kB 2*256kB 1*512kB 2*1024kB 2*2048kB 2*4096kB = 15908kB [72391.421002] Node 0 DMA32: 12227*4kB 11475*8kB 90*16kB 1*32kB 0*64kB 0*128kB 1*256kB 1*512kB 0*1024kB 0*2048kB 0*4096kB = 142948kB [72391.421027] Node 0 Normal: 1763*4kB 615*8kB 161*16kB 3*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 14644kB [72391.421051] 144792 total pagecache pages [72391.421055] 22389 pages in swap cache [72391.421060] Swap cache stats: add 161351, delete 138962, find 58436/65495 [72391.421065] Free swap = 1808772kB [72391.421069] Total swap = 2097144kB [72391.463581] 1048576 pages RAM [72391.463586] 42552 pages reserved [72391.463590] 502575 pages shared [72391.463594] 524759 pages non-shared [72391.463603] iwlagn 0000:03:00.0: kmalloc for auxiliary BD structures failed [72391.463701] iwlagn 0000:03:00.0: Tx 7 queue init failed [72391.464233] iwlagn 0000:03:00.0: Unable to init nic [72402.683834] wpa_supplicant: page allocation failure. order:4, mode:0x40d0 [72402.683838] Pid: 1138, comm: wpa_supplicant Tainted: P 2.6.32-31-generic #61-Ubuntu [72402.683840] Call Trace: [72402.683848] [] __alloc_pages_slowpath+0x4a9/0x590 [72402.683852] [] __alloc_pages_nodemask+0x15e/0x1a0 [72402.683856] [] alloc_pages_current+0x87/0xd0 [72402.683859] [] __get_free_pages+0xe/0x50 [72402.683876] [] iwl_tx_queue_alloc+0x50/0x220 [iwlcore] [72402.683883] [] ? iwl_tx_queue_init+0xc5/0x210 [iwlcore] [72402.683889] [] iwl_tx_queue_init+0x13f/0x210 [iwlcore] [72402.683896] [] iwl_txq_ctx_reset+0x297/0x4b0 [iwlcore] [72402.683903] [] iwl_hw_nic_init+0xf8/0x170 [iwlcore] [72402.683908] [] __iwl_up+0x9f/0x390 [iwlagn] [72402.683913] [] iwl_mac_start+0x5a/0x1f0 [iwlagn] [72402.683917] [] ? default_spin_lock_flags+0x9/0x10 [72402.683927] [] ieee80211_open+0x391/0x840 [mac80211] [72402.683931] [] ? notifier_call_chain+0x56/0x80 [72402.683935] [] dev_open+0xa2/0x100 [72402.683938] [] dev_change_flags+0xa1/0x1e0 [72402.683941] [] devinet_ioctl+0x593/0x5f0 [72402.683943] [] inet_ioctl+0x90/0xb0 [72402.683947] [] sock_ioctl+0x7a/0x280 [72402.683950] [] vfs_ioctl+0x22/0xa0 [72402.683953] [] ? sys_bind+0xd0/0xf0 [72402.683956] [] do_vfs_ioctl+0x81/0x380 [72402.683958] [] ? sock_map_fd+0x4c/0x80 [72402.683960] [] sys_ioctl+0x81/0xa0 [72402.683963] [] ? sys_socket+0x51/0x80 [72402.683967] [] system_call_fastpath+0x16/0x1b [72402.683969] Mem-Info: [72402.683970] Node 0 DMA per-cpu: [72402.683972] CPU 0: hi: 0, btch: 1 usd: 0 [72402.683974] CPU 1: hi: 0, btch: 1 usd: 0 [72402.683975] Node 0 DMA32 per-cpu: [72402.683977] CPU 0: hi: 186, btch: 31 usd: 0 [72402.683979] CPU 1: hi: 186, btch: 31 usd: 0 [72402.683980] Node 0 Normal per-cpu: [72402.683982] CPU 0: hi: 186, btch: 31 usd: 0 [72402.683984] CPU 1: hi: 186, btch: 31 usd: 0 [72402.683987] active_anon:554268 inactive_anon:199261 isolated_anon:26 [72402.683988] active_file:41220 inactive_file:77879 isolated_file:6 [72402.683989] unevictable:13 dirty:306 writeback:524 unstable:0 [72402.683990] free:42909 slab_reclaimable:18303 slab_unreclaimable:6439 [72402.683991] mapped:39108 shmem:3017 pagetables:7749 bounce:0 [72402.683993] Node 0 DMA free:15908kB min:28kB low:32kB high:40kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15344kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:8kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72402.684000] lowmem_reserve[]: 0 2964 3974 3974 [72402.684004] Node 0 DMA32 free:147980kB min:6004kB low:7504kB high:9004kB active_anon:2033132kB inactive_anon:546332kB active_file:27656kB inactive_file:107952kB unevictable:4kB isolated(anon):104kB isolated(file):24kB present:3036024kB mlocked:4kB dirty:112kB writeback:544kB mapped:37192kB shmem:5696kB slab_reclaimable:34484kB slab_unreclaimable:4632kB kernel_stack:344kB pagetables:5672kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72402.684012] lowmem_reserve[]: 0 0 1010 1010 [72402.684015] Node 0 Normal free:7748kB min:2044kB low:2552kB high:3064kB active_anon:183940kB inactive_anon:250712kB active_file:137224kB inactive_file:203564kB unevictable:48kB isolated(anon):0kB isolated(file):0kB present:1034240kB mlocked:48kB dirty:1112kB writeback:1552kB mapped:119240kB shmem:6372kB slab_reclaimable:38728kB slab_unreclaimable:21116kB kernel_stack:2392kB pagetables:25324kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72402.684024] lowmem_reserve[]: 0 0 0 0 [72402.684026] Node 0 DMA: 1*4kB 2*8kB 3*16kB 3*32kB 4*64kB 1*128kB 2*256kB 1*512kB 2*1024kB 2*2048kB 2*4096kB = 15908kB [72402.684034] Node 0 DMA32: 12469*4kB 11523*8kB 320*16kB 1*32kB 0*64kB 0*128kB 1*256kB 1*512kB 0*1024kB 0*2048kB 0*4096kB = 147980kB [72402.684042] Node 0 Normal: 503*4kB 591*8kB 49*16kB 7*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 7748kB [72402.684050] 146757 total pagecache pages [72402.684051] 24636 pages in swap cache [72402.684053] Swap cache stats: add 164076, delete 139440, find 58875/65974 [72402.684054] Free swap = 1799540kB [72402.684055] Total swap = 2097144kB [72402.699349] 1048576 pages RAM [72402.699352] 42552 pages reserved [72402.699353] 506979 pages shared [72402.699354] 524829 pages non-shared [72402.699358] iwlagn 0000:03:00.0: kmalloc for auxiliary BD structures failed [72402.699406] iwlagn 0000:03:00.0: Tx 7 queue init failed [72402.699655] iwlagn 0000:03:00.0: Unable to init nic [72413.709725] CPU0 attaching NULL sched-domain. [72413.709729] CPU1 attaching NULL sched-domain. [72413.780096] CPU0 attaching sched-domain: [72413.780099] domain 0: span 0-1 level MC [72413.780101] groups: 0 1 [72413.780105] CPU1 attaching sched-domain: [72413.780107] domain 0: span 0-1 level MC [72413.780109] groups: 1 0 [72545.356113] iwlagn 0000:03:00.0: RF_KILL bit toggled to disable radio. [72553.832480] iwlagn 0000:03:00.0: PCI INT A disabled [72554.156012] iwlagn: Intel(R) Wireless WiFi Link AGN driver for Linux, 1.3.27k [72554.156014] iwlagn: Copyright(c) 2003-2009 Intel Corporation [72554.156315] iwlagn 0000:03:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [72554.156327] iwlagn 0000:03:00.0: setting latency timer to 64 [72554.156387] iwlagn 0000:03:00.0: Detected Intel Wireless WiFi Link 5300AGN REV=0x24 [72554.192931] iwlagn 0000:03:00.0: Tunable channels: 13 802.11bg, 24 802.11a channels [72554.193009] iwlagn 0000:03:00.0: irq 30 for MSI/MSI-X [72554.194253] phy1: Selected rate control algorithm 'iwl-agn-rs' [72578.047763] iwlagn 0000:03:00.0: RF_KILL bit toggled to enable radio. [72578.121526] iwlagn 0000:03:00.0: firmware: requesting iwlwifi-5000-2.ucode [72578.159155] iwlagn 0000:03:00.0: loaded firmware version 8.24.2.12 [72578.501038] NetworkManager: page allocation failure. order:4, mode:0x40d0 [72578.501049] Pid: 1041, comm: NetworkManager Tainted: P 2.6.32-31-generic #61-Ubuntu [72578.501056] Call Trace: [72578.501075] [] __alloc_pages_slowpath+0x4a9/0x590 [72578.501086] [] __alloc_pages_nodemask+0x15e/0x1a0 [72578.501098] [] alloc_pages_current+0x87/0xd0 [72578.501107] [] __get_free_pages+0xe/0x50 [72578.501132] [] iwl_tx_queue_alloc+0x50/0x220 [iwlcore] [72578.501151] [] ? iwl_tx_queue_init+0xc5/0x210 [iwlcore] [72578.501169] [] iwl_tx_queue_init+0x13f/0x210 [iwlcore] [72578.501187] [] iwl_txq_ctx_reset+0x297/0x4b0 [iwlcore] [72578.501205] [] iwl_hw_nic_init+0xf8/0x170 [iwlcore] [72578.501219] [] __iwl_up+0x9f/0x390 [iwlagn] [72578.501231] [] iwl_mac_start+0x5a/0x1f0 [iwlagn] [72578.501243] [] ? default_spin_lock_flags+0x9/0x10 [72578.501279] [] ieee80211_open+0x391/0x840 [mac80211] [72578.501290] [] ? notifier_call_chain+0x56/0x80 [72578.501301] [] dev_open+0xa2/0x100 [72578.501422] [] dev_change_flags+0xa1/0x1e0 [72578.501433] [] do_setlink+0x1af/0x430 [72578.501444] [] ? nla_parse+0x34/0x110 [72578.501452] [] rtnl_setlink+0x132/0x180 [72578.501461] [] rtnetlink_rcv_msg+0x1e0/0x220 [72578.501470] [] ? rtnetlink_rcv_msg+0x0/0x220 [72578.501479] [] netlink_rcv_skb+0xa9/0xd0 [72578.501487] [] rtnetlink_rcv+0x25/0x40 [72578.501495] [] netlink_unicast+0x2de/0x2f0 [72578.501504] [] netlink_sendmsg+0x1fe/0x2e0 [72578.501514] [] sock_sendmsg+0x10b/0x140 [72578.501522] [] ? sock_recvmsg+0x11e/0x150 [72578.501532] [] ? autoremove_wake_function+0x0/0x40 [72578.501542] [] ? __destroy_inode+0x2a/0xa0 [72578.501551] [] ? move_addr_to_kernel+0x64/0x70 [72578.501559] [] ? verify_iovec+0x66/0xd0 [72578.501576] [] sys_sendmsg+0x233/0x3a0 [72578.501585] [] ? sys_sendto+0x185/0x190 [72578.501595] [] ? fput+0x25/0x30 [72578.501603] [] ? filp_close+0x5d/0x90 [72578.501614] [] system_call_fastpath+0x16/0x1b [72578.501620] Mem-Info: [72578.501624] Node 0 DMA per-cpu: [72578.501631] CPU 0: hi: 0, btch: 1 usd: 0 [72578.501636] CPU 1: hi: 0, btch: 1 usd: 0 [72578.501640] Node 0 DMA32 per-cpu: [72578.501647] CPU 0: hi: 186, btch: 31 usd: 0 [72578.501652] CPU 1: hi: 186, btch: 31 usd: 0 [72578.501656] Node 0 Normal per-cpu: [72578.501662] CPU 0: hi: 186, btch: 31 usd: 0 [72578.501667] CPU 1: hi: 186, btch: 31 usd: 0 [72578.501679] active_anon:516279 inactive_anon:220315 isolated_anon:6 [72578.501682] active_file:33772 inactive_file:80115 isolated_file:0 [72578.501685] unevictable:13 dirty:61 writeback:362 unstable:0 [72578.501687] free:67443 slab_reclaimable:16308 slab_unreclaimable:6263 [72578.501690] mapped:39377 shmem:3211 pagetables:7591 bounce:0 [72578.501695] Node 0 DMA free:15908kB min:28kB low:32kB high:40kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15344kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:8kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72578.501821] lowmem_reserve[]: 0 2964 3974 3974 [72578.501832] Node 0 DMA32 free:232648kB min:6004kB low:7504kB high:9004kB active_anon:1925512kB inactive_anon:585980kB active_file:26408kB inactive_file:98124kB unevictable:4kB isolated(anon):0kB isolated(file):0kB present:3036024kB mlocked:4kB dirty:0kB writeback:660kB mapped:36676kB shmem:5612kB slab_reclaimable:29656kB slab_unreclaimable:4532kB kernel_stack:312kB pagetables:5520kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72578.501859] lowmem_reserve[]: 0 0 1010 1010 [72578.501869] Node 0 Normal free:21216kB min:2044kB low:2552kB high:3064kB active_anon:139604kB inactive_anon:295280kB active_file:108680kB inactive_file:222336kB unevictable:48kB isolated(anon):24kB isolated(file):0kB present:1034240kB mlocked:48kB dirty:248kB writeback:788kB mapped:120832kB shmem:7232kB slab_reclaimable:35576kB slab_unreclaimable:20512kB kernel_stack:2376kB pagetables:24844kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [72578.501895] lowmem_reserve[]: 0 0 0 0 [72578.501904] Node 0 DMA: 1*4kB 2*8kB 3*16kB 3*32kB 4*64kB 1*128kB 2*256kB 1*512kB 2*1024kB 2*2048kB 2*4096kB = 15908kB [72578.501930] Node 0 DMA32: 19156*4kB 16231*8kB 1586*16kB 5*32kB 0*64kB 1*128kB 0*256kB 1*512kB 0*1024kB 0*2048kB 0*4096kB = 232648kB [72578.501954] Node 0 Normal: 922*4kB 2035*8kB 76*16kB 1*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 21216kB [72578.501978] 167309 total pagecache pages [72578.501982] 50205 pages in swap cache [72578.501987] Swap cache stats: add 203823, delete 153618, find 69249/77151 [72578.501992] Free swap = 1705048kB [72578.501996] Total swap = 2097144kB [72578.540063] usb 3-1: new full speed USB device using uhci_hcd and address 26 [72578.547808] 1048576 pages RAM [72578.547813] 42552 pages reserved [72578.547817] 499611 pages shared [72578.547821] 499751 pages non-shared [72578.547829] iwlagn 0000:03:00.0: kmalloc for auxiliary BD structures failed [72578.547922] iwlagn 0000:03:00.0: Tx 2 queue init failed [72578.548100] iwlagn 0000:03:00.0: Unable to init nic [72578.670072] usb 3-1: device descriptor read/64, error -71 [72578.911632] usb 3-1: device descriptor read/64, error -71 [72579.141344] usb 3-1: new full speed USB device using uhci_hcd and address 27 [72579.271642] usb 3-1: device descriptor read/64, error -71 [72579.510060] usb 3-1: device descriptor read/64, error -71 [72579.740069] usb 3-1: new full speed USB device using uhci_hcd and address 28 [72580.160046] usb 3-1: device not accepting address 28, error -71 [72580.280070] usb 3-1: new full speed USB device using uhci_hcd and address 29 [72580.700045] usb 3-1: device not accepting address 29, error -71 [72580.700082] hub 3-0:1.0: unable to enumerate USB device on port 1 [72601.965567] iwlagn 0000:03:00.0: RF_KILL bit toggled to disable radio. [72652.264199] iwlagn 0000:03:00.0: RF_KILL bit toggled to enable radio. [72652.348253] ------------[ cut here ]------------ [72652.348286] WARNING: at /build/buildd/linux-2.6.32/drivers/net/wireless/iwlwifi/iwl-tx.c:1172 iwl_tx_cmd_complete+0x133/0x170 [iwlcore]() [72652.348293] Hardware name: HP EliteBook 8530w [72652.348298] wrong command queue 0, sequence 0x0 readp=0 writep=0 [72652.348303] Modules linked in: aes_x86_64 aes_generic iwlagn iwlcore usb_storage vmnet vmblock vsock vmci vmmon autofs4 cryptd binfmt_misc snd_hda_codec_analog pata_pcmcia snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss arc4 snd_pcm snd_seq_dummy snd_seq_oss pcmcia snd_seq_midi snd_rawmidi snd_seq_midi_event fbcon tileblit snd_seq font yenta_socket snd_timer snd_seq_device usbhid hid mac80211 sdhci_pci tpm_infineon snd rsrc_nonstatic bitblit soundcore pcmcia_core ricoh_mmc sdhci softcursor cfg80211 snd_page_alloc joydev nvidia(P) vga16fb vgastate video output tpm_tis tpm tpm_bios intel_agp ppdev hp_accel lis3lv02d psmouse serio_raw parport_pc input_polldev led_class uvcvideo videodev v4l1_compat v4l2_compat_ioctl32 lp parport ohci1394 ieee1394 e1000e [last unloaded: aes_generic] [72652.348452] Pid: 0, comm: swapper Tainted: P 2.6.32-31-generic #61-Ubuntu [72652.348458] Call Trace: [72652.348464] [] warn_slowpath_common+0x7b/0xc0 [72652.348491] [] warn_slowpath_fmt+0x41/0x50 [72652.348510] [] iwl_tx_cmd_complete+0x133/0x170 [iwlcore] [72652.348521] [] ? unmap_single+0x34/0x70 [72652.348535] [] iwl_rx_handle+0x11c/0x2f0 [iwlagn] [72652.348543] [] ? enqueue_task_fair+0x9b/0xa0 [72652.348556] [] iwl_irq_tasklet+0x148/0x510 [iwlagn] [72652.348563] [] ? try_to_wake_up+0x2fb/0x480 [72652.348573] [] tasklet_action+0xd5/0xe0 [72652.348582] [] __do_softirq+0xb7/0x1f0 [72652.348591] [] ? handle_IRQ_event+0x60/0x170 [72652.348601] [] call_softirq+0x1c/0x30 [72652.348609] [] do_softirq+0x65/0xa0 [72652.348616] [] irq_exit+0x85/0x90 [72652.348626] [] do_IRQ+0x75/0xf0 [72652.348634] [] ret_from_intr+0x0/0x11 [72652.348639] [] ? acpi_idle_enter_c1+0xa3/0xc1 [72652.348656] [] ? acpi_idle_enter_c1+0x82/0xc1 [72652.348666] [] ? cpuidle_idle_call+0xa7/0x140 [72652.348676] [] ? cpu_idle+0xb3/0x110 [72652.348685] [] ? start_secondary+0xa8/0xaa [72652.348692] ---[ end trace 886d0dd08bf3c8e3 ]--- [72652.348699] iwl data: 00000000: a0 39 4c 00 00 00 00 00 70 5d 28 b7 07 7f 00 00 .9L.....p](..... [72652.348708] iwl data: 00000010: 10 73 28 b7 07 7f 00 00 f0 08 46 00 00 00 00 00 .s(.......F..... [72652.772333] usb 3-1: new full speed USB device using uhci_hcd and address 30 [72652.901313] usb 3-1: device descriptor read/64, error -71 [72653.140104] usb 3-1: device descriptor read/64, error -71 [72653.371453] usb 3-1: new full speed USB device using uhci_hcd and address 31 [72653.501335] usb 3-1: device descriptor read/64, error -71 [72653.740074] usb 3-1: device descriptor read/64, error -71 [72653.970058] usb 3-1: new full speed USB device using uhci_hcd and address 32 [72654.390050] usb 3-1: device not accepting address 32, error -71 [72654.510072] usb 3-1: new full speed USB device using uhci_hcd and address 33 [72654.930083] usb 3-1: device not accepting address 33, error -71 [72654.930120] hub 3-0:1.0: unable to enumerate USB device on port 1 [72656.331310] iwlagn 0000:03:00.0: START_ALIVE timeout after 4000ms. [72684.472098] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None [72684.472107] 0000:00:19.0: eth0: 10/100 speed: disabling TSO [72684.473405] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [72684.483465] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [72684.483500] /dev/vmnet: hub 0 does not exist, allocating memory. [72684.483551] /dev/vmnet: port on hub 0 successfully opened [72684.483576] bridge-eth0: up [72684.483583] bridge-eth0: attached [72690.584422] /dev/vmmon[8747]: HostIF_ReadUptime: detected settimeofday: fixed uptimeBase old 18445438350353349751 new 18445438350352176469 attempts 1 [72695.261543] eth0: no IPv6 routers present [84660.230078] usb 2-2: new high speed USB device using ehci_hcd and address 4 [84660.381247] usb 2-2: configuration #1 chosen from 1 choice [84660.381728] scsi7 : SCSI emulation for USB Mass Storage devices [84660.382021] usb-storage: device found at 4 [84660.382026] usb-storage: waiting for device to settle before scanning [84661.321312] usb 3-1: new full speed USB device using uhci_hcd and address 34 [84661.451281] usb 3-1: device descriptor read/64, error -71 [84661.690094] usb 3-1: device descriptor read/64, error -71 [84661.920969] usb 3-1: new full speed USB device using uhci_hcd and address 35 [84662.051311] usb 3-1: device descriptor read/64, error -71 [84662.290121] usb 3-1: device descriptor read/64, error -71 [84662.521590] usb 3-1: new full speed USB device using uhci_hcd and address 36 [84662.940285] usb 3-1: device not accepting address 36, error -71 [84663.060295] usb 3-1: new full speed USB device using uhci_hcd and address 37 [84663.480135] usb 3-1: device not accepting address 37, error -71 [84663.480205] hub 3-0:1.0: unable to enumerate USB device on port 1 [84663.601591] usb 2-2: reset high speed USB device using ehci_hcd and address 4 [84663.750917] scsi8 : SCSI emulation for USB Mass Storage devices [84663.763259] usb-storage: device found at 4 [84663.763262] usb-storage: waiting for device to settle before scanning [84663.940319] usb 2-2: reset high speed USB device using ehci_hcd and address 4 [84666.324619] usb 2-2: usbfs: interface 0 claimed by usb-storage while 'vmware-vmx' sets config #1 [90989.396375] usb 2-2: USB disconnect, address 4 [90989.711284] usb 2-2: new high speed USB device using ehci_hcd and address 5 [90989.871310] usb 2-2: configuration #1 chosen from 1 choice [90989.871688] scsi9 : SCSI emulation for USB Mass Storage devices [90989.872076] usb-storage: device found at 5 [90989.872082] usb-storage: waiting for device to settle before scanning [90990.410056] usb 3-1: new full speed USB device using uhci_hcd and address 38 [90990.550144] usb 3-1: device descriptor read/64, error -71 [90990.780074] usb 3-1: device descriptor read/64, error -71 [90991.011375] usb 3-1: new full speed USB device using uhci_hcd and address 39 [90991.150101] usb 3-1: device descriptor read/64, error -71 [90991.381541] usb 3-1: device descriptor read/64, error -71 [90991.610092] usb 3-1: new full speed USB device using uhci_hcd and address 40 [90992.030086] usb 3-1: device not accepting address 40, error -71 [90992.151322] usb 2-2: reset high speed USB device using ehci_hcd and address 5 [90992.301404] scsi10 : SCSI emulation for USB Mass Storage devices [90992.305295] usb-storage: device found at 5 [90992.305300] usb-storage: waiting for device to settle before scanning [90992.420102] usb 3-1: new full speed USB device using uhci_hcd and address 41 [90992.840094] usb 3-1: device not accepting address 41, error -71 [90992.840141] hub 3-0:1.0: unable to enumerate USB device on port 1 [90992.960462] usb 2-2: reset high speed USB device using ehci_hcd and address 5 [90993.207580] usb 2-2: usbfs: interface 0 claimed by usb-storage while 'vmware-vmx' sets config #1 [91177.087220] usb 2-2: USB disconnect, address 5 [92168.490070] usb 2-2: new high speed USB device using ehci_hcd and address 6 [92168.643047] usb 2-2: configuration #1 chosen from 1 choice [92168.643810] scsi11 : SCSI emulation for USB Mass Storage devices [92168.644206] usb-storage: device found at 6 [92168.644211] usb-storage: waiting for device to settle before scanning [92169.020117] usb 3-1: new full speed USB device using uhci_hcd and address 42 [92169.150074] usb 3-1: device descriptor read/64, error -71 [92169.390055] usb 3-1: device descriptor read/64, error -71 [92169.620060] usb 3-1: new full speed USB device using uhci_hcd and address 43 [92169.750058] usb 3-1: device descriptor read/64, error -71 [92169.991317] usb 3-1: device descriptor read/64, error -71 [92170.220324] usb 3-1: new full speed USB device using uhci_hcd and address 44 [92170.641411] usb 3-1: device not accepting address 44, error -71 [92170.761588] usb 3-1: new full speed USB device using uhci_hcd and address 45 [92171.180322] usb 3-1: device not accepting address 45, error -71 [92171.180371] hub 3-0:1.0: unable to enumerate USB device on port 1 [92171.301590] usb 2-2: reset high speed USB device using ehci_hcd and address 6 [92171.452255] scsi12 : SCSI emulation for USB Mass Storage devices [92171.461528] usb-storage: device found at 6 [92171.461535] usb-storage: waiting for device to settle before scanning [92171.631302] usb 2-2: reset high speed USB device using ehci_hcd and address 6 [92171.890571] usb 2-2: usbfs: interface 0 claimed by usb-storage while 'vmware-vmx' sets config #1 [92836.606796] usb 2-2: USB disconnect, address 6 [101841.992062] CPU0 attaching NULL sched-domain. [101841.992073] CPU1 attaching NULL sched-domain. [101842.050275] CPU0 attaching sched-domain: [101842.050283] domain 0: span 0-1 level MC [101842.050290] groups: 0 1 [101842.050300] domain 1: span 0-1 level CPU [101842.050306] groups: 0-1 (cpu_power = 2048) [101842.050319] CPU1 attaching sched-domain: [101842.050324] domain 0: span 0-1 level MC [101842.050329] groups: 1 0 [101842.050338] domain 1: span 0-1 level CPU [101842.050353] groups: 0-1 (cpu_power = 2048) [101932.893570] CPU0 attaching NULL sched-domain. [101932.893581] CPU1 attaching NULL sched-domain. [101932.951455] CPU0 attaching sched-domain: [101932.951463] domain 0: span 0-1 level MC [101932.951469] groups: 0 1 [101932.951482] CPU1 attaching sched-domain: [101932.951487] domain 0: span 0-1 level MC [101932.951493] groups: 1 0 [101934.313190] bridge-eth0: disabling the bridge on dev down [101934.340071] bridge-eth0: down [101934.341801] bridge-eth0: detached [101947.744256] PM: Syncing filesystems ... done. [101948.121408] PM: Preparing system for mem sleep [101948.121414] Freezing user space processes ... (elapsed 0.06 seconds) done. [101948.188740] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [101948.188779] PM: Entering mem sleep [101948.188791] Suspending console(s) (use no_console_suspend to debug) [101948.765926] PM: suspend of drv:psmouse dev:serio5 complete after 495.892 msecs [101948.780085] sd 0:0:0:0: [sda] Synchronizing SCSI cache [101948.783010] sd 0:0:0:0: [sda] Stopping disk [101949.422107] PM: suspend of drv:sd dev:0:0:0:0 complete after 642.023 msecs [101949.806272] PM: suspend of drv:psmouse dev:serio4 complete after 384.101 msecs [101949.910030] PM: suspend of drv:atkbd dev:serio0 complete after 103.740 msecs [101949.912236] parport_pc 00:09: disabled [101949.990177] tpm_tis 00:04: Operation Timed out [101949.991274] ACPI handle has no context! [101949.991280] sdhci-pci 0000:86:09.1: PCI INT B disabled [101949.991286] ACPI handle has no context! [101950.015242] ACPI handle has no context! [101950.144389] ata_piix 0000:00:1f.5: PCI INT C disabled [101950.160205] ata_piix 0000:00:1f.2: PCI INT A disabled [101950.180194] ehci_hcd 0000:00:1d.7: PCI INT D disabled [101950.180205] uhci_hcd 0000:00:1d.2: PCI INT C disabled [101950.180215] uhci_hcd 0000:00:1d.1: PCI INT B disabled [101950.180226] uhci_hcd 0000:00:1d.0: PCI INT A disabled [101950.290474] HDA Intel 0000:00:1b.0: PCI INT A disabled [101950.315408] HDA Intel 0000:00:1b.0: power state changed by ACPI to D3 [101950.315416] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 135.164 msecs [101950.315427] ehci_hcd 0000:00:1a.7: PCI INT D disabled [101950.315437] uhci_hcd 0000:00:1a.2: PCI INT C disabled [101950.315447] uhci_hcd 0000:00:1a.1: PCI INT B disabled [101950.315465] uhci_hcd 0000:00:1a.0: PCI INT A disabled [101950.315673] e1000e 0000:00:19.0: PCI INT A disabled [101950.315683] e1000e 0000:00:19.0: PME# enabled [101950.315688] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [101950.331360] PM: suspend of devices complete after 2142.163 msecs [101950.331362] PM: suspend devices took 2.150 seconds [101950.331813] ricoh-mmc: Suspending. [101950.331823] ricoh-mmc: Controller is now re-enabled. [101950.370257] PM: late suspend of devices complete after 38.890 msecs [101950.370899] ACPI: Preparing to enter system sleep state S3 [101950.420742] Disabling non-boot CPUs ... [101950.420761] CPU0 attaching NULL sched-domain. [101950.420763] CPU1 attaching NULL sched-domain. [101950.540016] CPU0 attaching NULL sched-domain. [101950.650019] CPU 1 is now offline [101950.650022] SMP alternatives: switching to UP code [101950.655793] Extended CMOS year: 2000 [101950.655793] Back to C! [101950.655793] CPU0: Thermal monitoring handled by SMI [101950.655793] Extended CMOS year: 2000 [101950.655793] Enabling non-boot CPUs ... [101950.655793] SMP alternatives: switching to SMP code [101950.661473] Booting processor 1 APIC 0x1 ip 0x6000 [101950.655746] Initializing CPU#1 [101950.655746] CPU: L1 I cache: 32K, L1 D cache: 32K [101950.655746] CPU: L2 cache: 6144K [101950.655746] CPU 1/0x1 -> Node 0 [101950.655746] CPU: Physical Processor ID: 0 [101950.655746] CPU: Processor Core ID: 1 [101950.655746] CPU1: Thermal monitoring handled by SMI [101950.820092] CPU1: Intel(R) Core(TM)2 Duo CPU T9400 @ 2.53GHz stepping 06 [101950.820149] /dev/vmmon[10208]: HostIF_ReadUptime: detected settimeofday: fixed uptimeBase old 18445438350352176469 new 18445438333211176489 attempts 1 [101950.820170] CPU0 attaching NULL sched-domain. [101950.890017] CPU0 attaching sched-domain: [101950.890019] domain 0: span 0-1 level MC [101950.890021] groups: 0 1 [101950.890025] CPU1 attaching sched-domain: [101950.890026] domain 0: span 0-1 level MC [101950.890028] groups: 1 0 [101950.890454] CPU1 is up [101950.891288] ACPI: Waking up from system sleep state S3 [101951.137957] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x80100, writing 0x8010a) [101951.137963] pcieport 0000:00:01.0: restoring config space at offset 0xa (was 0xf, writing 0x0) [101951.137969] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010) [101951.137972] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [101951.138000] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [101951.138015] e1000e 0000:00:19.0: restoring config space at offset 0x6 (was 0x1, writing 0x80c1) [101951.138019] e1000e 0000:00:19.0: restoring config space at offset 0x5 (was 0x0, writing 0xdb324000) [101951.138024] e1000e 0000:00:19.0: restoring config space at offset 0x4 (was 0x0, writing 0xdb300000) [101951.138031] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [101951.138055] uhci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [101951.138067] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x8 (was 0x1, writing 0x80a1) [101951.138079] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [101951.138099] uhci_hcd 0000:00:1a.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [101951.138111] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x8 (was 0x1, writing 0x8081) [101951.138123] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [101951.138142] uhci_hcd 0000:00:1a.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [101951.138154] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x8 (was 0x1, writing 0x8061) [101951.138167] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [101951.138193] ehci_hcd 0000:00:1a.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [101951.138210] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325400) [101951.138217] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [101951.138268] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [101951.138298] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [101951.138309] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdb51db41) [101951.138313] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xdb20db20) [101951.138318] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x9090) [101951.138322] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x20200) [101951.138329] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [101951.138335] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [101951.138380] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [101951.138391] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xdb71db61) [101951.138395] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xdb10db10) [101951.138400] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0xa0a0) [101951.138408] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [101951.138414] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [101951.138459] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [101951.138470] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xdb91db81) [101951.138474] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xdb00d710) [101951.138479] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x20000000, writing 0x6050) [101951.138483] pcieport 0000:00:1c.2: restoring config space at offset 0x6 (was 0x0, writing 0x440400) [101951.138490] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [101951.138496] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [101951.138540] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x10a) [101951.138551] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0xdbb1dba1) [101951.138556] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xd700d310) [101951.138560] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x4030) [101951.138565] pcieport 0000:00:1c.4: restoring config space at offset 0x6 (was 0x0, writing 0x854500) [101951.138572] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [101951.138578] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [101951.138616] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [101951.138628] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x8041) [101951.138641] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [101951.138660] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [101951.138672] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x8021) [101951.138684] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [101951.138703] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [101951.138715] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x8001) [101951.138727] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [101951.138752] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [101951.138770] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325000) [101951.138777] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [101951.138802] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x20000, writing 0x200ff) [101951.138813] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdff1dc01) [101951.138818] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xd300d300) [101951.138822] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x22802020) [101951.138827] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x20000000, writing 0x208a8600) [101951.138836] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100100, writing 0x100107) [101951.138911] ata_piix 0000:00:1f.2: restoring config space at offset 0x9 (was 0x1, writing 0x8101) [101951.138924] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [101951.138949] ata_piix 0000:00:1f.5: restoring config space at offset 0xf (was 0x300, writing 0x30a) [101951.138962] ata_piix 0000:00:1f.5: restoring config space at offset 0x8 (was 0x1, writing 0x80f1) [101951.138966] ata_piix 0000:00:1f.5: restoring config space at offset 0x7 (was 0x1, writing 0x8141) [101951.138970] ata_piix 0000:00:1f.5: restoring config space at offset 0x6 (was 0x1, writing 0x8121) [101951.138975] ata_piix 0000:00:1f.5: restoring config space at offset 0x5 (was 0x1, writing 0x8145) [101951.138980] ata_piix 0000:00:1f.5: restoring config space at offset 0x4 (was 0x1, writing 0x8129) [101951.138986] ata_piix 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [101951.139091] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [101951.139297] iwlagn 0000:03:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [101951.139330] iwlagn 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xdb100004) [101951.139338] iwlagn 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) [101951.139348] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006) [101951.139422] ohci1394 0000:86:09.0: restoring config space at offset 0xf (was 0x4020100, writing 0x402010a) [101951.139445] ohci1394 0000:86:09.0: restoring config space at offset 0x4 (was 0x0, writing 0xd3001000) [101951.139450] ohci1394 0000:86:09.0: restoring config space at offset 0x3 (was 0x800000, writing 0x804010) [101951.139479] sdhci-pci 0000:86:09.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [101951.139502] sdhci-pci 0000:86:09.1: restoring config space at offset 0x4 (was 0x0, writing 0xd3001b00) [101951.139507] sdhci-pci 0000:86:09.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [101951.139515] sdhci-pci 0000:86:09.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [101951.139540] ricoh-mmc 0000:86:09.2: restoring config space at offset 0xf (was 0x200, writing 0x20b) [101951.139563] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x4 (was 0x0, writing 0xd3001a00) [101951.139568] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [101951.139575] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [101951.139588] ricoh-mmc: Resuming. [101951.139598] ricoh-mmc: Controller is now disabled. [101951.139612] pci 0000:86:09.3: restoring config space at offset 0xf (was 0x200, writing 0x20b) [101951.139635] pci 0000:86:09.3: restoring config space at offset 0x4 (was 0x0, writing 0xd3001800) [101951.139640] pci 0000:86:09.3: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [101951.139647] pci 0000:86:09.3: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [101951.139669] pci 0000:86:09.4: restoring config space at offset 0xf (was 0x800200, writing 0x180020b) [101951.139674] pci 0000:86:09.4: restoring config space at offset 0xe (was 0x0, writing 0x24fc) [101951.139680] pci 0000:86:09.4: restoring config space at offset 0xd (was 0x0, writing 0x2400) [101951.139685] pci 0000:86:09.4: restoring config space at offset 0xc (was 0x0, writing 0x20fc) [101951.139690] pci 0000:86:09.4: restoring config space at offset 0xb (was 0x0, writing 0x2000) [101951.139695] pci 0000:86:09.4: restoring config space at offset 0xa (was 0x0, writing 0xf3fff000) [101951.139701] pci 0000:86:09.4: restoring config space at offset 0x9 (was 0x0, writing 0xf0000000) [101951.139706] pci 0000:86:09.4: restoring config space at offset 0x8 (was 0x0, writing 0xdffff000) [101951.139711] pci 0000:86:09.4: restoring config space at offset 0x7 (was 0x0, writing 0xdc000000) [101951.139716] pci 0000:86:09.4: restoring config space at offset 0x6 (was 0x0, writing 0xb08a8786) [101951.139723] pci 0000:86:09.4: restoring config space at offset 0x4 (was 0x0, writing 0xd3000000) [101951.139729] pci 0000:86:09.4: restoring config space at offset 0x3 (was 0x820000, writing 0x824000) [101951.150017] yenta_cardbus 0000:86:09.5: Refused to change power state, currently in D3 [101951.880020] PM: early resume of drv:yenta_cardbus dev:0000:86:09.5 complete after 740.271 msecs [101951.880308] PM: early resume of devices complete after 742.483 msecs [101951.963635] e1000e 0000:00:19.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [101951.963639] e1000e 0000:00:19.0: setting latency timer to 64 [101951.963645] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [101951.963649] e1000e 0000:00:19.0: PME# disabled [101951.963687] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [101952.022257] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [101952.022263] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [101952.022285] usb usb3: root hub lost power or was reset [101952.022311] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [101952.022320] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [101952.022345] usb usb4: root hub lost power or was reset [101952.022364] uhci_hcd 0000:00:1a.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [101952.022374] uhci_hcd 0000:00:1a.2: setting latency timer to 64 [101952.022398] usb usb5: root hub lost power or was reset [101952.022416] ehci_hcd 0000:00:1a.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [101952.022421] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [101952.027557] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [101952.027625] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [101952.027663] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [101952.027701] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [101952.027707] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [101952.027713] HDA Intel 0000:00:1b.0: setting latency timer to 64 [101952.027746] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [101952.027751] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [101952.027773] usb usb6: root hub lost power or was reset [101952.027791] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [101952.027797] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [101952.027819] usb usb7: root hub lost power or was reset [101952.027838] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [101952.027843] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [101952.027865] usb usb8: root hub lost power or was reset [101952.027884] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 20 (level, low) -> IRQ 20 [101952.027889] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [101952.027902] pci 0000:00:1e.0: setting latency timer to 64 [101952.027914] ata_piix 0000:00:1f.2: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [101952.027918] ata_piix 0000:00:1f.2: setting latency timer to 64 [101952.027936] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [101952.027940] ata_piix 0000:00:1f.5: setting latency timer to 64 [101952.386553] ata3: SATA link down (SStatus 0 SControl 300) [101952.401959] ata4: SATA link down (SStatus 0 SControl 310) [101952.561643] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [101952.583353] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [101952.583356] ata2.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [101952.623371] ata2.00: configured for UDMA/100 [101952.759024] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 731.047 msecs [101952.823160] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[20] MMIO=[d3001000-d30017ff] Max Packet=[2048] IR/IT contexts=[4/4] [101952.829242] sdhci-pci 0000:86:09.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [101953.050173] tpm_tis 00:04: Operation Timed out [101953.050178] PM: resume of drv:tpm_tis dev:00:04 complete after 219.634 msecs [101953.052872] parport_pc 00:09: activated [101953.330190] PM: resume of drv:usb dev:usb1 complete after 276.872 msecs [101953.640034] PM: resume of drv:usb dev:usb4 complete after 269.810 msecs [101953.641703] sd 0:0:0:0: [sda] Starting disk [101955.140078] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [101955.160274] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [101955.160277] ata1.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [101955.201622] ata1.00: configured for UDMA/133 [101955.214694] PM: resume of drv:sd dev:0:0:0:0 complete after 1572.990 msecs [101955.390030] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [101955.547228] PM: resume of drv:usb dev:4-1 complete after 276.143 msecs [101955.587445] PM: resume of devices complete after 3707.094 msecs [101955.587663] PM: resume devices took 3.700 seconds [101955.587702] PM: Finishing wakeup. [101955.587703] Restarting tasks ... done. [101955.971285] usb 3-1: new full speed USB device using uhci_hcd and address 46 [101956.100027] usb 3-1: device descriptor read/64, error -71 [101956.341296] usb 3-1: device descriptor read/64, error -71 [101956.571295] usb 3-1: new full speed USB device using uhci_hcd and address 47 [101957.140033] usb 3-1: device descriptor read/64, error -71 [101957.380820] usb 3-1: device descriptor read/64, error -71 [101957.411527] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [101957.471359] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [101957.471910] ADDRCONF(NETDEV_UP): eth0: link is not ready [101957.565012] Registered led device: iwl-phy1::radio [101957.565028] Registered led device: iwl-phy1::assoc [101957.565044] Registered led device: iwl-phy1::RX [101957.565061] Registered led device: iwl-phy1::TX [101957.592231] ADDRCONF(NETDEV_UP): wlan0: link is not ready [101957.611282] usb 3-1: new full speed USB device using uhci_hcd and address 48 [101957.847889] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [101957.847902] /dev/vmnet: hub 0 does not exist, allocating memory. [101957.847918] /dev/vmnet: port on hub 0 successfully opened [101957.848312] bridge-wlan0: device is wireless, enabling SMAC [101957.848316] bridge-wlan0: up [101957.848321] bridge-wlan0: attached [101957.848372] bridge-wlan0: disabling the bridge [101957.870031] bridge-wlan0: down [101957.870036] bridge-wlan0: detached [101958.031267] usb 3-1: device not accepting address 48, error -71 [101958.155056] usb 3-1: new full speed USB device using uhci_hcd and address 49 [101958.580035] usb 3-1: device not accepting address 49, error -71 [101958.580057] hub 3-0:1.0: unable to enumerate USB device on port 1 [101977.902074] CPU0 attaching NULL sched-domain. [101977.902086] CPU1 attaching NULL sched-domain. [101977.960142] CPU0 attaching sched-domain: [101977.960145] domain 0: span 0-1 level MC [101977.960148] groups: 0 1 [101977.960153] CPU1 attaching sched-domain: [101977.960154] domain 0: span 0-1 level MC [101977.960156] groups: 1 0 [101978.123439] CPU0 attaching NULL sched-domain. [101978.123444] CPU1 attaching NULL sched-domain. [101978.181439] CPU0 attaching sched-domain: [101978.181448] domain 0: span 0-1 level MC [101978.181455] groups: 0 1 [101978.181468] CPU1 attaching sched-domain: [101978.181473] domain 0: span 0-1 level MC [101978.181478] groups: 1 0 [101980.833434] wlan0: deauthenticating from 00:22:f7:21:5f:28 by local choice (reason=3) [101980.834079] wlan0: direct probe to AP 00:22:f7:21:5f:28 (try 1) [101980.838285] wlan0: direct probe responded [101980.838287] wlan0: authenticate with AP 00:22:f7:21:5f:28 (try 1) [101980.840094] wlan0: authenticated [101980.840107] wlan0: associate with AP 00:22:f7:21:5f:28 (try 1) [101980.844639] wlan0: RX AssocResp from 00:22:f7:21:5f:28 (capab=0x411 status=0 aid=2) [101980.844641] wlan0: associated [101980.853589] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [101981.073927] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [101981.073941] /dev/vmnet: hub 0 does not exist, allocating memory. [101981.073957] /dev/vmnet: port on hub 0 successfully opened [101981.073966] bridge-wlan0: device is wireless, enabling SMAC [101981.073969] bridge-wlan0: up [101981.073971] bridge-wlan0: attached [101991.800035] wlan0: no IPv6 routers present [101997.345552] lo: Disabled Privacy Extensions [102060.814451] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 0 [102078.220055] usb 6-1: new low speed USB device using uhci_hcd and address 4 [102078.398253] usb 6-1: configuration #1 chosen from 1 choice [102078.421378] input: Logitech Trackball as /devices/pci0000:00/0000:00:1d.0/usb6/6-1/6-1:1.0/input/input18 [102078.421674] generic-usb 0003:046D:C404.0003: input,hidraw0: USB HID v1.10 Mouse [Logitech Trackball] on usb-0000:00:1d.0-1/input0 [102079.101258] usb 3-1: new full speed USB device using uhci_hcd and address 50 [102079.230059] usb 3-1: device descriptor read/64, error -71 [102079.470091] usb 3-1: device descriptor read/64, error -71 [102079.701302] usb 3-1: new full speed USB device using uhci_hcd and address 51 [102079.831612] usb 3-1: device descriptor read/64, error -71 [102080.074594] usb 3-1: device descriptor read/64, error -71 [102080.301285] usb 3-1: new full speed USB device using uhci_hcd and address 52 [102080.720054] usb 3-1: device not accepting address 52, error -71 [102080.841349] usb 3-1: new full speed USB device using uhci_hcd and address 53 [102081.260292] usb 3-1: device not accepting address 53, error -71 [102081.260338] hub 3-0:1.0: unable to enumerate USB device on port 1 [112030.090374] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 6 [147638.901283] usb 3-1: new full speed USB device using uhci_hcd and address 54 [147639.031272] usb 3-1: device descriptor read/64, error -71 [147639.340065] usb 3-1: device descriptor read/64, error -71 [147639.570266] usb 3-1: new full speed USB device using uhci_hcd and address 55 [147639.710022] usb 3-1: device descriptor read/64, error -71 [147639.940042] usb 3-1: device descriptor read/64, error -71 [147640.170056] usb 3-1: new full speed USB device using uhci_hcd and address 56 [147640.591540] usb 3-1: device not accepting address 56, error -71 [147640.710064] usb 3-1: new full speed USB device using uhci_hcd and address 57 [147641.130056] usb 3-1: device not accepting address 57, error -71 [147641.130099] hub 3-0:1.0: unable to enumerate USB device on port 1 [148615.370051] No probe response from AP 00:22:f7:21:5f:28 after 500ms, disconnecting. [148615.470660] bridge-wlan0: disabling the bridge [148615.500019] bridge-wlan0: down [148615.500024] bridge-wlan0: detached [148618.829206] wlan0: direct probe to AP 00:22:f7:21:5f:28 (try 1) [148618.833043] wlan0: direct probe responded [148618.833047] wlan0: authenticate with AP 00:22:f7:21:5f:28 (try 1) [148618.835843] wlan0: authenticated [148618.835862] wlan0: associate with AP 00:22:f7:21:5f:28 (try 1) [148618.839560] wlan0: RX AssocResp from 00:22:f7:21:5f:28 (capab=0x411 status=0 aid=2) [148618.839564] wlan0: associated [148619.090442] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [148619.090455] /dev/vmnet: hub 0 does not exist, allocating memory. [148619.090472] /dev/vmnet: port on hub 0 successfully opened [148619.090484] bridge-wlan0: device is wireless, enabling SMAC [148619.090488] bridge-wlan0: up [148619.090491] bridge-wlan0: attached [148623.165256] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 0 [150400.390288] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 6 [152884.041351] usb 2-6: new high speed USB device using ehci_hcd and address 8 [152884.204715] usb 2-6: configuration #1 chosen from 1 choice [152884.206573] scsi13 : SCSI emulation for USB Mass Storage devices [152884.206836] usb-storage: device found at 8 [152884.206841] usb-storage: waiting for device to settle before scanning [152887.461304] usb 2-6: reset high speed USB device using ehci_hcd and address 8 [152887.617862] scsi14 : SCSI emulation for USB Mass Storage devices [152887.621075] usb-storage: device found at 8 [152887.621081] usb-storage: waiting for device to settle before scanning [152887.791608] usb 2-6: reset high speed USB device using ehci_hcd and address 8 [152888.213784] usb 2-6: usbfs: interface 0 claimed by usb-storage while 'vmware-vmx' sets config #1 [156295.931278] No probe response from AP 00:22:f7:21:5f:28 after 500ms, disconnecting. [156296.002248] bridge-wlan0: disabling the bridge [156296.031291] bridge-wlan0: down [156296.031302] bridge-wlan0: detached [156299.424223] wlan0: direct probe to AP 00:22:f7:21:5f:28 (try 1) [156299.430114] wlan0: direct probe responded [156299.430392] wlan0: authenticate with AP 00:22:f7:21:5f:28 (try 1) [156299.432194] wlan0: authenticated [156299.432233] wlan0: associate with AP 00:22:f7:21:5f:28 (try 1) [156299.447373] wlan0: RX AssocResp from 00:22:f7:21:5f:28 (capab=0x411 status=0 aid=2) [156299.447376] wlan0: associated [156299.680891] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [156299.680918] /dev/vmnet: hub 0 does not exist, allocating memory. [156299.680967] /dev/vmnet: port on hub 0 successfully opened [156299.680998] bridge-wlan0: device is wireless, enabling SMAC [156299.681008] bridge-wlan0: up [156299.681018] bridge-wlan0: attached [156315.421822] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 0 [156775.780053] No probe response from AP 00:22:f7:21:5f:28 after 500ms, disconnecting. [156775.803132] bridge-wlan0: disabling the bridge [156775.830079] bridge-wlan0: down [156775.830095] bridge-wlan0: detached [156779.266224] wlan0: direct probe to AP 00:22:f7:21:5f:28 (try 1) [156779.271640] wlan0: direct probe responded [156779.271644] wlan0: authenticate with AP 00:22:f7:21:5f:28 (try 1) [156779.274542] wlan0: authenticated [156779.274557] wlan0: associate with AP 00:22:f7:21:5f:28 (try 1) [156779.279224] wlan0: RX AssocResp from 00:22:f7:21:5f:28 (capab=0x411 status=0 aid=2) [156779.279227] wlan0: associated [156779.591133] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [156779.591160] /dev/vmnet: hub 0 does not exist, allocating memory. [156779.591211] /dev/vmnet: port on hub 0 successfully opened [156779.591239] bridge-wlan0: device is wireless, enabling SMAC [156779.591252] bridge-wlan0: up [156779.591255] bridge-wlan0: attached [156795.388377] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 0 [164530.050417] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 6 [168273.366936] usb 2-6: USB disconnect, address 8 [360201.291621] usb 6-1: USB disconnect, address 4 [360206.434498] CPU0 attaching NULL sched-domain. [360206.434508] CPU1 attaching NULL sched-domain. [360206.490181] CPU0 attaching sched-domain: [360206.490189] domain 0: span 0-1 level MC [360206.490196] groups: 0 1 [360206.490206] domain 1: span 0-1 level CPU [360206.490212] groups: 0-1 (cpu_power = 2048) [360206.490224] CPU1 attaching sched-domain: [360206.490229] domain 0: span 0-1 level MC [360206.490235] groups: 1 0 [360206.490244] domain 1: span 0-1 level CPU [360206.490249] groups: 0-1 (cpu_power = 2048) [360207.625359] CPU0 attaching NULL sched-domain. [360207.625370] CPU1 attaching NULL sched-domain. [360207.680274] CPU0 attaching sched-domain: [360207.680282] domain 0: span 0-1 level MC [360207.680289] groups: 0 1 [360207.680311] CPU1 attaching sched-domain: [360207.680316] domain 0: span 0-1 level MC [360207.680322] groups: 1 0 [360210.710171] wlan0: deauthenticating from 00:22:f7:21:5f:28 by local choice (reason=3) [360210.897279] bridge-wlan0: disabling the bridge [360210.920152] bridge-wlan0: down [360210.920166] bridge-wlan0: detached [360211.003857] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [360211.003879] /dev/vmnet: hub 0 does not exist, allocating memory. [360211.003928] /dev/vmnet: port on hub 0 successfully opened [360211.003955] bridge-wlan0: device is wireless, enabling SMAC [360211.003964] bridge-wlan0: up [360211.051050] bridge-wlan0: attached [360211.051146] bridge-wlan0: disabling the bridge [360211.070073] bridge-wlan0: down [360211.070085] bridge-wlan0: detached [360226.401545] PM: Syncing filesystems ... done. [360227.127238] PM: Preparing system for mem sleep [360227.127244] Freezing user space processes ... (elapsed 0.07 seconds) done. [360227.206614] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [360227.206652] PM: Entering mem sleep [360227.206664] Suspending console(s) (use no_console_suspend to debug) [360227.795957] PM: suspend of drv:psmouse dev:serio5 complete after 505.916 msecs [360227.810086] sd 0:0:0:0: [sda] Synchronizing SCSI cache [360227.829768] sd 0:0:0:0: [sda] Stopping disk [360228.480610] PM: suspend of drv:sd dev:0:0:0:0 complete after 670.524 msecs [360228.867287] PM: suspend of drv:psmouse dev:serio4 complete after 386.613 msecs [360228.970042] PM: suspend of drv:atkbd dev:serio0 complete after 102.738 msecs [360228.972258] parport_pc 00:09: disabled [360229.050173] tpm_tis 00:04: Operation Timed out [360229.051271] ACPI handle has no context! [360229.051278] sdhci-pci 0000:86:09.1: PCI INT B disabled [360229.051283] ACPI handle has no context! [360229.075237] ACPI handle has no context! [360229.195382] ata_piix 0000:00:1f.5: PCI INT C disabled [360229.210362] ata_piix 0000:00:1f.2: PCI INT A disabled [360229.230197] ehci_hcd 0000:00:1d.7: PCI INT D disabled [360229.230208] uhci_hcd 0000:00:1d.2: PCI INT C disabled [360229.230219] uhci_hcd 0000:00:1d.1: PCI INT B disabled [360229.230229] uhci_hcd 0000:00:1d.0: PCI INT A disabled [360229.340476] HDA Intel 0000:00:1b.0: PCI INT A disabled [360229.364941] HDA Intel 0000:00:1b.0: power state changed by ACPI to D3 [360229.364949] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 134.694 msecs [360229.364960] ehci_hcd 0000:00:1a.7: PCI INT D disabled [360229.364971] uhci_hcd 0000:00:1a.2: PCI INT C disabled [360229.364981] uhci_hcd 0000:00:1a.1: PCI INT B disabled [360229.364996] uhci_hcd 0000:00:1a.0: PCI INT A disabled [360229.365189] e1000e 0000:00:19.0: PCI INT A disabled [360229.365194] e1000e 0000:00:19.0: PME# enabled [360229.365199] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [360229.381503] PM: suspend of devices complete after 2174.437 msecs [360229.381506] PM: suspend devices took 2.180 seconds [360229.381956] ricoh-mmc: Suspending. [360229.381966] ricoh-mmc: Controller is now re-enabled. [360229.420255] PM: late suspend of devices complete after 38.745 msecs [360229.420866] ACPI: Preparing to enter system sleep state S3 [360229.470769] Disabling non-boot CPUs ... [360229.470787] CPU0 attaching NULL sched-domain. [360229.470790] CPU1 attaching NULL sched-domain. [360229.590015] CPU0 attaching NULL sched-domain. [360229.700015] CPU 1 is now offline [360229.700018] SMP alternatives: switching to UP code [360229.705787] Extended CMOS year: 2000 [360229.705787] Back to C! [360229.705787] CPU0: Thermal monitoring handled by SMI [360229.705787] Extended CMOS year: 2000 [360229.705787] Enabling non-boot CPUs ... [360229.705787] SMP alternatives: switching to SMP code [360229.711464] Booting processor 1 APIC 0x1 ip 0x6000 [360229.705738] Initializing CPU#1 [360229.705738] CPU: L1 I cache: 32K, L1 D cache: 32K [360229.705738] CPU: L2 cache: 6144K [360229.705738] CPU 1/0x1 -> Node 0 [360229.705738] CPU: Physical Processor ID: 0 [360229.705738] CPU: Processor Core ID: 1 [360229.705738] CPU1: Thermal monitoring handled by SMI [360229.870079] CPU1: Intel(R) Core(TM)2 Duo CPU T9400 @ 2.53GHz stepping 06 [360229.870140] CPU0 attaching NULL sched-domain. [360229.940016] CPU0 attaching sched-domain: [360229.940019] domain 0: span 0-1 level MC [360229.940021] groups: 0 1 [360229.940024] CPU1 attaching sched-domain: [360229.940026] domain 0: span 0-1 level MC [360229.940027] groups: 1 0 [360229.940452] CPU1 is up [360229.941286] ACPI: Waking up from system sleep state S3 [360230.197962] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x80100, writing 0x8010a) [360230.197968] pcieport 0000:00:01.0: restoring config space at offset 0xa (was 0xf, writing 0x0) [360230.197974] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010) [360230.197977] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [360230.198006] e1000e 0000:00:19.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [360230.198020] e1000e 0000:00:19.0: restoring config space at offset 0x6 (was 0x1, writing 0x80c1) [360230.198025] e1000e 0000:00:19.0: restoring config space at offset 0x5 (was 0x0, writing 0xdb324000) [360230.198029] e1000e 0000:00:19.0: restoring config space at offset 0x4 (was 0x0, writing 0xdb300000) [360230.198036] e1000e 0000:00:19.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [360230.198060] uhci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [360230.198073] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x8 (was 0x1, writing 0x80a1) [360230.198085] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [360230.198105] uhci_hcd 0000:00:1a.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [360230.198117] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x8 (was 0x1, writing 0x8081) [360230.198129] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [360230.198148] uhci_hcd 0000:00:1a.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [360230.198160] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x8 (was 0x1, writing 0x8061) [360230.198172] uhci_hcd 0000:00:1a.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [360230.198198] ehci_hcd 0000:00:1a.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [360230.198215] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325400) [360230.198223] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [360230.198273] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100002) [360230.198303] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [360230.198314] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdb51db41) [360230.198319] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xdb20db20) [360230.198323] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x20009090) [360230.198328] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x20200) [360230.198335] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [360230.198340] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [360230.198385] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x20a) [360230.198396] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xdb71db61) [360230.198401] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xdb10db10) [360230.198405] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x2000a0a0) [360230.198414] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [360230.198419] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [360230.198464] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [360230.198475] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xdb91db81) [360230.198480] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xdb00d710) [360230.198484] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x20000000, writing 0x20006050) [360230.198489] pcieport 0000:00:1c.2: restoring config space at offset 0x6 (was 0x0, writing 0x440400) [360230.198496] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [360230.198501] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [360230.198546] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x10a) [360230.198557] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0xdbb1dba1) [360230.198561] pcieport 0000:00:1c.4: restoring config space at offset 0x8 (was 0x0, writing 0xd700d310) [360230.198566] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x20004030) [360230.198570] pcieport 0000:00:1c.4: restoring config space at offset 0x6 (was 0x0, writing 0x854500) [360230.198577] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) [360230.198583] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [360230.198621] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [360230.198633] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x8041) [360230.198645] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [360230.198664] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [360230.198676] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x8021) [360230.198689] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [360230.198708] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30a) [360230.198720] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x8001) [360230.198732] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900001) [360230.198757] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40a) [360230.198775] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xdb325000) [360230.198782] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002) [360230.198806] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x20000, writing 0x200ff) [360230.198817] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0xdff1dc01) [360230.198822] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xd300d300) [360230.198826] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x22802020) [360230.198831] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x20000000, writing 0x208a8600) [360230.198840] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100100, writing 0x100107) [360230.198915] ata_piix 0000:00:1f.2: restoring config space at offset 0x9 (was 0x1, writing 0x8101) [360230.198929] ata_piix 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [360230.198954] ata_piix 0000:00:1f.5: restoring config space at offset 0xf (was 0x300, writing 0x30a) [360230.198966] ata_piix 0000:00:1f.5: restoring config space at offset 0x8 (was 0x1, writing 0x80f1) [360230.198970] ata_piix 0000:00:1f.5: restoring config space at offset 0x7 (was 0x1, writing 0x8141) [360230.198975] ata_piix 0000:00:1f.5: restoring config space at offset 0x6 (was 0x1, writing 0x8121) [360230.198979] ata_piix 0000:00:1f.5: restoring config space at offset 0x5 (was 0x1, writing 0x8145) [360230.198984] ata_piix 0000:00:1f.5: restoring config space at offset 0x4 (was 0x1, writing 0x8129) [360230.198991] ata_piix 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2b00000, writing 0x2b00007) [360230.199095] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [360230.199300] iwlagn 0000:03:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [360230.199334] iwlagn 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xdb100004) [360230.199341] iwlagn 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) [360230.199351] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100406) [360230.199422] ohci1394 0000:86:09.0: restoring config space at offset 0xf (was 0x4020100, writing 0x402010a) [360230.199445] ohci1394 0000:86:09.0: restoring config space at offset 0x4 (was 0x0, writing 0xd3001000) [360230.199450] ohci1394 0000:86:09.0: restoring config space at offset 0x3 (was 0x800000, writing 0x804010) [360230.199479] sdhci-pci 0000:86:09.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [360230.199502] sdhci-pci 0000:86:09.1: restoring config space at offset 0x4 (was 0x0, writing 0xd3001b00) [360230.199507] sdhci-pci 0000:86:09.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [360230.199514] sdhci-pci 0000:86:09.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [360230.199540] ricoh-mmc 0000:86:09.2: restoring config space at offset 0xf (was 0x200, writing 0x20b) [360230.199562] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x4 (was 0x0, writing 0xd3001a00) [360230.199568] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [360230.199575] ricoh-mmc 0000:86:09.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [360230.199588] ricoh-mmc: Resuming. [360230.199598] ricoh-mmc: Controller is now disabled. [360230.199612] pci 0000:86:09.3: restoring config space at offset 0xf (was 0x200, writing 0x20b) [360230.199634] pci 0000:86:09.3: restoring config space at offset 0x4 (was 0x0, writing 0xd3001800) [360230.199640] pci 0000:86:09.3: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [360230.199647] pci 0000:86:09.3: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [360230.199669] pci 0000:86:09.4: restoring config space at offset 0xf (was 0x800200, writing 0x180020b) [360230.199674] pci 0000:86:09.4: restoring config space at offset 0xe (was 0x0, writing 0x24fc) [360230.199679] pci 0000:86:09.4: restoring config space at offset 0xd (was 0x0, writing 0x2400) [360230.199685] pci 0000:86:09.4: restoring config space at offset 0xc (was 0x0, writing 0x20fc) [360230.199690] pci 0000:86:09.4: restoring config space at offset 0xb (was 0x0, writing 0x2000) [360230.199695] pci 0000:86:09.4: restoring config space at offset 0xa (was 0x0, writing 0xf3fff000) [360230.199700] pci 0000:86:09.4: restoring config space at offset 0x9 (was 0x0, writing 0xf0000000) [360230.199706] pci 0000:86:09.4: restoring config space at offset 0x8 (was 0x0, writing 0xdffff000) [360230.199711] pci 0000:86:09.4: restoring config space at offset 0x7 (was 0x0, writing 0xdc000000) [360230.199716] pci 0000:86:09.4: restoring config space at offset 0x6 (was 0x0, writing 0xb08a8786) [360230.199723] pci 0000:86:09.4: restoring config space at offset 0x4 (was 0x0, writing 0xd3000000) [360230.199729] pci 0000:86:09.4: restoring config space at offset 0x3 (was 0x820000, writing 0x824000) [360230.210017] yenta_cardbus 0000:86:09.5: Refused to change power state, currently in D3 [360230.280012] /dev/vmmon[0]: HostIF_ReadUptime: detected settimeofday: fixed uptimeBase old 18445438333211176489 new 18445438327820176650 attempts 1 [360230.940017] PM: early resume of drv:yenta_cardbus dev:0000:86:09.5 complete after 740.268 msecs [360230.940303] PM: early resume of devices complete after 742.473 msecs [360231.022055] e1000e 0000:00:19.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [360231.022060] e1000e 0000:00:19.0: setting latency timer to 64 [360231.022065] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [360231.022069] e1000e 0000:00:19.0: PME# disabled [360231.022107] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [360231.082083] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [360231.082088] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [360231.082110] usb usb3: root hub lost power or was reset [360231.082138] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [360231.082146] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [360231.082171] usb usb4: root hub lost power or was reset [360231.082190] uhci_hcd 0000:00:1a.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [360231.082200] uhci_hcd 0000:00:1a.2: setting latency timer to 64 [360231.082224] usb usb5: root hub lost power or was reset [360231.082242] ehci_hcd 0000:00:1a.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [360231.082247] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [360231.087024] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [360231.087091] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [360231.087130] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [360231.087168] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 [360231.087173] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [360231.087179] HDA Intel 0000:00:1b.0: setting latency timer to 64 [360231.087212] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [360231.087218] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [360231.087240] usb usb6: root hub lost power or was reset [360231.087258] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [360231.087264] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [360231.087286] usb usb7: root hub lost power or was reset [360231.087304] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [360231.087310] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [360231.087332] usb usb8: root hub lost power or was reset [360231.087351] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 20 (level, low) -> IRQ 20 [360231.087356] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [360231.087369] pci 0000:00:1e.0: setting latency timer to 64 [360231.087381] ata_piix 0000:00:1f.2: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [360231.087385] ata_piix 0000:00:1f.2: setting latency timer to 64 [360231.087403] ata_piix 0000:00:1f.5: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [360231.087408] ata_piix 0000:00:1f.5: setting latency timer to 64 [360231.446563] ata3: SATA link down (SStatus 0 SControl 300) [360231.462144] ata4: SATA link down (SStatus 0 SControl 310) [360231.621470] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [360231.643600] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [360231.643603] ata2.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [360231.683633] ata2.00: configured for UDMA/100 [360231.816392] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 728.946 msecs [360231.873477] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[20] MMIO=[d3001000-d30017ff] Max Packet=[2048] IR/IT contexts=[4/4] [360231.879504] sdhci-pci 0000:86:09.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22 [360232.091468] tpm_tis 00:04: Operation Timed out [360232.091473] PM: resume of drv:tpm_tis dev:00:04 complete after 210.667 msecs [360232.094136] parport_pc 00:09: activated [360232.371448] PM: resume of drv:usb dev:usb1 complete after 276.867 msecs [360232.541463] PM: resume of drv:usb dev:usb2 complete after 169.998 msecs [360232.811284] PM: resume of drv:usb dev:usb4 complete after 269.791 msecs [360232.812931] sd 0:0:0:0: [sda] Starting disk [360234.141346] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [360234.201566] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [360234.201569] ata1.00: ACPI cmd ef/03:41:00:00:00:a0 (SET FEATURES) filtered out [360234.242895] ata1.00: configured for UDMA/133 [360234.258417] PM: resume of drv:sd dev:0:0:0:0 complete after 1445.484 msecs [360234.430032] usb 4-1: reset full speed USB device using uhci_hcd and address 2 [360234.586479] PM: resume of drv:usb dev:4-1 complete after 275.392 msecs [360234.626692] PM: resume of devices complete after 3686.346 msecs [360234.626911] PM: resume devices took 3.680 seconds [360234.626951] PM: Finishing wakeup. [360234.626952] Restarting tasks ... done. [360235.010023] usb 3-1: new full speed USB device using uhci_hcd and address 58 [360235.150054] usb 3-1: device descriptor read/64, error -71 [360235.390024] usb 3-1: device descriptor read/64, error -71 [360235.620134] usb 3-1: new full speed USB device using uhci_hcd and address 59 [360235.751275] usb 3-1: device descriptor read/64, error -71 [360235.910238] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [360235.970065] e1000e 0000:00:19.0: irq 29 for MSI/MSI-X [360235.970567] ADDRCONF(NETDEV_UP): eth0: link is not ready [360235.991277] usb 3-1: device descriptor read/64, error -71 [360236.221276] usb 3-1: new full speed USB device using uhci_hcd and address 60 [360236.641270] usb 3-1: device not accepting address 60, error -71 [360236.763211] usb 3-1: new full speed USB device using uhci_hcd and address 61 [360237.190035] usb 3-1: device not accepting address 61, error -71 [360237.190059] hub 3-0:1.0: unable to enumerate USB device on port 1 [360262.481527] CE: hpet increasing min_delta_ns to 33750 nsec [360271.115688] NetworkManager: page allocation failure. order:4, mode:0x40d0 [360271.115699] Pid: 1754, comm: NetworkManager Tainted: P W 2.6.32-31-generic #61-Ubuntu [360271.115705] Call Trace: [360271.115724] [] __alloc_pages_slowpath+0x4a9/0x590 [360271.115736] [] __alloc_pages_nodemask+0x15e/0x1a0 [360271.115747] [] alloc_pages_current+0x87/0xd0 [360271.115756] [] __get_free_pages+0xe/0x50 [360271.115780] [] iwl_tx_queue_alloc+0x50/0x220 [iwlcore] [360271.115799] [] ? iwl_tx_queue_init+0xc5/0x210 [iwlcore] [360271.115817] [] iwl_tx_queue_init+0x13f/0x210 [iwlcore] [360271.115835] [] iwl_txq_ctx_reset+0x297/0x4b0 [iwlcore] [360271.115853] [] iwl_hw_nic_init+0xf8/0x170 [iwlcore] [360271.115867] [] __iwl_up+0x9f/0x390 [iwlagn] [360271.115879] [] iwl_mac_start+0x5a/0x1f0 [iwlagn] [360271.115892] [] ? default_spin_lock_flags+0x9/0x10 [360271.115928] [] ieee80211_open+0x391/0x840 [mac80211] [360271.115939] [] ? notifier_call_chain+0x56/0x80 [360271.115950] [] dev_open+0xa2/0x100 [360271.115957] [] dev_change_flags+0xa1/0x1e0 [360271.115967] [] do_setlink+0x1af/0x430 [360271.115978] [] ? nla_parse+0x34/0x110 [360271.115987] [] rtnl_setlink+0x132/0x180 [360271.115997] [] rtnetlink_rcv_msg+0x1e0/0x220 [360271.116005] [] ? rtnetlink_rcv_msg+0x0/0x220 [360271.116015] [] netlink_rcv_skb+0xa9/0xd0 [360271.116023] [] rtnetlink_rcv+0x25/0x40 [360271.116031] [] netlink_unicast+0x2de/0x2f0 [360271.116039] [] netlink_sendmsg+0x1fe/0x2e0 [360271.116047] [] ? skb_queue_tail+0x4d/0x60 [360271.116057] [] sock_sendmsg+0x10b/0x140 [360271.116065] [] ? sock_recvmsg+0x11e/0x150 [360271.116075] [] ? autoremove_wake_function+0x0/0x40 [360271.116085] [] ? move_addr_to_kernel+0x64/0x70 [360271.116093] [] ? verify_iovec+0x66/0xd0 [360271.116101] [] sys_sendmsg+0x233/0x3a0 [360271.116110] [] ? sys_sendto+0x185/0x190 [360271.116121] [] ? fput+0x25/0x30 [360271.116129] [] ? filp_close+0x5d/0x90 [360271.116140] [] system_call_fastpath+0x16/0x1b [360271.116146] Mem-Info: [360271.116150] Node 0 DMA per-cpu: [360271.116157] CPU 0: hi: 0, btch: 1 usd: 0 [360271.116162] CPU 1: hi: 0, btch: 1 usd: 0 [360271.116166] Node 0 DMA32 per-cpu: [360271.116173] CPU 0: hi: 186, btch: 31 usd: 0 [360271.116178] CPU 1: hi: 186, btch: 31 usd: 0 [360271.116182] Node 0 Normal per-cpu: [360271.116189] CPU 0: hi: 186, btch: 31 usd: 0 [360271.116194] CPU 1: hi: 186, btch: 31 usd: 0 [360271.116206] active_anon:519699 inactive_anon:194286 isolated_anon:28 [360271.116209] active_file:55232 inactive_file:76136 isolated_file:15 [360271.116211] unevictable:13 dirty:736 writeback:140 unstable:0 [360271.116214] free:73837 slab_reclaimable:15594 slab_unreclaimable:6709 [360271.116216] mapped:28601 shmem:2798 pagetables:7521 bounce:0 [360271.116222] Node 0 DMA free:15908kB min:28kB low:32kB high:40kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15344kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:8kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [360271.116246] lowmem_reserve[]: 0 2964 3974 3974 [360271.116256] Node 0 DMA32 free:274716kB min:6004kB low:7504kB high:9004kB active_anon:1828876kB inactive_anon:514500kB active_file:87028kB inactive_file:145376kB unevictable:4kB isolated(anon):112kB isolated(file):60kB present:3036024kB mlocked:4kB dirty:152kB writeback:360kB mapped:34012kB shmem:2288kB slab_reclaimable:39996kB slab_unreclaimable:5648kB kernel_stack:320kB pagetables:5916kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [360271.116283] lowmem_reserve[]: 0 0 1010 1010 [360271.116292] Node 0 Normal free:4724kB min:2044kB low:2552kB high:3064kB active_anon:249920kB inactive_anon:262644kB active_file:133900kB inactive_file:159168kB unevictable:48kB isolated(anon):0kB isolated(file):0kB present:1034240kB mlocked:48kB dirty:2792kB writeback:200kB mapped:80392kB shmem:8904kB slab_reclaimable:22380kB slab_unreclaimable:21180kB kernel_stack:2320kB pagetables:24168kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [360271.116319] lowmem_reserve[]: 0 0 0 0 [360271.116328] Node 0 DMA: 1*4kB 2*8kB 3*16kB 3*32kB 4*64kB 1*128kB 2*256kB 1*512kB 2*1024kB 2*2048kB 2*4096kB = 15908kB [360271.116353] Node 0 DMA32: 6787*4kB 30316*8kB 259*16kB 16*32kB 0*64kB 1*128kB 1*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 274716kB [360271.116378] Node 0 Normal: 707*4kB 61*8kB 86*16kB 1*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 4724kB [360271.116402] 207919 total pagecache pages [360271.116406] 73756 pages in swap cache [360271.116412] Swap cache stats: add 1402932, delete 1329176, find 1021188/1203388 [360271.116417] Free swap = 1310276kB [360271.116421] Total swap = 2097144kB [360271.160522] 1048576 pages RAM [360271.160527] 42552 pages reserved [360271.160531] 466188 pages shared [360271.160534] 519841 pages non-shared [360271.160542] iwlagn 0000:03:00.0: kmalloc for auxiliary BD structures failed [360271.160635] iwlagn 0000:03:00.0: Tx 16 queue init failed [360271.161860] iwlagn 0000:03:00.0: Unable to init nic [360287.899553] CPU0 attaching NULL sched-domain. [360287.899565] CPU1 attaching NULL sched-domain. [360287.951459] CPU0 attaching sched-domain: [360287.951468] domain 0: span 0-1 level MC [360287.951474] groups: 0 1 [360287.951484] domain 1: span 0-1 level CPU [360287.951490] groups: 0-1 (cpu_power = 2048) [360287.951503] CPU1 attaching sched-domain: [360287.951508] domain 0: span 0-1 level MC [360287.951513] groups: 1 0 [360287.951522] domain 1: span 0-1 level CPU [360287.951528] groups: 0-1 (cpu_power = 2048) [360312.568328] wpa_supplicant: page allocation failure. order:4, mode:0x40d0 [360312.568339] Pid: 1138, comm: wpa_supplicant Tainted: P W 2.6.32-31-generic #61-Ubuntu [360312.568345] Call Trace: [360312.568364] [] __alloc_pages_slowpath+0x4a9/0x590 [360312.568375] [] __alloc_pages_nodemask+0x15e/0x1a0 [360312.568387] [] alloc_pages_current+0x87/0xd0 [360312.568395] [] __get_free_pages+0xe/0x50 [360312.568420] [] iwl_tx_queue_alloc+0x50/0x220 [iwlcore] [360312.568439] [] ? iwl_tx_queue_init+0xc5/0x210 [iwlcore] [360312.568457] [] iwl_tx_queue_init+0x13f/0x210 [iwlcore] [360312.568476] [] iwl_txq_ctx_reset+0x297/0x4b0 [iwlcore] [360312.568494] [] iwl_hw_nic_init+0xf8/0x170 [iwlcore] [360312.568508] [] __iwl_up+0x9f/0x390 [iwlagn] [360312.568520] [] iwl_mac_start+0x5a/0x1f0 [iwlagn] [360312.568532] [] ? default_spin_lock_flags+0x9/0x10 [360312.568568] [] ieee80211_open+0x391/0x840 [mac80211] [360312.568579] [] ? notifier_call_chain+0x56/0x80 [360312.568590] [] dev_open+0xa2/0x100 [360312.568598] [] dev_change_flags+0xa1/0x1e0 [360312.568607] [] devinet_ioctl+0x593/0x5f0 [360312.568615] [] inet_ioctl+0x90/0xb0 [360312.568624] [] sock_ioctl+0x7a/0x280 [360312.568634] [] vfs_ioctl+0x22/0xa0 [360312.568643] [] ? sys_bind+0xd0/0xf0 [360312.568651] [] do_vfs_ioctl+0x81/0x380 [360312.568658] [] ? sock_map_fd+0x4c/0x80 [360312.568666] [] sys_ioctl+0x81/0xa0 [360312.568674] [] ? sys_socket+0x51/0x80 [360312.568685] [] system_call_fastpath+0x16/0x1b [360312.568690] Mem-Info: [360312.568694] Node 0 DMA per-cpu: [360312.568701] CPU 0: hi: 0, btch: 1 usd: 0 [360312.568707] CPU 1: hi: 0, btch: 1 usd: 0 [360312.568711] Node 0 DMA32 per-cpu: [360312.568717] CPU 0: hi: 186, btch: 31 usd: 0 [360312.568722] CPU 1: hi: 186, btch: 31 usd: 0 [360312.568726] Node 0 Normal per-cpu: [360312.568733] CPU 0: hi: 186, btch: 31 usd: 0 [360312.568738] CPU 1: hi: 186, btch: 31 usd: 0 [360312.568750] active_anon:516952 inactive_anon:196458 isolated_anon:16 [360312.568753] active_file:54406 inactive_file:72076 isolated_file:16 [360312.568756] unevictable:13 dirty:115 writeback:178 unstable:0 [360312.568758] free:79645 slab_reclaimable:15268 slab_unreclaimable:6739 [360312.568761] mapped:28265 shmem:2777 pagetables:7506 bounce:0 [360312.568767] Node 0 DMA free:15908kB min:28kB low:32kB high:40kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15344kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:8kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [360312.568791] lowmem_reserve[]: 0 2964 3974 3974 [360312.568801] Node 0 DMA32 free:288080kB min:6004kB low:7504kB high:9004kB active_anon:1820872kB inactive_anon:520564kB active_file:86456kB inactive_file:136716kB unevictable:4kB isolated(anon):0kB isolated(file):0kB present:3036024kB mlocked:4kB dirty:28kB writeback:432kB mapped:33876kB shmem:2256kB slab_reclaimable:39024kB slab_unreclaimable:5480kB kernel_stack:304kB pagetables:5856kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [360312.568828] lowmem_reserve[]: 0 0 1010 1010 [360312.568837] Node 0 Normal free:14592kB min:2044kB low:2552kB high:3064kB active_anon:246936kB inactive_anon:265268kB active_file:131168kB inactive_file:151588kB unevictable:48kB isolated(anon):64kB isolated(file):64kB present:1034240kB mlocked:48kB dirty:432kB writeback:280kB mapped:79184kB shmem:8852kB slab_reclaimable:22048kB slab_unreclaimable:21468kB kernel_stack:2320kB pagetables:24168kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no [360312.568867] lowmem_reserve[]: 0 0 0 0 [360312.568876] Node 0 DMA: 1*4kB 2*8kB 3*16kB 3*32kB 4*64kB 1*128kB 2*256kB 1*512kB 2*1024kB 2*2048kB 2*4096kB = 15908kB [360312.568901] Node 0 DMA32: 7944*4kB 30852*8kB 543*16kB 9*32kB 0*64kB 0*128kB 0*256kB 1*512kB 0*1024kB 0*2048kB 0*4096kB = 288080kB [360312.568925] Node 0 Normal: 1728*4kB 598*8kB 175*16kB 3*32kB 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 14592kB [360312.568949] 205677 total pagecache pages [360312.568954] 76420 pages in swap cache [360312.568959] Swap cache stats: add 1406754, delete 1330334, find 1021449/1203789 [360312.568964] Free swap = 1297508kB [360312.568968] Total swap = 2097144kB [360312.612465] 1048576 pages RAM [360312.612470] 42552 pages reserved [360312.612476] 461429 pages shared [360312.612478] 518428 pages non-shared [360312.612486] iwlagn 0000:03:00.0: kmalloc for auxiliary BD structures failed [360312.612582] iwlagn 0000:03:00.0: Tx 17 queue init failed [360312.613919] iwlagn 0000:03:00.0: Unable to init nic [360323.560218] CE: hpet increasing min_delta_ns to 50624 nsec [360323.560555] CE: hpet increasing min_delta_ns to 75936 nsec [360323.570186] CE: hpet increasing min_delta_ns to 113904 nsec [360330.262124] iwlagn 0000:03:00.0: RF_KILL bit toggled to disable radio. [360352.500535] CE: hpet increasing min_delta_ns to 170856 nsec [360386.566993] CE: hpet increasing min_delta_ns to 256284 nsec [360431.354327] iwlagn 0000:03:00.0: RF_KILL bit toggled to enable radio. [360431.852304] usb 3-1: new full speed USB device using uhci_hcd and address 62 [360431.980064] usb 3-1: device descriptor read/64, error -71 [360432.221298] usb 3-1: device descriptor read/64, error -71 [360432.451330] usb 3-1: new full speed USB device using uhci_hcd and address 63 [360432.580057] usb 3-1: device descriptor read/64, error -71 [360432.820048] usb 3-1: device descriptor read/64, error -71 [360433.050052] usb 3-1: new full speed USB device using uhci_hcd and address 64 [360433.470204] usb 3-1: device not accepting address 64, error -71 [360433.590135] usb 3-1: new full speed USB device using uhci_hcd and address 65 [360434.010061] usb 3-1: device not accepting address 65, error -71 [360434.010094] hub 3-0:1.0: unable to enumerate USB device on port 1 [360435.910710] ------------[ cut here ]------------ [360435.910742] WARNING: at /build/buildd/linux-2.6.32/drivers/net/wireless/iwlwifi/iwl-tx.c:1172 iwl_tx_cmd_complete+0x133/0x170 [iwlcore]() [360435.910750] Hardware name: HP EliteBook 8530w [360435.910756] wrong command queue 0, sequence 0x0 readp=0 writep=0 [360435.910761] Modules linked in: aes_x86_64 aes_generic iwlagn iwlcore usb_storage vmnet vmblock vsock vmci vmmon autofs4 cryptd binfmt_misc snd_hda_codec_analog pata_pcmcia snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss arc4 snd_pcm snd_seq_dummy snd_seq_oss pcmcia snd_seq_midi snd_rawmidi snd_seq_midi_event fbcon tileblit snd_seq font yenta_socket snd_timer snd_seq_device usbhid hid mac80211 sdhci_pci tpm_infineon snd rsrc_nonstatic bitblit soundcore pcmcia_core ricoh_mmc sdhci softcursor cfg80211 snd_page_alloc joydev nvidia(P) vga16fb vgastate video output tpm_tis tpm tpm_bios intel_agp ppdev hp_accel lis3lv02d psmouse serio_raw parport_pc input_polldev led_class uvcvideo videodev v4l1_compat v4l2_compat_ioctl32 lp parport ohci1394 ieee1394 e1000e [last unloaded: aes_generic] [360435.910910] Pid: 0, comm: swapper Tainted: P W 2.6.32-31-generic #61-Ubuntu [360435.910917] Call Trace: [360435.910921] [] warn_slowpath_common+0x7b/0xc0 [360435.910944] [] warn_slowpath_fmt+0x41/0x50 [360435.910954] [] ? it_real_fn+0x43/0x90 [360435.910964] [] ? ktime_get+0x63/0xe0 [360435.910982] [] iwl_tx_cmd_complete+0x133/0x170 [iwlcore] [360435.910993] [] ? unmap_single+0x34/0x70 [360435.911007] [] iwl_rx_handle+0x11c/0x2f0 [iwlagn] [360435.911017] [] ? hrtimer_interrupt+0x130/0x220 [360435.911029] [] iwl_irq_tasklet+0x148/0x510 [iwlagn] [360435.911038] [] tasklet_action+0xd5/0xe0 [360435.911047] [] __do_softirq+0xb7/0x1f0 [360435.911055] [] ? handle_IRQ_event+0x60/0x170 [360435.911065] [] call_softirq+0x1c/0x30 [360435.911072] [] do_softirq+0x65/0xa0 [360435.911080] [] irq_exit+0x85/0x90 [360435.911089] [] do_IRQ+0x75/0xf0 [360435.911097] [] ret_from_intr+0x0/0x11 [360435.911101] [] ? acpi_idle_enter_simple+0x117/0x14b [360435.911119] [] ? acpi_idle_enter_simple+0x110/0x14b [360435.911130] [] ? cpuidle_idle_call+0xa7/0x140 [360435.911139] [] ? cpu_idle+0xb3/0x110 [360435.911148] [] ? rest_init+0x6b/0x80 [360435.911159] [] ? start_kernel+0x36d/0x376 [360435.911167] [] ? x86_64_start_reservations+0x125/0x129 [360435.911175] [] ? x86_64_start_kernel+0xfa/0x109 [360435.911181] ---[ end trace 886d0dd08bf3c8e4 ]--- [360435.911189] iwl data: 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ [360435.911198] iwl data: 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ [360439.910024] iwlagn 0000:03:00.0: START_ALIVE timeout after 4000ms. [360655.673157] iwlagn 0000:03:00.0: RF_KILL bit toggled to disable radio. [360655.872752] iwlagn 0000:03:00.0: Microcode SW error detected. Restarting 0x2000000. [360728.822951] iwlagn 0000:03:00.0: PCI INT A disabled [360729.392824] iwlagn: Intel(R) Wireless WiFi Link AGN driver for Linux, 1.3.27k [360729.392827] iwlagn: Copyright(c) 2003-2009 Intel Corporation [360729.392903] iwlagn 0000:03:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 [360729.392914] iwlagn 0000:03:00.0: setting latency timer to 64 [360729.393273] iwlagn 0000:03:00.0: Detected Intel Wireless WiFi Link 5300AGN REV=0x24 [360729.430821] iwlagn 0000:03:00.0: Tunable channels: 13 802.11bg, 24 802.11a channels [360729.430897] iwlagn 0000:03:00.0: irq 30 for MSI/MSI-X [360729.431463] phy2: Selected rate control algorithm 'iwl-agn-rs' [360739.808455] iwlagn 0000:03:00.0: RF_KILL bit toggled to enable radio. [360740.073957] iwlagn 0000:03:00.0: firmware: requesting iwlwifi-5000-2.ucode [360740.190048] iwlagn 0000:03:00.0: loaded firmware version 8.24.2.12 [360740.301344] usb 3-1: new full speed USB device using uhci_hcd and address 66 [360740.440069] usb 3-1: device descriptor read/64, error -71 [360740.670065] usb 3-1: device descriptor read/64, error -71 [360740.901386] usb 3-1: new full speed USB device using uhci_hcd and address 67 [360741.031374] usb 3-1: device descriptor read/64, error -71 [360741.270113] usb 3-1: device descriptor read/64, error -71 [360741.500065] usb 3-1: new full speed USB device using uhci_hcd and address 68 [360741.920126] usb 3-1: device not accepting address 68, error -71 [360742.040092] usb 3-1: new full speed USB device using uhci_hcd and address 69 [360742.265600] Registered led device: iwl-phy2::radio [360742.265690] Registered led device: iwl-phy2::assoc [360742.265767] Registered led device: iwl-phy2::RX [360742.265842] Registered led device: iwl-phy2::TX [360742.292038] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [360742.292064] /dev/vmnet: hub 0 does not exist, allocating memory. [360742.292129] /dev/vmnet: port on hub 0 successfully opened [360742.292158] bridge-wlan0: device is wireless, enabling SMAC [360742.292167] bridge-wlan0: up [360742.293148] ADDRCONF(NETDEV_UP): wlan0: link is not ready [360742.322508] bridge-wlan0: attached [360742.322587] bridge-wlan0: disabling the bridge [360742.381322] bridge-wlan0: down [360742.381333] bridge-wlan0: detached [360742.470036] usb 3-1: device not accepting address 69, error -71 [360742.470069] hub 3-0:1.0: unable to enumerate USB device on port 1 [360755.584361] wlan0: deauthenticating from 00:22:f7:21:5f:28 by local choice (reason=3) [360755.584539] wlan0: direct probe to AP 00:22:f7:21:5f:28 (try 1) [360755.589227] wlan0: direct probe responded [360755.589235] wlan0: authenticate with AP 00:22:f7:21:5f:28 (try 1) [360755.591173] wlan0: authenticated [360755.591212] wlan0: associate with AP 00:22:f7:21:5f:28 (try 1) [360755.595131] wlan0: RX AssocResp from 00:22:f7:21:5f:28 (capab=0x411 status=0 aid=1) [360755.595138] wlan0: associated [360755.602370] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [360756.352843] /dev/vmnet: open called by PID 8639 (vmnet-bridge) [360756.352857] /dev/vmnet: hub 0 does not exist, allocating memory. [360756.352874] /dev/vmnet: port on hub 0 successfully opened [360756.352883] bridge-wlan0: device is wireless, enabling SMAC [360756.352887] bridge-wlan0: up [360756.352889] bridge-wlan0: attached [360766.000019] wlan0: no IPv6 routers present [360770.373091] /dev/vmmon[8744]: HostIF_ReadUptime: detected settimeofday: fixed uptimeBase old 18445438327820176650 new 18445438327815973230 attempts 1 [360773.711515] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = 00:22:f7:21:5f:28 tid = 0 [361324.769032] usb 4-1: usbfs: process 8744 (vmware-vmx) did not claim interface 0 before use [361410.643448] uvcvideo: Found UVC 1.00 device CKA7216 (04f2:b053) [361410.643485] uvcvideo: No streaming interface found for terminal 2. [361410.643630] input: CKA7216 as /devices/pci0000:00/0000:00:1a.7/usb1/1-5/1-5:1.0/input/input19