Time:  9:15:00  Date: 10/20/10
[    0.510057] NET: Registered protocol family 16
[    0.510232] Trying to unpack rootfs image as initramfs...
[    0.510238] EISA bus registered
[    0.510245] ACPI: bus type pci registered
[    0.519553] PCI: Using configuration type 1 for base access
[    0.520428] bio: create slab <bio-0> at 0
[    0.522324] ACPI: EC: Look up EC in DSDT
[    0.524198] ACPI: Executed 1 blocks of module-level executable AML code
[    0.531830] ACPI: BIOS _OSI(Linux) query ignored
[    0.541814] ACPI: SSDT bb620c18 003A4 (v01    AMI      IST 00000001 MSFT 03000001)
[    0.542558] ACPI: Dynamic OEM Table Load:
[    0.542750] ACPI: SSDT (null) 003A4 (v01    AMI      IST 00000001 MSFT 03000001)
[    0.543853] ACPI: Interpreter enabled
[    0.543935] ACPI: (supports S0 S3 S4 S5)
[    0.544262] ACPI: Using IOAPIC for interrupt routing
[    0.544666] ACPI: BIOS _OSI(Linux) query ignored
[    0.563953] ACPI: No dock devices found.
[    0.564039] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.564424] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.564712] pci_root PNP0A08:00: host bridge window [io  0x0000-0x0cf7]
[    0.564798] pci_root PNP0A08:00: host bridge window [io  0x0d00-0xffff]
[    0.564881] pci_root PNP0A08:00: host bridge window [mem 0x000a0000-0x000bffff]
[    0.564976] pci_root PNP0A08:00: host bridge window [mem 0xbc000000-0xffffffff]
[    0.565134] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold
[    0.565137] pci 0000:00:01.0: PME# disabled
[    0.565209] pci 0000:00:16.0: reg 10: [mem 0xfb409000-0xfb40900f 64bit]
[    0.565268] pci 0000:00:16.0: PME# supported from D0 D3hot D3cold
[    0.565273] pci 0000:00:16.0: PME# disabled
[    0.565331] pci 0000:00:1a.0: reg 10: [mem 0xfb408000-0xfb4083ff]
[    0.565399] pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold
[    0.565403] pci 0000:00:1a.0: PME# disabled
[    0.565446] pci 0000:00:1b.0: reg 10: [mem 0xfb400000-0xfb403fff 64bit]
[    0.565505] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[    0.565510] pci 0000:00:1b.0: PME# disabled
[    0.565599] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[    0.565604] pci 0000:00:1c.0: PME# disabled
[    0.565697] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[    0.565702] pci 0000:00:1c.1: PME# disabled
[    0.565795] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold
[    0.565800] pci 0000:00:1c.2: PME# disabled
[    0.565859] pci 0000:00:1d.0: reg 10: [mem 0xfb407000-0xfb4073ff]
[    0.565925] pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold
[    0.565930] pci 0000:00:1d.0: PME# disabled
[    0.566135] pci 0000:00:1f.2: reg 10: [io  0xf070-0xf077]
[    0.566143] pci 0000:00:1f.2: reg 14: [io  0xf060-0xf063]
[    0.566150] pci 0000:00:1f.2: reg 18: [io  0xf050-0xf057]
[    0.566157] pci 0000:00:1f.2: reg 1c: [io  0xf040-0xf043]
[    0.566164] pci 0000:00:1f.2: reg 20: [io  0xf020-0xf03f]
[    0.566172] pci 0000:00:1f.2: reg 24: [mem 0xfb406000-0xfb4067ff]
[    0.566218] pci 0000:00:1f.2: PME# supported from D3hot
[    0.566223] pci 0000:00:1f.2: PME# disabled
[    0.566262] pci 0000:00:1f.3: reg 10: [mem 0xfb405000-0xfb4050ff 64bit]
[    0.566281] pci 0000:00:1f.3: reg 20: [io  0xf000-0xf01f]
[    0.566343] pci 0000:00:1f.6: reg 10: [mem 0xfb404000-0xfb404fff 64bit]
[    0.566461] pci 0000:01:00.0: reg 10: [mem 0xfa000000-0xfaffffff]
[    0.566472] pci 0000:01:00.0: reg 14: [mem 0xc0000000-0xcfffffff 64bit pref]
[    0.566483] pci 0000:01:00.0: reg 1c: [mem 0xd0000000-0xd1ffffff 64bit pref]
[    0.566490] pci 0000:01:00.0: reg 24: [io  0xe000-0xe07f]
[    0.566497] pci 0000:01:00.0: reg 30: [mem 0xfb000000-0xfb07ffff pref]
[    0.566556] pci 0000:01:00.1: reg 10: [mem 0xfb080000-0xfb083fff]
[    0.566646] pci 0000:00:01.0: PCI bridge to [bus 01-01]
[    0.566730] pci 0000:00:01.0:   bridge window [io  0xe000-0xefff]
[    0.566733] pci 0000:00:01.0:   bridge window [mem 0xfa000000-0xfb0fffff]
[    0.566737] pci 0000:00:01.0:   bridge window [mem 0xc0000000-0xd1ffffff 64bit pref]
[    0.566793] pci 0000:00:1c.0: PCI bridge to [bus 11-11]
[    0.566879] pci 0000:00:1c.0:   bridge window [io  0xf000-0x0000] (disabled)
[    0.566884] pci 0000:00:1c.0:   bridge window [mem 0xfff00000-0x000fffff] (disabled)
[    0.566892] pci 0000:00:1c.0:   bridge window [mem 0xfff00000-0x000fffff pref] (disabled)
[    0.566998] pci 0000:12:00.0: reg 10: [mem 0xfb300000-0xfb303fff 64bit]
[    0.567094] pci 0000:12:00.0: supports D1 D2
[    0.567096] pci 0000:12:00.0: PME# supported from D0 D3hot D3cold
[    0.567103] pci 0000:12:00.0: PME# disabled
[    0.574433] pci 0000:00:1c.1: PCI bridge to [bus 12-12]
[    0.574520] pci 0000:00:1c.1:   bridge window [io  0xf000-0x0000] (disabled)
[    0.574526] pci 0000:00:1c.1:   bridge window [mem 0xfb300000-0xfb3fffff]
[    0.574533] pci 0000:00:1c.1:   bridge window [mem 0xfff00000-0x000fffff pref] (disabled)
[    0.574619] pci 0000:13:00.0: reg 10: [io  0xd000-0xd0ff]
[    0.574640] pci 0000:13:00.0: reg 18: [mem 0xd2104000-0xd2104fff 64bit pref]
[    0.574654] pci 0000:13:00.0: reg 20: [mem 0xd2100000-0xd2103fff 64bit pref]
[    0.574663] pci 0000:13:00.0: reg 30: [mem 0xfb200000-0xfb21ffff pref]
[    0.574704] pci 0000:13:00.0: supports D1 D2
[    0.574706] pci 0000:13:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.574711] pci 0000:13:00.0: PME# disabled
[    0.582413] pci 0000:00:1c.2: PCI bridge to [bus 13-13]
[    0.582500] pci 0000:00:1c.2:   bridge window [io  0xd000-0xdfff]
[    0.582505] pci 0000:00:1c.2:   bridge window [mem 0xfb200000-0xfb2fffff]
[    0.582513] pci 0000:00:1c.2:   bridge window [mem 0xd2100000-0xd21fffff 64bit pref]
[    0.582592] pci 0000:00:1e.0: PCI bridge to [bus 20-20] (subtractive decode)
[    0.582679] pci 0000:00:1e.0:   bridge window [io  0xf000-0x0000] (disabled)
[    0.582684] pci 0000:00:1e.0:   bridge window [mem 0xfff00000-0x000fffff] (disabled)
[    0.582691] pci 0000:00:1e.0:   bridge window [mem 0xfff00000-0x000fffff pref] (disabled)
[    0.582694] pci 0000:00:1e.0:   bridge window [io  0x0000-0x0cf7] (subtractive decode)
[    0.582696] pci 0000:00:1e.0:   bridge window [io  0x0d00-0xffff] (subtractive decode)
[    0.582699] pci 0000:00:1e.0:   bridge window [mem 0x000a0000-0x000bffff] (subtractive decode)
[    0.582701] pci 0000:00:1e.0:   bridge window [mem 0xbc000000-0xffffffff] (subtractive decode)
[    0.582730] pci_bus 0000:00: on NUMA node 0
[    0.582741] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[    0.583013] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.BR20._PRT]
[    0.583145] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX0._PRT]
[    0.583221] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX1._PRT]
[    0.583298] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX2._PRT]
[    0.589908] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 *11 12 14 15)
[    0.590813] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 *5 6 7 10 11 12 14 15)
[    0.591710] ACPI: PCI Interrupt Link [LNKC] (IRQs *3 4 5 6 10 11 12 14 15)
[    0.592546] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 *4 5 6 10 11 12 14 15)
[    0.593390] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0
[    0.594355] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0
[    0.595320] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 *10 11 12 14 15)
[    0.596207] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 *7 10 11 12 14 15)
[    0.597024] HEST: Table is not found!
[    0.597182] vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=io+mem,locks=none
[    0.597279] vgaarb: loaded
[    0.597494] SCSI subsystem initialized
[    0.597690] libata version 3.00 loaded.
[    0.597738] usbcore: registered new interface driver usbfs
[    0.597832] usbcore: registered new interface driver hub
[    0.597941] usbcore: registered new device driver usb
[    0.598248] ACPI: WMI: Mapper loaded
[    0.598327] PCI: Using ACPI for IRQ routing
[    0.598412] PCI: pci_cache_line_size set to 64 bytes
[    0.598502] reserve RAM buffer: 0000000000002000 - 000000000000ffff 
[    0.598504] reserve RAM buffer: 000000000009d400 - 000000000009ffff 
[    0.598506] reserve RAM buffer: 00000000bb592000 - 00000000bbffffff 
[    0.598510] reserve RAM buffer: 00000000bb800000 - 00000000bbffffff 
[    0.598588] NetLabel: Initializing
[    0.598669] NetLabel:  domain hash size = 128
[    0.598747] NetLabel:  protocols = UNLABELED CIPSOv4
[    0.598839] NetLabel:  unlabeled traffic allowed by default
[    0.598959] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0
[    0.599554] hpet0: 8 comparators, 64-bit 14.318180 MHz counter
[    0.601647] Switching to clocksource tsc
[    0.610238] AppArmor: AppArmor Filesystem Enabled
[    0.610345] pnp: PnP ACPI init
[    0.610442] ACPI: bus type pnp registered
[    0.611975]   alloc irq_desc for 20 on node -1
[    0.611977]   alloc kstat_irqs on node -1
[    0.612510] pnp: PnP ACPI: found 12 devices
[    0.612591] ACPI: ACPI bus type pnp unregistered
[    0.612672] PnPBIOS: Disabled by ACPI PNP
[    0.612760] system 00:01: [mem 0xfed14000-0xfed19fff] has been reserved
[    0.612846] system 00:01: [mem 0xe0000000-0xefffffff] has been reserved
[    0.612930] system 00:01: [mem 0xfed90000-0xfed93fff] has been reserved
[    0.613013] system 00:01: [mem 0xfed20000-0xfed3ffff] has been reserved
[    0.613096] system 00:01: [mem 0xfee00000-0xfee0ffff] has been reserved
[    0.613186] system 00:06: [io  0x04d0-0x04d1] has been reserved
[    0.613272] system 00:06: [mem 0xfe800000-0xfe8001ff] has been reserved
[    0.613356] system 00:09: [io  0x0400-0x047f] has been reserved
[    0.613440] system 00:09: [io  0x1180-0x119f] has been reserved
[    0.613523] system 00:09: [io  0x0500-0x057f] has been reserved
[    0.613607] system 00:09: [mem 0xfed1c000-0xfed1ffff] has been reserved
[    0.613692] system 00:09: [mem 0xfec00000-0xfecfffff] could not be reserved
[    0.613777] system 00:09: [mem 0xfed08000-0xfed08fff] has been reserved
[    0.613857] system 00:09: [mem 0xff000000-0xffffffff] has been reserved
[    0.649143] pci 0000:00:1c.0: BAR 14: assigned [mem 0xbc000000-0xbc1fffff]
[    0.649236] pci 0000:00:1c.0: BAR 15: assigned [mem 0xbc200000-0xbc3fffff 64bit pref]
[    0.649335] pci 0000:00:1c.1: BAR 15: assigned [mem 0xbc400000-0xbc5fffff 64bit pref]
[    0.649432] pci 0000:00:1c.0: BAR 13: assigned [io  0x2000-0x2fff]
[    0.649515] pci 0000:00:1c.1: BAR 13: assigned [io  0x3000-0x3fff]
[    0.649599] pci 0000:00:01.0: PCI bridge to [bus 01-01]
[    0.649681] pci 0000:00:01.0:   bridge window [io  0xe000-0xefff]
[    0.649764] pci 0000:00:01.0:   bridge window [mem 0xfa000000-0xfb0fffff]
[    0.649851] pci 0000:00:01.0:   bridge window [mem 0xc0000000-0xd1ffffff 64bit pref]
[    0.649954] pci 0000:00:1c.0: PCI bridge to [bus 11-11]
[    0.650033] pci 0000:00:1c.0:   bridge window [io  0x2000-0x2fff]
[    0.650120] pci 0000:00:1c.0:   bridge window [mem 0xbc000000-0xbc1fffff]
[    0.650211] pci 0000:00:1c.0:   bridge window [mem 0xbc200000-0xbc3fffff 64bit pref]
[    0.650315] pci 0000:00:1c.1: PCI bridge to [bus 12-12]
[    0.650398] pci 0000:00:1c.1:   bridge window [io  0x3000-0x3fff]
[    0.650485] pci 0000:00:1c.1:   bridge window [mem 0xfb300000-0xfb3fffff]
[    0.650577] pci 0000:00:1c.1:   bridge window [mem 0xbc400000-0xbc5fffff 64bit pref]
[    0.650679] pci 0000:00:1c.2: PCI bridge to [bus 13-13]
[    0.650764] pci 0000:00:1c.2:   bridge window [io  0xd000-0xdfff]
[    0.650850] pci 0000:00:1c.2:   bridge window [mem 0xfb200000-0xfb2fffff]
[    0.650941] pci 0000:00:1c.2:   bridge window [mem 0xd2100000-0xd21fffff 64bit pref]
[    0.651045] pci 0000:00:1e.0: PCI bridge to [bus 20-20]
[    0.651126] pci 0000:00:1e.0:   bridge window [io  disabled]
[    0.651211] pci 0000:00:1e.0:   bridge window [mem disabled]
[    0.651293] pci 0000:00:1e.0:   bridge window [mem pref disabled]
[    0.651391]   alloc irq_desc for 16 on node -1
[    0.651393]   alloc kstat_irqs on node -1
[    0.651400] pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[    0.651490] pci 0000:00:01.0: setting latency timer to 64
[    0.651501]   alloc irq_desc for 17 on node -1
[    0.651502]   alloc kstat_irqs on node -1
[    0.651505] pci 0000:00:1c.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[    0.651596] pci 0000:00:1c.0: setting latency timer to 64
[    0.651607] pci 0000:00:1c.1: PCI INT B -> GSI 16 (level, low) -> IRQ 16
[    0.651697] pci 0000:00:1c.1: setting latency timer to 64
[    0.651708]   alloc irq_desc for 18 on node -1
[    0.651709]   alloc kstat_irqs on node -1
[    0.651712] pci 0000:00:1c.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[    0.651799] pci 0000:00:1c.2: setting latency timer to 64
[    0.651808] pci 0000:00:1e.0: setting latency timer to 64
[    0.651813] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
[    0.651815] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
[    0.651817] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[    0.651819] pci_bus 0000:00: resource 7 [mem 0xbc000000-0xffffffff]
[    0.651821] pci_bus 0000:01: resource 0 [io  0xe000-0xefff]
[    0.651823] pci_bus 0000:01: resource 1 [mem 0xfa000000-0xfb0fffff]
[    0.651825] pci_bus 0000:01: resource 2 [mem 0xc0000000-0xd1ffffff 64bit pref]
[    0.651828] pci_bus 0000:11: resource 0 [io  0x2000-0x2fff]
[    0.651829] pci_bus 0000:11: resource 1 [mem 0xbc000000-0xbc1fffff]
[    0.651832] pci_bus 0000:11: resource 2 [mem 0xbc200000-0xbc3fffff 64bit pref]
[    0.651834] pci_bus 0000:12: resource 0 [io  0x3000-0x3fff]
[    0.651836] pci_bus 0000:12: resource 1 [mem 0xfb300000-0xfb3fffff]
[    0.651838] pci_bus 0000:12: resource 2 [mem 0xbc400000-0xbc5fffff 64bit pref]
[    0.651840] pci_bus 0000:13: resource 0 [io  0xd000-0xdfff]
[    0.651842] pci_bus 0000:13: resource 1 [mem 0xfb200000-0xfb2fffff]
[    0.651844] pci_bus 0000:13: resource 2 [mem 0xd2100000-0xd21fffff 64bit pref]
[    0.651847] pci_bus 0000:20: resource 4 [io  0x0000-0x0cf7]
[    0.651849] pci_bus 0000:20: resource 5 [io  0x0d00-0xffff]
[    0.651851] pci_bus 0000:20: resource 6 [mem 0x000a0000-0x000bffff]
[    0.651853] pci_bus 0000:20: resource 7 [mem 0xbc000000-0xffffffff]
[    0.651887] NET: Registered protocol family 2
[    0.652021] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.654325] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.655071] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[    0.655478] TCP: Hash tables configured (established 131072 bind 65536)
[    0.655567] TCP reno registered
[    0.655641] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    0.655733] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    0.655890] NET: Registered protocol family 1
[    0.909790] pci 0000:01:00.0: Boot video device
[    0.909813] PCI: CLS 64 bytes, default 64
[    0.910076] cpufreq-nforce2: No nForce2 chipset.
[    0.910184] Scanning for low memory corruption every 60 seconds
[    0.910387] audit: initializing netlink socket (disabled)
[    0.910481] type=2000 audit(1287566099.744:1): initialized
[    0.920750] highmem bounce pool size: 64 pages
[    0.920836] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[    0.922159] VFS: Disk quotas dquot_6.5.2
[    0.922292] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.922867] fuse init (API version 7.14)
[    0.923021] msgmni has been set to 1658
[    0.923399] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[    0.923502] io scheduler noop registered
[    0.923578] io scheduler deadline registered
[    0.923666] io scheduler cfq registered (default)
[    0.923829] pcieport 0000:00:01.0: setting latency timer to 64
[    0.923852]   alloc irq_desc for 40 on node -1
[    0.923853]   alloc kstat_irqs on node -1
[    0.923861] pcieport 0000:00:01.0: irq 40 for MSI/MSI-X
[    0.923902] pcieport 0000:00:1c.0: setting latency timer to 64
[    0.923945]   alloc irq_desc for 41 on node -1
[    0.923946]   alloc kstat_irqs on node -1
[    0.923954] pcieport 0000:00:1c.0: irq 41 for MSI/MSI-X
[    0.924036] pcieport 0000:00:1c.1: setting latency timer to 64
[    0.924078]   alloc irq_desc for 42 on node -1
[    0.924080]   alloc kstat_irqs on node -1
[    0.924088] pcieport 0000:00:1c.1: irq 42 for MSI/MSI-X
[    0.924168] pcieport 0000:00:1c.2: setting latency timer to 64
[    0.924212]   alloc irq_desc for 43 on node -1
[    0.924213]   alloc kstat_irqs on node -1
[    0.924221] pcieport 0000:00:1c.2: irq 43 for MSI/MSI-X
[    0.924312] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[    0.924813] pciehp 0000:00:1c.0:pcie04: HPC vendor_id 8086 device_id 3b42 ss_vid 1028 ss_did 43f
[    0.924958] pciehp 0000:00:1c.0:pcie04: service driver pciehp loaded
[    0.924976] pciehp 0000:00:1c.1:pcie04: HPC vendor_id 8086 device_id 3b44 ss_vid 1028 ss_did 43f
[    0.925109] pciehp 0000:00:1c.1:pcie04: service driver pciehp loaded
[    0.925125] pciehp 0000:00:1c.2:pcie04: HPC vendor_id 8086 device_id 3b46 ss_vid 1028 ss_did 43f
[    0.925259] pciehp 0000:00:1c.2:pcie04: service driver pciehp loaded
[    0.925265] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[    0.925420] intel_idle: MWAIT substates: 0x1120
[    0.925422] intel_idle: v0.4 model 0x25
[    0.925423] intel_idle: lapic_timer_reliable_states 0xffffffff
[    0.925553] ACPI: AC Adapter [AC] (on-line)
[    0.925692] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
[    0.925804] ACPI: Power Button [PWRB]
[    0.925919] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input1
[    0.927985] ACPI: Lid Switch [LID0]
[    0.928100] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2
[    0.928206] ACPI: Sleep Button [SBTN]
[    0.928316] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
[    0.928418] ACPI: Power Button [PWRF]
[    0.928885] ACPI: acpi_idle yielding to intel_idle
[    0.943534] thermal LNXTHERM:01: registered as thermal_zone0
[    0.943623] ACPI: Thermal Zone [THM] (62 C)
[    0.943775] ERST: Table is not found!
[    0.943899] isapnp: Scanning for PnP cards...
[    0.968360] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.971090] brd: module loaded
[    0.972198] loop: module loaded
[    0.973164] Fixed MDIO Bus: probed
[    0.973286] PPP generic driver version 2.4.2
[    0.973409] tun: Universal TUN/TAP device driver, 1.6
[    0.973495] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[    0.973662] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.973804] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[    0.973852] ACPI: Battery Slot [BAT0] (battery present)
[    0.973987] ehci_hcd 0000:00:1a.0: setting latency timer to 64
[    0.973991] ehci_hcd 0000:00:1a.0: EHCI Host Controller
[    0.974105] ehci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
[    0.974234] ehci_hcd 0000:00:1a.0: debug port 2
[    0.978251] ehci_hcd 0000:00:1a.0: cache line size of 64 is not supported
[    0.978271] ehci_hcd 0000:00:1a.0: irq 16, io mem 0xfb408000
[    0.993636] ehci_hcd 0000:00:1a.0: USB 2.0 started, EHCI 1.00
[    0.993833] hub 1-0:1.0: USB hub found
[    0.993918] hub 1-0:1.0: 2 ports detected
[    0.994056]   alloc irq_desc for 23 on node -1
[    0.994058]   alloc kstat_irqs on node -1
[    0.994064] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[    0.994170] ehci_hcd 0000:00:1d.0: setting latency timer to 64
[    0.994173] ehci_hcd 0000:00:1d.0: EHCI Host Controller
[    0.994287] ehci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[    0.994412] ehci_hcd 0000:00:1d.0: debug port 2
[    0.998454] ehci_hcd 0000:00:1d.0: cache line size of 64 is not supported
[    0.998470] ehci_hcd 0000:00:1d.0: irq 23, io mem 0xfb407000
[    1.013593] ehci_hcd 0000:00:1d.0: USB 2.0 started, EHCI 1.00
[    1.013761] hub 2-0:1.0: USB hub found
[    1.013844] hub 2-0:1.0: 2 ports detected
[    1.013972] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.014068] uhci_hcd: USB Universal Host Controller Interface driver
[    1.014239] PNP: PS/2 Controller [PNP0303:KBC,PNP0f13:PS2] at 0x60,0x64 irq 1,12
[    1.039014] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.039110] serio: i8042 AUX port at 0x60,0x64 irq 12
[    1.039269] mice: PS/2 mouse device common for all mice
[    1.039490] rtc_cmos 00:03: RTC can wake from S4
[    1.039620] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[    1.039739] rtc0: alarms up to one year, y3k, 114 bytes nvram, hpet irqs
[    1.039958] device-mapper: uevent: version 1.0.3
[    1.040400] device-mapper: ioctl: 4.17.0-ioctl (2010-03-05) initialised: dm-devel@redhat.com
[    1.040602] device-mapper: multipath: version 1.1.1 loaded
[    1.040689] device-mapper: multipath round-robin: version 1.0.0 loaded
[    1.040873] EISA: Probing bus 0 at eisa.0
[    1.040955] EISA: Cannot allocate resource for mainboard
[    1.041037] Cannot allocate resource for EISA slot 1
[    1.041117] Cannot allocate resource for EISA slot 2
[    1.041197] Cannot allocate resource for EISA slot 3
[    1.041279] Cannot allocate resource for EISA slot 4
[    1.041359] Cannot allocate resource for EISA slot 5
[    1.041437] Cannot allocate resource for EISA slot 6
[    1.041516] Cannot allocate resource for EISA slot 7
[    1.041599] Cannot allocate resource for EISA slot 8
[    1.041681] EISA: Detected 0 cards.
[    1.041984] cpuidle: using governor ladder
[    1.042213] cpuidle: using governor menu
[    1.042530] TCP cubic registered
[    1.042722] NET: Registered protocol family 10
[    1.043084] lo: Disabled Privacy Extensions
[    1.043331] NET: Registered protocol family 17
[    1.044948] Using IPI No-Shortcut mode
[    1.045104] PM: Resume from disk failed.
[    1.045119] registered taskstats version 1
[    1.045531]   Magic number: 14:200:273
[    1.045647] tty tty10: hash matches
[    1.045735] net lo: hash matches
[    1.045869] rtc_cmos 00:03: setting system clock to 2010-10-20 09:15:00 UTC (1287566100)
[    1.045975] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[    1.046058] EDD information not available.
[    1.060552] Freeing initrd memory: 10508k freed
[    1.068568] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input4
[    1.285903] isapnp: No Plug & Play device found
[    1.285999] Freeing unused kernel memory: 684k freed
[    1.286350] Write protecting the kernel text: 4932k
[    1.286465] Write protecting the kernel read-only data: 1976k
[    1.300717] udev[101]: starting version 163
[    1.309431] usb 1-1: new high speed USB device using ehci_hcd and address 2
[    1.337317] r8169 Gigabit Ethernet driver 2.3LK-NAPI loaded
[    1.337322] ahci 0000:00:1f.2: version 3.0
[    1.337346]   alloc irq_desc for 19 on node -1
[    1.337348]   alloc kstat_irqs on node -1
[    1.337356] ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[    1.337417]   alloc irq_desc for 44 on node -1
[    1.337419]   alloc kstat_irqs on node -1
[    1.337434] ahci 0000:00:1f.2: irq 44 for MSI/MSI-X
[    1.337554] r8169 0000:13:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[    1.337601] ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 6 ports 3 Gbps 0x3f impl SATA mode
[    1.337605] ahci 0000:00:1f.2: flags: 64bit ncq sntf ilck pm led clo pio slum part ems sxs apst 
[    1.337612] ahci 0000:00:1f.2: setting latency timer to 64
[    1.337888] r8169 0000:13:00.0: setting latency timer to 64
[    1.337937]   alloc irq_desc for 45 on node -1
[    1.337939]   alloc kstat_irqs on node -1
[    1.337951] r8169 0000:13:00.0: irq 45 for MSI/MSI-X
[    1.338452] r8169 0000:13:00.0: eth0: RTL8168d/8111d at 0xf80b0000, a4:ba:db:ca:e8:0e, XID 083000c0 IRQ 45
[    1.380453] scsi0 : ahci
[    1.384263] scsi1 : ahci
[    1.388116] scsi2 : ahci
[    1.391062] scsi3 : ahci
[    1.391238] scsi4 : ahci
[    1.391380] scsi5 : ahci
[    1.391638] ata1: SATA max UDMA/133 abar m2048@0xfb406000 port 0xfb406100 irq 44
[    1.391735] ata2: SATA max UDMA/133 abar m2048@0xfb406000 port 0xfb406180 irq 44
[    1.391829] ata3: SATA max UDMA/133 abar m2048@0xfb406000 port 0xfb406200 irq 44
[    1.391921] ata4: SATA max UDMA/133 abar m2048@0xfb406000 port 0xfb406280 irq 44
[    1.392017] ata5: SATA max UDMA/133 abar m2048@0xfb406000 port 0xfb406300 irq 44
[    1.392109] ata6: SATA max UDMA/133 abar m2048@0xfb406000 port 0xfb406380 irq 44
[    1.410217] hub 1-1:1.0: USB hub found
[    1.410373] hub 1-1:1.0: 6 ports detected
[    1.520141] usb 2-1: new high speed USB device using ehci_hcd and address 2
[    1.656713] hub 2-1:1.0: USB hub found
[    1.656880] hub 2-1:1.0: 8 ports detected
[    1.707830] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[    1.707837] ata4: SATA link down (SStatus 0 SControl 300)
[    1.707896] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[    1.707906] ata5: SATA link down (SStatus 0 SControl 300)
[    1.707960] ata3: SATA link down (SStatus 0 SControl 300)
[    1.709133] ata1.00: ATA-8: WDC WD3200BEKT-75A25T0, 01.01A01, max UDMA/133
[    1.709230] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[    1.710734] ata1.00: configured for UDMA/133
[    1.712404] ata2.00: ATAPI: HL-DT-ST DVD+/-RW GU10N, A102, max UDMA/133
[    1.713257] ata6: SATA link down (SStatus 0 SControl 300)
[    1.717245] ata2.00: configured for UDMA/133
[    1.723922] scsi 0:0:0:0: Direct-Access     ATA      WDC WD3200BEKT-7 01.0 PQ: 0 ANSI: 5
[    1.724154] sd 0:0:0:0: [sda] 625142448 512-byte logical blocks: (320 GB/298 GiB)
[    1.724157] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    1.724372] sd 0:0:0:0: [sda] Write Protect is off
[    1.724449] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    1.724464] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.726701]  sda:
[    1.728943] usb 1-1.1: new full speed USB device using ehci_hcd and address 3
[    1.736416] scsi 1:0:0:0: CD-ROM            HL-DT-ST DVD+-RW GU10N    A102 PQ: 0 ANSI: 5
[    1.747802] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
[    1.747904] Uniform CD-ROM driver Revision: 3.20
[    1.748081] sr 1:0:0:0: Attached scsi CD-ROM sr0
[    1.748138] sr 1:0:0:0: Attached scsi generic sg1 type 5
[    1.762399]  sda1 < sda5 sda6 sda7 >
[    1.793479] sd 0:0:0:0: [sda] Attached SCSI disk
[    1.823021] hub 1-1.1:1.0: USB hub found
[    1.823312] hub 1-1.1:1.0: 3 ports detected
[    1.896083] usb 1-1.2: new high speed USB device using ehci_hcd and address 4
[    2.011267] Initializing USB Mass Storage driver...
[    2.011427] scsi6 : usb-storage 1-1.2:1.0
[    2.011576] usbcore: registered new interface driver usb-storage
[    2.011659] USB Mass Storage support registered.
[    2.075282] usb 1-1.4: new high speed USB device using ehci_hcd and address 5
[    2.151444] EXT4-fs (sda5): mounted filesystem with ordered data mode. Opts: (null)
[    2.331740] usb 2-1.3: new full speed USB device using ehci_hcd and address 3
[    2.498508] usb 1-1.1.1: new full speed USB device using ehci_hcd and address 6
[    2.667594] usb 1-1.1.2: new full speed USB device using ehci_hcd and address 7
[    3.012330] scsi 6:0:0:0: Direct-Access     Generic- Multi-Card       1.00 PQ: 0 ANSI: 0 CCS
[    3.013828] sd 6:0:0:0: Attached scsi generic sg2 type 0
[    3.019766] sd 6:0:0:0: [sdb] Attached SCSI removable disk
[    3.690208] Adding 4096536k swap on /dev/sda6.  Priority:-1 extents:1 across:4096536k 
[    4.652588] udev[391]: starting version 163
[    4.961528] udev[415]: renamed network interface eth0 to eth1
[    5.243472] type=1400 audit(1287566104.701:2): apparmor="STATUS" operation="profile_load" name="/sbin/dhclient3" pid=521 comm="apparmor_parser"
[    5.243925] type=1400 audit(1287566104.701:3): apparmor="STATUS" operation="profile_load" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=521 comm="apparmor_parser"
[    5.244174] type=1400 audit(1287566104.701:4): apparmor="STATUS" operation="profile_load" name="/usr/lib/connman/scripts/dhclient-script" pid=521 comm="apparmor_parser"
[    5.270078] usb 1-1.1.3: new full speed USB device using ehci_hcd and address 8
[    5.984542] input: Dell WMI hotkeys as /devices/virtual/input/input5
[    5.994531] intel ips 0000:00:1f.6: Warning: CPU TDP doesn't match expected value (found 25, expected 35)
[    5.994554] intel ips 0000:00:1f.6: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[    5.994670] intel ips 0000:00:1f.6: failed to get i915 symbols, graphics turbo disabled
[    5.994904] intel ips 0000:00:1f.6: IPS driver initialized, MCP temp limit 65535
[    6.051441] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[    6.177923] lp: driver loaded but no devices found
[    6.198082] Linux agpgart interface v0.103
[    6.286267] Bluetooth: Core ver 2.15
[    6.286290] NET: Registered protocol family 31
[    6.286292] Bluetooth: HCI device and connection manager initialized
[    6.286295] Bluetooth: HCI socket layer initialized
[    6.358226] ACPI Warning: _BQC returned an invalid level (20100428/video-640)
[    6.359557] acpi device:02: registered as cooling_device4
[    6.359772] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/device:00/LNXVIDEO:00/input/input6
[    6.359905] ACPI: Video Device [PEGP] (multi-head: yes  rom: no  post: no)
[    6.386415] usbcore: registered new interface driver hiddev
[    6.387562] input: Logitech USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3/2-1.3:1.0/input/input7
[    6.387918] generic-usb 0003:046D:C526.0001: input,hidraw0: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-0000:00:1d.0-1.3/input0
[    6.389930] input: Logitech USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3/2-1.3:1.1/input/input8
[    6.390187] generic-usb 0003:046D:C526.0002: input,hiddev96,hidraw1: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:00:1d.0-1.3/input1
[    6.391569] input: HID 413c:8161 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.1/1-1.1.1/1-1.1.1:1.0/input/input9
[    6.391737] generic-usb 0003:413C:8161.0003: input,hidraw2: USB HID v1.11 Keyboard [HID 413c:8161] on usb-0000:00:1a.0-1.1.1/input0
[    6.394255] input: HID 413c:8162 as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.1/1-1.1.2/1-1.1.2:1.0/input/input10
[    6.394432] generic-usb 0003:413C:8162.0004: input,hidraw3: USB HID v1.11 Mouse [HID 413c:8162] on usb-0000:00:1a.0-1.1.2/input0
[    6.394452] usbcore: registered new interface driver usbhid
[    6.394454] usbhid: USB HID core driver
[    6.411042] lib80211: common routines for IEEE802.11 drivers
[    6.411046] lib80211_crypt: registered algorithm 'NULL'
[    6.434558] Bluetooth: Generic Bluetooth USB driver ver 0.6
[    6.434716] usbcore: registered new interface driver btusb
[    6.485918] Linux video capture interface: v2.00
[    6.575574] uvcvideo: Found UVC 1.00 device Laptop_Integrated_Webcam_2M (0c45:6481)
[    6.583894] input: Laptop_Integrated_Webcam_2M as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.4/1-1.4:1.0/input/input11
[    6.583946] usbcore: registered new interface driver uvcvideo
[    6.583947] USB Video Class driver (v0.1.0)
[    7.096041] wl: module license 'MIXED/Proprietary' taints kernel.
[    7.096046] Disabling lock debugging due to kernel taint
[    7.099028] wl 0000:12:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[    7.099037] wl 0000:12:00.0: setting latency timer to 64
[    7.342115] lib80211_crypt: registered algorithm 'TKIP'
[    7.342255] eth0: Broadcom BCM4353 802.11 Hybrid Wireless Controller 5.60.48.36 
[    7.364725] udev[401]: renamed network interface eth0 to eth2
[    7.473164] Synaptics Touchpad, model: 1, fw: 7.2, id: 0x1c0b1, caps: 0xd04731/0xa40000/0xa0000
[    7.547839] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input12
[    7.721875]   alloc irq_desc for 22 on node -1
[    7.721878]   alloc kstat_irqs on node -1
[    7.721885] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[    7.721939]   alloc irq_desc for 46 on node -1
[    7.721940]   alloc kstat_irqs on node -1
[    7.721951] HDA Intel 0000:00:1b.0: irq 46 for MSI/MSI-X
[    7.721984] HDA Intel 0000:00:1b.0: setting latency timer to 64
[    7.891806] input: HDA Intel Mic at Ext Front Jack as /devices/pci0000:00/0000:00:1b.0/sound/card0/input13
[    7.891913] input: HDA Intel HP Out at Ext Front Jack as /devices/pci0000:00/0000:00:1b.0/sound/card0/input14
[    7.892138] HDA Intel 0000:01:00.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[    7.892141] hda_intel: Disable MSI for Nvidia chipset
[    7.892185] HDA Intel 0000:01:00.1: setting latency timer to 64
[    8.806421] nvidia 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[    8.806436] nvidia 0000:01:00.0: setting latency timer to 64
[    8.806442] vgaarb: device changed decodes: PCI:0000:01:00.0,olddecodes=io+mem,decodes=none:owns=io+mem
[    8.806582] NVRM: loading NVIDIA UNIX x86 Kernel Module  260.19.12  Fri Oct  8 13:22:24 PDT 2010
[   10.848148] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro
[   11.193359] EXT4-fs (sda7): mounted filesystem with ordered data mode. Opts: (null)
[   12.672051] type=1400 audit(1287566112.145:5): apparmor="STATUS" operation="profile_replace" name="/sbin/dhclient3" pid=1125 comm="apparmor_parser"
[   12.672507] type=1400 audit(1287566112.145:6): apparmor="STATUS" operation="profile_replace" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=1125 comm="apparmor_parser"
[   12.672757] type=1400 audit(1287566112.145:7): apparmor="STATUS" operation="profile_replace" name="/usr/lib/connman/scripts/dhclient-script" pid=1125 comm="apparmor_parser"
[   12.685126] type=1400 audit(1287566112.157:8): apparmor="STATUS" operation="profile_load" name="/usr/share/gdm/guest-session/Xsession" pid=1124 comm="apparmor_parser"
[   12.694939] type=1400 audit(1287566112.169:9): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince" pid=1126 comm="apparmor_parser"
[   12.700604] type=1400 audit(1287566112.173:10): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-previewer" pid=1126 comm="apparmor_parser"
[   12.704149] type=1400 audit(1287566112.177:11): apparmor="STATUS" operation="profile_load" name="/usr/bin/evince-thumbnailer" pid=1126 comm="apparmor_parser"
[   12.917087] type=1400 audit(1287566112.389:12): apparmor="STATUS" operation="profile_load" name="/usr/sbin/tcpdump" pid=1132 comm="apparmor_parser"
[   12.936156] type=1400 audit(1287566112.409:13): apparmor="STATUS" operation="profile_load" name="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" pid=1129 comm="apparmor_parser"
[   12.938721] type=1400 audit(1287566112.413:14): apparmor="STATUS" operation="profile_load" name="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}//browser_java" pid=1129 comm="apparmor_parser"
[   13.090418] ppdev: user-space parallel port driver
[   14.769730] RPC: Registered udp transport module.
[   14.769733] RPC: Registered tcp transport module.
[   14.769735] RPC: Registered tcp NFSv4.1 backchannel transport module.
[   15.243200] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[   15.440017] svc: failed to register lockdv1 RPC service (errno 97).
[   15.440645] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory
[   15.454927] NFSD: starting 90-second grace period
[   15.525287] r8169 0000:13:00.0: eth1: link down
[   15.525450] ADDRCONF(NETDEV_UP): eth1: link is not ready
[   19.960844] vboxdrv: Trying to deactivate the NMI watchdog permanently...
[   19.960847] vboxdrv: Successfully done.
[   19.960851] vboxdrv: Found 4 processor cores.
[   19.960971] vboxdrv: fAsync=0 offMin=0x1d6 offMax=0x175f
[   19.961039] vboxdrv: TSC mode is 'synchronous', kernel timer mode is 'normal'.
[   19.961041] vboxdrv: Successfully loaded version 3.2.8 (interface 0x00140001).
[   21.015750] vboxnetflt: no symbol version for RTSemFastMutexCreate
[   21.015754] vboxnetflt: Unknown symbol RTSemFastMutexCreate (err -22)
[   21.015857] vboxnetflt: no symbol version for RTR0Init
[   21.015858] vboxnetflt: Unknown symbol RTR0Init (err -22)
[   21.016069] vboxnetflt: no symbol version for SUPDrvLinuxIDC
[   21.016071] vboxnetflt: Unknown symbol SUPDrvLinuxIDC (err -22)
[   21.016174] vboxnetflt: no symbol version for RTSemEventDestroy
[   21.016175] vboxnetflt: Unknown symbol RTSemEventDestroy (err -22)
[   21.016244] vboxnetflt: no symbol version for RTUuidFromStr
[   21.016245] vboxnetflt: Unknown symbol RTUuidFromStr (err -22)
[   21.016311] vboxnetflt: no symbol version for RTSemEventSignal
[   21.016312] vboxnetflt: Unknown symbol RTSemEventSignal (err -22)
[   21.016379] vboxnetflt: no symbol version for RTErrConvertFromErrno
[   21.016381] vboxnetflt: Unknown symbol RTErrConvertFromErrno (err -22)
[   21.016446] vboxnetflt: no symbol version for RTSemEventWait
[   21.016448] vboxnetflt: Unknown symbol RTSemEventWait (err -22)
[   21.016513] vboxnetflt: no symbol version for RTSpinlockReleaseNoInts
[   21.016515] vboxnetflt: Unknown symbol RTSpinlockReleaseNoInts (err -22)
[   21.016580] vboxnetflt: no symbol version for RTMemAllocZ
[   21.016581] vboxnetflt: Unknown symbol RTMemAllocZ (err -22)
[   21.016668] vboxnetflt: no symbol version for RTErrConvertToErrno
[   21.016670] vboxnetflt: Unknown symbol RTErrConvertToErrno (err -22)
[   21.016772] vboxnetflt: no symbol version for RTSemFastMutexRequest
[   21.016774] vboxnetflt: Unknown symbol RTSemFastMutexRequest (err -22)
[   21.016840] vboxnetflt: no symbol version for RTSpinlockCreate
[   21.016842] vboxnetflt: Unknown symbol RTSpinlockCreate (err -22)
[   21.016908] vboxnetflt: no symbol version for RTNetIPv4PseudoChecksum
[   21.016910] vboxnetflt: Unknown symbol RTNetIPv4PseudoChecksum (err -22)
[   21.017014] vboxnetflt: no symbol version for RTLogRelDefaultInstance
[   21.017016] vboxnetflt: Unknown symbol RTLogRelDefaultInstance (err -22)
[   21.017080] vboxnetflt: no symbol version for RTMemFree
[   21.017082] vboxnetflt: Unknown symbol RTMemFree (err -22)
[   21.017182] vboxnetflt: no symbol version for RTSemFastMutexRelease
[   21.017183] vboxnetflt: Unknown symbol RTSemFastMutexRelease (err -22)
[   21.017291] vboxnetflt: no symbol version for RTNetIPv4FinalizeChecksum
[   21.017293] vboxnetflt: Unknown symbol RTNetIPv4FinalizeChecksum (err -22)
[   21.017365] vboxnetflt: no symbol version for RTTimeNanoTS
[   21.017366] vboxnetflt: Unknown symbol RTTimeNanoTS (err -22)
[   21.017489] vboxnetflt: no symbol version for RTNetIPv4HdrChecksum
[   21.017491] vboxnetflt: Unknown symbol RTNetIPv4HdrChecksum (err -22)
[   21.017780] vboxnetflt: no symbol version for RTSpinlockDestroy
[   21.017783] vboxnetflt: Unknown symbol RTSpinlockDestroy (err -22)
[   21.017971] vboxnetflt: no symbol version for RTSemEventCreate
[   21.017974] vboxnetflt: Unknown symbol RTSemEventCreate (err -22)
[   21.018081] vboxnetflt: no symbol version for RTNetIPv6PseudoChecksumEx
[   21.018084] vboxnetflt: Unknown symbol RTNetIPv6PseudoChecksumEx (err -22)
[   21.018246] vboxnetflt: no symbol version for RTR0Term
[   21.018248] vboxnetflt: Unknown symbol RTR0Term (err -22)
[   21.018470] vboxnetflt: no symbol version for RTUuidCompareStr
[   21.018473] vboxnetflt: Unknown symbol RTUuidCompareStr (err -22)
[   21.018579] vboxnetflt: no symbol version for RTThreadPreemptIsEnabled
[   21.018582] vboxnetflt: Unknown symbol RTThreadPreemptIsEnabled (err -22)
[   21.018780] vboxnetflt: no symbol version for RTSemFastMutexDestroy
[   21.018783] vboxnetflt: Unknown symbol RTSemFastMutexDestroy (err -22)
[   21.018889] vboxnetflt: no symbol version for RTSpinlockAcquireNoInts
[   21.018892] vboxnetflt: Unknown symbol RTSpinlockAcquireNoInts (err -22)
[   21.327898] Bluetooth: L2CAP ver 2.14
[   21.327904] Bluetooth: L2CAP socket layer initialized
[   21.491876] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[   21.491879] Bluetooth: BNEP filters: protocol multicast
[   21.583691] Bluetooth: SCO (Voice Link) ver 0.6
[   21.583694] Bluetooth: SCO socket layer initialized
[   21.731045] Bluetooth: RFCOMM TTY layer initialized
[   21.731051] Bluetooth: RFCOMM socket layer initialized
[   21.731053] Bluetooth: RFCOMM ver 1.11
[   23.856601] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[   23.950710] EXT4-fs (sda7): re-mounted. Opts: commit=0
[   26.275415] eth2: no IPv6 routers present
[   28.721909] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[   28.724655] EXT4-fs (sda7): re-mounted. Opts: commit=0
[   42.499921] hda-intel: IRQ timing workaround is activated for card #1. Suggest a bigger bdl_pos_adj.
[  232.946192] audit_printk_skb: 15 callbacks suppressed
[  232.946195] type=1400 audit(1287566332.944:20): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/2589/mountinfo" pid=2628 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[  245.169585] type=1400 audit(1287566345.198:21): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  245.169811] type=1400 audit(1287566345.198:22): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  245.172757] type=1400 audit(1287566345.202:23): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  245.172955] type=1400 audit(1287566345.202:24): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  246.606092] type=1400 audit(1287566346.639:25): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  246.606207] type=1400 audit(1287566346.639:26): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  247.410214] type=1400 audit(1287566347.447:27): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  247.410412] type=1400 audit(1287566347.447:28): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  256.224918] type=1400 audit(1287566356.283:29): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  256.225030] type=1400 audit(1287566356.283:30): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=2678 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 3043.240798] hda-intel: IRQ timing workaround is activated for card #0. Suggest a bigger bdl_pos_adj.
[ 5006.515501] type=1400 audit(1287571116.344:31): apparmor="DENIED" operation="exec" parent=5224 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=5231 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[29378.919522] type=1400 audit(1287595537.652:32): apparmor="DENIED" operation="exec" parent=10270 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=10277 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[29701.639897] type=1400 audit(1287595861.020:33): apparmor="DENIED" operation="exec" parent=10317 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=10324 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[30625.780975] type=1400 audit(1287596787.016:34): apparmor="DENIED" operation="exec" parent=10470 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=10477 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[30859.747474] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[30860.282940] EXT4-fs (sda7): re-mounted. Opts: commit=0
[30865.966167] PM: Syncing filesystems ... done.
[30865.973985] PM: Preparing system for mem sleep
[30865.974001] Freezing user space processes ... (elapsed 0.03 seconds) done.
[30866.009806] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[30866.025769] PM: Entering mem sleep
[30866.025842] Suspending console(s) (use no_console_suspend to debug)
[30866.026501] btusb_intr_complete: hci0 urb f1fc9a80 failed to resubmit (1)
[30866.026713] btusb_bulk_complete: hci0 urb f1fc9780 failed to resubmit (1)
[30866.026791] btusb_bulk_complete: hci0 urb f1fc9380 failed to resubmit (1)
[30866.027283] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[30866.113022] wl 0000:12:00.0: PCI INT A disabled
[30866.113408] pciehp 0000:00:1c.2:pcie04: pciehp_suspend ENTRY
[30866.113501] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY
[30866.129497] ehci_hcd 0000:00:1a.0: PCI INT A disabled
[30866.129535] ehci_hcd 0000:00:1d.0: PCI INT A disabled
[30866.129558] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY
[30866.217240] sd 0:0:0:0: [sda] Stopping disk
[30866.222484] HDA Intel 0000:00:1b.0: PCI INT A disabled
[30866.222592] ACPI handle has no context!
[30866.237283] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 123.958 msecs
[30866.561698] HDA Intel 0000:01:00.1: PCI INT A disabled
[30866.561840] ACPI handle has no context!
[30866.577624] PM: suspend of drv:HDA Intel dev:0000:01:00.1 complete after 465.583 msecs
[30866.802404] PM: suspend of drv:sd dev:0:0:0:0 complete after 776.678 msecs
[30866.802417] PM: suspend of drv:scsi dev:target0:0:0 complete after 776.632 msecs
[30866.802427] PM: suspend of drv:scsi dev:host0 complete after 776.517 msecs
[30866.911913] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 800.297 msecs
[30867.181420] PM: suspend of drv:nvidia dev:0000:01:00.0 complete after 1070.499 msecs
[30867.181437] PM: suspend of drv:pcieport dev:0000:00:01.0 complete after 1069.862 msecs
[30867.181467] PM: suspend of drv: dev:pci0000:00 complete after 1069.829 msecs
[30867.181485] PM: suspend of devices complete after 1157.775 msecs
[30867.181490] PM: suspend devices took 1.156 seconds
[30867.181674] r8169 0000:13:00.0: PME# enabled
[30867.181688] pcieport 0000:00:1c.2: wake-up capability enabled by ACPI
[30867.228432] PM: late suspend of devices complete after 47.029 msecs
[30867.231746] ACPI: Preparing to enter system sleep state S3
[30867.239342] PM: Saving platform NVS memory
[30867.259099] Disabling non-boot CPUs ...
[30867.321648] CPU 1 is now offline
[30867.426896] CPU 2 is now offline
[30867.538664] CPU 3 is now offline
[30867.538669] SMP alternatives: switching to UP code
[30867.542832] Extended CMOS year: 2000
[1266874881.229435] Back to C!
[1266874881.229439] PM: Restoring platform NVS memory
[1266874881.250289] Extended CMOS year: 2000
[1266874881.250326] Enabling non-boot CPUs ...
[1266874881.250493] SMP alternatives: switching to SMP code
[1266874881.254055] Booting Node 0 Processor 1 APIC 0x4
[1266874881.264210] Initializing CPU#1
[1266874881.386358] CPU1 is up
[1266874881.386668] Booting Node 0 Processor 2 APIC 0x1
[1266874881.396805] Initializing CPU#2
[1266874881.526854] CPU2 is up
[1266874881.527266] Booting Node 0 Processor 3 APIC 0x5
[1266874881.537405] Initializing CPU#3
[1266874881.702203] CPU3 is up
[1266874881.704061] ACPI: Waking up from system sleep state S3
[1266874881.724659] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x100, writing 0x18010b)
[1266874881.724664] pcieport 0000:00:01.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0xd1f1c001)
[1266874881.724667] pcieport 0000:00:01.0: restoring config space at offset 0x8 (was 0xfff0, writing 0xfb00fa00)
[1266874881.724670] pcieport 0000:00:01.0: restoring config space at offset 0x7 (was 0xf0, writing 0xe0e0)
[1266874881.724674] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010)
[1266874881.724677] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.724702] pci 0000:00:16.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.724720] pci 0000:00:16.0: restoring config space at offset 0x4 (was 0xfed10004, writing 0xfb409004)
[1266874881.724728] pci 0000:00:16.0: restoring config space at offset 0x1 (was 0x180006, writing 0x100006)
[1266874881.724756] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.724774] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xfb408000)
[1266874881.724782] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
[1266874881.724816] HDA Intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a)
[1266874881.724835] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.724842] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100002)
[1266874881.724876] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x100105)
[1266874881.724887] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xbc31bc21)
[1266874881.724892] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xbc10bc00)
[1266874881.724897] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x0, writing 0x2020)
[1266874881.724906] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.724912] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.724960] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x10020b)
[1266874881.724971] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xbc51bc41)
[1266874881.724976] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xfb30fb30)
[1266874881.724981] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x0, writing 0x3030)
[1266874881.724990] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.724997] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.725046] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x100303)
[1266874881.725057] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xd211d211)
[1266874881.725062] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xfb20fb20)
[1266874881.725067] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x0, writing 0xd0d0)
[1266874881.725076] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.725082] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.725127] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x107)
[1266874881.725149] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xfb407000)
[1266874881.725157] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
[1266874881.725182] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x0, writing 0x100000)
[1266874881.725193] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[1266874881.725198] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0)
[1266874881.725204] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x0, writing 0x20202000)
[1266874881.725214] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007)
[1266874881.725275] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x204)
[1266874881.725297] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[1266874881.725365] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x300, writing 0x303)
[1266874881.725383] intel ips 0000:00:1f.6: restoring config space at offset 0x4 (was 0x4, writing 0xfb404004)
[1266874881.725391] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[1266874881.725426] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.725436] nvidia 0000:01:00.0: restoring config space at offset 0x9 (was 0x1, writing 0xe001)
[1266874881.725441] nvidia 0000:01:00.0: restoring config space at offset 0x7 (was 0xc, writing 0xd000000c)
[1266874881.725447] nvidia 0000:01:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xc000000c)
[1266874881.725451] nvidia 0000:01:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xfa000000)
[1266874881.725458] nvidia 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
[1266874881.725505] HDA Intel 0000:01:00.1: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.725520] HDA Intel 0000:01:00.1: restoring config space at offset 0x4 (was 0x0, writing 0xfb080000)
[1266874881.725524] HDA Intel 0000:01:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010)
[1266874881.725530] HDA Intel 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100002)
[1266874881.725582] wl 0000:12:00.0: restoring config space at offset 0xf (was 0x100, writing 0x105)
[1266874881.725608] wl 0000:12:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xfb300004)
[1266874881.725615] wl 0000:12:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.725623] wl 0000:12:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[1266874881.725678] r8169 0000:13:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x103)
[1266874881.725686] r8169 0000:13:00.0: restoring config space at offset 0xc (was 0x0, writing 0xfb200000)
[1266874881.725695] r8169 0000:13:00.0: restoring config space at offset 0x8 (was 0xc, writing 0xd210000c)
[1266874881.725702] r8169 0000:13:00.0: restoring config space at offset 0x6 (was 0xc, writing 0xd210400c)
[1266874881.725708] r8169 0000:13:00.0: restoring config space at offset 0x4 (was 0x1, writing 0xd001)
[1266874881.725713] r8169 0000:13:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.725720] r8169 0000:13:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.725827] PM: early resume of devices complete after 1.208 msecs
[1266874881.725888] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[1266874881.725896] ehci_hcd 0000:00:1a.0: setting latency timer to 64
[1266874881.725904] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY
[1266874881.725909] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[1266874881.725912] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY
[1266874881.725917] pciehp 0000:00:1c.2:pcie04: pciehp_resume ENTRY
[1266874881.725920] HDA Intel 0000:00:1b.0: setting latency timer to 64
[1266874881.725927] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[1266874881.725937] pci 0000:00:1e.0: setting latency timer to 64
[1266874881.725941] ehci_hcd 0000:00:1d.0: setting latency timer to 64
[1266874881.725958] ahci 0000:00:1f.2: setting latency timer to 64
[1266874881.726032] HDA Intel 0000:00:1b.0: irq 46 for MSI/MSI-X
[1266874881.726098] HDA Intel 0000:01:00.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[1266874881.726102] wl 0000:12:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[1266874881.726105] HDA Intel 0000:01:00.1: setting latency timer to 64
[1266874881.726114] wl 0000:12:00.0: setting latency timer to 64
[1266874881.726290] pcieport 0000:00:1c.2: wake-up capability disabled by ACPI
[1266874881.726300] r8169 0000:13:00.0: PME# disabled
[1266874881.782517] sd 0:0:0:0: [sda] Starting disk
[1266874881.920816] PM: resume of drv:usb dev:1-1 complete after 153.853 msecs
[1266874881.920827] PM: resume of drv:hub dev:1-1:1.0 complete after 152.881 msecs
[1266874881.920844] PM: resume of drv: dev:ep_81 complete after 131.622 msecs
[1266874881.996877] usb 1-1.1: reset full speed USB device using ehci_hcd and address 3
[1266874882.045595] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[1266874882.053555] ata4: SATA link down (SStatus 0 SControl 300)
[1266874882.054446] ata2.00: configured for UDMA/133
[1266874882.064533] ata5: SATA link down (SStatus 0 SControl 300)
[1266874882.092954] ata3: SATA link down (SStatus 0 SControl 300)
[1266874882.100922] ata6: SATA link down (SStatus 0 SControl 300)
[1266874882.165398] usb 1-1.2: reset high speed USB device using ehci_hcd and address 4
[1266874882.204333] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 479.320 msecs
[1266874882.269717] PM: resume of drv:usb dev:1-1.2 complete after 439.365 msecs
[1266874882.269735] PM: resume of drv:usb-storage dev:1-1.2:1.0 complete after 439.378 msecs
[1266874882.269754] PM: resume of drv:scsi dev:host6 complete after 349.626 msecs
[1266874882.269770] PM: resume of drv:scsi_host dev:host6 complete after 349.633 msecs
[1266874882.304029] PM: resume of drv:usb dev:1-1.1 complete after 513.378 msecs
[1266874882.304047] PM: resume of drv:hub dev:1-1.1:1.0 complete after 503.287 msecs
[1266874882.332739] usb 1-1.4: reset high speed USB device using ehci_hcd and address 5
[1266874882.504631] usb 1-1.1.2: reset full speed USB device using ehci_hcd and address 7
[1266874882.510647] PM: resume of drv:usb dev:1-1.4 complete after 306.923 msecs
[1266874882.510695] PM: resume of drv:uvcvideo dev:1-1.4:1.1 complete after 306.022 msecs
[1266874882.510699] PM: resume of drv:uvcvideo dev:1-1.4:1.0 complete after 306.896 msecs
[1266874882.599189] PM: resume of drv:usb dev:1-1.1.2 complete after 394.524 msecs
[1266874882.599293] PM: resume of drv:usbhid dev:1-1.1.2:1.0 complete after 394.608 msecs
[1266874882.671608] usb 1-1.1.1: reset full speed USB device using ehci_hcd and address 6
[1266874882.771117] PM: resume of drv:usb dev:1-1.1.1 complete after 566.883 msecs
[1266874882.771188] PM: resume of drv:usbhid dev:1-1.1.1:1.0 complete after 566.933 msecs
[1266874884.265118] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[1266874884.446796] ata1.00: configured for UDMA/133
[1266874884.462606] PM: resume of drv:sd dev:0:0:0:0 complete after 2685.468 msecs
[1266874884.462627] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2676.554 msecs
[1266874884.462638] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2546.887 msecs
[1266874884.469400] PM: resume of devices complete after 2749.048 msecs
[1266874884.469751] PM: resume devices took 2.748 seconds
[1266874884.470076] PM: Finishing wakeup.
[1266874884.470078] Restarting tasks ... 
[1266874884.472137] usb 1-1.1.3: USB disconnect, address 8
[1266874884.539371] done.
[1266874884.539378] video LNXVIDEO:00: Restoring backlight state
[1266874884.873052] r8169 0000:13:00.0: eth1: link down
[1266874884.873233] ADDRCONF(NETDEV_UP): eth1: link is not ready
[1266874885.126486] usb 1-1.1.3: new full speed USB device using ehci_hcd and address 9
[1266874887.323341] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[    0.118696] EXT4-fs (sda7): re-mounted. Opts: commit=600
[    1.700779] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[    2.984627] EXT4-fs (sda7): re-mounted. Opts: commit=600
[    5.705117] eth2: no IPv6 routers present
[ 1326.893968] type=1400 audit(1287606844.462:35): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894086] type=1400 audit(1287606844.462:36): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894181] type=1400 audit(1287606844.462:37): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894275] type=1400 audit(1287606844.462:38): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894369] type=1400 audit(1287606844.462:39): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894463] type=1400 audit(1287606844.462:40): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894556] type=1400 audit(1287606844.462:41): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.894650] type=1400 audit(1287606844.462:42): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.927839] type=1400 audit(1287606844.498:43): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1326.927937] type=1400 audit(1287606844.498:44): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029528] audit_printk_skb: 42 callbacks suppressed
[ 1333.029533] type=1400 audit(1287606850.610:59): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029613] type=1400 audit(1287606850.610:60): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029688] type=1400 audit(1287606850.610:61): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029763] type=1400 audit(1287606850.610:62): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029839] type=1400 audit(1287606850.610:63): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029913] type=1400 audit(1287606850.610:64): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.029988] type=1400 audit(1287606850.610:65): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1333.030062] type=1400 audit(1287606850.610:66): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.880525] type=1400 audit(1287607350.425:67): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.880626] type=1400 audit(1287607350.425:68): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.880722] type=1400 audit(1287607350.425:69): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.880816] type=1400 audit(1287607350.425:70): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.880910] type=1400 audit(1287607350.425:71): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.881004] type=1400 audit(1287607350.425:72): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.881097] type=1400 audit(1287607350.425:73): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.881259] type=1400 audit(1287607350.425:74): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.883017] type=1400 audit(1287607350.425:75): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1831.883159] type=1400 audit(1287607350.425:76): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.298660] audit_printk_skb: 66 callbacks suppressed
[ 1863.298666] type=1400 audit(1287607381.885:99): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.298764] type=1400 audit(1287607381.885:100): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.298854] type=1400 audit(1287607381.885:101): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.298943] type=1400 audit(1287607381.885:102): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.299035] type=1400 audit(1287607381.885:103): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.299123] type=1400 audit(1287607381.885:104): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.299222] type=1400 audit(1287607381.885:105): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.299312] type=1400 audit(1287607381.885:106): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.331457] type=1400 audit(1287607381.921:107): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1863.331541] type=1400 audit(1287607381.921:108): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636089] audit_printk_skb: 66 callbacks suppressed
[ 1874.636095] type=1400 audit(1287607393.243:131): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636196] type=1400 audit(1287607393.243:132): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636291] type=1400 audit(1287607393.243:133): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636386] type=1400 audit(1287607393.243:134): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636482] type=1400 audit(1287607393.243:135): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636576] type=1400 audit(1287607393.243:136): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636671] type=1400 audit(1287607393.243:137): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.636765] type=1400 audit(1287607393.243:138): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.649437] type=1400 audit(1287607393.255:139): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1874.649487] type=1400 audit(1287607393.255:140): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.996559] audit_printk_skb: 66 callbacks suppressed
[ 1982.996565] type=1400 audit(1287607501.765:163): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.996660] type=1400 audit(1287607501.765:164): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.996750] type=1400 audit(1287607501.765:165): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.996838] type=1400 audit(1287607501.765:166): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.996927] type=1400 audit(1287607501.765:167): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.997016] type=1400 audit(1287607501.765:168): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.997104] type=1400 audit(1287607501.765:169): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.997193] type=1400 audit(1287607501.765:170): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.998860] type=1400 audit(1287607501.765:171): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 1982.998952] type=1400 audit(1287607501.765:172): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=2589 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[ 3651.526538] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[ 3651.631016] EXT4-fs (sda7): re-mounted. Opts: commit=0
[ 3651.781459] ata1: exception Emask 0x10 SAct 0x0 SErr 0x50000 action 0xe frozen
[ 3651.781467] ata1: irq_stat 0x00400000, PHY RDY changed
[ 3651.781472] ata1: SError: { PHYRdyChg CommWake }
[ 3651.781482] ata1: hard resetting link
[ 3652.505068] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3652.507757] ata1.00: configured for UDMA/133
[ 3652.507765] ata1: EH complete
[ 9536.653105] audit_printk_skb: 66 callbacks suppressed
[ 9536.653109] type=1400 audit(1287615070.566:195): apparmor="DENIED" operation="exec" parent=14423 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=14430 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[38577.188790] type=1400 audit(1287644169.374:196): apparmor="DENIED" operation="open" parent=2589 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/2589/auxv" pid=18109 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[38578.779977] type=1400 audit(1287644170.970:197): apparmor="DENIED" operation="open" parent=2589 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/etc/lsb-release" pid=18109 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38578.780012] type=1400 audit(1287644170.970:198): apparmor="DENIED" operation="open" parent=2589 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/2589/environ" pid=18109 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[38578.780025] type=1400 audit(1287644170.970:199): apparmor="DENIED" operation="open" parent=2589 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/2589/auxv" pid=18109 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[38588.898667] type=1400 audit(1287644181.110:200): apparmor="DENIED" operation="open" parent=18117 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/18119/mountinfo" pid=18206 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[38642.531840] type=1400 audit(1287644234.844:201): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/18440/mountinfo" pid=18480 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[38650.692549] type=1400 audit(1287644243.016:202): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38650.692709] type=1400 audit(1287644243.020:203): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38650.699265] type=1400 audit(1287644243.024:204): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38650.699381] type=1400 audit(1287644243.024:205): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38652.000840] type=1400 audit(1287644244.327:206): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38652.000974] type=1400 audit(1287644244.327:207): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38652.049282] type=1400 audit(1287644244.375:208): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38652.049480] type=1400 audit(1287644244.375:209): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38666.034612] type=1400 audit(1287644258.384:210): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38666.034730] type=1400 audit(1287644258.384:211): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=18514 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[38960.785433] lo: Disabled Privacy Extensions
[39495.523925] lo: Disabled Privacy Extensions
[42078.067070] type=1400 audit(1287647676.861:212): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/18440/mountinfo" pid=20054 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[42084.546574] type=1400 audit(1287647683.357:213): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42084.546748] type=1400 audit(1287647683.357:214): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42084.549547] type=1400 audit(1287647683.357:215): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42084.549712] type=1400 audit(1287647683.357:216): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42085.974933] type=1400 audit(1287647684.785:217): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42085.975048] type=1400 audit(1287647684.785:218): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42086.183332] type=1400 audit(1287647684.989:219): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42086.183450] type=1400 audit(1287647684.997:220): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[42088.974195] type=1400 audit(1287647687.789:221): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=20077 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[43221.122787] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[43221.644621] EXT4-fs (sda7): re-mounted. Opts: commit=0
[43225.563389] PM: Syncing filesystems ... done.
[43225.569039] PM: Preparing system for mem sleep
[43225.569054] Freezing user space processes ... (elapsed 0.01 seconds) done.
[43225.584674] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[43225.600627] PM: Entering mem sleep
[43225.600690] Suspending console(s) (use no_console_suspend to debug)
[43225.601016] btusb_intr_complete: hci0 urb ee2b8800 failed to resubmit (1)
[43225.601106] btusb_bulk_complete: hci0 urb ee2b8a80 failed to resubmit (1)
[43225.601424] btusb_bulk_complete: hci0 urb ee2b8000 failed to resubmit (1)
[43225.601562] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[43225.690023] HDA Intel 0000:01:00.1: PCI INT A disabled
[43225.690100] wl 0000:12:00.0: PCI INT A disabled
[43225.690178] ACPI handle has no context!
[43225.690194] pciehp 0000:00:1c.2:pcie04: pciehp_suspend ENTRY
[43225.690221] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY
[43225.703375] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY
[43225.703388] ehci_hcd 0000:00:1d.0: PCI INT A disabled
[43225.703415] ehci_hcd 0000:00:1a.0: PCI INT A disabled
[43225.793558] HDA Intel 0000:00:1b.0: PCI INT A disabled
[43225.793635] ACPI handle has no context!
[43225.806784] sd 0:0:0:0: [sda] Stopping disk
[43225.808627] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 118.637 msecs
[43226.391571] PM: suspend of drv:sd dev:0:0:0:0 complete after 791.597 msecs
[43226.391583] PM: suspend of drv:scsi dev:target0:0:0 complete after 791.585 msecs
[43226.391592] PM: suspend of drv:scsi dev:host0 complete after 791.456 msecs
[43226.501786] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 813.291 msecs
[43226.815922] PM: suspend of drv:nvidia dev:0000:01:00.0 complete after 1128.172 msecs
[43226.815944] PM: suspend of drv:pcieport dev:0000:00:01.0 complete after 1127.058 msecs
[43226.815957] PM: suspend of drv: dev:pci0000:00 complete after 1127.065 msecs
[43226.816005] PM: suspend of devices complete after 1217.569 msecs
[43226.816011] PM: suspend devices took 1.216 seconds
[43226.816210] r8169 0000:13:00.0: PME# enabled
[43226.816225] pcieport 0000:00:1c.2: wake-up capability enabled by ACPI
[43226.861209] PM: late suspend of devices complete after 45.282 msecs
[43226.864957] ACPI: Preparing to enter system sleep state S3
[43226.871972] PM: Saving platform NVS memory
[43226.891768] Disabling non-boot CPUs ...
[43226.894515] CPU 1 is now offline
[43227.000745] CPU 2 is now offline
[43227.108542] CPU 3 is now offline
[43227.108547] SMP alternatives: switching to UP code
[43227.112696] Extended CMOS year: 2000
[1266874881.227015] Back to C!
[1266874881.227020] PM: Restoring platform NVS memory
[1266874881.247873] Extended CMOS year: 2000
[1266874881.247910] Enabling non-boot CPUs ...
[1266874881.248080] SMP alternatives: switching to SMP code
[1266874881.251642] Booting Node 0 Processor 1 APIC 0x4
[1266874881.261796] Initializing CPU#1
[1266874881.383959] CPU1 is up
[1266874881.384271] Booting Node 0 Processor 2 APIC 0x1
[1266874881.394409] Initializing CPU#2
[1266874881.532428] CPU2 is up
[1266874881.532841] Booting Node 0 Processor 3 APIC 0x5
[1266874881.542980] Initializing CPU#3
[1266874881.707792] CPU3 is up
[1266874881.709639] ACPI: Waking up from system sleep state S3
[1266874881.731309] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x100, writing 0x18010b)
[1266874881.731315] pcieport 0000:00:01.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0xd1f1c001)
[1266874881.731317] pcieport 0000:00:01.0: restoring config space at offset 0x8 (was 0xfff0, writing 0xfb00fa00)
[1266874881.731320] pcieport 0000:00:01.0: restoring config space at offset 0x7 (was 0xf0, writing 0xe0e0)
[1266874881.731324] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010)
[1266874881.731328] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.731352] pci 0000:00:16.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.731371] pci 0000:00:16.0: restoring config space at offset 0x4 (was 0xfed10004, writing 0xfb409004)
[1266874881.731403] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.731422] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xfb408000)
[1266874881.731430] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
[1266874881.731464] HDA Intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a)
[1266874881.731484] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.731490] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100002)
[1266874881.731525] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x100105)
[1266874881.731537] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xbc31bc21)
[1266874881.731542] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xbc10bc00)
[1266874881.731546] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x0, writing 0x2020)
[1266874881.731555] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.731562] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.731611] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x10020b)
[1266874881.731622] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xbc51bc41)
[1266874881.731627] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xfb30fb30)
[1266874881.731632] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x0, writing 0x3030)
[1266874881.731641] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.731647] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.731696] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x100303)
[1266874881.731708] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xd211d211)
[1266874881.731714] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xfb20fb20)
[1266874881.731719] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x0, writing 0xd0d0)
[1266874881.731728] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.731734] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.731779] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x107)
[1266874881.731798] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xfb407000)
[1266874881.731806] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
[1266874881.731831] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x0, writing 0x100000)
[1266874881.731843] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[1266874881.731847] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0)
[1266874881.731854] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x0, writing 0x20202000)
[1266874881.731864] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007)
[1266874881.731925] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x204)
[1266874881.731947] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[1266874881.732016] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x300, writing 0x303)
[1266874881.732035] intel ips 0000:00:1f.6: restoring config space at offset 0x4 (was 0x4, writing 0xfb404004)
[1266874881.732042] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[1266874881.732078] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.732088] nvidia 0000:01:00.0: restoring config space at offset 0x9 (was 0x1, writing 0xe001)
[1266874881.732093] nvidia 0000:01:00.0: restoring config space at offset 0x7 (was 0xc, writing 0xd000000c)
[1266874881.732098] nvidia 0000:01:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xc000000c)
[1266874881.732103] nvidia 0000:01:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xfa000000)
[1266874881.732109] nvidia 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
[1266874881.732157] HDA Intel 0000:01:00.1: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.732172] HDA Intel 0000:01:00.1: restoring config space at offset 0x4 (was 0x0, writing 0xfb080000)
[1266874881.732176] HDA Intel 0000:01:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010)
[1266874881.732182] HDA Intel 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100002)
[1266874881.732234] wl 0000:12:00.0: restoring config space at offset 0xf (was 0x100, writing 0x105)
[1266874881.732261] wl 0000:12:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xfb300004)
[1266874881.732268] wl 0000:12:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.732275] wl 0000:12:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[1266874881.732331] r8169 0000:13:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x103)
[1266874881.732340] r8169 0000:13:00.0: restoring config space at offset 0xc (was 0x0, writing 0xfb200000)
[1266874881.732351] r8169 0000:13:00.0: restoring config space at offset 0x8 (was 0xc, writing 0xd210000c)
[1266874881.732357] r8169 0000:13:00.0: restoring config space at offset 0x6 (was 0xc, writing 0xd210400c)
[1266874881.732365] r8169 0000:13:00.0: restoring config space at offset 0x4 (was 0x1, writing 0xd001)
[1266874881.732370] r8169 0000:13:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.732378] r8169 0000:13:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.732485] PM: early resume of devices complete after 1.216 msecs
[1266874881.732589] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[1266874881.732593] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[1266874881.732599] HDA Intel 0000:00:1b.0: setting latency timer to 64
[1266874881.732602] ehci_hcd 0000:00:1a.0: setting latency timer to 64
[1266874881.732630] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY
[1266874881.732635] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY
[1266874881.732639] pciehp 0000:00:1c.2:pcie04: pciehp_resume ENTRY
[1266874881.732656] HDA Intel 0000:00:1b.0: irq 46 for MSI/MSI-X
[1266874881.732700] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[1266874881.732712] ehci_hcd 0000:00:1d.0: setting latency timer to 64
[1266874881.732794] HDA Intel 0000:01:00.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[1266874881.732802] HDA Intel 0000:01:00.1: setting latency timer to 64
[1266874881.732834] pci 0000:00:1e.0: setting latency timer to 64
[1266874881.732959] ahci 0000:00:1f.2: setting latency timer to 64
[1266874881.733325] wl 0000:12:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[1266874881.733335] wl 0000:12:00.0: setting latency timer to 64
[1266874881.762083] pcieport 0000:00:1c.2: wake-up capability disabled by ACPI
[1266874881.762091] r8169 0000:13:00.0: PME# disabled
[1266874881.793215] sd 0:0:0:0: [sda] Starting disk
[1266874881.934366] PM: resume of drv:usb dev:1-1 complete after 163.803 msecs
[1266874881.934378] PM: resume of drv:hub dev:1-1:1.0 complete after 157.061 msecs
[1266874881.934393] PM: resume of drv: dev:ep_81 complete after 121.876 msecs
[1266874882.010389] usb 1-1.4: reset high speed USB device using ehci_hcd and address 5
[1266874882.059158] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[1266874882.068035] ata2.00: configured for UDMA/133
[1266874882.068091] ata5: SATA link down (SStatus 0 SControl 300)
[1266874882.075094] ata3: SATA link down (SStatus 0 SControl 300)
[1266874882.083097] ata6: SATA link down (SStatus 0 SControl 300)
[1266874882.090595] ata4: SATA link down (SStatus 0 SControl 300)
[1266874882.176058] usb 1-1.1: reset full speed USB device using ehci_hcd and address 3
[1266874882.179300] PM: resume of drv:usb dev:1-1.4 complete after 245.405 msecs
[1266874882.210164] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 478.423 msecs
[1266874882.350126] usb 1-1.2: reset high speed USB device using ehci_hcd and address 4
[1266874882.456678] PM: resume of drv:usb dev:1-1.2 complete after 642.893 msecs
[1266874882.456700] PM: resume of drv:usb-storage dev:1-1.2:1.0 complete after 609.596 msecs
[1266874882.456767] PM: resume of drv:scsi dev:host6 complete after 609.656 msecs
[1266874882.456787] PM: resume of drv:scsi dev:target6:0:0 complete after 246.921 msecs
[1266874882.456811] PM: resume of drv:sd dev:6:0:0:0 complete after 246.917 msecs
[1266874882.456826] PM: resume of drv:scsi_device dev:6:0:0:0 complete after 246.913 msecs
[1266874882.456857] PM: resume of drv:scsi_host dev:host6 complete after 523.526 msecs
[1266874882.484511] PM: resume of drv:usb dev:1-1.1 complete after 692.601 msecs
[1266874882.484581] PM: resume of drv:hub dev:1-1.1:1.0 complete after 672.824 msecs
[1266874882.485351] PM: resume of drv:usb dev:1-1.1.3 complete after 275.473 msecs
[1266874882.485445] PM: resume of drv:btusb dev:1-1.1.3:1.0 complete after 275.547 msecs
[1266874882.485454] PM: resume of drv:btusb dev:1-1.1.3:1.1 complete after 275.539 msecs
[1266874882.485461] PM: resume of drv:usb dev:1-1.1.3:1.2 complete after 275.525 msecs
[1266874882.485468] PM: resume of drv:usb dev:1-1.1.3:1.3 complete after 275.512 msecs
[1266874882.553394] usb 1-1.1.1: reset full speed USB device using ehci_hcd and address 6
[1266874882.651197] PM: resume of drv:usb dev:1-1.1.1 complete after 441.812 msecs
[1266874882.651273] PM: resume of drv:usbhid dev:1-1.1.1:1.0 complete after 441.863 msecs
[1266874882.721061] usb 1-1.1.2: reset full speed USB device using ehci_hcd and address 7
[1266874882.819053] PM: resume of drv:usb dev:1-1.1.2 complete after 609.957 msecs
[1266874882.819142] PM: resume of drv:usb dev:1-1.1.2:1.0 complete after 610.024 msecs
[1266874884.118003] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[1266874884.299616] ata1.00: configured for UDMA/133
[1266874884.323696] PM: resume of drv:sd dev:0:0:0:0 complete after 2535.560 msecs
[1266874884.323720] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2394.112 msecs
[1266874884.323746] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2535.567 msecs
[1266874884.330604] PM: resume of devices complete after 2603.302 msecs
[1266874884.330934] PM: resume devices took 2.604 seconds
[1266874884.331251] PM: Finishing wakeup.
[1266874884.331252] Restarting tasks ... 
[1266874884.358555] usb 1-1.1.3: USB disconnect, address 9
[1266874884.378469] done.
[1266874884.378475] video LNXVIDEO:00: Restoring backlight state
[1266874884.795849] r8169 0000:13:00.0: eth1: link down
[1266874884.796067] ADDRCONF(NETDEV_UP): eth1: link is not ready
[1266874885.271762] usb 1-1.1.3: new full speed USB device using ehci_hcd and address 10
[1266874886.550982] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[1266874887.162409] EXT4-fs (sda7): re-mounted. Opts: commit=600
[1266874888.107966] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[1266874889.628634] EXT4-fs (sda7): re-mounted. Opts: commit=600
[    5.593989] eth2: no IPv6 routers present
[   25.683685] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[   25.966235] EXT4-fs (sda7): re-mounted. Opts: commit=0
[   26.161692] ata1: exception Emask 0x10 SAct 0x0 SErr 0x50000 action 0xe frozen
[   26.161699] ata1: irq_stat 0x00400000, PHY RDY changed
[   26.161704] ata1: SError: { PHYRdyChg CommWake }
[   26.161713] ata1: hard resetting link
[   26.883253] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[   26.885807] ata1.00: configured for UDMA/133
[   26.885815] ata1: EH complete
[  476.882766] audit_printk_skb: 3 callbacks suppressed
[  476.882771] type=1400 audit(1287651970.267:223): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/18440/mountinfo" pid=23820 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[  488.320924] type=1400 audit(1287651981.727:224): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  488.321090] type=1400 audit(1287651981.731:225): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  488.323432] type=1400 audit(1287651981.731:226): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  488.323579] type=1400 audit(1287651981.731:227): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  488.881159] type=1400 audit(1287651982.291:228): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  488.881329] type=1400 audit(1287651982.291:229): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  489.764990] type=1400 audit(1287651983.179:230): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  489.765158] type=1400 audit(1287651983.179:231): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  490.444291] type=1400 audit(1287651983.859:232): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=23892 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  771.823914] audit_printk_skb: 3 callbacks suppressed
[  771.823917] type=1400 audit(1287652265.803:234): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/proc/18440/mountinfo" pid=24041 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=1000
[  782.320886] type=1400 audit(1287652276.319:235): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  782.321008] type=1400 audit(1287652276.319:236): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  782.322860] type=1400 audit(1287652276.323:237): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  782.322967] type=1400 audit(1287652276.323:238): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  782.774695] type=1400 audit(1287652276.775:239): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  782.774838] type=1400 audit(1287652276.775:240): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  783.674774] type=1400 audit(1287652277.675:241): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  783.674895] type=1400 audit(1287652277.679:242): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[  785.325607] type=1400 audit(1287652279.331:243): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/dev/video0" pid=24098 comm="GoogleTalkPlugi" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[15524.935269] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[15525.327810] EXT4-fs (sda7): re-mounted. Opts: commit=600
[15696.361390] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[15696.567524] EXT4-fs (sda7): re-mounted. Opts: commit=0
[15696.712507] ata1: exception Emask 0x10 SAct 0x0 SErr 0x50000 action 0xe frozen
[15696.712516] ata1: irq_stat 0x00400000, PHY RDY changed
[15696.712523] ata1: SError: { PHYRdyChg CommWake }
[15696.712535] ata1: hard resetting link
[15697.449582] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[15697.451959] ata1.00: configured for UDMA/133
[15697.451967] ata1: EH complete
[16307.383460] audit_printk_skb: 3 callbacks suppressed
[16307.383465] type=1400 audit(1287667832.365:245): apparmor="DENIED" operation="exec" parent=29575 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=29582 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[16669.017080] type=1400 audit(1287668194.725:246): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017156] type=1400 audit(1287668194.725:247): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017203] type=1400 audit(1287668194.725:248): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017248] type=1400 audit(1287668194.725:249): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017293] type=1400 audit(1287668194.725:250): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017337] type=1400 audit(1287668194.725:251): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017381] type=1400 audit(1287668194.725:252): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.017425] type=1400 audit(1287668194.725:253): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[16669.061882] type=1400 audit(1287668194.769:254): apparmor="DENIED" operation="open" parent=1 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/opt/libreoffice3/share/xdg/writer.desktop" pid=18440 comm="firefox-4.0-bin" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0
[18414.588438] audit_printk_skb: 69 callbacks suppressed
[18414.588443] type=1400 audit(1287669943.801:278): apparmor="DENIED" operation="exec" parent=30339 profile="/usr/lib/firefox-4.0b8pre/firefox{,*[^s][^h]}" name="/usr/bin/expr" pid=30346 comm="firefox-4.0" requested_mask="x" denied_mask="x" fsuid=1000 ouid=0
[26629.076283] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=0
[26629.366084] EXT4-fs (sda7): re-mounted. Opts: commit=0
[26633.665468] PM: Syncing filesystems ... done.
[26633.671943] PM: Preparing system for mem sleep
[26633.671958] Freezing user space processes ... (elapsed 0.01 seconds) done.
[26633.688814] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[26633.704760] PM: Entering mem sleep
[26633.704832] Suspending console(s) (use no_console_suspend to debug)
[26633.705223] btusb_intr_complete: hci0 urb f11c4080 failed to resubmit (1)
[26633.705379] btusb_bulk_complete: hci0 urb f11c4b00 failed to resubmit (1)
[26633.705529] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[26633.705636] btusb_bulk_complete: hci0 urb f11c4380 failed to resubmit (1)
[26633.705707] sd 0:0:0:0: [sda] Stopping disk
[26633.794829] HDA Intel 0000:01:00.1: PCI INT A disabled
[26633.794909] wl 0000:12:00.0: PCI INT A disabled
[26633.794970] pciehp 0000:00:1c.2:pcie04: pciehp_suspend ENTRY
[26633.794983] ACPI handle has no context!
[26633.795013] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY
[26633.807009] ehci_hcd 0000:00:1d.0: PCI INT A disabled
[26633.807031] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY
[26633.812015] ehci_hcd 0000:00:1a.0: PCI INT A disabled
[26633.901152] HDA Intel 0000:00:1b.0: PCI INT A disabled
[26633.901229] ACPI handle has no context!
[26633.916254] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 121.463 msecs
[26634.290880] PM: suspend of drv:sd dev:0:0:0:0 complete after 586.528 msecs
[26634.290893] PM: suspend of drv:scsi dev:target0:0:0 complete after 586.495 msecs
[26634.290903] PM: suspend of drv:scsi dev:host0 complete after 586.429 msecs
[26634.401825] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 608.152 msecs
[26634.915793] PM: suspend of drv:nvidia dev:0000:01:00.0 complete after 1123.221 msecs
[26634.915863] PM: suspend of drv:pcieport dev:0000:00:01.0 complete after 1123.010 msecs
[26634.915887] PM: suspend of drv: dev:pci0000:00 complete after 1122.996 msecs
[26634.915897] PM: suspend of devices complete after 1213.312 msecs
[26634.915901] PM: suspend devices took 1.212 seconds
[26634.916101] r8169 0000:13:00.0: PME# enabled
[26634.916114] pcieport 0000:00:1c.2: wake-up capability enabled by ACPI
[26634.960847] PM: late suspend of devices complete after 45.026 msecs
[26634.964659] ACPI: Preparing to enter system sleep state S3
[26634.971822] PM: Saving platform NVS memory
[26634.991595] Disabling non-boot CPUs ...
[26634.993142] CPU 1 is now offline
[26635.104374] CPU 2 is now offline
[26635.212176] CPU 3 is now offline
[26635.212180] SMP alternatives: switching to UP code
[26635.216342] Extended CMOS year: 2000
[1266874881.226620] Back to C!
[1266874881.226625] PM: Restoring platform NVS memory
[1266874881.247478] Extended CMOS year: 2000
[1266874881.247515] Enabling non-boot CPUs ...
[1266874881.247684] SMP alternatives: switching to SMP code
[1266874881.251246] Booting Node 0 Processor 1 APIC 0x4
[1266874881.261401] Initializing CPU#1
[1266874881.391534] CPU1 is up
[1266874881.391813] Booting Node 0 Processor 2 APIC 0x1
[1266874881.401951] Initializing CPU#2
[1266874881.551958] CPU2 is up
[1266874881.552362] Booting Node 0 Processor 3 APIC 0x5
[1266874881.562500] Initializing CPU#3
[1266874881.711374] CPU3 is up
[1266874881.713227] ACPI: Waking up from system sleep state S3
[1266874881.733651] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x100, writing 0x18010b)
[1266874881.733657] pcieport 0000:00:01.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0xd1f1c001)
[1266874881.733660] pcieport 0000:00:01.0: restoring config space at offset 0x8 (was 0xfff0, writing 0xfb00fa00)
[1266874881.733662] pcieport 0000:00:01.0: restoring config space at offset 0x7 (was 0xf0, writing 0xe0e0)
[1266874881.733666] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010)
[1266874881.733670] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.733694] pci 0000:00:16.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.733712] pci 0000:00:16.0: restoring config space at offset 0x4 (was 0xfed10004, writing 0xfb409004)
[1266874881.733744] ehci_hcd 0000:00:1a.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.733763] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x4 (was 0x0, writing 0xfb408000)
[1266874881.733771] ehci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
[1266874881.733805] HDA Intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a)
[1266874881.733825] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.733831] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100002)
[1266874881.733866] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x100105)
[1266874881.733878] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xbc31bc21)
[1266874881.733882] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xbc10bc00)
[1266874881.733887] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x0, writing 0x2020)
[1266874881.733896] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.733903] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.733951] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x10020b)
[1266874881.733963] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xbc51bc41)
[1266874881.733968] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xfb30fb30)
[1266874881.733973] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x0, writing 0x3030)
[1266874881.733981] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.733988] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.734037] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x100303)
[1266874881.734048] pcieport 0000:00:1c.2: restoring config space at offset 0x9 (was 0x10001, writing 0xd211d211)
[1266874881.734053] pcieport 0000:00:1c.2: restoring config space at offset 0x8 (was 0x0, writing 0xfb20fb20)
[1266874881.734058] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x0, writing 0xd0d0)
[1266874881.734067] pcieport 0000:00:1c.2: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[1266874881.734074] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.734119] ehci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x107)
[1266874881.734138] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x4 (was 0x0, writing 0xfb407000)
[1266874881.734146] ehci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900002)
[1266874881.734171] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x0, writing 0x100000)
[1266874881.734182] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[1266874881.734187] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0)
[1266874881.734193] pci 0000:00:1e.0: restoring config space at offset 0x6 (was 0x0, writing 0x20202000)
[1266874881.734203] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007)
[1266874881.734265] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x204)
[1266874881.734287] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[1266874881.734359] intel ips 0000:00:1f.6: restoring config space at offset 0xf (was 0x300, writing 0x303)
[1266874881.734378] intel ips 0000:00:1f.6: restoring config space at offset 0x4 (was 0x4, writing 0xfb404004)
[1266874881.734386] intel ips 0000:00:1f.6: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[1266874881.734421] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.734431] nvidia 0000:01:00.0: restoring config space at offset 0x9 (was 0x1, writing 0xe001)
[1266874881.734436] nvidia 0000:01:00.0: restoring config space at offset 0x7 (was 0xc, writing 0xd000000c)
[1266874881.734442] nvidia 0000:01:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xc000000c)
[1266874881.734446] nvidia 0000:01:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xfa000000)
[1266874881.734453] nvidia 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
[1266874881.734501] HDA Intel 0000:01:00.1: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[1266874881.734516] HDA Intel 0000:01:00.1: restoring config space at offset 0x4 (was 0x0, writing 0xfb080000)
[1266874881.734520] HDA Intel 0000:01:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010)
[1266874881.734526] HDA Intel 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100002)
[1266874881.734578] wl 0000:12:00.0: restoring config space at offset 0xf (was 0x100, writing 0x105)
[1266874881.734604] wl 0000:12:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xfb300004)
[1266874881.734610] wl 0000:12:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.734619] wl 0000:12:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100006)
[1266874881.734672] r8169 0000:13:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x103)
[1266874881.734681] r8169 0000:13:00.0: restoring config space at offset 0xc (was 0x0, writing 0xfb200000)
[1266874881.734691] r8169 0000:13:00.0: restoring config space at offset 0x8 (was 0xc, writing 0xd210000c)
[1266874881.734698] r8169 0000:13:00.0: restoring config space at offset 0x6 (was 0xc, writing 0xd210400c)
[1266874881.734705] r8169 0000:13:00.0: restoring config space at offset 0x4 (was 0x1, writing 0xd001)
[1266874881.734710] r8169 0000:13:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[1266874881.734717] r8169 0000:13:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[1266874881.734820] PM: early resume of devices complete after 1.209 msecs
[1266874881.734880] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[1266874881.734888] ehci_hcd 0000:00:1a.0: setting latency timer to 64
[1266874881.734911] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[1266874881.734916] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY
[1266874881.734919] HDA Intel 0000:00:1b.0: setting latency timer to 64
[1266874881.734921] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY
[1266874881.734926] pciehp 0000:00:1c.2:pcie04: pciehp_resume ENTRY
[1266874881.734933] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[1266874881.734942] ehci_hcd 0000:00:1d.0: setting latency timer to 64
[1266874881.734977] pci 0000:00:1e.0: setting latency timer to 64
[1266874881.734979] HDA Intel 0000:00:1b.0: irq 46 for MSI/MSI-X
[1266874881.735023] HDA Intel 0000:01:00.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[1266874881.735032] HDA Intel 0000:01:00.1: setting latency timer to 64
[1266874881.755089] ahci 0000:00:1f.2: setting latency timer to 64
[1266874881.755190] wl 0000:12:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[1266874881.755198] wl 0000:12:00.0: setting latency timer to 64
[1266874881.755205] pcieport 0000:00:1c.2: wake-up capability disabled by ACPI
[1266874881.755213] r8169 0000:13:00.0: PME# disabled
[1266874881.814671] sd 0:0:0:0: [sda] Starting disk
[1266874881.949887] PM: resume of drv:usb dev:1-1 complete after 154.674 msecs
[1266874881.949945] PM: resume of drv:hub dev:1-1:1.0 complete after 154.702 msecs
[1266874881.949961] PM: resume of drv: dev:ep_81 complete after 128.553 msecs
[1266874882.025869] usb 1-1.2: reset high speed USB device using ehci_hcd and address 4
[1266874882.105592] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[1266874882.105649] ata4: SATA link down (SStatus 0 SControl 300)
[1266874882.113573] ata5: SATA link down (SStatus 0 SControl 300)
[1266874882.113618] ata3: SATA link down (SStatus 0 SControl 300)
[1266874882.114404] ata2.00: configured for UDMA/133
[1266874882.121560] ata6: SATA link down (SStatus 0 SControl 300)
[1266874882.130164] PM: resume of drv:usb dev:1-1.2 complete after 180.630 msecs
[1266874882.130175] PM: resume of drv:usb-storage dev:1-1.2:1.0 complete after 180.583 msecs
[1266874882.200696] usb 1-1.1: reset full speed USB device using ehci_hcd and address 3
[1266874882.209989] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 475.943 msecs
[1266874882.361290] usb 1-1.4: reset high speed USB device using ehci_hcd and address 5
[1266874882.500803] PM: resume of drv:usb dev:1-1.1 complete after 632.100 msecs
[1266874882.500887] PM: resume of drv:hub dev:1-1.1:1.0 complete after 632.153 msecs
[1266874882.503146] PM: resume of drv:usb dev:1-1.1.3 complete after 292.123 msecs
[1266874882.503168] PM: resume of drv:btusb dev:1-1.1.3:1.0 complete after 292.115 msecs
[1266874882.503181] PM: resume of drv:btusb dev:1-1.1.3:1.1 complete after 292.094 msecs
[1266874882.503189] PM: resume of drv:usb dev:1-1.1.3:1.2 complete after 292.068 msecs
[1266874882.503196] PM: resume of drv:usb dev:1-1.1.3:1.3 complete after 292.049 msecs
[1266874882.530190] PM: resume of drv:usb dev:1-1.4 complete after 400.802 msecs
[1266874882.530296] PM: resume of drv:uvcvideo dev:1-1.4:1.1 complete after 320.855 msecs
[1266874882.530312] PM: resume of drv:uvcvideo dev:1-1.4:1.0 complete after 400.910 msecs
[1266874882.576886] usb 1-1.1.1: reset full speed USB device using ehci_hcd and address 6
[1266874882.675436] PM: resume of drv:usb dev:1-1.1.1 complete after 464.953 msecs
[1266874882.675458] PM: resume of drv:usbhid dev:1-1.1.1:1.0 complete after 464.925 msecs
[1266874882.748034] usb 1-1.1.2: reset full speed USB device using ehci_hcd and address 7
[1266874882.842728] PM: resume of drv:usb dev:1-1.1.2 complete after 632.481 msecs
[1266874882.842750] PM: resume of drv:usb dev:1-1.1.2:1.0 complete after 632.458 msecs
[1266874884.217396] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[1266874884.394387] ata1.00: configured for UDMA/133
[1266874884.418438] PM: resume of drv:sd dev:0:0:0:0 complete after 2608.991 msecs
[1266874884.418460] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 2608.997 msecs
[1266874884.418473] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 2473.457 msecs
[1266874884.425900] PM: resume of devices complete after 2696.450 msecs
[1266874884.426007] PM: resume devices took 2.696 seconds
[1266874884.426407] PM: Finishing wakeup.
[1266874884.426408] Restarting tasks ... 
[1266874884.452394] usb 1-1.1.3: USB disconnect, address 10
[1266874884.471689] done.
[1266874884.471694] video LNXVIDEO:00: Restoring backlight state
[1266874884.754219] r8169 0000:13:00.0: eth1: link down
[1266874884.754462] ADDRCONF(NETDEV_UP): eth1: link is not ready
[1266874885.032911] usb 1-1.1.3: new full speed USB device using ehci_hcd and address 11
[1266874886.616099] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[1266874888.127517] EXT4-fs (sda7): re-mounted. Opts: commit=600
[1266874889.479399] EXT4-fs (sda5): re-mounted. Opts: errors=remount-ro,commit=600
[    0.261734] EXT4-fs (sda7): re-mounted. Opts: commit=600
[    5.741294] eth2: no IPv6 routers present
[  579.645696] NVRM: Xid (0001:00): 8, Channel 00000001
[ 1088.610462] NVRM: Xid (0001:00): 8, Channel 00000001
[ 1142.502283] NVRM: Xid (0001:00): 8, Channel 00000001